2023-03-21T16:53:52.466Z,1679417632.466 [Supervisor](DEBUG): Initializing supervisor. 2023-03-21T16:53:52.470Z,1679417632.470 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2023-03-21T16:53:52.471Z,1679417632.471 [SyncHandler](INFO): Protected caller Thread ID is 9367 2023-03-21T16:53:52.471Z,1679417632.471 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2023-03-21T16:53:52.472Z,1679417632.472 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2023-03-21T16:53:52.473Z,1679417632.473 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9368 2023-03-21T16:53:52.476Z,1679417632.476 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2023-03-21T16:53:52.494Z,1679417632.494 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2023-03-21T16:53:52.495Z,1679417632.495 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2023-03-21T16:53:52.495Z,1679417632.495 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 9369 2023-03-21T16:53:52.499Z,1679417632.499 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2023-03-21T16:53:52.500Z,1679417632.500 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2023-03-21T16:53:52.501Z,1679417632.501 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9370 2023-03-21T16:53:52.503Z,1679417632.503 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2023-03-21T16:53:52.503Z,1679417632.503 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2023-03-21T16:53:52.504Z,1679417632.504 [logger ThreadHandler](INFO): Protected caller Thread ID is 9371 2023-03-21T16:53:52.507Z,1679417632.507 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2023-03-21T16:53:52.508Z,1679417632.508 [Supervisor](INFO): Looking for Config files in directory: Config/ 2023-03-21T16:53:52.509Z,1679417632.509 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2023-03-21T16:53:52.827Z,1679417632.827 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2023-03-21T16:53:52.828Z,1679417632.828 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2023-03-21T16:53:53.481Z,1679417633.481 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2023-03-21T16:53:53.481Z,1679417633.481 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2023-03-21T16:53:53.585Z,1679417633.585 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2023-03-21T16:53:53.586Z,1679417633.586 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2023-03-21T16:53:54.054Z,1679417634.054 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2023-03-21T16:53:54.055Z,1679417634.055 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2023-03-21T16:53:54.148Z,1679417634.148 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2023-03-21T16:53:54.149Z,1679417634.149 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2023-03-21T16:53:54.226Z,1679417634.226 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2023-03-21T16:53:54.607Z,1679417634.607 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2023-03-21T16:53:54.608Z,1679417634.608 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2023-03-21T16:53:54.824Z,1679417634.824 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2023-03-21T16:53:54.825Z,1679417634.825 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2023-03-21T16:53:54.957Z,1679417634.957 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2023-03-21T16:53:54.958Z,1679417634.958 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2023-03-21T16:53:55.181Z,1679417635.181 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2023-03-21T16:53:55.181Z,1679417635.181 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2023-03-21T16:53:55.683Z,1679417635.683 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2023-03-21T16:53:55.683Z,1679417635.683 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2023-03-21T16:53:56.041Z,1679417636.041 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2023-03-21T16:53:56.041Z,1679417636.041 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2023-03-21T16:53:56.118Z,1679417636.118 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2023-03-21T16:53:56.296Z,1679417636.296 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2023-03-21T16:53:56.296Z,1679417636.296 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2023-03-21T16:53:56.506Z,1679417636.506 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2023-03-21T16:53:56.507Z,1679417636.507 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2023-03-21T16:53:56.788Z,1679417636.788 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2023-03-21T16:53:56.790Z,1679417636.790 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/ 2023-03-21T16:53:56.791Z,1679417636.791 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg 2023-03-21T16:53:56.896Z,1679417636.896 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg 2023-03-21T16:53:57.035Z,1679417637.035 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg 2023-03-21T16:53:57.119Z,1679417637.119 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg 2023-03-21T16:53:57.211Z,1679417637.211 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg 2023-03-21T16:53:57.360Z,1679417637.360 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg 2023-03-21T16:53:57.565Z,1679417637.565 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg 2023-03-21T16:53:58.057Z,1679417638.057 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2023-03-21T16:53:58.057Z,1679417638.057 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg 2023-03-21T16:53:58.183Z,1679417638.183 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg 2023-03-21T16:53:58.273Z,1679417638.273 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg 2023-03-21T16:53:58.373Z,1679417638.373 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg 2023-03-21T16:53:58.471Z,1679417638.471 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2023-03-21T16:53:58.482Z,1679417638.482 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2023-03-21T16:53:58.592Z,1679417638.592 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2023-03-21T16:53:58.592Z,1679417638.592 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2023-03-21T16:53:58.603Z,1679417638.603 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2023-03-21T16:53:58.603Z,1679417638.603 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2023-03-21T16:53:58.659Z,1679417638.659 [DepthRateCalculator] Loaded 2023-03-21T16:53:58.659Z,1679417638.659 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2023-03-21T16:53:58.664Z,1679417638.664 [PitchRateCalculator] Loaded 2023-03-21T16:53:58.665Z,1679417638.665 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2023-03-21T16:53:58.675Z,1679417638.675 [SpeedCalculator] Loaded 2023-03-21T16:53:58.675Z,1679417638.675 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2023-03-21T16:53:58.680Z,1679417638.680 [YawRateCalculator] Loaded 2023-03-21T16:53:58.680Z,1679417638.680 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2023-03-21T16:53:58.701Z,1679417638.701 [ElevatorOffsetCalculator] Loaded 2023-03-21T16:53:58.701Z,1679417638.701 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2023-03-21T16:53:58.702Z,1679417638.702 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2023-03-21T16:53:58.702Z,1679417638.702 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2023-03-21T16:53:58.758Z,1679417638.758 [VerticalControl](DEBUG): Construct VerticalControl. 2023-03-21T16:53:58.812Z,1679417638.812 [VerticalControl] Loaded 2023-03-21T16:53:58.812Z,1679417638.812 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2023-03-21T16:53:58.815Z,1679417638.815 [HorizontalControl](DEBUG): Construct HorizontalControl. 2023-03-21T16:53:58.854Z,1679417638.854 [HorizontalControl] Loaded 2023-03-21T16:53:58.854Z,1679417638.854 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2023-03-21T16:53:58.857Z,1679417638.857 [SpeedControl](DEBUG): Construct SpeedControl. 2023-03-21T16:53:58.859Z,1679417638.859 [SpeedControl] Loaded 2023-03-21T16:53:58.860Z,1679417638.860 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2023-03-21T16:53:58.862Z,1679417638.862 [LoopControl](DEBUG): Construct LoopControl. 2023-03-21T16:53:58.863Z,1679417638.863 [LoopControl] Loaded 2023-03-21T16:53:58.863Z,1679417638.863 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2023-03-21T16:53:58.864Z,1679417638.864 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2023-03-21T16:53:58.864Z,1679417638.864 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2023-03-21T16:53:58.980Z,1679417638.980 [DeadReckonUsingMultipleVelocitySources] Loaded 2023-03-21T16:53:58.980Z,1679417638.980 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2023-03-21T16:53:58.993Z,1679417638.993 [NavChart] Loaded 2023-03-21T16:53:58.994Z,1679417638.994 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2023-03-21T16:53:58.999Z,1679417638.999 [UniversalFixResidualReporter] Loaded 2023-03-21T16:53:58.000Z,1679417639.000 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2023-03-21T16:53:59.000Z,1679417639.000 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2023-03-21T16:53:59.001Z,1679417639.001 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2023-03-21T16:53:59.164Z,1679417639.164 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2023-03-21T16:53:59.164Z,1679417639.164 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2023-03-21T16:53:59.611Z,1679417639.611 [AHRS_M2] Loaded 2023-03-21T16:53:59.611Z,1679417639.611 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2023-03-21T16:53:59.647Z,1679417639.647 [BackseatComponent] Loaded 2023-03-21T16:53:59.647Z,1679417639.647 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2023-03-21T16:53:59.648Z,1679417639.648 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408FD4E0 2023-03-21T16:53:59.649Z,1679417639.649 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 9454 2023-03-21T16:53:59.652Z,1679417639.652 [LcmUniversalReporter] Loaded 2023-03-21T16:53:59.652Z,1679417639.652 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2023-03-21T16:53:59.725Z,1679417639.725 [DataOverHttps] Loaded 2023-03-21T16:53:59.725Z,1679417639.725 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2023-03-21T16:53:59.726Z,1679417639.726 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4092D4E0 2023-03-21T16:53:59.726Z,1679417639.726 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 9455 2023-03-21T16:53:59.747Z,1679417639.747 [Depth_Keller] Loaded 2023-03-21T16:53:59.747Z,1679417639.747 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2023-03-21T16:53:59.752Z,1679417639.752 [DropWeight] Loaded 2023-03-21T16:53:59.752Z,1679417639.752 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2023-03-21T16:53:59.790Z,1679417639.790 [DVL_micro] Loaded 2023-03-21T16:53:59.790Z,1679417639.790 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2023-03-21T16:53:59.854Z,1679417639.854 [NAL9602] Loaded 2023-03-21T16:53:59.854Z,1679417639.854 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2023-03-21T16:53:59.884Z,1679417639.884 [Onboard] Loaded 2023-03-21T16:53:59.885Z,1679417639.885 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2023-03-21T16:53:59.886Z,1679417639.886 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4095D4E0 2023-03-21T16:53:59.886Z,1679417639.886 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 9456 2023-03-21T16:53:59.898Z,1679417639.898 [Power24vConverter] Loaded 2023-03-21T16:53:59.898Z,1679417639.898 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2023-03-21T16:53:59.912Z,1679417639.912 [Radio_Surface] Loaded 2023-03-21T16:53:59.912Z,1679417639.912 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2023-03-21T16:53:59.913Z,1679417639.913 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4098D4E0 2023-03-21T16:53:59.913Z,1679417639.913 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9457 2023-03-21T16:54:00.006Z,1679417640.006 [DAT] Loaded 2023-03-21T16:54:00.006Z,1679417640.006 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2023-03-21T16:54:00.007Z,1679417640.007 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409BD4E0 2023-03-21T16:54:00.007Z,1679417640.007 [DAT ThreadHandler](INFO): Protected caller Thread ID is 9458 2023-03-21T16:54:00.008Z,1679417640.008 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2023-03-21T16:54:00.008Z,1679417640.008 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2023-03-21T16:54:00.151Z,1679417640.151 [BuoyancyServo] Loaded 2023-03-21T16:54:00.152Z,1679417640.152 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2023-03-21T16:54:00.172Z,1679417640.172 [ElevatorServo] Loaded 2023-03-21T16:54:00.172Z,1679417640.172 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2023-03-21T16:54:00.191Z,1679417640.191 [MassServo] Loaded 2023-03-21T16:54:00.192Z,1679417640.192 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2023-03-21T16:54:00.210Z,1679417640.210 [RudderServo] Loaded 2023-03-21T16:54:00.210Z,1679417640.210 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2023-03-21T16:54:00.225Z,1679417640.225 [ThrusterHE] Loaded 2023-03-21T16:54:00.225Z,1679417640.225 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2023-03-21T16:54:00.225Z,1679417640.225 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2023-03-21T16:54:00.226Z,1679417640.226 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2023-03-21T16:54:00.288Z,1679417640.288 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2023-03-21T16:54:00.289Z,1679417640.289 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2023-03-21T16:54:00.319Z,1679417640.319 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2023-03-21T16:54:00.319Z,1679417640.319 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2023-03-21T16:54:00.661Z,1679417640.661 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2023-03-21T16:54:00.662Z,1679417640.662 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2023-03-21T16:54:00.843Z,1679417640.843 [CTD_Seabird] Loaded 2023-03-21T16:54:00.843Z,1679417640.843 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2023-03-21T16:54:00.844Z,1679417640.844 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B474E0 2023-03-21T16:54:00.845Z,1679417640.845 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 9459 2023-03-21T16:54:00.877Z,1679417640.877 [ESPComponent] Loaded 2023-03-21T16:54:00.878Z,1679417640.878 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2023-03-21T16:54:00.897Z,1679417640.897 [PAR_Licor] Loaded 2023-03-21T16:54:00.898Z,1679417640.898 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2023-03-21T16:54:00.928Z,1679417640.928 [WetLabsBB2FL] Loaded 2023-03-21T16:54:00.929Z,1679417640.929 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2023-03-21T16:54:00.930Z,1679417640.930 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B774E0 2023-03-21T16:54:00.930Z,1679417640.930 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 9460 2023-03-21T16:54:00.931Z,1679417640.931 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2023-03-21T16:54:00.931Z,1679417640.931 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2023-03-21T16:54:01.088Z,1679417641.088 [SBIT](DEBUG): Construct Startup Built In Test. 2023-03-21T16:54:01.097Z,1679417641.097 [SBIT] Loaded 2023-03-21T16:54:01.097Z,1679417641.097 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2023-03-21T16:54:01.100Z,1679417641.100 [IBIT](DEBUG): Construct Initiated Built In Test. 2023-03-21T16:54:01.113Z,1679417641.113 [IBIT] Loaded 2023-03-21T16:54:01.113Z,1679417641.113 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2023-03-21T16:54:01.119Z,1679417641.119 [CBIT](DEBUG): Construct Continuous Built In Test. 2023-03-21T16:54:01.348Z,1679417641.348 [CBIT] Loaded 2023-03-21T16:54:01.348Z,1679417641.348 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2023-03-21T16:54:01.349Z,1679417641.349 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2023-03-21T16:54:01.355Z,1679417641.355 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2023-03-21T16:54:01.358Z,1679417641.358 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2023-03-21T16:54:01.368Z,1679417641.368 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2023-03-21T16:54:01.370Z,1679417641.370 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BE54E0 2023-03-21T16:54:01.370Z,1679417641.370 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9461 2023-03-21T16:54:01.374Z,1679417641.374 [Supervisor](INFO): Main Thread ID is 9366 2023-03-21T16:54:01.374Z,1679417641.374 [Supervisor](DEBUG): Running supervisor. 2023-03-21T16:54:01.375Z,1679417641.375 [CommandExec ThreadHandler](INFO): Handler Thread ID is 9462 2023-03-21T16:54:01.376Z,1679417641.376 [CommandExec](INFO): Initializing the command executive. 2023-03-21T16:54:01.377Z,1679417641.377 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9463 2023-03-21T16:54:01.379Z,1679417641.379 [controlThread ThreadHandler](INFO): Handler Thread ID is 9464 2023-03-21T16:54:01.380Z,1679417641.380 [controlThread](DEBUG): Initializing ControlThread 2023-03-21T16:54:01.381Z,1679417641.381 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2023-03-21T16:54:01.381Z,1679417641.381 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2023-03-21T16:54:01.381Z,1679417641.381 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2023-03-21T16:54:01.382Z,1679417641.382 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2023-03-21T16:54:01.382Z,1679417641.382 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2023-03-21T16:54:01.383Z,1679417641.383 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2023-03-21T16:54:01.384Z,1679417641.384 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2023-03-21T16:54:01.385Z,1679417641.385 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2023-03-21T16:54:01.385Z,1679417641.385 [LoopControl](DEBUG): Initialize LoopControlComponent. 2023-03-21T16:54:01.386Z,1679417641.386 [NavChart](DEBUG): Initialize NavChart Navigation. 2023-03-21T16:54:01.387Z,1679417641.387 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2023-03-21T16:54:01.400Z,1679417641.400 [SBIT](INFO): Initialize SBIT Component. 2023-03-21T16:54:01.400Z,1679417641.400 [SBIT](IMPORTANT): git: 2023-02-15A-18-g952c73059 2023-03-21T16:54:01.400Z,1679417641.400 [SBIT](INFO): git hash: 952c7305905b924e3dfe6a20bfba2406582094af 2023-03-21T16:54:01.401Z,1679417641.401 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2023-03-21T16:54:01.402Z,1679417641.402 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Sep 24 11:12:27 PDT 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2023-03-21T16:54:01.403Z,1679417641.403 [SBIT](INFO): Beginning SBIT in 22.000000 seconds. 2023-03-21T16:54:01.404Z,1679417641.404 [IBIT](INFO): Initialize IBIT Component. 2023-03-21T16:54:01.405Z,1679417641.405 [CBIT](DEBUG): Initialize CBIT Component. 2023-03-21T16:54:01.406Z,1679417641.406 [logger ThreadHandler](INFO): Handler Thread ID is 9465 2023-03-21T16:54:01.416Z,1679417641.416 [CBIT](DEBUG): Initialized mux pins. 2023-03-21T16:54:01.416Z,1679417641.416 [CBIT](DEBUG): Initializing the watchdog timer. 2023-03-21T16:54:01.424Z,1679417641.424 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 9466 2023-03-21T16:54:01.436Z,1679417641.436 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 9467 2023-03-21T16:54:01.437Z,1679417641.437 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2023-03-21T16:54:01.440Z,1679417641.440 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2023-03-21T16:54:01.440Z,1679417641.440 [CBIT](DEBUG): Initializing heartbeat. 2023-03-21T16:54:01.448Z,1679417641.448 [Onboard ThreadHandler](INFO): Handler Thread ID is 9468 2023-03-21T16:54:01.478Z,1679417641.478 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9469 2023-03-21T16:54:01.488Z,1679417641.488 [DAT ThreadHandler](INFO): Handler Thread ID is 9470 2023-03-21T16:54:01.489Z,1679417641.489 [DAT](INFO): Powering up 2023-03-21T16:54:01.489Z,1679417641.489 [DAT](DEBUG): Initializing DAT. 2023-03-21T16:54:01.493Z,1679417641.493 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 9472 2023-03-21T16:54:01.493Z,1679417641.493 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2023-03-21T16:54:01.497Z,1679417641.497 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 9474 2023-03-21T16:54:01.500Z,1679417641.500 [WetLabsBB2FL](INFO): Powering up 2023-03-21T16:54:01.501Z,1679417641.501 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9476 2023-03-21T16:54:01.504Z,1679417641.504 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2023-03-21T16:54:01.504Z,1679417641.504 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2023-03-21T16:54:01.505Z,1679417641.505 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2023-03-21T16:54:01.505Z,1679417641.505 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2023-03-21T16:54:01.505Z,1679417641.505 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2023-03-21T16:54:01.505Z,1679417641.505 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2023-03-21T16:54:01.505Z,1679417641.505 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2023-03-21T16:54:01.505Z,1679417641.505 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2023-03-21T16:54:01.512Z,1679417641.512 [CBIT](DEBUG): Deactivating GF circuits. 2023-03-21T16:54:01.512Z,1679417641.512 [CBIT](DEBUG): Deactivating emergency mode. 2023-03-21T16:54:01.547Z,1679417641.547 [CBIT](DEBUG): Backplane powered. 2023-03-21T16:54:01.549Z,1679417641.549 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2023-03-21T16:54:01.561Z,1679417641.561 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2023-03-21T16:54:01.573Z,1679417641.573 [MissionManager](DEBUG): 2023-03-21T16:54:01.574Z,1679417641.574 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2023-03-21T16:54:01.663Z,1679417641.663 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2023-03-21T16:54:01.664Z,1679417641.664 [Default:A.Wait](DEBUG): Construct Wait. 2023-03-21T16:54:01.666Z,1679417641.666 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2023-03-21T16:54:01.708Z,1679417641.708 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-03-21T16:54:01.710Z,1679417641.710 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-03-21T16:54:01.744Z,1679417641.744 [Default:E.Execute](DEBUG): Construct Execute. 2023-03-21T16:54:01.748Z,1679417641.748 [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 2023-03-21T16:54:01.768Z,1679417641.768 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-03-21T16:54:01.774Z,1679417641.774 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-03-21T16:54:01.845Z,1679417641.845 [Power24vConverter](INFO): Powering up. 2023-03-21T16:54:01.880Z,1679417641.880 [Radio_Surface](INFO): Powering up 2023-03-21T16:54:01.886Z,1679417641.886 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2023-03-21T16:54:01.892Z,1679417641.892 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2023-03-21T16:54:01.893Z,1679417641.893 [ElevatorServo](DEBUG): Initializing EZServoServo. 2023-03-21T16:54:01.900Z,1679417641.900 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2023-03-21T16:54:01.901Z,1679417641.901 [MassServo](DEBUG): Initializing EZServoServo. 2023-03-21T16:54:01.908Z,1679417641.908 [MassServo](DEBUG): Initializing MassServo. 2023-03-21T16:54:01.909Z,1679417641.909 [RudderServo](DEBUG): Initializing EZServoServo. 2023-03-21T16:54:01.916Z,1679417641.916 [RudderServo](DEBUG): Initializing RudderServo. 2023-03-21T16:54:01.917Z,1679417641.917 [ThrusterHE](DEBUG): Initializing EZServoServo. 2023-03-21T16:54:01.928Z,1679417641.928 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2023-03-21T16:54:02.225Z,1679417642.225 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2023-03-21T16:54:02.225Z,1679417642.225 [DropWeight] Hardware Fault, FailCount= 1 2023-03-21T16:54:02.225Z,1679417642.225 [DropWeight](ERROR): Hardware Fault 2023-03-21T16:54:02.263Z,1679417642.263 [CommandExec](FAULT): Scheduling is paused 2023-03-21T16:54:02.263Z,1679417642.263 [CBIT](INFO): Critical error at 20230321T165402 2023-03-21T16:54:02.280Z,1679417642.280 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2023-03-21T16:54:02.282Z,1679417642.282 [CBIT](ERROR): Hardware Fault in component: DropWeight 2023-03-21T16:54:02.283Z,1679417642.283 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2023-03-21T16:54:02.642Z,1679417642.642 [CBIT](INFO): Critical error at 20230321T165402 2023-03-21T16:54:04.112Z,1679417644.112 [WetLabsBB2FL](INFO): Powering down 2023-03-21T16:54:07.541Z,1679417647.541 [ThrusterHE](ERROR): Zero Speed Commanded. 2023-03-21T16:54:13.332Z,1679417653.332 [DAT](INFO): DAT read: 2023-03-21T16:54:13.334Z,1679417653.334 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2023-03-21T16:54:14.845Z,1679417654.845 [DAT](INFO): DAT read: MF Frequency Band 2023-03-21T16:54:14.846Z,1679417654.846 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2023-03-21T16:54:14.846Z,1679417654.846 [DAT](INFO): DAT read: Mar 21 2023 16:54:09 2023-03-21T16:54:15.194Z,1679417655.194 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004606 2023-03-21T16:54:15.853Z,1679417655.852 [DAT](INFO): DAT read: Features enabled [Bearing] 2023-03-21T16:54:15.854Z,1679417655.854 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2023-03-21T16:54:15.854Z,1679417655.854 [DAT](INFO): commRate: 800 2023-03-21T16:54:17.933Z,1679417657.933 [DAT](INFO): entering command mode 2023-03-21T16:54:17.933Z,1679417657.933 [DAT](DEBUG): checking for command mode acknowledgment 2023-03-21T16:54:18.120Z,1679417658.120 [DAT](INFO): DAT read: 2023-03-21T16:54:18.121Z,1679417658.121 [DAT](INFO): DAT read: user:1> 2023-03-21T16:54:18.121Z,1679417658.121 [DAT](INFO): setting verbose to 3 2023-03-21T16:54:18.372Z,1679417658.372 [DAT](INFO): DAT read: user:1> 2023-03-21T16:54:18.373Z,1679417658.373 [DAT](INFO): DAT read: Verbose | 3 2023-03-21T16:54:18.374Z,1679417658.374 [DAT](INFO): set verbose to 3 2023-03-21T16:54:18.374Z,1679417658.374 [DAT](INFO): setting DatVerbose to 27440 2023-03-21T16:54:18.624Z,1679417658.624 [DAT](INFO): DAT read: user:2> 2023-03-21T16:54:18.625Z,1679417658.625 [DAT](INFO): DAT read: DatVerbose | 27440 2023-03-21T16:54:18.626Z,1679417658.626 [DAT](INFO): set DatVerbose to 27440 2023-03-21T16:54:18.626Z,1679417658.626 [DAT](INFO): setting transmit power to 8 2023-03-21T16:54:18.876Z,1679417658.876 [DAT](INFO): DAT read: user:3> 2023-03-21T16:54:18.877Z,1679417658.877 [DAT](INFO): DAT read: TxPower | 8 (Max) 2023-03-21T16:54:18.878Z,1679417658.878 [DAT](INFO): set transmit power to 8 2023-03-21T16:54:18.878Z,1679417658.878 [DAT](INFO): setting local address to 8 2023-03-21T16:54:19.128Z,1679417659.128 [DAT](INFO): DAT read: user:4> 2023-03-21T16:54:19.129Z,1679417659.129 [DAT](INFO): DAT read: LocalAddr | 8 2023-03-21T16:54:19.129Z,1679417659.129 [DAT](INFO): set local address to 8 2023-03-21T16:54:19.130Z,1679417659.130 [DAT](INFO): Setting time to: 16:54:19 And date to:3/21/2023 2023-03-21T16:54:19.380Z,1679417659.380 [DAT](INFO): DAT read: user:5> 2023-03-21T16:54:19.381Z,1679417659.381 [DAT](INFO): DAT read: Tue Mar 21, 2023 16:54:19 2023-03-21T16:54:19.381Z,1679417659.381 [DAT](INFO): Local DAT time set to Tue Mar 21, 2023 16:54:19 2023-03-21T16:54:24.030Z,1679417664.030 [SBIT](IMPORTANT): Beginning Startup BIT 2023-03-21T16:54:24.066Z,1679417664.066 [CBIT](IMPORTANT): Beginning ground fault scan 2023-03-21T16:54:30.062Z,1679417670.062 [NAL9602](INFO): Powering up NAL9602 2023-03-21T16:54:35.072Z,1679417675.072 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.018098 CHAN A1 (24V): -0.002777 CHAN A2 (12V): 0.002185 CHAN A3 (5V): 0.000346 CHAN B0 (3.3V): 0.000545 CHAN B1 (3.15aV): 0.000603 CHAN B2 (3.15bV): 0.000045 CHAN B3 (GND): 0.001185 OPEN: 0.004612 Full Scale: +/- 1 mA 2023-03-21T16:54:40.969Z,1679417680.969 [NAL9602](INFO): NAL9602 initialized 2023-03-21T16:55:18.202Z,1679417718.202 [SBIT](IMPORTANT): SBIT PASSED 2023-03-21T16:55:18.202Z,1679417718.202 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2023-03-21T16:55:18.203Z,1679417718.203 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=35 count; 2023-03-21T16:55:18.209Z,1679417718.209 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool; 2023-03-21T16:55:18.209Z,1679417718.209 [SBIT](IMPORTANT): CTD_Seabird.minSalinityBound=0 practical_salinity_unit; 2023-03-21T16:55:18.209Z,1679417718.209 [SBIT](IMPORTANT): DAT.sbdAddress=-1 enum; 2023-03-21T16:55:18.211Z,1679417718.211 [SBIT](IMPORTANT): Depth_Keller.offset=3.9 decibar; 2023-03-21T16:55:18.211Z,1679417718.211 [SBIT](IMPORTANT): Express mostRecent CBIT.ampHoursUsed; 2023-03-21T16:55:18.211Z,1679417718.211 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water; 2023-03-21T16:55:18.211Z,1679417718.211 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=547.568399 cubic_centimeter; 2023-03-21T16:55:18.211Z,1679417718.211 [SBIT](IMPORTANT): VerticalControl.massDefault=0.503160 millimeter; 2023-03-21T16:55:18.211Z,1679417718.211 [SBIT](IMPORTANT): VerticalControl.massPositionLimitAft=-28 millimeter; 2023-03-21T16:55:18.223Z,1679417718.223 [SBIT](IMPORTANT): VerticalControl.massPositionLimitFwd=32 millimeter; 2023-03-21T16:55:18.224Z,1679417718.224 [SBIT](IMPORTANT): VerticalControl.surfaceThreshold=1.5 meter; 2023-03-21T16:55:18.481Z,1679417718.481 [CommandExec](IMPORTANT): got command show variable par 2023-03-21T16:55:18.566Z,1679417718.566 [MissionManager](IMPORTANT): Started mission Startup 2023-03-21T16:55:18.566Z,1679417718.566 [Startup] Running Loop=1 2023-03-21T16:55:18.566Z,1679417718.566 [Startup](DEBUG): Aggregate::initialize Startup 2023-03-21T16:55:18.566Z,1679417718.566 [Startup:A.GoToSurface] Running Loop=1 2023-03-21T16:55:18.567Z,1679417718.567 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-03-21T16:55:18.567Z,1679417718.567 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-03-21T16:55:18.580Z,1679417718.580 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-03-21T16:55:18.580Z,1679417718.580 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-03-21T16:55:18.581Z,1679417718.581 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-03-21T16:55:18.581Z,1679417718.581 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-03-21T16:55:18.582Z,1679417718.582 [Startup:StartupSatComms] Running Loop=1 2023-03-21T16:55:18.582Z,1679417718.582 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2023-03-21T16:55:18.582Z,1679417718.582 [Startup:StartupSatComms:A] Running Loop=1 2023-03-21T16:55:18.645Z,1679417718.645 [CommandExec](IMPORTANT): PAR_Licor.loadControl (none) 2023-03-21T16:55:18.645Z,1679417718.645 [CommandExec](IMPORTANT): PAR_Licor.ad (none) 2023-03-21T16:55:18.645Z,1679417718.645 [CommandExec](IMPORTANT): PAR_Licor.adRes (bit) 2023-03-21T16:55:18.646Z,1679417718.646 [CommandExec](IMPORTANT): PAR_Licor.adTimeout (millisecond) 2023-03-21T16:55:18.646Z,1679417718.646 [CommandExec](IMPORTANT): PAR_Licor.adVref (volt) 2023-03-21T16:55:18.663Z,1679417718.663 [CommandExec](IMPORTANT): PAR_Licor.loadAtStartup (bool) 2023-03-21T16:55:18.676Z,1679417718.676 [CommandExec](IMPORTANT): PAR_Licor.simulateHardware (bool) 2023-03-21T16:55:18.676Z,1679417718.676 [CommandExec](IMPORTANT): PAR_Licor.adcCal (microampere_per_count) 2023-03-21T16:55:18.677Z,1679417718.677 [CommandExec](IMPORTANT): PAR_Licor.darkCount (count) 2023-03-21T16:55:18.677Z,1679417718.677 [CommandExec](IMPORTANT): PAR_Licor.maxBound (micromole_per_second_per_square_meter) 2023-03-21T16:55:18.677Z,1679417718.677 [CommandExec](IMPORTANT): PAR_Licor.maxValidPitch (degree) 2023-03-21T16:55:18.677Z,1679417718.677 [CommandExec](IMPORTANT): PAR_Licor.minBound (micromole_per_second_per_square_meter) 2023-03-21T16:55:18.678Z,1679417718.678 [CommandExec](IMPORTANT): PAR_Licor.minValidPitch (degree) 2023-03-21T16:55:18.678Z,1679417718.678 [CommandExec](IMPORTANT): PAR_Licor.multiplier (micromole_per_second_per_square_meter_per_microampere) 2023-03-21T16:55:18.678Z,1679417718.678 [CommandExec](IMPORTANT): PAR_Licor.parCal (none) 2023-03-21T16:55:18.679Z,1679417718.679 [CommandExec](IMPORTANT): PAR_Licor.serial (none) 2023-03-21T16:55:18.770Z,1679417718.770 [CommandExec](IMPORTANT): PAR_Licor.enableBroadcast (bool) 2023-03-21T16:55:18.771Z,1679417718.771 [CommandExec](IMPORTANT): PAR_Licor.component_voltage (volt) 2023-03-21T16:55:18.771Z,1679417718.771 [CommandExec](IMPORTANT): PAR_Licor.component_avgVoltage (volt) 2023-03-21T16:55:18.785Z,1679417718.785 [CommandExec](IMPORTANT): PAR_Licor.component_current (milliampere) 2023-03-21T16:55:18.786Z,1679417718.786 [CommandExec](IMPORTANT): PAR_Licor.component_avgCurrent (milliampere) 2023-03-21T16:55:18.786Z,1679417718.786 [CommandExec](IMPORTANT): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water (micromole_per_second_per_square_meter) 2023-03-21T16:55:18.787Z,1679417718.787 [CommandExec](IMPORTANT): PAR_Licor.adcCount (count) 2023-03-21T16:55:18.962Z,1679417718.962 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2023-03-21T16:55:39.459Z,1679417739.459 [CommandExec](IMPORTANT): got command report touch PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 2023-03-21T16:55:39.595Z,1679417739.595 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.780399 umol/s/m2 2023-03-21T16:55:39.976Z,1679417739.976 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.773544 umol/s/m2 2023-03-21T16:55:40.384Z,1679417740.384 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.780399 umol/s/m2 2023-03-21T16:55:40.793Z,1679417740.793 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.766689 umol/s/m2 2023-03-21T16:55:41.218Z,1679417741.218 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.770117 umol/s/m2 2023-03-21T16:55:41.626Z,1679417741.626 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.775258 umol/s/m2 2023-03-21T16:55:42.037Z,1679417742.037 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.797540 umol/s/m2 2023-03-21T16:55:42.428Z,1679417742.428 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.778687 umol/s/m2 2023-03-21T16:55:42.828Z,1679417742.828 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.749548 umol/s/m2 2023-03-21T16:55:43.208Z,1679417743.208 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.756405 umol/s/m2 2023-03-21T16:55:43.628Z,1679417743.628 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 5.800108 umol/s/m2 2023-03-21T16:55:44.022Z,1679417744.022 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.015426 umol/s/m2 2023-03-21T16:55:44.437Z,1679417744.437 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.010284 umol/s/m2 2023-03-21T16:55:44.824Z,1679417744.824 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.008570 umol/s/m2 2023-03-21T16:55:45.228Z,1679417745.228 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.027424 umol/s/m2 2023-03-21T16:55:45.644Z,1679417745.644 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.006856 umol/s/m2 2023-03-21T16:55:46.069Z,1679417746.069 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.018854 umol/s/m2 2023-03-21T16:55:46.441Z,1679417746.441 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.029138 umol/s/m2 2023-03-21T16:55:46.865Z,1679417746.865 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 10.585541 umol/s/m2 2023-03-21T16:55:47.269Z,1679417747.269 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.734123 umol/s/m2 2023-03-21T16:55:47.679Z,1679417747.679 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.742692 umol/s/m2 2023-03-21T16:55:48.088Z,1679417748.088 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.761546 umol/s/m2 2023-03-21T16:55:48.460Z,1679417748.460 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.768402 umol/s/m2 2023-03-21T16:55:48.875Z,1679417748.875 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.775258 umol/s/m2 2023-03-21T16:55:49.285Z,1679417749.285 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.775258 umol/s/m2 2023-03-21T16:55:49.672Z,1679417749.672 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.773544 umol/s/m2 2023-03-21T16:55:50.082Z,1679417750.082 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.780399 umol/s/m2 2023-03-21T16:55:50.491Z,1679417750.491 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.768402 umol/s/m2 2023-03-21T16:55:50.900Z,1679417750.900 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.773544 umol/s/m2 2023-03-21T16:55:51.379Z,1679417751.379 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.799253 umol/s/m2 2023-03-21T16:55:51.729Z,1679417751.729 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.802682 umol/s/m2 2023-03-21T16:55:52.129Z,1679417752.129 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.799253 umol/s/m2 2023-03-21T16:55:52.536Z,1679417752.536 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.790684 umol/s/m2 2023-03-21T16:55:52.586Z,1679417752.586 [CommandExec](IMPORTANT): got command report clear 2023-03-21T16:56:14.303Z,1679417774.303 [DVL_micro](ERROR): only read 3 of 4 data items 2023-03-21T16:56:14.304Z,1679417774.304 [DVL_micro](ERROR): Failed to parse: :RD,+99999.99,+9999.99,+9999.99 2023-03-21T16:56:18.770Z,1679417778.770 [Startup:StartupSatComms:A](INFO): Timed out from 2023-03-21T16:55:18.6Z 2023-03-21T16:56:18.770Z,1679417778.770 [Startup:StartupSatComms:A] Stopped 2023-03-21T16:56:18.770Z,1679417778.770 [Startup:StartupSatComms:B] Running Loop=1 2023-03-21T16:56:19.188Z,1679417779.188 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-03-21T16:56:27.279Z,1679417787.279 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20230321T163034/Courier0007.lzma 2023-03-21T16:56:28.282Z,1679417788.282 [DataOverHttps](INFO): Moved sent file to Logs/20230321T163034/Courier0007.lzma.bak 2023-03-21T16:56:28.282Z,1679417788.282 [DataOverHttps](INFO): SBD MOMSN=17536830 2023-03-21T16:56:37.933Z,1679417797.933 [DataOverHttps](IMPORTANT): SBD MTMSN=20230321T165636 2023-03-21T16:56:45.171Z,1679417805.171 [DataOverHttps](INFO): Sending 245 bytes from file Logs/20230321T165352/Courier0000.lzma 2023-03-21T16:56:45.175Z,1679417805.175 [DataOverHttps](INFO): Received command: run Maintenance/run_backseat_on_surface.xml 2023-03-21T16:56:45.300Z,1679417805.300 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.xml 2023-03-21T16:56:45.300Z,1679417805.300 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.xml 2023-03-21T16:56:45.337Z,1679417805.337 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min 2023-03-21T16:56:45.338Z,1679417805.338 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.xml 2023-03-21T16:56:45.639Z,1679417805.639 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectChlActive = 0 bool 2023-03-21T16:56:45.642Z,1679417805.642 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.TimeWindowPeakReport = nan min 2023-03-21T16:56:45.645Z,1679417805.645 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestChlPeakReportActive = 0 bool 2023-03-21T16:56:45.648Z,1679417805.648 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestSaltPeakReportActive = 0 bool 2023-03-21T16:56:45.650Z,1679417805.650 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestOilPeakReportActive = 0 bool 2023-03-21T16:56:45.653Z,1679417805.653 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PatchTracking = 0 bool 2023-03-21T16:56:45.658Z,1679417805.658 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DetectTrough = 0 bool 2023-03-21T16:56:45.664Z,1679417805.664 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.FilterWidthHorizontal = 3.000000 count 2023-03-21T16:56:45.667Z,1679417805.667 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesSlidingwindow = 100.000000 count 2023-03-21T16:56:45.686Z,1679417805.686 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.OffPeakFractionHorizontal = 80.000000 % 2023-03-21T16:56:45.689Z,1679417805.689 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectNO3Active = 0 bool 2023-03-21T16:56:45.704Z,1679417805.704 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectOilActive = 0 bool 2023-03-21T16:56:45.706Z,1679417805.706 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectFDOMActive = 0 bool 2023-03-21T16:56:45.710Z,1679417805.710 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectSalinityActive = 0 bool 2023-03-21T16:56:45.724Z,1679417805.724 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2023-03-21T16:56:45.730Z,1679417805.730 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledAanderaaO2 = 0 bool 2023-03-21T16:56:45.734Z,1679417805.734 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledNeilBrown = 0 bool 2023-03-21T16:56:45.743Z,1679417805.743 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledSeabird = 1 bool 2023-03-21T16:56:45.755Z,1679417805.755 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsBB2FL = 1 bool 2023-03-21T16:56:45.762Z,1679417805.762 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool 2023-03-21T16:56:45.776Z,1679417805.776 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsUBAT = 0 bool 2023-03-21T16:56:45.783Z,1679417805.783 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.LowPassWindowLength = 20.000000 count 2023-03-21T16:56:45.786Z,1679417805.786 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.MedianFilterLen = 5.000000 count 2023-03-21T16:56:45.790Z,1679417805.790 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakShallowBound = nan m 2023-03-21T16:56:45.810Z,1679417805.810 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDeepBound = nan m 2023-03-21T16:56:45.813Z,1679417805.813 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DepChangeThreshForAttitudeFlip = 2.000000 m 2023-03-21T16:56:45.816Z,1679417805.816 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChl = 0.000000 ug/l 2023-03-21T16:56:45.837Z,1679417805.837 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlDepth = 0.000000 m 2023-03-21T16:56:45.856Z,1679417805.856 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlTemperature = 0.000000 degC 2023-03-21T16:56:45.862Z,1679417805.862 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLatitude = nan arcdeg 2023-03-21T16:56:45.867Z,1679417805.867 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLongitude = nan arcdeg 2023-03-21T16:56:45.878Z,1679417805.878 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3 = 0.000000 umol/l 2023-03-21T16:56:45.894Z,1679417805.894 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Depth = 0.000000 m 2023-03-21T16:56:45.899Z,1679417805.899 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Latitude = nan arcdeg 2023-03-21T16:56:45.919Z,1679417805.919 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Longitude = nan arcdeg 2023-03-21T16:56:45.927Z,1679417805.927 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOil = 0.000000 kg/m3 2023-03-21T16:56:45.935Z,1679417805.935 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilDepth = 0.000000 m 2023-03-21T16:56:45.941Z,1679417805.941 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLatitude = nan arcdeg 2023-03-21T16:56:45.946Z,1679417805.946 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLongitude = nan arcdeg 2023-03-21T16:56:45.949Z,1679417805.949 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOM = 0.000000 ppb 2023-03-21T16:56:45.954Z,1679417805.954 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMDepth = 0.000000 m 2023-03-21T16:56:45.966Z,1679417805.966 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMTemperature = nan degC 2023-03-21T16:56:45.969Z,1679417805.969 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLatitude = nan arcdeg 2023-03-21T16:56:45.980Z,1679417805.980 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLongitude = nan arcdeg 2023-03-21T16:56:45.983Z,1679417805.983 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchFDOMDistance = nan m 2023-03-21T16:56:45.994Z,1679417805.994 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSalt = 0.000000 psu 2023-03-21T16:56:45.998Z,1679417805.998 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltDepth = 0.000000 m 2023-03-21T16:56:46.013Z,1679417806.013 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltTemperature = 0.000000 degC 2023-03-21T16:56:46.021Z,1679417806.021 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLatitude = nan arcdeg 2023-03-21T16:56:46.036Z,1679417806.036 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLongitude = nan arcdeg 2023-03-21T16:56:46.042Z,1679417806.042 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChl = 0.000000 ug/l 2023-03-21T16:56:46.053Z,1679417806.053 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDepth = 0.000000 m 2023-03-21T16:56:46.063Z,1679417806.063 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLatitude = nan arcdeg 2023-03-21T16:56:46.078Z,1679417806.078 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLongitude = nan arcdeg 2023-03-21T16:56:46.081Z,1679417806.081 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDistance = nan m 2023-03-21T16:56:46.085Z,1679417806.085 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSalt = 0.000000 psu 2023-03-21T16:56:46.100Z,1679417806.100 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDepth = 0.000000 m 2023-03-21T16:56:46.103Z,1679417806.103 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLatitude = nan arcdeg 2023-03-21T16:56:46.110Z,1679417806.110 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLongitude = nan arcdeg 2023-03-21T16:56:46.115Z,1679417806.115 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDistance = nan m 2023-03-21T16:56:46.134Z,1679417806.134 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOil = 0.000000 psu 2023-03-21T16:56:46.152Z,1679417806.152 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDepth = 0.000000 m 2023-03-21T16:56:46.155Z,1679417806.155 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLatitude = nan arcdeg 2023-03-21T16:56:46.162Z,1679417806.162 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLongitude = nan arcdeg 2023-03-21T16:56:46.166Z,1679417806.166 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDistance = nan m 2023-03-21T16:56:46.354Z,1679417806.354 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2023-03-21T16:56:46.405Z,1679417806.405 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2023-03-21T16:56:46.473Z,1679417806.473 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2023-03-21T16:56:46.519Z,1679417806.519 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2023-03-21T16:56:46.573Z,1679417806.573 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2023-03-21T16:56:46.606Z,1679417806.606 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2023-03-21T16:56:46.716Z,1679417806.716 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2023-03-21T16:56:46.766Z,1679417806.766 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2023-03-21T16:56:46.839Z,1679417806.839 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Construct BackseatDriver. 2023-03-21T16:56:46.843Z,1679417806.843 [run_backseat_on_surface:C.GoToSurface](DEBUG): Construct GoToSurface. 2023-03-21T16:56:46.884Z,1679417806.884 [DataOverHttps](INFO): Moved sent file to Logs/20230321T165352/Courier0000.lzma.bak 2023-03-21T16:56:46.885Z,1679417806.885 [DataOverHttps](INFO): SBD MOMSN=17536837 2023-03-21T16:56:46.895Z,1679417806.895 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-03-21T16:56:46.913Z,1679417806.913 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-03-21T16:56:46.928Z,1679417806.928 [run_backseat_on_surface:F.Execute](DEBUG): Construct Execute. 2023-03-21T16:56:46.967Z,1679417806.967 [MissionManager](DEBUG): 0 Burn on Dropped weight due to communications timeout. 5 run_backseat_on_surface mission has been running for Restarting logs and run_backseat_on_surface mission. restart logs 2023-03-21T16:56:46.974Z,1679417806.974 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/run_backseat_on_surface.xml 2023-03-21T16:57:01.627Z,1679417821.627 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2023-03-21T16:57:01.627Z,1679417821.627 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-21T16:57:01.679Z,1679417821.679 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-21T16:57:02.073Z,1679417822.073 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-21T16:57:02.073Z,1679417822.073 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2023-03-21T16:57:03.539Z,1679417823.539 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230321T165352/Courier0004.lzma 2023-03-21T16:57:04.541Z,1679417824.541 [DataOverHttps](INFO): Moved sent file to Logs/20230321T165352/Courier0004.lzma.bak 2023-03-21T16:57:04.541Z,1679417824.541 [DataOverHttps](INFO): SBD MOMSN=17536843 2023-03-21T16:57:18.977Z,1679417838.977 [Startup:StartupSatComms:B](INFO): Timed out from 2023-03-21T16:56:18.8Z 2023-03-21T16:57:18.977Z,1679417838.977 [Startup:StartupSatComms:B] Stopped 2023-03-21T16:57:18.977Z,1679417838.977 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2023-03-21T16:57:18.977Z,1679417838.977 [Startup:StartupSatComms] Stopped 2023-03-21T16:57:18.977Z,1679417838.977 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2023-03-21T16:57:18.978Z,1679417838.978 [Startup](INFO): Completed Startup 2023-03-21T16:57:18.978Z,1679417838.978 [MissionManager](INFO): Startup is completed. 2023-03-21T16:57:18.978Z,1679417838.978 [MissionManager](INFO): Uninitializing Mission Startup 2023-03-21T16:57:18.978Z,1679417838.978 [Startup] Stopped 2023-03-21T16:57:18.979Z,1679417838.979 [Startup](DEBUG): Aggregate::uninitialize Startup 2023-03-21T16:57:18.979Z,1679417838.979 [Startup:A.GoToSurface] Stopped 2023-03-21T16:57:18.979Z,1679417838.979 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-03-21T16:57:19.385Z,1679417839.385 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface 2023-03-21T16:57:19.385Z,1679417839.385 [run_backseat_on_surface] Running Loop=1 2023-03-21T16:57:19.385Z,1679417839.385 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface 2023-03-21T16:57:19.385Z,1679417839.385 [run_backseat_on_surface:Science] Running Loop=1 2023-03-21T16:57:19.385Z,1679417839.385 [run_backseat_on_surface:Science](DEBUG): Aggregate::initialize run_backseat_on_surface:Science 2023-03-21T16:57:19.385Z,1679417839.385 [run_backseat_on_surface:Science:A] Running Loop=1 2023-03-21T16:57:19.385Z,1679417839.385 [run_backseat_on_surface:Science:B] Running Loop=1 2023-03-21T16:57:19.385Z,1679417839.385 [run_backseat_on_surface:Science:C] Running Loop=1 2023-03-21T16:57:19.385Z,1679417839.385 [run_backseat_on_surface:Science:D] Running Loop=1 2023-03-21T16:57:19.385Z,1679417839.385 [run_backseat_on_surface:Science:E] Running Loop=1 2023-03-21T16:57:19.385Z,1679417839.385 [run_backseat_on_surface:Science:F] Running Loop=1 2023-03-21T16:57:19.386Z,1679417839.386 [run_backseat_on_surface:Science:Read_Oil] Running Loop=1 2023-03-21T16:57:19.386Z,1679417839.386 [run_backseat_on_surface:Science:PeakDetectChl] Running Loop=1 2023-03-21T16:57:19.386Z,1679417839.386 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectChl 2023-03-21T16:57:19.386Z,1679417839.386 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2023-03-21T16:57:19.386Z,1679417839.386 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2023-03-21T16:57:19.388Z,1679417839.388 [run_backseat_on_surface:Science:HighestChlPeakReport] Running Loop=1 2023-03-21T16:57:19.388Z,1679417839.388 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestChlPeakReport 2023-03-21T16:57:19.388Z,1679417839.388 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2023-03-21T16:57:19.388Z,1679417839.388 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2023-03-21T16:57:19.389Z,1679417839.389 [run_backseat_on_surface:Science:PeakDetectNO3] Running Loop=1 2023-03-21T16:57:19.389Z,1679417839.389 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectNO3 2023-03-21T16:57:19.390Z,1679417839.390 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2023-03-21T16:57:19.390Z,1679417839.390 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2023-03-21T16:57:19.392Z,1679417839.392 [run_backseat_on_surface:Science:PeakDetectOil] Running Loop=1 2023-03-21T16:57:19.392Z,1679417839.392 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectOil 2023-03-21T16:57:19.392Z,1679417839.392 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2023-03-21T16:57:19.392Z,1679417839.392 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2023-03-21T16:57:19.394Z,1679417839.394 [run_backseat_on_surface:Science:HighestOilPeakReport] Running Loop=1 2023-03-21T16:57:19.394Z,1679417839.394 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestOilPeakReport 2023-03-21T16:57:19.394Z,1679417839.394 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1 2023-03-21T16:57:19.395Z,1679417839.395 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2023-03-21T16:57:19.395Z,1679417839.395 [run_backseat_on_surface:Science:PeakDetectFDOM] Running Loop=1 2023-03-21T16:57:19.395Z,1679417839.395 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectFDOM 2023-03-21T16:57:19.395Z,1679417839.395 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2023-03-21T16:57:19.395Z,1679417839.395 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2023-03-21T16:57:19.397Z,1679417839.397 [run_backseat_on_surface:Science:PeakDetectSalinity] Running Loop=1 2023-03-21T16:57:19.397Z,1679417839.397 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectSalinity 2023-03-21T16:57:19.398Z,1679417839.398 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1 2023-03-21T16:57:19.398Z,1679417839.398 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize. 2023-03-21T16:57:19.399Z,1679417839.399 [run_backseat_on_surface:Science:HighestSaltPeakReport] Running Loop=1 2023-03-21T16:57:19.399Z,1679417839.399 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestSaltPeakReport 2023-03-21T16:57:19.400Z,1679417839.400 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1 2023-03-21T16:57:19.400Z,1679417839.400 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2023-03-21T16:57:19.400Z,1679417839.400 [run_backseat_on_surface:Science:OceanCurrent] Running Loop=1 2023-03-21T16:57:19.400Z,1679417839.400 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:OceanCurrent 2023-03-21T16:57:19.400Z,1679417839.400 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1 2023-03-21T16:57:19.400Z,1679417839.400 [run_backseat_on_surface:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator. 2023-03-21T16:57:19.401Z,1679417839.401 [run_backseat_on_surface:B.BackseatDriver] Running Loop=1 2023-03-21T16:57:19.401Z,1679417839.401 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Initialize. 2023-03-21T16:57:19.422Z,1679417839.422 [DAT](INFO): DAT read: user:6>Lowpower 2023-03-21T16:57:19.423Z,1679417839.423 [DAT](DEBUG): Re-entering command mode due to deviceResponse_: user:6>Lowpower 2023-03-21T16:57:19.486Z,1679417839.486 [run_backseat_on_surface:C.GoToSurface] Running Loop=1 2023-03-21T16:57:19.486Z,1679417839.486 [run_backseat_on_surface:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-03-21T16:57:19.486Z,1679417839.486 [run_backseat_on_surface:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-03-21T16:57:19.486Z,1679417839.486 [run_backseat_on_surface:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-03-21T16:57:19.486Z,1679417839.486 [run_backseat_on_surface:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-03-21T16:57:19.487Z,1679417839.487 [run_backseat_on_surface:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-03-21T16:57:19.487Z,1679417839.487 [run_backseat_on_surface:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-03-21T16:57:19.488Z,1679417839.488 [run_backseat_on_surface:CheckIn] Running Loop=1 2023-03-21T16:57:19.489Z,1679417839.489 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2023-03-21T16:57:19.489Z,1679417839.489 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2023-03-21T16:57:19.489Z,1679417839.489 [run_backseat_on_surface:B.BackseatDriver] Running Loop=1 2023-03-21T16:57:19.492Z,1679417839.492 [run_backseat_on_surface:Science] Running Loop=1 2023-03-21T16:57:19.493Z,1679417839.493 [run_backseat_on_surface:Science:HighestSaltPeakReport] Stopped 2023-03-21T16:57:19.493Z,1679417839.493 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestSaltPeakReport 2023-03-21T16:57:19.493Z,1679417839.493 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped 2023-03-21T16:57:19.493Z,1679417839.493 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2023-03-21T16:57:19.493Z,1679417839.493 [run_backseat_on_surface:Science:PeakDetectSalinity] Stopped 2023-03-21T16:57:19.493Z,1679417839.493 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectSalinity 2023-03-21T16:57:19.493Z,1679417839.493 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped 2023-03-21T16:57:19.493Z,1679417839.493 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2023-03-21T16:57:19.493Z,1679417839.493 [run_backseat_on_surface:Science:PeakDetectFDOM] Stopped 2023-03-21T16:57:19.493Z,1679417839.493 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectFDOM 2023-03-21T16:57:19.494Z,1679417839.494 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2023-03-21T16:57:19.494Z,1679417839.494 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2023-03-21T16:57:19.494Z,1679417839.494 [run_backseat_on_surface:Science:HighestOilPeakReport] Stopped 2023-03-21T16:57:19.494Z,1679417839.494 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestOilPeakReport 2023-03-21T16:57:19.494Z,1679417839.494 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped 2023-03-21T16:57:19.494Z,1679417839.494 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2023-03-21T16:57:19.494Z,1679417839.494 [run_backseat_on_surface:Science:PeakDetectOil] Stopped 2023-03-21T16:57:19.494Z,1679417839.494 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectOil 2023-03-21T16:57:19.494Z,1679417839.494 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2023-03-21T16:57:19.494Z,1679417839.494 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2023-03-21T16:57:19.494Z,1679417839.494 [run_backseat_on_surface:Science:PeakDetectNO3] Stopped 2023-03-21T16:57:19.494Z,1679417839.494 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectNO3 2023-03-21T16:57:19.494Z,1679417839.494 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2023-03-21T16:57:19.495Z,1679417839.495 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2023-03-21T16:57:19.495Z,1679417839.495 [run_backseat_on_surface:Science:HighestChlPeakReport] Stopped 2023-03-21T16:57:19.495Z,1679417839.495 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestChlPeakReport 2023-03-21T16:57:19.495Z,1679417839.495 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2023-03-21T16:57:19.495Z,1679417839.495 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2023-03-21T16:57:19.495Z,1679417839.495 [run_backseat_on_surface:Science:PeakDetectChl] Stopped 2023-03-21T16:57:19.495Z,1679417839.495 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectChl 2023-03-21T16:57:19.495Z,1679417839.495 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2023-03-21T16:57:19.495Z,1679417839.495 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2023-03-21T16:57:19.495Z,1679417839.495 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1 2023-03-21T16:57:19.496Z,1679417839.496 [run_backseat_on_surface:Science:Read_Oil] Stopped 2023-03-21T16:57:19.496Z,1679417839.496 [run_backseat_on_surface:Science:F] Stopped 2023-03-21T16:57:19.496Z,1679417839.496 [run_backseat_on_surface:Science:E] Running Loop=1 2023-03-21T16:57:19.497Z,1679417839.497 [run_backseat_on_surface:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water 2023-03-21T16:57:19.497Z,1679417839.497 [run_backseat_on_surface:Science:D] Stopped 2023-03-21T16:57:19.497Z,1679417839.497 [run_backseat_on_surface:Science:C] Running Loop=1 2023-03-21T16:57:19.497Z,1679417839.497 [run_backseat_on_surface:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature 2023-03-21T16:57:19.498Z,1679417839.498 [run_backseat_on_surface:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity 2023-03-21T16:57:19.498Z,1679417839.498 [run_backseat_on_surface:Science:B] Running Loop=1 2023-03-21T16:57:19.499Z,1679417839.499 [run_backseat_on_surface:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature 2023-03-21T16:57:19.500Z,1679417839.500 [run_backseat_on_surface:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity 2023-03-21T16:57:19.500Z,1679417839.500 [run_backseat_on_surface:Science:A] Stopped 2023-03-21T16:57:19.552Z,1679417839.552 [BackseatComponent](INFO): Powering up 2023-03-21T16:57:19.552Z,1679417839.552 [BackseatComponent](INFO): Subscribing to LCM channels. 2023-03-21T16:57:19.645Z,1679417839.645 [WetLabsBB2FL](INFO): Powering up 2023-03-21T16:57:19.797Z,1679417839.797 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2023-03-21T16:57:23.349Z,1679417843.349 [CTD_Seabird](ERROR): Failed to parse device response: 2023-03-21T16:57:26.976Z,1679417846.976 [DataOverHttps](INFO): Sending 885 bytes from file Logs/20230321T163034/Express0008.lzma 2023-03-21T16:57:27.977Z,1679417847.977 [DataOverHttps](INFO): Moved sent file to Logs/20230321T163034/Express0008.lzma.bak 2023-03-21T16:57:27.977Z,1679417847.977 [DataOverHttps](INFO): SBD MOMSN=17536845 2023-03-21T16:59:44.405Z,1679417984.405 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-03-21T17:00:02.617Z,1679418002.617 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2023-03-21T17:00:02.617Z,1679418002.617 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-21T17:00:02.633Z,1679418002.633 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-21T17:00:03.041Z,1679418003.041 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-21T17:00:03.041Z,1679418003.041 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2023-03-21T17:02:19.589Z,1679418139.589 [run_backseat_on_surface:CheckIn:Read_GPS](INFO): Timed out from 2023-03-21T16:57:19.5Z 2023-03-21T17:02:19.589Z,1679418139.589 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2023-03-21T17:02:19.589Z,1679418139.589 [run_backseat_on_surface:CheckIn:Read_Iridium] Running Loop=1 2023-03-21T17:02:19.978Z,1679418139.978 [run_backseat_on_surface:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-03-21T17:02:23.995Z,1679418143.995 [DVL_micro](ERROR): only read 3 of 4 data items 2023-03-21T17:02:23.996Z,1679418143.996 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.999,+9999.99 2023-03-21T17:02:29.128Z,1679418149.128 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230321T165352/Courier0007.lzma 2023-03-21T17:02:30.129Z,1679418150.129 [DataOverHttps](INFO): Moved sent file to Logs/20230321T165352/Courier0007.lzma.bak 2023-03-21T17:02:30.130Z,1679418150.130 [DataOverHttps](INFO): SBD MOMSN=17536909 2023-03-21T17:02:34.877Z,1679418154.877 [BackseatComponent](FAULT): Failed to receive device response within the specified timeout. 2023-03-21T17:02:34.877Z,1679418154.877 [BackseatComponent] Communications Fault, FailCount= 1 2023-03-21T17:02:34.878Z,1679418154.878 [BackseatComponent](ERROR): Communications Fault 2023-03-21T17:02:34.993Z,1679418154.993 [CBIT](ERROR): Communications Fault in component: BackseatComponent 2023-03-21T17:02:35.285Z,1679418155.285 [BackseatComponent](INFO): Sent LCM shutdown request. 2023-03-21T17:02:50.640Z,1679418170.640 [BackseatComponent](INFO): Powering down and starting shutdown timer (15.00 sec). 2023-03-21T17:02:50.641Z,1679418170.641 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2023-03-21T17:02:50.641Z,1679418170.641 [LcmUniversalReporter](INFO): Deactivating messaging. 2023-03-21T17:02:53.693Z,1679418173.693 [DataOverHttps](INFO): Sending 1351 bytes from file Logs/20230321T165352/Express0001.lzma 2023-03-21T17:02:54.693Z,1679418174.693 [DataOverHttps](INFO): Moved sent file to Logs/20230321T165352/Express0001.lzma.bak 2023-03-21T17:02:54.693Z,1679418174.693 [DataOverHttps](INFO): SBD MOMSN=17536911 2023-03-21T17:03:03.628Z,1679418183.628 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2023-03-21T17:03:03.628Z,1679418183.628 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-21T17:03:03.669Z,1679418183.669 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-21T17:03:04.041Z,1679418184.041 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-21T17:03:04.041Z,1679418184.041 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2023-03-21T17:03:06.396Z,1679418186.396 [BackseatComponent](INFO): Powering up 2023-03-21T17:03:06.396Z,1679418186.396 [BackseatComponent](INFO): Subscribing to LCM channels. 2023-03-21T17:03:06.453Z,1679418186.453 [CBIT](INFO): Clearing failed state for component BackseatComponent 2023-03-21T17:03:06.453Z,1679418186.453 [BackseatComponent] No Fault, FailCount= 1 2023-03-21T17:03:15.283Z,1679418195.283 [DataOverHttps](INFO): Sending 173 bytes from file Logs/20230321T165352/Express0005.lzma 2023-03-21T17:03:16.285Z,1679418196.285 [DataOverHttps](INFO): Moved sent file to Logs/20230321T165352/Express0005.lzma.bak 2023-03-21T17:03:16.285Z,1679418196.286 [DataOverHttps](INFO): SBD MOMSN=17536961 2023-03-21T17:03:35.552Z,1679418215.552 [DataOverHttps](INFO): Sending 462 bytes from file Logs/20230321T165352/Express0008.lzma 2023-03-21T17:03:36.556Z,1679418216.556 [DataOverHttps](INFO): Moved sent file to Logs/20230321T165352/Express0008.lzma.bak 2023-03-21T17:03:36.556Z,1679418216.556 [DataOverHttps](INFO): SBD MOMSN=17536965 2023-03-21T17:03:42.823Z,1679418222.823 [run_backseat_on_surface:CheckIn:Read_Iridium] Stopped 2023-03-21T17:03:42.844Z,1679418222.844 [run_backseat_on_surface:CheckIn:C.Wait] Running Loop=1 2023-03-21T17:03:42.844Z,1679418222.844 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-03-21T17:04:42.577Z,1679418282.577 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-03-21T17:04:42.577Z,1679418282.577 [NAL9602] Data Fault, FailCount= 1 2023-03-21T17:04:42.577Z,1679418282.577 [NAL9602](ERROR): Data Fault 2023-03-21T17:04:42.597Z,1679418282.597 [CBIT](ERROR): Data Fault in component: NAL9602 2023-03-21T17:04:42.977Z,1679418282.977 [NAL9602](INFO): Powering down 2023-03-21T17:04:43.822Z,1679418283.822 [CBIT](INFO): Clearing failed state for component NAL9602 2023-03-21T17:04:43.822Z,1679418283.822 [NAL9602] No Fault, FailCount= 1 2023-03-21T17:04:46.624Z,1679418286.624 [DVL_micro](ERROR): Failed to parse: :WI,-00315,+00580,+00912,+00000,A 2023-03-21T17:05:13.281Z,1679418313.281 [NAL9602](INFO): Powering up NAL9602 2023-03-21T17:05:17.328Z,1679418317.328 [DVL_micro](ERROR): only read 3 of 4 data items 2023-03-21T17:05:17.328Z,1679418317.328 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+99999.99 2023-03-21T17:05:24.190Z,1679418324.190 [NAL9602](INFO): NAL9602 initialized 2023-03-21T17:06:04.592Z,1679418364.592 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2023-03-21T17:06:04.592Z,1679418364.592 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-21T17:06:04.621Z,1679418364.621 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-21T17:06:05.029Z,1679418365.029 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-21T17:06:05.029Z,1679418365.029 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2023-03-21T17:06:31.259Z,1679418391.259 [DVL_micro](ERROR): Failed to parse: :WI,+01781,+01125,+00553,+00000,A 2023-03-21T17:06:43.773Z,1679418403.773 [DVL_micro](ERROR): No DVL communication! Re-initializing 2023-03-21T17:06:43.774Z,1679418403.774 [DVL_micro] Communications Fault, FailCount= 1 2023-03-21T17:06:43.774Z,1679418403.774 [DVL_micro](ERROR): Communications Fault 2023-03-21T17:06:43.844Z,1679418403.844 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-03-21T17:06:44.181Z,1679418404.181 [DVL_micro](INFO): Powering down 2023-03-21T17:06:45.022Z,1679418405.022 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-03-21T17:06:45.022Z,1679418405.022 [DVL_micro] No Fault, FailCount= 1 2023-03-21T17:07:02.769Z,1679418422.769 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-03-21T17:07:02.769Z,1679418422.769 [DVL_micro] Communications Fault, FailCount= 2 2023-03-21T17:07:02.769Z,1679418422.769 [DVL_micro](ERROR): Communications Fault 2023-03-21T17:07:02.834Z,1679418422.834 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-03-21T17:07:03.244Z,1679418423.244 [DVL_micro](INFO): Powering down 2023-03-21T17:07:03.997Z,1679418423.997 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-03-21T17:07:03.997Z,1679418423.997 [DVL_micro] No Fault, FailCount= 2 2023-03-21T17:07:21.762Z,1679418441.762 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-03-21T17:07:21.762Z,1679418441.762 [DVL_micro] Communications Fault, FailCount= 3 2023-03-21T17:07:21.762Z,1679418441.762 [DVL_micro](ERROR): Communications Fault 2023-03-21T17:07:21.801Z,1679418441.801 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-03-21T17:07:21.802Z,1679418441.802 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2023-03-21T17:07:22.224Z,1679418442.224 [DVL_micro](INFO): Powering down 2023-03-21T17:07:22.263Z,1679418442.263 [CBIT](INFO): Critical error at 20230321T170721 2023-03-21T17:07:22.264Z,1679418442.264 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2023-03-21T17:07:22.609Z,1679418442.609 [MissionManager](INFO): MissionManager is completed. 2023-03-21T17:07:22.609Z,1679418442.609 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface 2023-03-21T17:07:22.609Z,1679418442.609 [run_backseat_on_surface] Stopped 2023-03-21T17:07:22.609Z,1679418442.609 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface 2023-03-21T17:07:22.610Z,1679418442.610 [run_backseat_on_surface:Science] Stopped 2023-03-21T17:07:22.610Z,1679418442.610 [run_backseat_on_surface:Science](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science 2023-03-21T17:07:22.610Z,1679418442.610 [run_backseat_on_surface:Science:B] Stopped 2023-03-21T17:07:22.610Z,1679418442.610 [run_backseat_on_surface:Science:C] Stopped 2023-03-21T17:07:22.610Z,1679418442.610 [run_backseat_on_surface:Science:E] Stopped 2023-03-21T17:07:22.610Z,1679418442.610 [run_backseat_on_surface:Science:OceanCurrent] Stopped 2023-03-21T17:07:22.610Z,1679418442.610 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:OceanCurrent 2023-03-21T17:07:22.610Z,1679418442.610 [run_backseat_on_surface:Science:OceanCurrent:A.] Stopped 2023-03-21T17:07:22.610Z,1679418442.610 [run_backseat_on_surface:B.BackseatDriver] Stopped 2023-03-21T17:07:22.611Z,1679418442.611 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Uninitialize. 2023-03-21T17:07:22.611Z,1679418442.611 [run_backseat_on_surface:C.GoToSurface] Stopped 2023-03-21T17:07:22.611Z,1679418442.611 [run_backseat_on_surface:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-03-21T17:07:22.611Z,1679418442.611 [run_backseat_on_surface:CheckIn] Stopped 2023-03-21T17:07:22.611Z,1679418442.611 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2023-03-21T17:07:22.611Z,1679418442.611 [run_backseat_on_surface:CheckIn:C.Wait] Stopped 2023-03-21T17:07:22.611Z,1679418442.611 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-03-21T17:07:22.776Z,1679418442.776 [WetLabsBB2FL](INFO): Powering down 2023-03-21T17:07:22.977Z,1679418442.977 [MissionManager](IMPORTANT): Started mission Default 2023-03-21T17:07:22.978Z,1679418442.978 [Default] Running Loop=1 2023-03-21T17:07:22.978Z,1679418442.978 [Default](DEBUG): Aggregate::initialize Default 2023-03-21T17:07:22.978Z,1679418442.978 [Default:B.GoToSurface] Running Loop=1 2023-03-21T17:07:22.978Z,1679418442.978 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-03-21T17:07:22.978Z,1679418442.978 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-03-21T17:07:22.978Z,1679418442.978 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-03-21T17:07:22.979Z,1679418442.979 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-03-21T17:07:22.979Z,1679418442.979 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-03-21T17:07:22.980Z,1679418442.980 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-03-21T17:07:22.980Z,1679418442.980 [Default:A.Wait] Running Loop=1 2023-03-21T17:07:22.980Z,1679418442.980 [Default:A.Wait](DEBUG): Initialize Wait Component. 2023-03-21T17:07:24.221Z,1679418444.221 [BackseatComponent](INFO): Sent LCM shutdown request. 2023-03-21T17:07:36.313Z,1679418456.313 [Default:A.Wait](INFO): Done Waiting. 2023-03-21T17:07:36.313Z,1679418456.313 [Default:A.Wait] Stopped 2023-03-21T17:07:36.314Z,1679418456.314 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2023-03-21T17:07:36.714Z,1679418456.714 [Default:CheckIn] Running Loop=1 2023-03-21T17:07:36.714Z,1679418456.714 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-03-21T17:07:36.714Z,1679418456.714 [Default:CheckIn:Read_GPS] Running Loop=1 2023-03-21T17:07:37.118Z,1679418457.118 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2023-03-21T17:07:39.324Z,1679418459.324 [BackseatComponent](INFO): Powering down and starting shutdown timer (15.00 sec). 2023-03-21T17:07:39.325Z,1679418459.325 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2023-03-21T17:07:39.325Z,1679418459.325 [LcmUniversalReporter](INFO): Deactivating messaging. 2023-03-21T17:09:02.401Z,1679418542.401 [CBIT](INFO): Clearing failed state for component DropWeight 2023-03-21T17:09:02.401Z,1679418542.401 [DropWeight] No Fault, FailCount= 1 2023-03-21T17:09:05.617Z,1679418545.617 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2023-03-21T17:09:05.617Z,1679418545.617 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-21T17:09:05.627Z,1679418545.627 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-21T17:09:06.019Z,1679418546.019 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-21T17:09:06.019Z,1679418546.019 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2023-03-21T17:10:09.824Z,1679418609.824 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2023-03-21T17:10:09.824Z,1679418609.824 [AHRS_M2] Data Fault, FailCount= 1 2023-03-21T17:10:09.824Z,1679418609.824 [AHRS_M2](ERROR): Data Fault 2023-03-21T17:10:09.845Z,1679418609.845 [CBIT](ERROR): Data Fault in component: AHRS_M2 2023-03-21T17:10:10.216Z,1679418610.216 [AHRS_M2](INFO): Powering down 2023-03-21T17:10:11.078Z,1679418611.078 [CBIT](INFO): Clearing failed state for component AHRS_M2 2023-03-21T17:10:11.078Z,1679418611.078 [AHRS_M2] No Fault, FailCount= 1 2023-03-21T17:10:11.430Z,1679418611.430 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-03-21T17:10:21.992Z,1679418621.992 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-03-21T17:10:21.992Z,1679418621.992 [DVL_micro] No Fault, FailCount= 3 2023-03-21T17:10:25.968Z,1679418625.968 [CommandExec](IMPORTANT): got command quit 2023-03-21T17:10:26.972Z,1679418626.972 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-21T17:10:26.972Z,1679418626.972 [CommandExec](INFO): Uninitializing the command executive. 2023-03-21T17:10:26.972Z,1679418626.972 [CommandExec](INFO): Uninitializing the command scheduler. 2023-03-21T17:10:26.972Z,1679418626.972 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:27.052Z,1679418627.052 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-03-21T17:10:27.052Z,1679418627.052 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-03-21T17:10:27.052Z,1679418627.052 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:27.053Z,1679418627.053 [NavChartDb](INFO): Join timeout helper Thread ID is 9535 2023-03-21T17:10:27.428Z,1679418627.428 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-21T17:10:27.428Z,1679418627.428 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:27.432Z,1679418627.432 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-03-21T17:10:27.432Z,1679418627.432 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:27.432Z,1679418627.432 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 9536 2023-03-21T17:10:27.712Z,1679418627.712 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-21T17:10:27.712Z,1679418627.712 [WetLabsBB2FL](INFO): Powering down 2023-03-21T17:10:27.713Z,1679418627.713 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:27.720Z,1679418627.720 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-03-21T17:10:27.720Z,1679418627.720 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:27.720Z,1679418627.720 [CTD_Seabird](INFO): Join timeout helper Thread ID is 9537 2023-03-21T17:10:28.656Z,1679418628.656 [CTD_Seabird](INFO): Powering down 2023-03-21T17:10:28.669Z,1679418628.669 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-21T17:10:28.669Z,1679418628.669 [CTD_Seabird](INFO): Powering down 2023-03-21T17:10:28.684Z,1679418628.684 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:28.696Z,1679418628.696 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2023-03-21T17:10:28.696Z,1679418628.696 [DAT ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:28.696Z,1679418628.696 [DAT](INFO): Join timeout helper Thread ID is 9538 2023-03-21T17:10:28.936Z,1679418628.936 [DAT](INFO): Powering down 2023-03-21T17:10:29.008Z,1679418629.008 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-21T17:10:29.008Z,1679418629.008 [DAT](INFO): Powering down 2023-03-21T17:10:29.009Z,1679418629.009 [DAT ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:29.016Z,1679418629.016 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-03-21T17:10:29.016Z,1679418629.016 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:29.016Z,1679418629.016 [Radio_Surface](INFO): Join timeout helper Thread ID is 9539 2023-03-21T17:10:29.376Z,1679418629.376 [Radio_Surface](INFO): Powering down 2023-03-21T17:10:29.376Z,1679418629.376 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-21T17:10:29.377Z,1679418629.377 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:29.380Z,1679418629.380 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-03-21T17:10:29.381Z,1679418629.381 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:29.381Z,1679418629.381 [Onboard](INFO): Join timeout helper Thread ID is 9540 2023-03-21T17:10:32.284Z,1679418632.284 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-21T17:10:32.284Z,1679418632.284 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:32.301Z,1679418632.301 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-03-21T17:10:32.301Z,1679418632.301 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:32.301Z,1679418632.301 [DataOverHttps](INFO): Join timeout helper Thread ID is 9541 2023-03-21T17:10:33.084Z,1679418633.084 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-21T17:10:33.087Z,1679418633.087 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.106Z,1679418633.106 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2023-03-21T17:10:33.106Z,1679418633.106 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.107Z,1679418633.107 [BackseatComponent](INFO): Join timeout helper Thread ID is 9542 2023-03-21T17:10:33.304Z,1679418633.304 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-21T17:10:33.304Z,1679418633.304 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.324Z,1679418633.324 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-03-21T17:10:33.325Z,1679418633.325 [logger ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.325Z,1679418633.325 [logger](INFO): Join timeout helper Thread ID is 9543 2023-03-21T17:10:33.350Z,1679418633.350 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-21T17:10:33.350Z,1679418633.350 [logger ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.364Z,1679418633.364 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-03-21T17:10:33.364Z,1679418633.364 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.365Z,1679418633.365 [CommandLine](INFO): Join timeout helper Thread ID is 9544 2023-03-21T17:10:33.404Z,1679418633.404 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-21T17:10:33.404Z,1679418633.404 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.425Z,1679418633.425 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-03-21T17:10:33.425Z,1679418633.425 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.425Z,1679418633.425 [CommandExec](INFO): Join timeout helper Thread ID is 9545 2023-03-21T17:10:33.427Z,1679418633.427 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-03-21T17:10:33.427Z,1679418633.427 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.427Z,1679418633.427 [controlThread](INFO): Join timeout helper Thread ID is 9546 2023-03-21T17:10:33.648Z,1679418633.648 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-21T17:10:33.648Z,1679418633.648 [controlThread](DEBUG): Uninitializing ControlThread 2023-03-21T17:10:33.648Z,1679418633.648 [AHRS_M2](INFO): Powering down 2023-03-21T17:10:33.792Z,1679418633.792 [DVL_micro](INFO): Powering down 2023-03-21T17:10:33.793Z,1679418633.793 [NAL9602](INFO): Powering down 2023-03-21T17:10:33.796Z,1679418633.796 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-03-21T17:10:33.796Z,1679418633.796 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-03-21T17:10:33.797Z,1679418633.797 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-03-21T17:10:33.797Z,1679418633.797 [MissionManager](INFO): Uninitializing Mission Default 2023-03-21T17:10:33.797Z,1679418633.797 [Default] Stopped 2023-03-21T17:10:33.798Z,1679418633.798 [Default](DEBUG): Aggregate::uninitialize Default 2023-03-21T17:10:33.798Z,1679418633.798 [Default:B.GoToSurface] Stopped 2023-03-21T17:10:33.798Z,1679418633.798 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-03-21T17:10:33.798Z,1679418633.798 [Default:CheckIn] Stopped 2023-03-21T17:10:33.798Z,1679418633.798 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-03-21T17:10:33.798Z,1679418633.798 [Default:CheckIn:Read_GPS] Stopped 2023-03-21T17:10:33.801Z,1679418633.801 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-03-21T17:10:33.801Z,1679418633.801 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-03-21T17:10:33.801Z,1679418633.801 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-03-21T17:10:33.802Z,1679418633.802 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-03-21T17:10:33.802Z,1679418633.802 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-03-21T17:10:33.802Z,1679418633.802 [BuoyancyServo](INFO): Powering down 2023-03-21T17:10:33.816Z,1679418633.816 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-03-21T17:10:33.816Z,1679418633.816 [ElevatorServo](INFO): Powering down 2023-03-21T17:10:33.817Z,1679418633.817 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-03-21T17:10:33.817Z,1679418633.817 [MassServo](INFO): Powering down 2023-03-21T17:10:33.818Z,1679418633.818 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-03-21T17:10:33.818Z,1679418633.818 [RudderServo](INFO): Powering down 2023-03-21T17:10:33.819Z,1679418633.819 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2023-03-21T17:10:33.819Z,1679418633.819 [ThrusterHE](INFO): Powering down 2023-03-21T17:10:33.820Z,1679418633.820 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-03-21T17:10:33.820Z,1679418633.820 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-03-21T17:10:33.820Z,1679418633.820 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-03-21T17:10:33.820Z,1679418633.820 [CBIT](DEBUG): Powering off loads. 2023-03-21T17:10:33.831Z,1679418633.831 [CBIT](DEBUG): Disabling WDT. 2023-03-21T17:10:33.843Z,1679418633.843 [CBIT](DEBUG): Opening all GF detection circuits. 2023-03-21T17:10:33.844Z,1679418633.844 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.891Z,1679418633.891 [DAT ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.896Z,1679418633.896 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.898Z,1679418633.898 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.905Z,1679418633.905 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.911Z,1679418633.911 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.962Z,1679418633.962 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.966Z,1679418633.966 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:33.988Z,1679418633.988 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-03-21T17:10:34.047Z,1679418634.047 [logger ThreadHandler](INFO): Thread cancelled.