2021-03-25T00:23:12.169Z,1616631792.169 [Supervisor](DEBUG): Initializing supervisor. 2021-03-25T00:23:12.174Z,1616631792.174 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2021-03-25T00:23:12.174Z,1616631792.174 [SyncHandler](INFO): Protected caller Thread ID is 842 2021-03-25T00:23:12.175Z,1616631792.175 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2021-03-25T00:23:12.176Z,1616631792.176 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2021-03-25T00:23:12.176Z,1616631792.176 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 843 2021-03-25T00:23:12.180Z,1616631792.180 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2021-03-25T00:23:12.199Z,1616631792.199 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2021-03-25T00:23:12.200Z,1616631792.200 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2021-03-25T00:23:12.201Z,1616631792.201 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 844 2021-03-25T00:23:12.203Z,1616631792.203 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2021-03-25T00:23:12.204Z,1616631792.204 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2021-03-25T00:23:12.204Z,1616631792.204 [logger ThreadHandler](INFO): Protected caller Thread ID is 845 2021-03-25T00:23:12.208Z,1616631792.208 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2021-03-25T00:23:12.208Z,1616631792.208 [Supervisor](INFO): Looking for Config files in directory: Config/ 2021-03-25T00:23:12.212Z,1616631792.212 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2021-03-25T00:23:12.362Z,1616631792.362 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2021-03-25T00:23:12.363Z,1616631792.363 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2021-03-25T00:23:12.994Z,1616631792.994 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2021-03-25T00:23:12.996Z,1616631792.996 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2021-03-25T00:23:13.218Z,1616631793.218 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2021-03-25T00:23:13.218Z,1616631793.218 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2021-03-25T00:23:13.299Z,1616631793.299 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2021-03-25T00:23:13.425Z,1616631793.425 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2021-03-25T00:23:13.427Z,1616631793.427 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2021-03-25T00:23:13.509Z,1616631793.509 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2021-03-25T00:23:13.620Z,1616631793.620 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2021-03-25T00:23:13.622Z,1616631793.622 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2021-03-25T00:23:13.980Z,1616631793.980 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2021-03-25T00:23:13.982Z,1616631793.982 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2021-03-25T00:23:14.518Z,1616631794.518 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2021-03-25T00:23:14.520Z,1616631794.520 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2021-03-25T00:23:14.671Z,1616631794.671 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2021-03-25T00:23:14.672Z,1616631794.672 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2021-03-25T00:23:14.871Z,1616631794.871 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2021-03-25T00:23:14.872Z,1616631794.872 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2021-03-25T00:23:15.681Z,1616631795.681 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2021-03-25T00:23:15.682Z,1616631795.682 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2021-03-25T00:23:15.963Z,1616631795.963 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2021-03-25T00:23:15.965Z,1616631795.965 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2021-03-25T00:23:16.178Z,1616631796.178 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2021-03-25T00:23:16.180Z,1616631796.180 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2021-03-25T00:23:16.549Z,1616631796.549 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2021-03-25T00:23:16.550Z,1616631796.550 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2021-03-25T00:23:16.900Z,1616631796.900 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2021-03-25T00:23:16.902Z,1616631796.902 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2021-03-25T00:23:16.905Z,1616631796.905 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2021-03-25T00:23:16.990Z,1616631796.990 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2021-03-25T00:23:17.154Z,1616631797.154 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2021-03-25T00:23:17.266Z,1616631797.266 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2021-03-25T00:23:17.356Z,1616631797.356 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2021-03-25T00:23:17.452Z,1616631797.452 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2021-03-25T00:23:17.645Z,1616631797.645 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2021-03-25T00:23:17.904Z,1616631797.904 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2021-03-25T00:23:17.905Z,1616631797.905 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2021-03-25T00:23:18.000Z,1616631798.000 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2021-03-25T00:23:18.104Z,1616631798.104 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2021-03-25T00:23:18.248Z,1616631798.248 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2021-03-25T00:23:18.350Z,1616631798.350 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2021-03-25T00:23:18.375Z,1616631798.375 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2021-03-25T00:23:18.482Z,1616631798.482 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2021-03-25T00:23:18.484Z,1616631798.484 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2021-03-25T00:23:18.550Z,1616631798.550 [VerticalControl](DEBUG): Construct VerticalControl. 2021-03-25T00:23:18.611Z,1616631798.611 [VerticalControl] Loaded 2021-03-25T00:23:18.611Z,1616631798.611 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2021-03-25T00:23:18.614Z,1616631798.614 [HorizontalControl](DEBUG): Construct HorizontalControl. 2021-03-25T00:23:18.652Z,1616631798.652 [HorizontalControl] Loaded 2021-03-25T00:23:18.652Z,1616631798.652 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2021-03-25T00:23:18.655Z,1616631798.655 [SpeedControl](DEBUG): Construct SpeedControl. 2021-03-25T00:23:18.658Z,1616631798.658 [SpeedControl] Loaded 2021-03-25T00:23:18.658Z,1616631798.658 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2021-03-25T00:23:18.660Z,1616631798.660 [LoopControl](DEBUG): Construct LoopControl. 2021-03-25T00:23:18.661Z,1616631798.661 [LoopControl] Loaded 2021-03-25T00:23:18.661Z,1616631798.661 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2021-03-25T00:23:18.662Z,1616631798.662 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2021-03-25T00:23:18.662Z,1616631798.662 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2021-03-25T00:23:18.718Z,1616631798.718 [DepthRateCalculator] Loaded 2021-03-25T00:23:18.718Z,1616631798.718 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2021-03-25T00:23:18.723Z,1616631798.723 [PitchRateCalculator] Loaded 2021-03-25T00:23:18.723Z,1616631798.723 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2021-03-25T00:23:18.733Z,1616631798.733 [SpeedCalculator] Loaded 2021-03-25T00:23:18.733Z,1616631798.733 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2021-03-25T00:23:18.747Z,1616631798.747 [TempGradientCalculator] Loaded 2021-03-25T00:23:18.747Z,1616631798.747 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2021-03-25T00:23:18.751Z,1616631798.751 [YawRateCalculator] Loaded 2021-03-25T00:23:18.751Z,1616631798.751 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2021-03-25T00:23:18.768Z,1616631798.768 [ElevatorOffsetCalculator] Loaded 2021-03-25T00:23:18.768Z,1616631798.768 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2021-03-25T00:23:18.769Z,1616631798.769 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2021-03-25T00:23:18.769Z,1616631798.769 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2021-03-25T00:23:18.810Z,1616631798.810 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2021-03-25T00:23:18.812Z,1616631798.812 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2021-03-25T00:23:18.891Z,1616631798.891 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2021-03-25T00:23:18.892Z,1616631798.892 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2021-03-25T00:23:19.247Z,1616631799.247 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2021-03-25T00:23:19.248Z,1616631799.248 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2021-03-25T00:23:19.375Z,1616631799.375 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2021-03-25T00:23:19.377Z,1616631799.377 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2021-03-25T00:23:20.205Z,1616631800.205 [AHRS_M2] Loaded 2021-03-25T00:23:20.205Z,1616631800.205 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2021-03-25T00:23:20.451Z,1616631800.451 [BackseatComponent] Loaded 2021-03-25T00:23:20.451Z,1616631800.451 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2021-03-25T00:23:20.452Z,1616631800.452 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408FE4E0 2021-03-25T00:23:20.453Z,1616631800.453 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 928 2021-03-25T00:23:20.455Z,1616631800.455 [LcmUniversalReporter] Loaded 2021-03-25T00:23:20.456Z,1616631800.456 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2021-03-25T00:23:21.822Z,1616631801.822 [BPC1] Loaded 2021-03-25T00:23:21.822Z,1616631801.822 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2021-03-25T00:23:22.160Z,1616631802.160 [DataOverHttps] Loaded 2021-03-25T00:23:22.160Z,1616631802.160 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2021-03-25T00:23:22.161Z,1616631802.161 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4092E4E0 2021-03-25T00:23:22.162Z,1616631802.162 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 930 2021-03-25T00:23:22.181Z,1616631802.181 [Depth_Keller] Loaded 2021-03-25T00:23:22.181Z,1616631802.181 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2021-03-25T00:23:22.239Z,1616631802.239 [NAL9602] Loaded 2021-03-25T00:23:22.240Z,1616631802.240 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2021-03-25T00:23:22.268Z,1616631802.268 [Onboard] Loaded 2021-03-25T00:23:22.268Z,1616631802.268 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2021-03-25T00:23:22.269Z,1616631802.269 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4095E4E0 2021-03-25T00:23:22.270Z,1616631802.270 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 931 2021-03-25T00:23:22.283Z,1616631802.283 [Radio_Surface] Loaded 2021-03-25T00:23:22.283Z,1616631802.283 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2021-03-25T00:23:22.284Z,1616631802.284 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4098E4E0 2021-03-25T00:23:22.284Z,1616631802.284 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 932 2021-03-25T00:23:22.325Z,1616631802.325 [RDI_Pathfinder] Loaded 2021-03-25T00:23:22.326Z,1616631802.326 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2021-03-25T00:23:22.326Z,1616631802.326 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2021-03-25T00:23:22.328Z,1616631802.328 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2021-03-25T00:23:22.424Z,1616631802.424 [DeadReckonUsingMultipleVelocitySources] Loaded 2021-03-25T00:23:22.424Z,1616631802.424 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2021-03-25T00:23:22.437Z,1616631802.437 [NavChart] Loaded 2021-03-25T00:23:22.437Z,1616631802.437 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2021-03-25T00:23:22.443Z,1616631802.443 [UniversalFixResidualReporter] Loaded 2021-03-25T00:23:22.443Z,1616631802.443 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2021-03-25T00:23:22.444Z,1616631802.444 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2021-03-25T00:23:22.444Z,1616631802.444 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2021-03-25T00:23:22.608Z,1616631802.608 [SBIT](DEBUG): Construct Startup Built In Test. 2021-03-25T00:23:22.618Z,1616631802.618 [SBIT] Loaded 2021-03-25T00:23:22.618Z,1616631802.618 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2021-03-25T00:23:22.621Z,1616631802.621 [IBIT](DEBUG): Construct Initiated Built In Test. 2021-03-25T00:23:22.634Z,1616631802.634 [IBIT] Loaded 2021-03-25T00:23:22.634Z,1616631802.634 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2021-03-25T00:23:22.640Z,1616631802.640 [CBIT](DEBUG): Construct Continuous Built In Test. 2021-03-25T00:23:22.738Z,1616631802.738 [CBIT] Loaded 2021-03-25T00:23:22.738Z,1616631802.738 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2021-03-25T00:23:22.739Z,1616631802.739 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2021-03-25T00:23:22.739Z,1616631802.739 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2021-03-25T00:23:22.871Z,1616631802.871 [BuoyancyServo] Loaded 2021-03-25T00:23:22.871Z,1616631802.871 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2021-03-25T00:23:22.890Z,1616631802.890 [ElevatorServo] Loaded 2021-03-25T00:23:22.891Z,1616631802.891 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2021-03-25T00:23:22.909Z,1616631802.909 [MassServo] Loaded 2021-03-25T00:23:22.909Z,1616631802.909 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2021-03-25T00:23:22.927Z,1616631802.927 [RudderServo] Loaded 2021-03-25T00:23:22.928Z,1616631802.928 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2021-03-25T00:23:22.945Z,1616631802.945 [ThrusterServo] Loaded 2021-03-25T00:23:22.945Z,1616631802.945 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2021-03-25T00:23:22.946Z,1616631802.946 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2021-03-25T00:23:22.947Z,1616631802.947 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2021-03-25T00:23:22.963Z,1616631802.963 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2021-03-25T00:23:22.965Z,1616631802.965 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2021-03-25T00:23:23.183Z,1616631803.183 [CTD_Seabird] Loaded 2021-03-25T00:23:23.183Z,1616631803.183 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2021-03-25T00:23:23.184Z,1616631803.184 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ABB4E0 2021-03-25T00:23:23.185Z,1616631803.185 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 933 2021-03-25T00:23:23.204Z,1616631803.204 [PAR_Licor] Loaded 2021-03-25T00:23:23.204Z,1616631803.204 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2021-03-25T00:23:23.236Z,1616631803.236 [WetLabsBB2FL] Loaded 2021-03-25T00:23:23.236Z,1616631803.236 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2021-03-25T00:23:23.237Z,1616631803.237 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AEB4E0 2021-03-25T00:23:23.238Z,1616631803.238 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 934 2021-03-25T00:23:23.238Z,1616631803.238 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2021-03-25T00:23:23.244Z,1616631803.244 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2021-03-25T00:23:23.247Z,1616631803.247 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2021-03-25T00:23:23.259Z,1616631803.259 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2021-03-25T00:23:23.260Z,1616631803.260 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B1B4E0 2021-03-25T00:23:23.260Z,1616631803.260 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 935 2021-03-25T00:23:23.265Z,1616631803.265 [Supervisor](INFO): Main Thread ID is 836 2021-03-25T00:23:23.265Z,1616631803.265 [Supervisor](DEBUG): Running supervisor. 2021-03-25T00:23:23.265Z,1616631803.265 [CommandLine ThreadHandler](INFO): Handler Thread ID is 936 2021-03-25T00:23:23.273Z,1616631803.273 [CommandLine](IMPORTANT): got command quit 2021-03-25T00:23:23.277Z,1616631803.277 [controlThread ThreadHandler](INFO): Handler Thread ID is 937 2021-03-25T00:23:23.278Z,1616631803.278 [controlThread](DEBUG): Initializing ControlThread 2021-03-25T00:23:23.279Z,1616631803.279 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2021-03-25T00:23:23.280Z,1616631803.280 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2021-03-25T00:23:23.281Z,1616631803.281 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2021-03-25T00:23:23.281Z,1616631803.281 [LoopControl](DEBUG): Initialize LoopControlComponent. 2021-03-25T00:23:23.282Z,1616631803.282 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2021-03-25T00:23:23.282Z,1616631803.282 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2021-03-25T00:23:23.282Z,1616631803.282 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2021-03-25T00:23:23.283Z,1616631803.283 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2021-03-25T00:23:23.283Z,1616631803.283 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2021-03-25T00:23:23.284Z,1616631803.284 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2021-03-25T00:23:23.288Z,1616631803.288 [NavChart](DEBUG): Initialize NavChart Navigation. 2021-03-25T00:23:23.288Z,1616631803.288 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2021-03-25T00:23:23.288Z,1616631803.288 [SBIT](INFO): Initialize SBIT Component. 2021-03-25T00:23:23.289Z,1616631803.289 [SBIT](IMPORTANT): git: 2021-03-22 2021-03-25T00:23:23.289Z,1616631803.289 [SBIT](INFO): git hash: c086f31f44ef30168cb38b2179cdcdc6e70e9d06 2021-03-25T00:23:23.289Z,1616631803.289 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2021-03-25T00:23:23.291Z,1616631803.291 [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-03-25T00:23:23.292Z,1616631803.292 [SBIT](INFO): Beginning SBIT in 40.000000 seconds. 2021-03-25T00:23:23.292Z,1616631803.292 [IBIT](INFO): Initialize IBIT Component. 2021-03-25T00:23:23.293Z,1616631803.293 [CBIT](DEBUG): Initialize CBIT Component. 2021-03-25T00:23:23.294Z,1616631803.294 [logger ThreadHandler](INFO): Handler Thread ID is 938 2021-03-25T00:23:23.306Z,1616631803.306 [CBIT](DEBUG): Initialized mux pins. 2021-03-25T00:23:23.307Z,1616631803.307 [CBIT](DEBUG): Initializing the watchdog timer. 2021-03-25T00:23:23.311Z,1616631803.311 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 939 2021-03-25T00:23:23.319Z,1616631803.319 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 940 2021-03-25T00:23:23.320Z,1616631803.320 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2021-03-25T00:23:23.327Z,1616631803.327 [Onboard ThreadHandler](INFO): Handler Thread ID is 941 2021-03-25T00:23:23.331Z,1616631803.331 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2021-03-25T00:23:23.332Z,1616631803.332 [CBIT](DEBUG): Initializing heartbeat. 2021-03-25T00:23:23.348Z,1616631803.348 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 942 2021-03-25T00:23:23.367Z,1616631803.367 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 943 2021-03-25T00:23:23.368Z,1616631803.368 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2021-03-25T00:23:23.372Z,1616631803.372 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 945 2021-03-25T00:23:23.375Z,1616631803.375 [WetLabsBB2FL](INFO): Powering up 2021-03-25T00:23:23.376Z,1616631803.376 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 947 2021-03-25T00:23:23.386Z,1616631803.386 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2021-03-25T00:23:23.386Z,1616631803.386 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2021-03-25T00:23:23.386Z,1616631803.386 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2021-03-25T00:23:23.387Z,1616631803.387 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2021-03-25T00:23:23.387Z,1616631803.387 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2021-03-25T00:23:23.387Z,1616631803.387 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2021-03-25T00:23:23.387Z,1616631803.387 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2021-03-25T00:23:23.387Z,1616631803.387 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2021-03-25T00:23:23.387Z,1616631803.387 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2021-03-25T00:23:23.387Z,1616631803.387 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2021-03-25T00:23:23.388Z,1616631803.388 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2021-03-25T00:23:23.388Z,1616631803.388 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2021-03-25T00:23:23.388Z,1616631803.388 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2021-03-25T00:23:23.388Z,1616631803.388 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2021-03-25T00:23:23.389Z,1616631803.389 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2021-03-25T00:23:23.389Z,1616631803.389 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2021-03-25T00:23:23.402Z,1616631803.402 [CBIT](DEBUG): Deactivating GF circuits. 2021-03-25T00:23:23.403Z,1616631803.403 [CBIT](DEBUG): Deactivating emergency mode. 2021-03-25T00:23:23.438Z,1616631803.438 [CBIT](DEBUG): Backplane powered. 2021-03-25T00:23:23.443Z,1616631803.443 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2021-03-25T00:23:23.470Z,1616631803.470 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2021-03-25T00:23:23.514Z,1616631803.514 [MissionManager](DEBUG): 2021-03-25T00:23:23.527Z,1616631803.527 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2021-03-25T00:23:23.599Z,1616631803.599 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2021-03-25T00:23:23.600Z,1616631803.600 [Default:A.Wait](DEBUG): Construct Wait. 2021-03-25T00:23:23.602Z,1616631803.602 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2021-03-25T00:23:23.637Z,1616631803.637 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2021-03-25T00:23:23.639Z,1616631803.639 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2021-03-25T00:23:23.661Z,1616631803.661 [Default:E.Execute](DEBUG): Construct Execute. 2021-03-25T00:23:23.664Z,1616631803.664 [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-03-25T00:23:23.669Z,1616631803.669 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,RDI_Pathfinder,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-03-25T00:23:23.687Z,1616631803.687 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-03-25T00:23:23.687Z,1616631803.687 [AHRS_M2](INFO): AHRS_M2: Not simulateHardware. 2021-03-25T00:23:23.751Z,1616631803.751 [Radio_Surface](INFO): Powering up 2021-03-25T00:23:23.752Z,1616631803.752 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar 2021-03-25T00:23:23.765Z,1616631803.765 [DepthRateCalculator](ERROR): Depth measurement is not active 2021-03-25T00:23:23.836Z,1616631803.836 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-03-25T00:23:23.843Z,1616631803.843 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-03-25T00:23:23.844Z,1616631803.844 [ElevatorServo](DEBUG): Initializing EZServoServo. 2021-03-25T00:23:23.851Z,1616631803.851 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2021-03-25T00:23:23.852Z,1616631803.852 [MassServo](DEBUG): Initializing EZServoServo. 2021-03-25T00:23:23.859Z,1616631803.859 [MassServo](DEBUG): Initializing MassServo. 2021-03-25T00:23:23.860Z,1616631803.860 [RudderServo](DEBUG): Initializing EZServoServo. 2021-03-25T00:23:23.867Z,1616631803.867 [RudderServo](DEBUG): Initializing RudderServo. 2021-03-25T00:23:23.868Z,1616631803.868 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-03-25T00:23:23.875Z,1616631803.875 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-03-25T00:23:24.278Z,1616631804.278 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2021-03-25T00:23:24.279Z,1616631804.279 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-25T00:23:24.279Z,1616631804.279 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:24.398Z,1616631804.398 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2021-03-25T00:23:24.399Z,1616631804.399 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:24.399Z,1616631804.399 [CommandLine](INFO): Join timeout helper Thread ID is 955 2021-03-25T00:23:24.415Z,1616631804.415 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2021-03-25T00:23:24.415Z,1616631804.415 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:24.415Z,1616631804.415 [NavChartDb](INFO): Join timeout helper Thread ID is 956 2021-03-25T00:23:24.835Z,1616631804.835 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2021-03-25T00:23:24.835Z,1616631804.835 [RudderServo](FAULT): Rudder failed to initialize 2021-03-25T00:23:24.835Z,1616631804.835 [RudderServo] Communications Fault, FailCount= 1 2021-03-25T00:23:24.835Z,1616631804.835 [RudderServo](ERROR): Communications Fault 2021-03-25T00:23:24.935Z,1616631804.935 [CBIT](ERROR): Communications Fault in component: RudderServo 2021-03-25T00:23:25.104Z,1616631805.104 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-03-25T00:23:25.104Z,1616631805.104 [RudderServo](INFO): Powering down 2021-03-25T00:23:25.778Z,1616631805.778 [RudderServo](DEBUG): Initializing EZServoServo. 2021-03-25T00:23:25.896Z,1616631805.896 [RudderServo](DEBUG): Initializing RudderServo. 2021-03-25T00:23:25.900Z,1616631805.900 [CBIT](INFO): Clearing failed state for component RudderServo 2021-03-25T00:23:25.900Z,1616631805.900 [RudderServo] No Fault, FailCount= 1 2021-03-25T00:23:25.987Z,1616631805.987 [WetLabsBB2FL](INFO): Powering down 2021-03-25T00:23:29.029Z,1616631809.029 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-25T00:23:29.029Z,1616631809.029 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:29.047Z,1616631809.047 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2021-03-25T00:23:29.047Z,1616631809.047 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:29.047Z,1616631809.047 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 958 2021-03-25T00:23:29.423Z,1616631809.423 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-25T00:23:29.423Z,1616631809.423 [WetLabsBB2FL](INFO): Powering down 2021-03-25T00:23:29.424Z,1616631809.424 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:29.427Z,1616631809.427 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2021-03-25T00:23:29.427Z,1616631809.427 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:29.427Z,1616631809.427 [CTD_Seabird](INFO): Join timeout helper Thread ID is 959 2021-03-25T00:23:30.395Z,1616631810.395 [CTD_Seabird](INFO): Powering down 2021-03-25T00:23:30.527Z,1616631810.527 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-25T00:23:30.527Z,1616631810.527 [CTD_Seabird](INFO): Powering down 2021-03-25T00:23:30.539Z,1616631810.539 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:30.550Z,1616631810.550 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2021-03-25T00:23:30.551Z,1616631810.551 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:30.551Z,1616631810.551 [Radio_Surface](INFO): Join timeout helper Thread ID is 960 2021-03-25T00:23:30.623Z,1616631810.623 [Radio_Surface](INFO): Powering down 2021-03-25T00:23:30.624Z,1616631810.624 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-25T00:23:30.624Z,1616631810.624 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:30.625Z,1616631810.625 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2021-03-25T00:23:30.625Z,1616631810.625 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:30.626Z,1616631810.626 [Onboard](INFO): Join timeout helper Thread ID is 961 2021-03-25T00:23:33.335Z,1616631813.335 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-25T00:23:33.335Z,1616631813.335 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:33.351Z,1616631813.351 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2021-03-25T00:23:33.351Z,1616631813.351 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:33.352Z,1616631813.352 [DataOverHttps](INFO): Join timeout helper Thread ID is 962 2021-03-25T00:23:33.359Z,1616631813.359 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-25T00:23:33.359Z,1616631813.359 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:33.371Z,1616631813.371 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2021-03-25T00:23:33.371Z,1616631813.371 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:33.372Z,1616631813.372 [BackseatComponent](INFO): Join timeout helper Thread ID is 963 2021-03-25T00:23:33.519Z,1616631813.519 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-25T00:23:33.519Z,1616631813.519 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:33.527Z,1616631813.527 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2021-03-25T00:23:33.527Z,1616631813.527 [logger ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:33.528Z,1616631813.528 [logger](INFO): Join timeout helper Thread ID is 964 2021-03-25T00:23:33.565Z,1616631813.565 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-25T00:23:33.565Z,1616631813.565 [logger ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:33.567Z,1616631813.567 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2021-03-25T00:23:33.567Z,1616631813.567 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:33.568Z,1616631813.568 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2021-03-25T00:23:33.568Z,1616631813.568 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:33.568Z,1616631813.568 [controlThread](INFO): Join timeout helper Thread ID is 965 2021-03-25T00:23:33.823Z,1616631813.823 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2021-03-25T00:23:33.823Z,1616631813.823 [controlThread](DEBUG): Uninitializing ControlThread 2021-03-25T00:23:33.823Z,1616631813.823 [AHRS_M2](INFO): Powering down 2021-03-25T00:23:33.896Z,1616631813.896 [NAL9602](INFO): Powering down 2021-03-25T00:23:33.967Z,1616631813.967 [RDI_Pathfinder](INFO): Powering down 2021-03-25T00:23:33.968Z,1616631813.968 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2021-03-25T00:23:33.969Z,1616631813.969 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2021-03-25T00:23:33.969Z,1616631813.969 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2021-03-25T00:23:33.970Z,1616631813.970 [MissionManager](INFO): Uninitializing Mission Default 2021-03-25T00:23:33.973Z,1616631813.973 [MissionManager](INFO): Uninitializing Mission Startup 2021-03-25T00:23:33.974Z,1616631813.974 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2021-03-25T00:23:33.974Z,1616631813.974 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2021-03-25T00:23:33.975Z,1616631813.975 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2021-03-25T00:23:33.975Z,1616631813.975 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2021-03-25T00:23:33.975Z,1616631813.975 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-03-25T00:23:33.975Z,1616631813.975 [BuoyancyServo](INFO): Powering down 2021-03-25T00:23:33.987Z,1616631813.987 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2021-03-25T00:23:33.987Z,1616631813.987 [ElevatorServo](INFO): Powering down 2021-03-25T00:23:33.988Z,1616631813.988 [MassServo](DEBUG): Uninitialize Mass Servo. 2021-03-25T00:23:33.988Z,1616631813.988 [MassServo](INFO): Powering down 2021-03-25T00:23:33.988Z,1616631813.988 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-03-25T00:23:33.989Z,1616631813.989 [RudderServo](INFO): Powering down 2021-03-25T00:23:33.989Z,1616631813.989 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-03-25T00:23:33.989Z,1616631813.989 [ThrusterServo](INFO): Powering down 2021-03-25T00:23:33.990Z,1616631813.990 [SBIT](DEBUG): Uninitialize SBIT Component. 2021-03-25T00:23:33.991Z,1616631813.991 [IBIT](DEBUG): Uninitialize IBIT Component. 2021-03-25T00:23:33.991Z,1616631813.991 [CBIT](DEBUG): Uninitialize CBIT Component. 2021-03-25T00:23:33.991Z,1616631813.991 [CBIT](DEBUG): Powering off loads. 2021-03-25T00:23:34.002Z,1616631814.002 [CBIT](DEBUG): Disabling WDT. 2021-03-25T00:23:34.014Z,1616631814.014 [CBIT](DEBUG): Opening all GF detection circuits. 2021-03-25T00:23:34.015Z,1616631814.015 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:34.069Z,1616631814.069 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:34.072Z,1616631814.072 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:34.078Z,1616631814.078 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:34.124Z,1616631814.124 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:34.410Z,1616631814.410 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:34.414Z,1616631814.414 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:34.422Z,1616631814.422 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-03-25T00:23:34.483Z,1616631814.483 [logger ThreadHandler](INFO): Thread cancelled.