2021-04-10T19:14:04.249Z,1618082044.249 [Supervisor](DEBUG): Initializing supervisor. 2021-04-10T19:14:04.254Z,1618082044.254 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2021-04-10T19:14:04.254Z,1618082044.254 [SyncHandler](INFO): Protected caller Thread ID is 837 2021-04-10T19:14:04.255Z,1618082044.255 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2021-04-10T19:14:04.256Z,1618082044.256 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2021-04-10T19:14:04.256Z,1618082044.256 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 838 2021-04-10T19:14:04.260Z,1618082044.260 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2021-04-10T19:14:04.279Z,1618082044.279 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2021-04-10T19:14:04.280Z,1618082044.280 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2021-04-10T19:14:04.280Z,1618082044.280 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 839 2021-04-10T19:14:04.282Z,1618082044.282 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2021-04-10T19:14:04.283Z,1618082044.283 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2021-04-10T19:14:04.284Z,1618082044.284 [logger ThreadHandler](INFO): Protected caller Thread ID is 840 2021-04-10T19:14:04.287Z,1618082044.287 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2021-04-10T19:14:04.288Z,1618082044.288 [Supervisor](INFO): Looking for Config files in directory: Config/ 2021-04-10T19:14:04.292Z,1618082044.292 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2021-04-10T19:14:04.389Z,1618082044.389 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2021-04-10T19:14:04.391Z,1618082044.391 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2021-04-10T19:14:05.013Z,1618082045.013 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2021-04-10T19:14:05.013Z,1618082045.013 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2021-04-10T19:14:05.228Z,1618082045.228 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2021-04-10T19:14:05.230Z,1618082045.230 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2021-04-10T19:14:05.310Z,1618082045.310 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2021-04-10T19:14:05.434Z,1618082045.434 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2021-04-10T19:14:05.436Z,1618082045.436 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2021-04-10T19:14:05.518Z,1618082045.518 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2021-04-10T19:14:05.619Z,1618082045.619 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2021-04-10T19:14:05.620Z,1618082045.620 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2021-04-10T19:14:05.970Z,1618082045.970 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2021-04-10T19:14:05.972Z,1618082045.972 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2021-04-10T19:14:06.494Z,1618082046.494 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2021-04-10T19:14:06.495Z,1618082046.495 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2021-04-10T19:14:06.642Z,1618082046.642 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2021-04-10T19:14:06.644Z,1618082046.644 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2021-04-10T19:14:06.847Z,1618082046.847 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2021-04-10T19:14:06.848Z,1618082046.848 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2021-04-10T19:14:07.283Z,1618082047.283 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2021-04-10T19:14:07.284Z,1618082047.284 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2021-04-10T19:14:07.531Z,1618082047.531 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2021-04-10T19:14:07.533Z,1618082047.533 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2021-04-10T19:14:07.749Z,1618082047.749 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2021-04-10T19:14:07.750Z,1618082047.750 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2021-04-10T19:14:09.186Z,1618082049.186 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2021-04-10T19:14:09.188Z,1618082049.188 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2021-04-10T19:14:09.528Z,1618082049.528 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2021-04-10T19:14:09.530Z,1618082049.530 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2021-04-10T19:14:09.533Z,1618082049.533 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2021-04-10T19:14:09.616Z,1618082049.616 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2021-04-10T19:14:09.777Z,1618082049.777 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2021-04-10T19:14:09.887Z,1618082049.887 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2021-04-10T19:14:09.973Z,1618082049.973 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2021-04-10T19:14:10.069Z,1618082050.069 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2021-04-10T19:14:10.257Z,1618082050.257 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2021-04-10T19:14:10.555Z,1618082050.555 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2021-04-10T19:14:10.556Z,1618082050.556 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2021-04-10T19:14:10.651Z,1618082050.651 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2021-04-10T19:14:10.751Z,1618082050.751 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2021-04-10T19:14:10.893Z,1618082050.893 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2021-04-10T19:14:10.993Z,1618082050.993 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2021-04-10T19:14:10.999Z,1618082050.999 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2021-04-10T19:14:11.107Z,1618082051.107 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2021-04-10T19:14:11.109Z,1618082051.109 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2021-04-10T19:14:11.176Z,1618082051.176 [VerticalControl](DEBUG): Construct VerticalControl. 2021-04-10T19:14:11.236Z,1618082051.236 [VerticalControl] Loaded 2021-04-10T19:14:11.237Z,1618082051.237 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2021-04-10T19:14:11.239Z,1618082051.239 [HorizontalControl](DEBUG): Construct HorizontalControl. 2021-04-10T19:14:11.277Z,1618082051.277 [HorizontalControl] Loaded 2021-04-10T19:14:11.277Z,1618082051.277 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2021-04-10T19:14:11.279Z,1618082051.279 [SpeedControl](DEBUG): Construct SpeedControl. 2021-04-10T19:14:11.283Z,1618082051.283 [SpeedControl] Loaded 2021-04-10T19:14:11.283Z,1618082051.283 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2021-04-10T19:14:11.285Z,1618082051.285 [LoopControl](DEBUG): Construct LoopControl. 2021-04-10T19:14:11.286Z,1618082051.286 [LoopControl] Loaded 2021-04-10T19:14:11.286Z,1618082051.286 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2021-04-10T19:14:11.286Z,1618082051.286 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2021-04-10T19:14:11.287Z,1618082051.287 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2021-04-10T19:14:11.344Z,1618082051.344 [DepthRateCalculator] Loaded 2021-04-10T19:14:11.344Z,1618082051.344 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2021-04-10T19:14:11.349Z,1618082051.349 [PitchRateCalculator] Loaded 2021-04-10T19:14:11.349Z,1618082051.349 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2021-04-10T19:14:11.359Z,1618082051.359 [SpeedCalculator] Loaded 2021-04-10T19:14:11.359Z,1618082051.359 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2021-04-10T19:14:11.372Z,1618082051.372 [TempGradientCalculator] Loaded 2021-04-10T19:14:11.372Z,1618082051.372 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2021-04-10T19:14:11.376Z,1618082051.376 [YawRateCalculator] Loaded 2021-04-10T19:14:11.377Z,1618082051.377 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2021-04-10T19:14:11.393Z,1618082051.393 [ElevatorOffsetCalculator] Loaded 2021-04-10T19:14:11.393Z,1618082051.393 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2021-04-10T19:14:11.394Z,1618082051.394 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2021-04-10T19:14:11.394Z,1618082051.394 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2021-04-10T19:14:11.436Z,1618082051.436 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2021-04-10T19:14:11.436Z,1618082051.436 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2021-04-10T19:14:11.514Z,1618082051.514 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2021-04-10T19:14:11.514Z,1618082051.514 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2021-04-10T19:14:11.869Z,1618082051.869 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2021-04-10T19:14:11.870Z,1618082051.870 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2021-04-10T19:14:11.996Z,1618082051.996 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2021-04-10T19:14:11.996Z,1618082051.996 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2021-04-10T19:14:12.646Z,1618082052.646 [AHRS_M2] Loaded 2021-04-10T19:14:12.647Z,1618082052.647 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2021-04-10T19:14:12.890Z,1618082052.890 [BackseatComponent] Loaded 2021-04-10T19:14:12.891Z,1618082052.891 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2021-04-10T19:14:12.892Z,1618082052.892 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408FE4E0 2021-04-10T19:14:12.892Z,1618082052.892 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 923 2021-04-10T19:14:12.895Z,1618082052.895 [LcmUniversalReporter] Loaded 2021-04-10T19:14:12.895Z,1618082052.895 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2021-04-10T19:14:13.645Z,1618082053.645 [BPC1] Loaded 2021-04-10T19:14:13.646Z,1618082053.646 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2021-04-10T19:14:13.795Z,1618082053.795 [DataOverHttps] Loaded 2021-04-10T19:14:13.795Z,1618082053.795 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2021-04-10T19:14:13.796Z,1618082053.796 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4092E4E0 2021-04-10T19:14:13.797Z,1618082053.797 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 924 2021-04-10T19:14:13.815Z,1618082053.815 [Depth_Keller] Loaded 2021-04-10T19:14:13.816Z,1618082053.816 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2021-04-10T19:14:13.820Z,1618082053.820 [DropWeight] Loaded 2021-04-10T19:14:13.820Z,1618082053.820 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2021-04-10T19:14:13.877Z,1618082053.877 [NAL9602] Loaded 2021-04-10T19:14:13.877Z,1618082053.877 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2021-04-10T19:14:13.906Z,1618082053.906 [Onboard] Loaded 2021-04-10T19:14:13.906Z,1618082053.906 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2021-04-10T19:14:13.907Z,1618082053.907 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4095E4E0 2021-04-10T19:14:13.907Z,1618082053.907 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 925 2021-04-10T19:14:13.920Z,1618082053.920 [Radio_Surface] Loaded 2021-04-10T19:14:13.920Z,1618082053.920 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2021-04-10T19:14:13.921Z,1618082053.921 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4098E4E0 2021-04-10T19:14:13.921Z,1618082053.921 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 926 2021-04-10T19:14:13.962Z,1618082053.962 [RDI_Pathfinder] Loaded 2021-04-10T19:14:13.963Z,1618082053.963 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2021-04-10T19:14:14.114Z,1618082054.114 [DAT] Loaded 2021-04-10T19:14:14.118Z,1618082054.118 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2021-04-10T19:14:14.118Z,1618082054.118 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2021-04-10T19:14:14.119Z,1618082054.119 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2021-04-10T19:14:14.443Z,1618082054.443 [DeadReckonUsingMultipleVelocitySources] Loaded 2021-04-10T19:14:14.444Z,1618082054.444 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2021-04-10T19:14:14.457Z,1618082054.457 [NavChart] Loaded 2021-04-10T19:14:14.457Z,1618082054.457 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2021-04-10T19:14:14.463Z,1618082054.463 [UniversalFixResidualReporter] Loaded 2021-04-10T19:14:14.463Z,1618082054.463 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2021-04-10T19:14:14.464Z,1618082054.464 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2021-04-10T19:14:14.465Z,1618082054.465 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2021-04-10T19:14:14.631Z,1618082054.631 [SBIT](DEBUG): Construct Startup Built In Test. 2021-04-10T19:14:14.641Z,1618082054.641 [SBIT] Loaded 2021-04-10T19:14:14.641Z,1618082054.641 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2021-04-10T19:14:14.644Z,1618082054.644 [IBIT](DEBUG): Construct Initiated Built In Test. 2021-04-10T19:14:14.656Z,1618082054.656 [IBIT] Loaded 2021-04-10T19:14:14.657Z,1618082054.657 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2021-04-10T19:14:14.662Z,1618082054.662 [CBIT](DEBUG): Construct Continuous Built In Test. 2021-04-10T19:14:14.759Z,1618082054.759 [CBIT] Loaded 2021-04-10T19:14:14.759Z,1618082054.759 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2021-04-10T19:14:14.760Z,1618082054.760 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2021-04-10T19:14:14.760Z,1618082054.760 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2021-04-10T19:14:14.892Z,1618082054.892 [BuoyancyServo] Loaded 2021-04-10T19:14:14.892Z,1618082054.892 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2021-04-10T19:14:14.911Z,1618082054.911 [ElevatorServo] Loaded 2021-04-10T19:14:14.911Z,1618082054.911 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2021-04-10T19:14:14.930Z,1618082054.930 [MassServo] Loaded 2021-04-10T19:14:14.930Z,1618082054.930 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2021-04-10T19:14:14.948Z,1618082054.948 [RudderServo] Loaded 2021-04-10T19:14:14.948Z,1618082054.948 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2021-04-10T19:14:14.965Z,1618082054.965 [ThrusterServo] Loaded 2021-04-10T19:14:14.965Z,1618082054.965 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2021-04-10T19:14:14.966Z,1618082054.966 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2021-04-10T19:14:14.967Z,1618082054.967 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2021-04-10T19:14:14.983Z,1618082054.983 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2021-04-10T19:14:14.983Z,1618082054.983 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2021-04-10T19:14:15.201Z,1618082055.201 [CTD_Seabird] Loaded 2021-04-10T19:14:15.202Z,1618082055.202 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2021-04-10T19:14:15.203Z,1618082055.203 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ABB4E0 2021-04-10T19:14:15.203Z,1618082055.203 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 927 2021-04-10T19:14:15.223Z,1618082055.223 [PAR_Licor] Loaded 2021-04-10T19:14:15.223Z,1618082055.223 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2021-04-10T19:14:15.254Z,1618082055.254 [WetLabsBB2FL] Loaded 2021-04-10T19:14:15.255Z,1618082055.255 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2021-04-10T19:14:15.255Z,1618082055.255 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AEB4E0 2021-04-10T19:14:15.256Z,1618082055.256 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 928 2021-04-10T19:14:15.275Z,1618082055.275 [WetLabsUBAT] Loaded 2021-04-10T19:14:15.276Z,1618082055.276 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2021-04-10T19:14:15.277Z,1618082055.277 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40B1B4E0 2021-04-10T19:14:15.277Z,1618082055.277 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 929 2021-04-10T19:14:15.278Z,1618082055.278 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2021-04-10T19:14:15.284Z,1618082055.284 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2021-04-10T19:14:15.286Z,1618082055.286 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2021-04-10T19:14:15.297Z,1618082055.297 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2021-04-10T19:14:15.298Z,1618082055.297 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B4B4E0 2021-04-10T19:14:15.298Z,1618082055.298 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 930 2021-04-10T19:14:15.302Z,1618082055.302 [Supervisor](INFO): Main Thread ID is 831 2021-04-10T19:14:15.303Z,1618082055.303 [Supervisor](DEBUG): Running supervisor. 2021-04-10T19:14:15.303Z,1618082055.303 [CommandLine ThreadHandler](INFO): Handler Thread ID is 931 2021-04-10T19:14:15.305Z,1618082055.305 [controlThread ThreadHandler](INFO): Handler Thread ID is 932 2021-04-10T19:14:15.306Z,1618082055.306 [controlThread](DEBUG): Initializing ControlThread 2021-04-10T19:14:15.307Z,1618082055.307 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2021-04-10T19:14:15.308Z,1618082055.308 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2021-04-10T19:14:15.309Z,1618082055.309 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2021-04-10T19:14:15.309Z,1618082055.309 [LoopControl](DEBUG): Initialize LoopControlComponent. 2021-04-10T19:14:15.310Z,1618082055.310 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2021-04-10T19:14:15.310Z,1618082055.310 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2021-04-10T19:14:15.311Z,1618082055.311 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2021-04-10T19:14:15.311Z,1618082055.311 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2021-04-10T19:14:15.312Z,1618082055.312 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2021-04-10T19:14:15.312Z,1618082055.312 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2021-04-10T19:14:15.317Z,1618082055.316 [NavChart](DEBUG): Initialize NavChart Navigation. 2021-04-10T19:14:15.317Z,1618082055.317 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2021-04-10T19:14:15.317Z,1618082055.317 [SBIT](INFO): Initialize SBIT Component. 2021-04-10T19:14:15.318Z,1618082055.318 [SBIT](IMPORTANT): git: 2021-04-08 2021-04-10T19:14:15.318Z,1618082055.318 [SBIT](INFO): git hash: 155c968ce6603225d0d05b13bd332de918e41ed7 2021-04-10T19:14:15.318Z,1618082055.318 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2021-04-10T19:14:15.319Z,1618082055.319 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020 2021-04-10T19:14:15.320Z,1618082055.320 [SBIT](INFO): Beginning SBIT in 49.000000 seconds. 2021-04-10T19:14:15.321Z,1618082055.321 [IBIT](INFO): Initialize IBIT Component. 2021-04-10T19:14:15.322Z,1618082055.322 [CBIT](DEBUG): Initialize CBIT Component. 2021-04-10T19:14:15.323Z,1618082055.323 [logger ThreadHandler](INFO): Handler Thread ID is 933 2021-04-10T19:14:15.334Z,1618082055.334 [CBIT](DEBUG): Initialized mux pins. 2021-04-10T19:14:15.334Z,1618082055.334 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2021-04-10T19:14:15.334Z,1618082055.334 [CBIT](DEBUG): Initializing the watchdog timer. 2021-04-10T19:14:15.343Z,1618082055.343 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 934 2021-04-10T19:14:15.355Z,1618082055.355 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 935 2021-04-10T19:14:15.355Z,1618082055.355 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2021-04-10T19:14:15.358Z,1618082055.358 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET. 2021-04-10T19:14:15.363Z,1618082055.363 [CBIT](FAULT): Found backtrace file: 1618081878.109186 [MissionManager]: SIGSEGV: address not mapped to object 1618081878.109186 [MissionManager]: Backtrace: ./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x19f388] 2021-04-10T19:14:15.364Z,1618082055.364 [CBIT](FAULT): Renaming backtrace file to Data/backtrace1 2021-04-10T19:14:15.364Z,1618082055.364 [CBIT](DEBUG): Initializing heartbeat. 2021-04-10T19:14:15.365Z,1618082055.365 [Onboard ThreadHandler](INFO): Handler Thread ID is 936 2021-04-10T19:14:15.382Z,1618082055.382 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 937 2021-04-10T19:14:15.414Z,1618082055.414 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 938 2021-04-10T19:14:15.415Z,1618082055.415 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2021-04-10T19:14:15.420Z,1618082055.420 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 940 2021-04-10T19:14:15.423Z,1618082055.423 [WetLabsBB2FL](INFO): Powering up 2021-04-10T19:14:15.424Z,1618082055.424 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 942 2021-04-10T19:14:15.427Z,1618082055.427 [WetLabsUBAT](INFO): Powering up 2021-04-10T19:14:15.428Z,1618082055.428 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 944 2021-04-10T19:14:15.434Z,1618082055.434 [CBIT](DEBUG): Deactivating GF circuits. 2021-04-10T19:14:15.434Z,1618082055.434 [CBIT](DEBUG): Deactivating emergency mode. 2021-04-10T19:14:15.440Z,1618082055.440 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2021-04-10T19:14:15.440Z,1618082055.440 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2021-04-10T19:14:15.440Z,1618082055.440 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2021-04-10T19:14:15.440Z,1618082055.440 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2021-04-10T19:14:15.441Z,1618082055.441 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2021-04-10T19:14:15.441Z,1618082055.441 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2021-04-10T19:14:15.441Z,1618082055.441 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2021-04-10T19:14:15.441Z,1618082055.441 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2021-04-10T19:14:15.441Z,1618082055.441 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2021-04-10T19:14:15.441Z,1618082055.441 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2021-04-10T19:14:15.442Z,1618082055.442 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2021-04-10T19:14:15.442Z,1618082055.442 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2021-04-10T19:14:15.442Z,1618082055.442 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2021-04-10T19:14:15.442Z,1618082055.442 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2021-04-10T19:14:15.442Z,1618082055.442 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2021-04-10T19:14:15.442Z,1618082055.442 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2021-04-10T19:14:15.470Z,1618082055.470 [CBIT](DEBUG): Backplane powered. 2021-04-10T19:14:15.475Z,1618082055.475 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2021-04-10T19:14:15.509Z,1618082055.509 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2021-04-10T19:14:15.544Z,1618082055.544 [MissionManager](DEBUG): 2021-04-10T19:14:15.545Z,1618082055.545 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2021-04-10T19:14:15.632Z,1618082055.632 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2021-04-10T19:14:15.633Z,1618082055.633 [Default:A.Wait](DEBUG): Construct Wait. 2021-04-10T19:14:15.648Z,1618082055.648 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2021-04-10T19:14:15.675Z,1618082055.675 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2021-04-10T19:14:15.677Z,1618082055.677 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2021-04-10T19:14:15.714Z,1618082055.714 [Default:E.Execute](DEBUG): Construct Execute. 2021-04-10T19:14:15.717Z,1618082055.717 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2021-04-10T19:14:15.722Z,1618082055.722 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,RDI_Pathfinder,DAT,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2021-04-10T19:14:15.741Z,1618082055.741 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-04-10T19:14:15.790Z,1618082055.790 [Radio_Surface](INFO): Powering up 2021-04-10T19:14:15.900Z,1618082055.900 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar 2021-04-10T19:14:15.905Z,1618082055.905 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2021-04-10T19:14:15.905Z,1618082055.905 [DAT](INFO): Powering up 2021-04-10T19:14:15.905Z,1618082055.905 [DAT](DEBUG): Initializing DAT. 2021-04-10T19:14:15.935Z,1618082055.935 [DepthRateCalculator](ERROR): Depth measurement is not active 2021-04-10T19:14:15.972Z,1618082055.972 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-04-10T19:14:15.978Z,1618082055.978 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-04-10T19:14:15.979Z,1618082055.979 [ElevatorServo](DEBUG): Initializing EZServoServo. 2021-04-10T19:14:15.986Z,1618082055.986 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2021-04-10T19:14:15.987Z,1618082055.987 [MassServo](DEBUG): Initializing EZServoServo. 2021-04-10T19:14:15.995Z,1618082055.995 [MassServo](DEBUG): Initializing MassServo. 2021-04-10T19:14:15.995Z,1618082055.995 [RudderServo](DEBUG): Initializing EZServoServo. 2021-04-10T19:14:16.002Z,1618082056.002 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2021-04-10T19:14:16.038Z,1618082056.038 [RudderServo](DEBUG): Initializing RudderServo. 2021-04-10T19:14:16.040Z,1618082056.040 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-04-10T19:14:16.043Z,1618082056.043 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-04-10T19:14:16.045Z,1618082056.045 [CommandLine](FAULT): Scheduling is paused 2021-04-10T19:14:16.046Z,1618082056.046 [CBIT](INFO): Critical error at 20210410T191415 2021-04-10T19:14:16.046Z,1618082056.046 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2021-04-10T19:14:16.152Z,1618082056.152 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2021-04-10T19:14:16.152Z,1618082056.152 [DropWeight] Hardware Fault, FailCount= 1 2021-04-10T19:14:16.152Z,1618082056.152 [DropWeight](ERROR): Hardware Fault 2021-04-10T19:14:16.198Z,1618082056.198 [CBIT](INFO): Critical error at 20210410T191416 2021-04-10T19:14:16.201Z,1618082056.201 [CBIT](ERROR): Hardware Fault in component: DropWeight 2021-04-10T19:14:16.201Z,1618082056.201 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2021-04-10T19:14:16.858Z,1618082056.858 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2021-04-10T19:14:16.858Z,1618082056.858 [RudderServo](FAULT): Rudder failed to initialize 2021-04-10T19:14:16.858Z,1618082056.858 [RudderServo] Communications Fault, FailCount= 1 2021-04-10T19:14:16.858Z,1618082056.858 [RudderServo](ERROR): Communications Fault 2021-04-10T19:14:16.956Z,1618082056.956 [CBIT](INFO): Critical error at 20210410T191416 2021-04-10T19:14:16.959Z,1618082056.959 [CBIT](ERROR): Communications Fault in component: RudderServo 2021-04-10T19:14:17.119Z,1618082057.119 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-04-10T19:14:17.119Z,1618082057.119 [RudderServo](INFO): Powering down 2021-04-10T19:14:17.789Z,1618082057.789 [RudderServo](DEBUG): Initializing EZServoServo. 2021-04-10T19:14:17.907Z,1618082057.907 [RudderServo](DEBUG): Initializing RudderServo. 2021-04-10T19:14:17.911Z,1618082057.911 [CBIT](INFO): Clearing failed state for component RudderServo 2021-04-10T19:14:17.911Z,1618082057.911 [RudderServo] No Fault, FailCount= 1 2021-04-10T19:14:18.034Z,1618082058.034 [WetLabsBB2FL](INFO): Powering down 2021-04-10T19:14:24.746Z,1618082064.746 [WetLabsUBAT](INFO): Powering down 2021-04-10T19:14:30.302Z,1618082070.302 [DAT](INFO): commRate: 800 2021-04-10T19:14:32.320Z,1618082072.320 [DAT](INFO): entering command mode 2021-04-10T19:14:32.724Z,1618082072.724 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:33.128Z,1618082073.128 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:33.532Z,1618082073.532 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:33.963Z,1618082073.963 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:34.340Z,1618082074.340 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:34.744Z,1618082074.744 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:35.148Z,1618082075.148 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:35.556Z,1618082075.556 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:35.980Z,1618082075.980 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:36.360Z,1618082076.360 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:36.769Z,1618082076.769 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:37.168Z,1618082077.168 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:37.572Z,1618082077.572 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:38.028Z,1618082078.028 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:38.385Z,1618082078.385 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:38.784Z,1618082078.784 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:39.188Z,1618082079.188 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:39.592Z,1618082079.592 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:40.057Z,1618082080.057 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:40.404Z,1618082080.404 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:40.816Z,1618082080.816 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:41.208Z,1618082081.208 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:41.623Z,1618082081.623 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:42.058Z,1618082082.058 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:42.432Z,1618082082.432 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:42.824Z,1618082082.824 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:43.233Z,1618082083.233 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:43.682Z,1618082083.682 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:44.036Z,1618082084.036 [NAL9602](INFO): Powering up NAL9602 2021-04-10T19:14:44.090Z,1618082084.090 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:44.440Z,1618082084.440 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:44.852Z,1618082084.852 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:45.248Z,1618082085.248 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:45.735Z,1618082085.735 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:46.056Z,1618082086.056 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:46.468Z,1618082086.468 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:46.864Z,1618082086.864 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:47.268Z,1618082087.268 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:47.736Z,1618082087.736 [DAT](DEBUG): checking for command mode acknowledgment 2021-04-10T19:14:47.736Z,1618082087.736 [DAT](FAULT): failed to enter command mode 2021-04-10T19:14:48.082Z,1618082088.082 [DAT](INFO): entering command mode 2021-04-10T19:14:48.481Z,1618082088.481 [DAT](INFO): setting verbose to 3 2021-04-10T19:14:48.885Z,1618082088.885 [DAT](INFO): set verbose to 3 2021-04-10T19:14:48.886Z,1618082088.886 [DAT](INFO): setting DatVerbose to 27440 2021-04-10T19:14:49.289Z,1618082089.289 [DAT](INFO): set DatVerbose to 27440 2021-04-10T19:14:49.290Z,1618082089.290 [DAT](INFO): setting transmit power to 8 2021-04-10T19:14:49.733Z,1618082089.733 [DAT](INFO): set transmit power to 8 2021-04-10T19:14:49.733Z,1618082089.733 [DAT](INFO): setting local address to 9 2021-04-10T19:14:50.097Z,1618082090.097 [DAT](INFO): set local address to 9 2021-04-10T19:14:54.944Z,1618082094.944 [NAL9602](INFO): NAL9602 initialized 2021-04-10T19:15:05.065Z,1618082105.065 [SBIT](IMPORTANT): Beginning Startup BIT 2021-04-10T19:15:05.069Z,1618082105.069 [CBIT](IMPORTANT): Beginning ground fault scan 2021-04-10T19:15:16.051Z,1618082116.051 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): -0.006040 CHAN A1 (24V): 0.035110 CHAN A2 (12V): -0.007585 CHAN A3 (5V): -0.001598 CHAN B0 (3.3V): -0.000104 CHAN B1 (3.15aV): -0.000058 CHAN B2 (3.15bV): -0.000257 CHAN B3 (GND): 0.001597 OPEN: -0.003746 Full Scale Calc: 4.765 mA, -1.589 mA 2021-04-10T19:15:28.939Z,1618082128.939 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2021-04-10T19:15:59.202Z,1618082159.202 [SBIT](IMPORTANT): SBIT PASSED 2021-04-10T19:15:59.202Z,1618082159.202 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2021-04-10T19:15:59.611Z,1618082159.611 [MissionManager](IMPORTANT): Started mission Startup 2021-04-10T19:15:59.612Z,1618082159.612 [Startup] Running Loop=1 2021-04-10T19:15:59.612Z,1618082159.612 [Startup](DEBUG): Aggregate::initialize Startup 2021-04-10T19:15:59.612Z,1618082159.612 [Startup:A.GoToSurface] Running Loop=1 2021-04-10T19:15:59.612Z,1618082159.612 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-04-10T19:15:59.613Z,1618082159.613 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-04-10T19:15:59.613Z,1618082159.613 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-04-10T19:15:59.613Z,1618082159.613 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-04-10T19:15:59.614Z,1618082159.614 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-04-10T19:15:59.614Z,1618082159.614 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-04-10T19:15:59.616Z,1618082159.616 [Startup:StartupSatComms] Running Loop=1 2021-04-10T19:15:59.616Z,1618082159.616 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2021-04-10T19:15:59.616Z,1618082159.616 [Startup:StartupSatComms:A] Running Loop=1 2021-04-10T19:16:00.040Z,1618082160.040 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2021-04-10T19:16:59.837Z,1618082219.837 [Startup:StartupSatComms:A](INFO): Timed out from 2021-04-10T19:15:59.6Z 2021-04-10T19:16:59.837Z,1618082219.837 [Startup:StartupSatComms:A] Stopped 2021-04-10T19:16:59.837Z,1618082219.837 [Startup:StartupSatComms:B] Running Loop=1 2021-04-10T19:17:00.223Z,1618082220.223 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2021-04-10T19:17:15.571Z,1618082235.571 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-04-10T19:17:15.571Z,1618082235.571 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-04-10T19:17:15.615Z,1618082235.615 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-04-10T19:17:15.995Z,1618082235.995 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-04-10T19:17:15.995Z,1618082235.995 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-04-10T19:17:16.577Z,1618082236.577 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004936 2021-04-10T19:17:24.712Z,1618082244.712 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20210410T183345/Courier0010.lzma 2021-04-10T19:17:24.776Z,1618082244.776 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2021-04-10T19:17:25.711Z,1618082245.711 [DataOverHttps](INFO): Moved sent file to Logs/20210410T183345/Courier0010.lzma.bak 2021-04-10T19:17:25.711Z,1618082245.711 [DataOverHttps](INFO): SBD MOMSN=15557587 2021-04-10T19:17:40.590Z,1618082260.590 [DataOverHttps](INFO): Sending 284 bytes from file Logs/20210410T191404/Courier0000.lzma 2021-04-10T19:17:41.566Z,1618082261.566 [DataOverHttps](INFO): Moved sent file to Logs/20210410T191404/Courier0000.lzma.bak 2021-04-10T19:17:41.567Z,1618082261.567 [DataOverHttps](INFO): SBD MOMSN=15557589 2021-04-10T19:17:57.208Z,1618082277.208 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20210410T183345/Express0011.lzma 2021-04-10T19:17:58.210Z,1618082278.210 [DataOverHttps](INFO): Moved sent file to Logs/20210410T183345/Express0011.lzma.bak 2021-04-10T19:17:58.211Z,1618082278.211 [DataOverHttps](INFO): SBD MOMSN=15557595 2021-04-10T19:17:59.884Z,1618082279.884 [Startup:StartupSatComms:B](INFO): Timed out from 2021-04-10T19:16:59.8Z 2021-04-10T19:17:59.884Z,1618082279.884 [Startup:StartupSatComms:B] Stopped 2021-04-10T19:17:59.884Z,1618082279.884 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2021-04-10T19:17:59.884Z,1618082279.884 [Startup:StartupSatComms] Stopped 2021-04-10T19:17:59.884Z,1618082279.884 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2021-04-10T19:17:59.885Z,1618082279.885 [Startup](INFO): Completed Startup 2021-04-10T19:17:59.885Z,1618082279.885 [MissionManager](INFO): Startup is completed. 2021-04-10T19:17:59.885Z,1618082279.885 [MissionManager](INFO): Uninitializing Mission Startup 2021-04-10T19:17:59.885Z,1618082279.885 [Startup] Stopped 2021-04-10T19:17:59.885Z,1618082279.885 [Startup](DEBUG): Aggregate::uninitialize Startup 2021-04-10T19:17:59.886Z,1618082279.886 [Startup:A.GoToSurface] Stopped 2021-04-10T19:17:59.886Z,1618082279.886 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-04-10T19:18:00.297Z,1618082280.297 [MissionManager](IMPORTANT): Started mission Default 2021-04-10T19:18:00.297Z,1618082280.297 [Default] Running Loop=1 2021-04-10T19:18:00.298Z,1618082280.298 [Default](DEBUG): Aggregate::initialize Default 2021-04-10T19:18:00.298Z,1618082280.298 [Default:B.GoToSurface] Running Loop=1 2021-04-10T19:18:00.298Z,1618082280.298 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-04-10T19:18:00.299Z,1618082280.299 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-04-10T19:18:00.300Z,1618082280.300 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-04-10T19:18:00.300Z,1618082280.300 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-04-10T19:18:00.300Z,1618082280.300 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-04-10T19:18:00.301Z,1618082280.301 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-04-10T19:18:00.301Z,1618082280.301 [Default:A.Wait] Running Loop=1 2021-04-10T19:18:00.301Z,1618082280.301 [Default:A.Wait](DEBUG): Initialize Wait Component. 2021-04-10T19:18:13.666Z,1618082293.666 [Default:A.Wait](INFO): Done Waiting. 2021-04-10T19:18:13.666Z,1618082293.666 [Default:A.Wait] Stopped 2021-04-10T19:18:13.666Z,1618082293.666 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2021-04-10T19:18:14.022Z,1618082294.022 [Default:CheckIn] Running Loop=1 2021-04-10T19:18:14.022Z,1618082294.022 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-04-10T19:18:14.022Z,1618082294.022 [Default:CheckIn:Read_GPS] Running Loop=1 2021-04-10T19:18:14.484Z,1618082294.484 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2021-04-10T19:18:39.979Z,1618082319.979 [DataOverHttps](INFO): Sending 909 bytes from file Logs/20210410T191404/Express0001.lzma 2021-04-10T19:18:40.962Z,1618082320.962 [DataOverHttps](INFO): Moved sent file to Logs/20210410T191404/Express0001.lzma.bak 2021-04-10T19:18:40.963Z,1618082320.963 [DataOverHttps](INFO): SBD MOMSN=15557597 2021-04-10T19:19:16.665Z,1618082356.665 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-04-10T19:19:56.643Z,1618082396.643 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-04-10T19:19:57.842Z,1618082397.842 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-04-10T19:20:16.501Z,1618082416.501 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-04-10T19:20:16.501Z,1618082416.501 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-04-10T19:20:16.520Z,1618082416.520 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-04-10T19:20:16.887Z,1618082416.887 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-04-10T19:20:16.887Z,1618082416.887 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-04-10T19:20:29.006Z,1618082429.006 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2021-04-10T19:20:42.371Z,1618082442.371 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2021-04-10T19:21:36.142Z,1618082496.142 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2021-04-10T19:21:49.036Z,1618082509.036 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2021-04-10T19:22:40.281Z,1618082560.281 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2021-04-10T19:22:40.284Z,1618082560.284 [BPC1](INFO): Received data from all battery sticks. 2021-04-10T19:23:14.239Z,1618082594.239 [Default:CheckIn:Read_GPS](INFO): Timed out from 2021-04-10T19:18:14.0Z 2021-04-10T19:23:14.239Z,1618082594.239 [Default:CheckIn:Read_GPS] Stopped 2021-04-10T19:23:14.239Z,1618082594.239 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-04-10T19:23:14.634Z,1618082594.634 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2021-04-10T19:23:17.481Z,1618082597.481 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2021-04-10T19:23:17.481Z,1618082597.481 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-04-10T19:23:17.496Z,1618082597.496 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-04-10T19:23:17.874Z,1618082597.874 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-04-10T19:23:17.874Z,1618082597.874 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2021-04-10T19:23:21.660Z,1618082601.660 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20210410T191404/Courier0004.lzma 2021-04-10T19:23:22.662Z,1618082602.662 [DataOverHttps](INFO): Moved sent file to Logs/20210410T191404/Courier0004.lzma.bak 2021-04-10T19:23:22.662Z,1618082602.662 [DataOverHttps](INFO): SBD MOMSN=15557615 2021-04-10T19:23:38.476Z,1618082618.476 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20210410T191404/Express0005.lzma 2021-04-10T19:23:39.478Z,1618082619.478 [DataOverHttps](INFO): Moved sent file to Logs/20210410T191404/Express0005.lzma.bak 2021-04-10T19:23:39.479Z,1618082619.479 [DataOverHttps](INFO): SBD MOMSN=15557617 2021-04-10T19:23:40.893Z,1618082620.893 [Default:CheckIn:Read_Iridium] Stopped 2021-04-10T19:23:40.893Z,1618082620.893 [Default:CheckIn:C.Wait] Running Loop=1 2021-04-10T19:23:40.893Z,1618082620.893 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-04-10T19:24:56.010Z,1618082696.010 [NAL9602](FAULT): GPS failed to acquire within timeout. 2021-04-10T19:24:56.010Z,1618082696.010 [NAL9602] Data Fault, FailCount= 1 2021-04-10T19:24:56.010Z,1618082696.010 [NAL9602](ERROR): Data Fault 2021-04-10T19:24:56.078Z,1618082696.078 [CBIT](ERROR): Data Fault in component: NAL9602 2021-04-10T19:24:56.414Z,1618082696.414 [NAL9602](INFO): Powering down 2021-04-10T19:24:57.255Z,1618082697.255 [CBIT](INFO): Clearing failed state for component NAL9602 2021-04-10T19:24:57.255Z,1618082697.255 [NAL9602] No Fault, FailCount= 1 2021-04-10T19:25:26.714Z,1618082726.714 [NAL9602](INFO): Powering up NAL9602 2021-04-10T19:25:37.631Z,1618082737.631 [NAL9602](INFO): NAL9602 initialized 2021-04-10T19:26:18.457Z,1618082778.457 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2021-04-10T19:26:18.458Z,1618082778.458 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-04-10T19:26:18.468Z,1618082778.468 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-04-10T19:26:18.871Z,1618082778.871 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-04-10T19:26:18.872Z,1618082778.872 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2021-04-10T19:28:41.459Z,1618082921.459 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-04-10T19:28:41.459Z,1618082921.459 [Default:CheckIn:C.Wait] Stopped 2021-04-10T19:28:41.459Z,1618082921.459 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-04-10T19:28:41.460Z,1618082921.460 [Default:CheckIn:D] Running Loop=1 2021-04-10T19:28:41.871Z,1618082921.871 [Default:CheckIn:D] Stopped 2021-04-10T19:28:41.872Z,1618082921.872 [Default:CheckIn:E] Running Loop=1 2021-04-10T19:28:42.263Z,1618082922.263 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.692908 min 2021-04-10T19:28:42.263Z,1618082922.263 [Default:CheckIn:E] Stopped 2021-04-10T19:28:42.264Z,1618082922.264 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-04-10T19:28:42.264Z,1618082922.264 [Default:CheckIn] Stopped 2021-04-10T19:28:42.264Z,1618082922.264 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-04-10T19:28:42.264Z,1618082922.264 [Default:CheckIn](INFO): Running loop #2 2021-04-10T19:28:42.264Z,1618082922.264 [Default:CheckIn] Running Loop=2 2021-04-10T19:28:42.264Z,1618082922.264 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-04-10T19:28:42.264Z,1618082922.264 [Default:CheckIn:Read_GPS] Running Loop=1 2021-04-10T19:29:16.220Z,1618082956.220 [CBIT](INFO): Clearing failed state for component DropWeight 2021-04-10T19:29:16.220Z,1618082956.220 [DropWeight] No Fault, FailCount= 1 2021-04-10T19:29:19.426Z,1618082959.426 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2021-04-10T19:29:19.427Z,1618082959.427 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-04-10T19:29:19.448Z,1618082959.448 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-04-10T19:29:19.843Z,1618082959.843 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-04-10T19:29:19.843Z,1618082959.843 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2021-04-10T19:32:20.466Z,1618083140.466 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2021-04-10T19:32:20.466Z,1618083140.466 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-04-10T19:32:20.476Z,1618083140.476 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-04-10T19:32:20.842Z,1618083140.842 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-04-10T19:32:20.842Z,1618083140.842 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2021-04-10T19:33:42.477Z,1618083222.477 [Default:CheckIn:Read_GPS](INFO): Timed out from 2021-04-10T19:28:42.3Z 2021-04-10T19:33:42.477Z,1618083222.477 [Default:CheckIn:Read_GPS] Stopped 2021-04-10T19:33:42.477Z,1618083222.477 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-04-10T19:33:49.672Z,1618083229.672 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210410T191404/Courier0007.lzma 2021-04-10T19:33:50.674Z,1618083230.674 [DataOverHttps](INFO): Moved sent file to Logs/20210410T191404/Courier0007.lzma.bak 2021-04-10T19:33:50.675Z,1618083230.675 [DataOverHttps](INFO): SBD MOMSN=15557621 2021-04-10T19:34:06.391Z,1618083246.391 [DataOverHttps](INFO): Sending 181 bytes from file Logs/20210410T191404/Express0008.lzma 2021-04-10T19:34:07.386Z,1618083247.386 [DataOverHttps](INFO): Moved sent file to Logs/20210410T191404/Express0008.lzma.bak 2021-04-10T19:34:07.387Z,1618083247.387 [DataOverHttps](INFO): SBD MOMSN=15557623 2021-04-10T19:34:08.735Z,1618083248.735 [Default:CheckIn:Read_Iridium] Stopped 2021-04-10T19:34:08.735Z,1618083248.735 [Default:CheckIn:C.Wait] Running Loop=1 2021-04-10T19:34:08.735Z,1618083248.735 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-04-10T19:35:21.441Z,1618083321.441 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2021-04-10T19:35:21.441Z,1618083321.441 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-04-10T19:35:21.456Z,1618083321.456 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-04-10T19:35:21.858Z,1618083321.858 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-04-10T19:35:21.858Z,1618083321.858 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2021-04-10T19:35:40.406Z,1618083340.406 [NAL9602](FAULT): GPS failed to acquire within timeout. 2021-04-10T19:35:40.406Z,1618083340.406 [NAL9602] Data Fault, FailCount= 2 2021-04-10T19:35:40.406Z,1618083340.406 [NAL9602](ERROR): Data Fault 2021-04-10T19:35:40.461Z,1618083340.461 [CBIT](ERROR): Data Fault in component: NAL9602 2021-04-10T19:35:40.802Z,1618083340.802 [NAL9602](INFO): Powering down 2021-04-10T19:35:41.638Z,1618083341.638 [CBIT](INFO): Clearing failed state for component NAL9602 2021-04-10T19:35:41.638Z,1618083341.638 [NAL9602] No Fault, FailCount= 2 2021-04-10T19:36:11.102Z,1618083371.102 [NAL9602](INFO): Powering up NAL9602 2021-04-10T19:36:22.014Z,1618083382.014 [NAL9602](INFO): NAL9602 initialized 2021-04-10T19:37:13.003Z,1618083433.003 [DataOverHttps](IMPORTANT): SBD MTMSN=20210410T193711 2021-04-10T19:37:20.453Z,1618083440.453 [DataOverHttps](INFO): Received command:restart sys 2021-04-10T19:37:20.474Z,1618083440.474 [CommandLine](IMPORTANT): got command restart system 2021-04-10T19:37:22.533Z,1618083442.533 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2021-04-10T19:37:22.533Z,1618083442.533 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-04-10T19:37:22.717Z,1618083442.717 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2021-04-10T19:37:22.717Z,1618083442.717 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-04-10T19:37:22.718Z,1618083442.718 [CommandLine](INFO): Join timeout helper Thread ID is 985 2021-04-10T19:37:22.718Z,1618083442.718 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2021-04-10T19:37:22.718Z,1618083442.718 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-04-10T19:37:22.719Z,1618083442.719 [NavChartDb](INFO): Join timeout helper Thread ID is 986 2021-04-10T19:37:22.805Z,1618083442.805 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2021-04-10T19:37:22.805Z,1618083442.805 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-04-10T19:37:22.817Z,1618083442.817 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2021-04-10T19:37:22.817Z,1618083442.817 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2021-04-10T19:37:22.817Z,1618083442.817 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 987 2021-04-10T19:37:23.141Z,1618083443.141 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2021-04-10T19:37:23.141Z,1618083443.141 [WetLabsUBAT](INFO): Powering down 2021-04-10T19:37:23.142Z,1618083443.142 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2021-04-10T19:37:23.145Z,1618083443.145 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2021-04-10T19:37:23.145Z,1618083443.145 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-04-10T19:37:23.145Z,1618083443.145 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 988 2021-04-10T19:37:23.529Z,1618083443.529 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2021-04-10T19:37:23.529Z,1618083443.529 [WetLabsBB2FL](INFO): Powering down 2021-04-10T19:37:23.530Z,1618083443.530 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-04-10T19:37:23.541Z,1618083443.541 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2021-04-10T19:37:23.541Z,1618083443.541 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-04-10T19:37:23.541Z,1618083443.541 [CTD_Seabird](INFO): Join timeout helper Thread ID is 989 2021-04-10T19:37:23.865Z,1618083443.865 [CTD_Seabird](INFO): Powering down 2021-04-10T19:37:23.877Z,1618083443.877 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2021-04-10T19:37:23.877Z,1618083443.877 [CTD_Seabird](INFO): Powering down 2021-04-10T19:37:23.889Z,1618083443.889 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-04-10T19:37:23.902Z,1618083443.902 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2021-04-10T19:37:23.902Z,1618083443.902 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-04-10T19:37:23.902Z,1618083443.902 [Radio_Surface](INFO): Join timeout helper Thread ID is 990 2021-04-10T19:37:23.957Z,1618083443.957 [Radio_Surface](INFO): Powering down 2021-04-10T19:37:23.958Z,1618083443.958 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2021-04-10T19:37:23.958Z,1618083443.958 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-04-10T19:37:23.961Z,1618083443.961 [Componen