2024-06-03T22:19:21.573Z,1717453161.573 [Supervisor](DEBUG): Initializing supervisor. 2024-06-03T22:19:21.577Z,1717453161.577 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-06-03T22:19:21.578Z,1717453161.578 [SyncHandler](INFO): Protected caller Thread ID is 572 2024-06-03T22:19:21.578Z,1717453161.578 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-06-03T22:19:21.579Z,1717453161.579 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-06-03T22:19:21.580Z,1717453161.580 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 573 2024-06-03T22:19:21.584Z,1717453161.584 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-06-03T22:19:21.603Z,1717453161.603 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-06-03T22:19:21.604Z,1717453161.604 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-06-03T22:19:21.604Z,1717453161.604 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 574 2024-06-03T22:19:21.608Z,1717453161.608 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-06-03T22:19:21.609Z,1717453161.609 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-06-03T22:19:21.610Z,1717453161.610 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 575 2024-06-03T22:19:21.612Z,1717453161.612 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-06-03T22:19:21.613Z,1717453161.613 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-06-03T22:19:21.613Z,1717453161.613 [logger ThreadHandler](INFO): Protected caller Thread ID is 576 2024-06-03T22:19:21.617Z,1717453161.617 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-06-03T22:19:21.618Z,1717453161.618 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-06-03T22:19:21.623Z,1717453161.623 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-06-03T22:19:22.225Z,1717453162.225 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-06-03T22:19:22.227Z,1717453162.227 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-06-03T22:19:22.476Z,1717453162.476 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-06-03T22:19:22.476Z,1717453162.476 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-06-03T22:19:22.573Z,1717453162.573 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-06-03T22:19:22.844Z,1717453162.844 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-06-03T22:19:22.846Z,1717453162.846 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-06-03T22:19:22.941Z,1717453162.941 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-06-03T22:19:23.054Z,1717453163.054 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-06-03T22:19:23.056Z,1717453163.056 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-06-03T22:19:23.452Z,1717453163.452 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-06-03T22:19:23.454Z,1717453163.454 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-06-03T22:19:23.611Z,1717453163.611 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-06-03T22:19:23.613Z,1717453163.613 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-06-03T22:19:24.245Z,1717453164.245 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-06-03T22:19:24.245Z,1717453164.245 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-06-03T22:19:24.474Z,1717453164.474 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-06-03T22:19:24.475Z,1717453164.475 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-06-03T22:19:25.005Z,1717453165.005 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-06-03T22:19:25.238Z,1717453165.238 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-06-03T22:19:25.597Z,1717453165.597 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-06-03T22:19:25.599Z,1717453165.599 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-06-03T22:19:25.729Z,1717453165.729 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-06-03T22:19:25.729Z,1717453165.729 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-06-03T22:19:26.671Z,1717453166.671 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-06-03T22:19:26.672Z,1717453166.672 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-06-03T22:19:27.076Z,1717453167.076 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-06-03T22:19:27.078Z,1717453167.078 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-06-03T22:19:27.342Z,1717453167.342 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-06-03T22:19:27.345Z,1717453167.345 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/ 2024-06-03T22:19:27.347Z,1717453167.347 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg 2024-06-03T22:19:27.488Z,1717453167.488 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg 2024-06-03T22:19:27.589Z,1717453167.589 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg 2024-06-03T22:19:27.753Z,1717453167.753 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg 2024-06-03T22:19:27.856Z,1717453167.856 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg 2024-06-03T22:19:28.141Z,1717453168.141 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-06-03T22:19:28.142Z,1717453168.142 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg 2024-06-03T22:19:28.268Z,1717453168.268 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg 2024-06-03T22:19:28.396Z,1717453168.396 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg 2024-06-03T22:19:28.510Z,1717453168.510 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg 2024-06-03T22:19:28.689Z,1717453168.689 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg 2024-06-03T22:19:28.807Z,1717453168.807 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg 2024-06-03T22:19:28.911Z,1717453168.911 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-06-03T22:19:28.942Z,1717453168.942 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-06-03T22:19:28.959Z,1717453168.959 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-06-03T22:19:28.959Z,1717453168.959 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-06-03T22:19:29.110Z,1717453169.110 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-06-03T22:19:29.113Z,1717453169.113 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-06-03T22:19:29.186Z,1717453169.186 [VerticalControl](DEBUG): Construct VerticalControl. 2024-06-03T22:19:29.248Z,1717453169.248 [VerticalControl] Loaded 2024-06-03T22:19:29.248Z,1717453169.248 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-06-03T22:19:29.251Z,1717453169.251 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-06-03T22:19:29.300Z,1717453169.300 [HorizontalControl] Loaded 2024-06-03T22:19:29.300Z,1717453169.300 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-06-03T22:19:29.302Z,1717453169.302 [SpeedControl](DEBUG): Construct SpeedControl. 2024-06-03T22:19:29.305Z,1717453169.305 [SpeedControl] Loaded 2024-06-03T22:19:29.306Z,1717453169.306 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-06-03T22:19:29.309Z,1717453169.309 [LoopControl](DEBUG): Construct LoopControl. 2024-06-03T22:19:29.309Z,1717453169.309 [LoopControl] Loaded 2024-06-03T22:19:29.309Z,1717453169.309 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-06-03T22:19:29.310Z,1717453169.310 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-06-03T22:19:29.310Z,1717453169.310 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-06-03T22:19:29.483Z,1717453169.483 [BuoyancyServo] Loaded 2024-06-03T22:19:29.483Z,1717453169.483 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-06-03T22:19:29.503Z,1717453169.503 [MassServo] Loaded 2024-06-03T22:19:29.503Z,1717453169.503 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-06-03T22:19:29.518Z,1717453169.518 [ThrusterHE] Loaded 2024-06-03T22:19:29.518Z,1717453169.518 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-06-03T22:19:29.519Z,1717453169.519 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-06-03T22:19:29.521Z,1717453169.521 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-06-03T22:19:29.592Z,1717453169.592 [DepthRateCalculator] Loaded 2024-06-03T22:19:29.592Z,1717453169.592 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-06-03T22:19:29.597Z,1717453169.597 [PitchRateCalculator] Loaded 2024-06-03T22:19:29.597Z,1717453169.597 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-06-03T22:19:29.608Z,1717453169.608 [SpeedCalculator] Loaded 2024-06-03T22:19:29.608Z,1717453169.608 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-06-03T22:19:29.612Z,1717453169.612 [YawRateCalculator] Loaded 2024-06-03T22:19:29.613Z,1717453169.613 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-06-03T22:19:29.632Z,1717453169.632 [ElevatorOffsetCalculator] Loaded 2024-06-03T22:19:29.632Z,1717453169.632 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-06-03T22:19:29.633Z,1717453169.633 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-06-03T22:19:29.634Z,1717453169.634 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-06-03T22:19:29.776Z,1717453169.776 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-06-03T22:19:29.776Z,1717453169.776 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-06-03T22:19:29.790Z,1717453169.790 [NavChart] Loaded 2024-06-03T22:19:29.790Z,1717453169.790 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-06-03T22:19:29.796Z,1717453169.796 [UniversalFixResidualReporter] Loaded 2024-06-03T22:19:29.796Z,1717453169.796 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-06-03T22:19:29.797Z,1717453169.797 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-06-03T22:19:29.797Z,1717453169.797 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-06-03T22:19:30.836Z,1717453170.836 [BackseatComponent] Loaded 2024-06-03T22:19:30.837Z,1717453170.837 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-06-03T22:19:30.838Z,1717453170.838 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4090C4E0 2024-06-03T22:19:30.838Z,1717453170.838 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 658 2024-06-03T22:19:30.841Z,1717453170.841 [LcmUniversalReporter] Loaded 2024-06-03T22:19:30.841Z,1717453170.841 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-06-03T22:19:30.893Z,1717453170.893 [BioacousticsDataBridge] Loaded 2024-06-03T22:19:30.894Z,1717453170.894 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread. 2024-06-03T22:19:31.834Z,1717453171.834 [BPC1] Loaded 2024-06-03T22:19:31.834Z,1717453171.834 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-06-03T22:19:32.150Z,1717453172.150 [DataOverHttps] Loaded 2024-06-03T22:19:32.151Z,1717453172.151 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-06-03T22:19:32.152Z,1717453172.152 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4093C4E0 2024-06-03T22:19:32.152Z,1717453172.152 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 659 2024-06-03T22:19:32.173Z,1717453172.173 [Depth_Keller] Loaded 2024-06-03T22:19:32.174Z,1717453172.174 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-06-03T22:19:32.238Z,1717453172.238 [NAL9602] Loaded 2024-06-03T22:19:32.238Z,1717453172.238 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-06-03T22:19:32.270Z,1717453172.270 [Onboard] Loaded 2024-06-03T22:19:32.270Z,1717453172.270 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-06-03T22:19:32.271Z,1717453172.271 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4096C4E0 2024-06-03T22:19:32.271Z,1717453172.271 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 660 2024-06-03T22:19:32.284Z,1717453172.284 [Power24vConverter] Loaded 2024-06-03T22:19:32.284Z,1717453172.284 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-06-03T22:19:32.298Z,1717453172.298 [Radio_Surface] Loaded 2024-06-03T22:19:32.298Z,1717453172.298 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-06-03T22:19:32.299Z,1717453172.299 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4099C4E0 2024-06-03T22:19:32.299Z,1717453172.299 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 661 2024-06-03T22:19:32.314Z,1717453172.314 [Sonardyne_Nano] Loaded 2024-06-03T22:19:32.314Z,1717453172.314 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-06-03T22:19:32.408Z,1717453172.408 [DAT] Loaded 2024-06-03T22:19:32.409Z,1717453172.409 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-06-03T22:19:32.410Z,1717453172.410 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409CC4E0 2024-06-03T22:19:32.410Z,1717453172.410 [DAT ThreadHandler](INFO): Protected caller Thread ID is 662 2024-06-03T22:19:32.411Z,1717453172.411 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-06-03T22:19:32.411Z,1717453172.411 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-06-03T22:19:32.508Z,1717453172.508 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-06-03T22:19:32.509Z,1717453172.509 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-06-03T22:19:32.750Z,1717453172.750 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-06-03T22:19:32.752Z,1717453172.752 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-06-03T22:19:32.798Z,1717453172.798 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-06-03T22:19:32.798Z,1717453172.798 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-06-03T22:19:33.037Z,1717453173.037 [CTD_Seabird] Loaded 2024-06-03T22:19:33.038Z,1717453173.038 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-06-03T22:19:33.039Z,1717453173.039 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B0C4E0 2024-06-03T22:19:33.039Z,1717453173.039 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 663 2024-06-03T22:19:33.065Z,1717453173.065 [PAR_Licor] Loaded 2024-06-03T22:19:33.066Z,1717453173.066 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-06-03T22:19:33.111Z,1717453173.111 [WetLabsBB2FL] Loaded 2024-06-03T22:19:33.111Z,1717453173.111 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-06-03T22:19:33.113Z,1717453173.113 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B3C4E0 2024-06-03T22:19:33.113Z,1717453173.113 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 664 2024-06-03T22:19:33.114Z,1717453173.114 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-06-03T22:19:33.114Z,1717453173.114 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-06-03T22:19:33.541Z,1717453173.541 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-06-03T22:19:33.542Z,1717453173.542 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-06-03T22:19:33.719Z,1717453173.719 [SBIT](DEBUG): Construct Startup Built In Test. 2024-06-03T22:19:33.729Z,1717453173.729 [SBIT] Loaded 2024-06-03T22:19:33.730Z,1717453173.730 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-06-03T22:19:33.732Z,1717453173.732 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-06-03T22:19:33.746Z,1717453173.746 [IBIT] Loaded 2024-06-03T22:19:33.746Z,1717453173.746 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-06-03T22:19:33.752Z,1717453173.752 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-06-03T22:19:33.867Z,1717453173.867 [CBIT] Loaded 2024-06-03T22:19:33.867Z,1717453173.867 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-06-03T22:19:33.867Z,1717453173.867 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-06-03T22:19:33.874Z,1717453173.874 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-06-03T22:19:33.877Z,1717453173.877 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-06-03T22:19:33.889Z,1717453173.889 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-06-03T22:19:33.890Z,1717453173.890 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0 2024-06-03T22:19:33.890Z,1717453173.890 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 665 2024-06-03T22:19:33.895Z,1717453173.895 [Supervisor](INFO): Main Thread ID is 571 2024-06-03T22:19:33.895Z,1717453173.895 [Supervisor](DEBUG): Running supervisor. 2024-06-03T22:19:33.896Z,1717453173.896 [CommandExec ThreadHandler](INFO): Handler Thread ID is 666 2024-06-03T22:19:33.896Z,1717453173.896 [CommandExec](INFO): Initializing the command executive. 2024-06-03T22:19:33.898Z,1717453173.898 [CommandLine ThreadHandler](INFO): Handler Thread ID is 667 2024-06-03T22:19:33.900Z,1717453173.900 [controlThread ThreadHandler](INFO): Handler Thread ID is 668 2024-06-03T22:19:33.900Z,1717453173.900 [controlThread](DEBUG): Initializing ControlThread 2024-06-03T22:19:33.901Z,1717453173.901 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-06-03T22:19:33.903Z,1717453173.903 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-06-03T22:19:33.903Z,1717453173.903 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-06-03T22:19:33.904Z,1717453173.904 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-06-03T22:19:33.905Z,1717453173.905 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-06-03T22:19:33.905Z,1717453173.905 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-06-03T22:19:33.905Z,1717453173.905 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-06-03T22:19:33.906Z,1717453173.906 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-06-03T22:19:33.906Z,1717453173.906 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-06-03T22:19:33.907Z,1717453173.907 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-06-03T22:19:33.907Z,1717453173.907 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-06-03T22:19:33.922Z,1717453173.922 [SBIT](INFO): Initialize SBIT Component. 2024-06-03T22:19:33.922Z,1717453173.922 [SBIT](IMPORTANT): git: 2024-04-25 2024-06-03T22:19:33.923Z,1717453173.923 [SBIT](INFO): git hash: 9c8b4752de92409818c57bb73ab755afa5204686 2024-06-03T22:19:33.923Z,1717453173.923 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-06-03T22:19:33.924Z,1717453173.924 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-06-03T22:19:33.925Z,1717453173.925 [SBIT](INFO): Beginning SBIT in 120.000000 seconds. 2024-06-03T22:19:33.926Z,1717453173.926 [IBIT](INFO): Initialize IBIT Component. 2024-06-03T22:19:33.927Z,1717453173.927 [CBIT](DEBUG): Initialize CBIT Component. 2024-06-03T22:19:33.927Z,1717453173.927 [logger ThreadHandler](INFO): Handler Thread ID is 669 2024-06-03T22:19:33.944Z,1717453173.944 [CBIT](DEBUG): Initialized mux pins. 2024-06-03T22:19:33.944Z,1717453173.944 [CBIT](DEBUG): Initializing the watchdog timer. 2024-06-03T22:19:33.945Z,1717453173.945 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 670 2024-06-03T22:19:33.953Z,1717453173.953 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 671 2024-06-03T22:19:33.954Z,1717453173.954 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-06-03T22:19:33.965Z,1717453173.965 [Onboard ThreadHandler](INFO): Handler Thread ID is 672 2024-06-03T22:19:33.969Z,1717453173.969 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-06-03T22:19:33.969Z,1717453173.969 [CBIT](DEBUG): Initializing heartbeat. 2024-06-03T22:19:33.985Z,1717453173.985 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 673 2024-06-03T22:19:34.001Z,1717453174.001 [DAT ThreadHandler](INFO): Handler Thread ID is 674 2024-06-03T22:19:34.002Z,1717453174.002 [DAT](INFO): Powering up 2024-06-03T22:19:34.002Z,1717453174.002 [DAT](DEBUG): Initializing DAT. 2024-06-03T22:19:34.006Z,1717453174.006 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 676 2024-06-03T22:19:34.006Z,1717453174.006 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-06-03T22:19:34.009Z,1717453174.009 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 678 2024-06-03T22:19:34.013Z,1717453174.013 [WetLabsBB2FL](INFO): Powering up 2024-06-03T22:19:34.014Z,1717453174.014 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 680 2024-06-03T22:19:34.026Z,1717453174.026 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-06-03T22:19:34.027Z,1717453174.027 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-06-03T22:19:34.027Z,1717453174.027 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-06-03T22:19:34.027Z,1717453174.027 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-06-03T22:19:34.027Z,1717453174.027 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-06-03T22:19:34.027Z,1717453174.027 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-06-03T22:19:34.027Z,1717453174.027 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-06-03T22:19:34.027Z,1717453174.027 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-06-03T22:19:34.040Z,1717453174.040 [CBIT](DEBUG): Deactivating GF circuits. 2024-06-03T22:19:34.040Z,1717453174.040 [CBIT](DEBUG): Deactivating emergency mode. 2024-06-03T22:19:34.080Z,1717453174.080 [CBIT](DEBUG): Backplane powered. 2024-06-03T22:19:34.081Z,1717453174.081 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-06-03T22:19:34.082Z,1717453174.082 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-06-03T22:19:34.082Z,1717453174.082 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-06-03T22:19:34.089Z,1717453174.089 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-06-03T22:19:34.145Z,1717453174.145 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-06-03T22:19:34.176Z,1717453174.176 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-06-03T22:19:34.196Z,1717453174.196 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-06-03T22:19:34.205Z,1717453174.205 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-06-03T22:19:34.205Z,1717453174.205 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-06-03T22:19:34.209Z,1717453174.209 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-06-03T22:19:34.388Z,1717453174.388 [Radio_Surface](INFO): Powering up 2024-06-03T22:19:34.510Z,1717453174.510 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-06-03T22:19:34.564Z,1717453174.564 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-06-03T22:19:34.565Z,1717453174.565 [Default:A.Wait](DEBUG): Construct Wait. 2024-06-03T22:19:34.568Z,1717453174.568 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-06-03T22:19:34.613Z,1717453174.613 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-06-03T22:19:34.615Z,1717453174.615 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-06-03T22:19:34.642Z,1717453174.642 [Default:E.Execute](DEBUG): Construct Execute. 2024-06-03T22:19:34.653Z,1717453174.653 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-06-03T22:19:34.657Z,1717453174.657 [controlThread](DEBUG): Component order: CycleStarter,BioacousticsDataBridge,BPC1,Depth_Keller,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,MassServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-06-03T22:19:34.783Z,1717453174.783 [Power24vConverter](INFO): Powering up. 2024-06-03T22:19:34.784Z,1717453174.784 [Sonardyne_Nano](INFO): Initializing. 2024-06-03T22:19:34.971Z,1717453174.971 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-06-03T22:19:34.988Z,1717453174.988 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-06-03T22:19:34.989Z,1717453174.989 [MassServo](DEBUG): Initializing EZServoServo. 2024-06-03T22:19:34.996Z,1717453174.996 [MassServo](DEBUG): Initializing MassServo. 2024-06-03T22:19:34.997Z,1717453174.997 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-06-03T22:19:35.004Z,1717453175.004 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-06-03T22:19:39.308Z,1717453179.308 [WetLabsBB2FL] Communications Fault, FailCount= 1 2024-06-03T22:19:39.308Z,1717453179.308 [WetLabsBB2FL](ERROR): Communications Fault 2024-06-03T22:19:39.602Z,1717453179.602 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-06-03T22:19:39.808Z,1717453179.808 [WetLabsBB2FL](INFO): Powering down 2024-06-03T22:19:40.401Z,1717453180.401 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-06-03T22:19:40.948Z,1717453180.948 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-06-03T22:19:40.948Z,1717453180.948 [WetLabsBB2FL] No Fault, FailCount= 1 2024-06-03T22:19:41.026Z,1717453181.026 [WetLabsBB2FL](INFO): Powering up 2024-06-03T22:19:44.104Z,1717453184.104 [CBIT](CRITICAL): Environmental Failure. Press:14.896706 PSI. Humidity:46%. Temp:26 C. ABORTING MISSION 2024-06-03T22:19:44.105Z,1717453184.105 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals 2024-06-03T22:19:44.482Z,1717453184.482 [CommandExec](FAULT): Scheduling is paused 2024-06-03T22:19:44.482Z,1717453184.482 [CBIT](INFO): Critical error at 20240603T221944 2024-06-03T22:19:46.312Z,1717453186.312 [WetLabsBB2FL] Communications Fault, FailCount= 2 2024-06-03T22:19:46.312Z,1717453186.312 [WetLabsBB2FL](ERROR): Communications Fault 2024-06-03T22:19:46.468Z,1717453186.468 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-06-03T22:19:46.816Z,1717453186.816 [WetLabsBB2FL](INFO): Powering down 2024-06-03T22:19:47.056Z,1717453187.056 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-06-03T22:19:47.056Z,1717453187.056 [CTD_Seabird] Communications Fault, FailCount= 1 2024-06-03T22:19:47.056Z,1717453187.056 [CTD_Seabird](ERROR): Communications Fault 2024-06-03T22:19:47.105Z,1717453187.105 [DAT](INFO): DAT read: 2024-06-03T22:19:47.106Z,1717453187.106 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-06-03T22:19:47.236Z,1717453187.236 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-06-03T22:19:47.461Z,1717453187.461 [CTD_Seabird](INFO): Powering down 2024-06-03T22:19:47.755Z,1717453187.755 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005167 2024-06-03T22:19:47.784Z,1717453187.784 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-06-03T22:19:47.784Z,1717453187.784 [WetLabsBB2FL] No Fault, FailCount= 2 2024-06-03T22:19:48.042Z,1717453188.042 [WetLabsBB2FL](INFO): Powering up 2024-06-03T22:19:48.457Z,1717453188.457 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-06-03T22:19:48.457Z,1717453188.457 [CTD_Seabird] No Fault, FailCount= 1 2024-06-03T22:19:48.812Z,1717453188.812 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-06-03T22:19:48.869Z,1717453188.869 [DAT](INFO): DAT read: MF Frequency Band 2024-06-03T22:19:48.871Z,1717453188.871 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-06-03T22:19:48.872Z,1717453188.872 [DAT](INFO): DAT read: May 23 2024 22:15:44 2024-06-03T22:19:49.877Z,1717453189.877 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-06-03T22:19:49.879Z,1717453189.879 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-06-03T22:19:49.879Z,1717453189.879 [DAT](INFO): commRate: 800 2024-06-03T22:19:51.944Z,1717453191.944 [DAT](INFO): entering command mode 2024-06-03T22:19:52.145Z,1717453192.145 [DAT](INFO): DAT read: 2024-06-03T22:19:52.145Z,1717453192.145 [DAT](INFO): DAT read: user:1> 2024-06-03T22:19:52.146Z,1717453192.146 [DAT](INFO): setting verbose to 3 2024-06-03T22:19:52.397Z,1717453192.397 [DAT](INFO): DAT read: user:1> 2024-06-03T22:19:52.398Z,1717453192.398 [DAT](INFO): DAT read: Verbose | 3 2024-06-03T22:19:52.398Z,1717453192.398 [DAT](INFO): set verbose to 3 2024-06-03T22:19:52.399Z,1717453192.399 [DAT](INFO): setting DatVerbose to 27440 2024-06-03T22:19:52.649Z,1717453192.649 [DAT](INFO): DAT read: user:2> 2024-06-03T22:19:52.650Z,1717453192.650 [DAT](INFO): DAT read: DatVerbose | 27440 2024-06-03T22:19:52.650Z,1717453192.650 [DAT](INFO): set DatVerbose to 27440 2024-06-03T22:19:52.650Z,1717453192.650 [DAT](INFO): setting transmit power to 8 2024-06-03T22:19:52.901Z,1717453192.901 [DAT](INFO): DAT read: user:3> 2024-06-03T22:19:52.902Z,1717453192.902 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-06-03T22:19:52.902Z,1717453192.902 [DAT](INFO): set transmit power to 8 2024-06-03T22:19:52.903Z,1717453192.903 [DAT](INFO): setting local address to 12 2024-06-03T22:19:53.153Z,1717453193.153 [DAT](INFO): DAT read: user:4> 2024-06-03T22:19:53.154Z,1717453193.154 [DAT](INFO): DAT read: LocalAddr | 12 2024-06-03T22:19:53.154Z,1717453193.154 [DAT](INFO): set local address to 12 2024-06-03T22:19:53.155Z,1717453193.155 [DAT](INFO): Setting time to: 22:19:53 And date to:6/3/2024 2024-06-03T22:19:53.320Z,1717453193.320 [WetLabsBB2FL] Communications Fault, FailCount= 3 2024-06-03T22:19:53.320Z,1717453193.320 [WetLabsBB2FL](ERROR): Communications Fault 2024-06-03T22:19:53.405Z,1717453193.405 [DAT](INFO): DAT read: user:5> 2024-06-03T22:19:53.406Z,1717453193.406 [DAT](INFO): DAT read: Mon Jun 3, 2024 22:19:53 2024-06-03T22:19:53.406Z,1717453193.406 [DAT](INFO): Local DAT time set to Mon Jun 3, 2024 22:19:53 2024-06-03T22:19:53.712Z,1717453193.712 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-06-03T22:19:53.820Z,1717453193.820 [WetLabsBB2FL](INFO): Powering down 2024-06-03T22:19:54.932Z,1717453194.932 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-06-03T22:19:54.932Z,1717453194.932 [WetLabsBB2FL] No Fault, FailCount= 3 2024-06-03T22:19:55.052Z,1717453195.052 [WetLabsBB2FL](INFO): Powering up 2024-06-03T22:20:00.340Z,1717453200.340 [WetLabsBB2FL] Communications Fault, FailCount= 4 2024-06-03T22:20:00.340Z,1717453200.340 [WetLabsBB2FL](ERROR): Communications Fault 2024-06-03T22:20:00.588Z,1717453200.588 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-06-03T22:20:00.840Z,1717453200.840 [WetLabsBB2FL](INFO): Powering down 2024-06-03T22:20:01.788Z,1717453201.788 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-06-03T22:20:01.788Z,1717453201.788 [WetLabsBB2FL] No Fault, FailCount= 4 2024-06-03T22:20:01.865Z,1717453201.865 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-06-03T22:20:01.865Z,1717453201.865 [CTD_Seabird] Communications Fault, FailCount= 2 2024-06-03T22:20:01.865Z,1717453201.865 [CTD_Seabird](ERROR): Communications Fault 2024-06-03T22:20:02.054Z,1717453202.054 [WetLabsBB2FL](INFO): Powering up 2024-06-03T22:20:02.204Z,1717453202.204 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-06-03T22:20:02.268Z,1717453202.268 [CTD_Seabird](INFO): Powering down 2024-06-03T22:20:02.550Z,1717453202.550 [NAL9602](INFO): Powering up NAL9602 2024-06-03T22:20:03.420Z,1717453203.420 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-06-03T22:20:03.420Z,1717453203.420 [CTD_Seabird] No Fault, FailCount= 2 2024-06-03T22:20:03.612Z,1717453203.612 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-06-03T22:20:07.344Z,1717453207.344 [WetLabsBB2FL] Communications Fault, FailCount= 5 2024-06-03T22:20:07.344Z,1717453207.344 [WetLabsBB2FL](ERROR): Communications Fault 2024-06-03T22:20:07.452Z,1717453207.452 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-06-03T22:20:07.453Z,1717453207.453 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2024-06-03T22:20:07.844Z,1717453207.844 [WetLabsBB2FL](INFO): Powering down 2024-06-03T22:20:13.450Z,1717453213.450 [NAL9602](INFO): NAL9602 initialized 2024-06-03T22:20:16.665Z,1717453216.665 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-06-03T22:20:16.665Z,1717453216.665 [CTD_Seabird] Communications Fault, FailCount= 3 2024-06-03T22:20:16.665Z,1717453216.665 [CTD_Seabird](ERROR): Communications Fault 2024-06-03T22:20:16.729Z,1717453216.729 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-06-03T22:20:16.729Z,1717453216.729 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2024-06-03T22:20:17.068Z,1717453217.068 [CTD_Seabird](INFO): Powering down 2024-06-03T22:21:18.565Z,1717453278.565 [CommandExec](IMPORTANT): got command failComponent 2024-06-03T22:21:18.565Z,1717453278.565 [CommandExec](IMPORTANT): Failed components: 2024-06-03T22:21:18.565Z,1717453278.565 [CommandExec](IMPORTANT): CTD_Seabird: Communications Fault 2024-06-03T22:21:18.565Z,1717453278.565 [CommandExec](IMPORTANT): WetLabsBB2FL: Communications Fault 2024-06-03T22:21:28.449Z,1717453288.449 [CommandExec](IMPORTANT): got command gfscan 2024-06-03T22:21:28.657Z,1717453288.657 [CBIT](IMPORTANT): Beginning ground fault scan 2024-06-03T22:21:34.281Z,1717453294.281 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-06-03T22:21:34.281Z,1717453294.281 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-06-03T22:21:34.281Z,1717453294.281 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T22:21:34.290Z,1717453294.290 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T22:21:34.750Z,1717453294.750 [SBIT](IMPORTANT): Beginning Startup BIT 2024-06-03T22:21:34.754Z,1717453294.754 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T22:21:34.754Z,1717453294.754 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-06-03T22:21:39.570Z,1717453299.570 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.034351 CHAN A1 (24V): -0.005626 CHAN A2 (12V): -0.003189 CHAN A3 (5V): -0.002717 CHAN B0 (3.3V): -0.000851 CHAN B1 (3.15aV): -0.000366 CHAN B2 (3.15bV): -0.001278 CHAN B3 (GND): -0.000525 OPEN: 0.004918 Full Scale: +/- 1 mA 2024-06-03T22:21:48.077Z,1717453308.077 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-06-03T22:21:48.078Z,1717453308.078 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-06-03T22:22:02.609Z,1717453322.609 [CommandExec](IMPORTANT): got command failComponent 2024-06-03T22:22:02.609Z,1717453322.609 [CommandExec](IMPORTANT): Failed components: 2024-06-03T22:22:02.609Z,1717453322.609 [CommandExec](IMPORTANT): CTD_Seabird: Communications Fault 2024-06-03T22:22:02.609Z,1717453322.609 [CommandExec](IMPORTANT): WetLabsBB2FL: Communications Fault 2024-06-03T22:22:14.681Z,1717453334.681 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-06-03T22:22:14.681Z,1717453334.681 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-06-03T22:22:14.681Z,1717453334.681 [SBIT](FAULT): Control surface position failure. 2024-06-03T22:22:28.569Z,1717453348.569 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-06-03T22:22:28.569Z,1717453348.569 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-06-03T22:22:28.569Z,1717453348.569 [SBIT](FAULT): Control surface position failure. 2024-06-03T22:22:28.903Z,1717453348.903 [SBIT](CRITICAL): SBIT FAILED 2024-06-03T22:22:28.903Z,1717453348.903 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-06-03T22:22:28.906Z,1717453348.906 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool; 2024-06-03T22:22:28.906Z,1717453348.906 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count; 2024-06-03T22:22:28.906Z,1717453348.906 [SBIT](IMPORTANT): BuoyancyServo.deviationVolume=1 cubic_centimeter; 2024-06-03T22:22:28.906Z,1717453348.906 [SBIT](IMPORTANT): BuoyancyServo.fastPumpDepth=6 meter; 2024-06-03T22:22:28.906Z,1717453348.906 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=1 bool; 2024-06-03T22:22:28.906Z,1717453348.906 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool; 2024-06-03T22:22:28.906Z,1717453348.906 [SBIT](IMPORTANT): DAT.simulateHardware=0 bool; 2024-06-03T22:22:28.907Z,1717453348.907 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=0 meter; 2024-06-03T22:22:28.907Z,1717453348.907 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-06-03T22:22:28.907Z,1717453348.907 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=10 minute; 2024-06-03T22:22:28.907Z,1717453348.907 [SBIT](IMPORTANT): ElevatorServo.loadAtStartup=0 bool; 2024-06-03T22:22:28.907Z,1717453348.907 [SBIT](IMPORTANT): Express linearApproximation BackseatComponent.handled_message 1.000000 bool; 2024-06-03T22:22:28.907Z,1717453348.907 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_mean_sea_water_temperature 5.000000 celsius; 2024-06-03T22:22:28.907Z,1717453348.907 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity; 2024-06-03T22:22:28.907Z,1717453348.907 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water; 2024-06-03T22:22:28.907Z,1717453348.907 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water; 2024-06-03T22:22:28.908Z,1717453348.908 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 50.000000 meter; 2024-06-03T22:22:28.908Z,1717453348.908 [SBIT](IMPORTANT): Express none platform_roll_angle; 2024-06-03T22:22:28.909Z,1717453348.909 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=0.001 ampere_hour; 2024-06-03T22:22:28.909Z,1717453348.909 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=10 volt; 2024-06-03T22:22:28.909Z,1717453348.909 [SBIT](IMPORTANT): NAL9602.fastGPSFix=1 bool; 2024-06-03T22:22:28.909Z,1717453348.909 [SBIT](IMPORTANT): NAL9602.iridiumMTQueueTimeout=5 minute; 2024-06-03T22:22:28.909Z,1717453348.909 [SBIT](IMPORTANT): RudderServo.loadAtStartup=0 bool; 2024-06-03T22:22:28.909Z,1717453348.909 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=1 bool; 2024-06-03T22:22:28.909Z,1717453348.909 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=90 cubic_centimeter; 2024-06-03T22:22:28.909Z,1717453348.909 [SBIT](IMPORTANT): VerticalControl.elevDeadband=0.1 angular_degree; 2024-06-03T22:22:28.910Z,1717453348.910 [SBIT](IMPORTANT): VerticalControl.kdDepthBuoy=1000 second; 2024-06-03T22:22:28.910Z,1717453348.910 [SBIT](IMPORTANT): VerticalControl.kiDepthBuoy=0.15 reciprocal_second; 2024-06-03T22:22:28.910Z,1717453348.910 [SBIT](IMPORTANT): VerticalControl.kiDepthOff=0.01 meter_per_second; 2024-06-03T22:22:28.910Z,1717453348.910 [SBIT](IMPORTANT): VerticalControl.kpDepthBuoy=120 ratio; 2024-06-03T22:22:28.910Z,1717453348.910 [SBIT](IMPORTANT): VerticalControl.massDefault=-2.5 centimeter; 2024-06-03T22:22:28.913Z,1717453348.913 [CBIT](INFO): Critical error at 20240603T222228 2024-06-03T22:22:29.239Z,1717453349.239 [MissionManager](IMPORTANT): Started mission Startup 2024-06-03T22:22:29.240Z,1717453349.240 [Startup] Running Loop=1 2024-06-03T22:22:29.240Z,1717453349.240 [Startup](DEBUG): Aggregate::initialize Startup 2024-06-03T22:22:29.240Z,1717453349.240 [Startup:A.GoToSurface] Running Loop=1 2024-06-03T22:22:29.240Z,1717453349.240 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-06-03T22:22:29.241Z,1717453349.241 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-06-03T22:22:29.241Z,1717453349.241 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-06-03T22:22:29.241Z,1717453349.241 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-06-03T22:22:29.242Z,1717453349.242 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-06-03T22:22:29.242Z,1717453349.242 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-06-03T22:22:29.245Z,1717453349.245 [Startup:StartupSatComms] Running Loop=1 2024-06-03T22:22:29.245Z,1717453349.245 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-06-03T22:22:29.245Z,1717453349.245 [Startup:StartupSatComms:A] Running Loop=1 2024-06-03T22:22:29.653Z,1717453349.653 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-06-03T22:22:37.730Z,1717453357.730 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-06-03T22:22:37.730Z,1717453357.730 [WetLabsBB2FL] No Fault, FailCount= 5 2024-06-03T22:22:37.798Z,1717453357.798 [WetLabsBB2FL](INFO): Powering up 2024-06-03T22:22:43.092Z,1717453363.092 [WetLabsBB2FL] Communications Fault, FailCount= 1 2024-06-03T22:22:43.092Z,1717453363.092 [WetLabsBB2FL](ERROR): Communications Fault 2024-06-03T22:22:43.398Z,1717453363.398 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-06-03T22:22:43.592Z,1717453363.592 [WetLabsBB2FL](INFO): Powering down 2024-06-03T22:22:44.590Z,1717453364.590 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-06-03T22:22:44.590Z,1717453364.590 [WetLabsBB2FL] No Fault, FailCount= 1 2024-06-03T22:22:44.806Z,1717453364.806 [WetLabsBB2FL](INFO): Powering up 2024-06-03T22:22:47.012Z,1717453367.012 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-06-03T22:22:47.013Z,1717453367.013 [CTD_Seabird] No Fault, FailCount= 3 2024-06-03T22:22:47.124Z,1717453367.124 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-06-03T22:22:50.108Z,1717453370.108 [WetLabsBB2FL] Communications Fault, FailCount= 2 2024-06-03T22:22:50.108Z,1717453370.108 [WetLabsBB2FL](ERROR): Communications Fault 2024-06-03T22:22:50.251Z,1717453370.251 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-06-03T22:22:50.541Z,1717453370.541 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15 degree 2024-06-03T22:22:50.545Z,1717453370.545 [ComponentRegistry](DEBUG): SyncComponent "Maintain_HorizontalControl.rudderAngleAction" handled in the control thread. 2024-06-03T22:22:50.608Z,1717453370.608 [WetLabsBB2FL](INFO): Powering down 2024-06-03T22:22:50.678Z,1717453370.678 [controlThread](DEBUG): Component order: CycleStarter,BioacousticsDataBridge,BPC1,Depth_Keller,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_HorizontalControl.rudderAngleAction,BuoyancyServo,MassServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-06-03T22:22:51.448Z,1717453371.448 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-06-03T22:22:51.448Z,1717453371.448 [WetLabsBB2FL] No Fault, FailCount= 2 2024-06-03T22:22:51.845Z,1717453371.845 [WetLabsBB2FL](INFO): Powering up 2024-06-03T22:22:57.136Z,1717453377.136 [WetLabsBB2FL] Communications Fault, FailCount= 3 2024-06-03T22:22:57.136Z,1717453377.136 [WetLabsBB2FL](ERROR): Communications Fault 2024-06-03T22:22:57.510Z,1717453377.510 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-06-03T22:22:57.637Z,1717453377.637 [WetLabsBB2FL](INFO): Powering down 2024-06-03T22:22:58.738Z,1717453378.738 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-06-03T22:22:58.738Z,1717453378.738 [WetLabsBB2FL] No Fault, FailCount= 3 2024-06-03T22:22:58.850Z,1717453378.850 [WetLabsBB2FL](INFO): Powering up 2024-06-03T22:23:00.176Z,1717453380.176 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-06-03T22:23:00.176Z,1717453380.176 [CTD_Seabird] Communications Fault, FailCount= 1 2024-06-03T22:23:00.176Z,1717453380.176 [CTD_Seabird](ERROR): Communications Fault 2024-06-03T22:23:00.341Z,1717453380.341 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-06-03T22:23:00.580Z,1717453380.580 [CTD_Seabird](INFO): Powering down 2024-06-03T22:23:01.553Z,1717453381.553 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-06-03T22:23:01.553Z,1717453381.553 [CTD_Seabird] No Fault, FailCount= 1 2024-06-03T22:23:01.928Z,1717453381.928 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-06-03T22:23:04.144Z,1717453384.144 [WetLabsBB2FL] Communications Fault, FailCount= 4 2024-06-03T22:23:04.144Z,1717453384.144 [WetLabsBB2FL](ERROR): Communications Fault 2024-06-03T22:23:04.407Z,1717453384.407 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-06-03T22:23:04.644Z,1717453384.644 [WetLabsBB2FL](INFO): Powering down 2024-06-03T22:23:05.607Z,1717453385.607 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-06-03T22:23:05.607Z,1717453385.607 [WetLabsBB2FL] No Fault, FailCount= 4 2024-06-03T22:23:05.858Z,1717453385.858 [WetLabsBB2FL](INFO): Powering up 2024-06-03T22:23:11.148Z,1717453391.148 [WetLabsBB2FL] Communications Fault, FailCount= 5 2024-06-03T22:23:11.148Z,1717453391.148 [WetLabsBB2FL](ERROR): Communications Fault 2024-06-03T22:23:11.266Z,1717453391.266 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-06-03T22:23:11.266Z,1717453391.266 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2024-06-03T22:23:11.648Z,1717453391.648 [WetLabsBB2FL](INFO): Powering down 2024-06-03T22:23:14.980Z,1717453394.980 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-06-03T22:23:14.980Z,1717453394.980 [CTD_Seabird] Communications Fault, FailCount= 2 2024-06-03T22:23:14.980Z,1717453394.980 [CTD_Seabird](ERROR): Communications Fault 2024-06-03T22:23:15.302Z,1717453395.302 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-06-03T22:23:15.384Z,1717453395.384 [CTD_Seabird](INFO): Powering down 2024-06-03T22:23:16.502Z,1717453396.502 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-06-03T22:23:16.502Z,1717453396.502 [CTD_Seabird] No Fault, FailCount= 2 2024-06-03T22:23:16.728Z,1717453396.728 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-06-03T22:23:29.418Z,1717453409.418 [Startup:StartupSatComms:A](INFO): Timed out from 2024-06-03T22:22:29.2Z 2024-06-03T22:23:29.418Z,1717453409.418 [Startup:StartupSatComms:A] Stopped 2024-06-03T22:23:29.418Z,1717453409.418 [Startup:StartupSatComms:B] Running Loop=1 2024-06-03T22:23:29.780Z,1717453409.780 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-06-03T22:23:29.780Z,1717453409.780 [CTD_Seabird] Communications Fault, FailCount= 3 2024-06-03T22:23:29.780Z,1717453409.780 [CTD_Seabird](ERROR): Communications Fault 2024-06-03T22:23:29.846Z,1717453409.846 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-06-03T22:23:29.880Z,1717453409.880 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-06-03T22:23:29.881Z,1717453409.881 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2024-06-03T22:23:30.185Z,1717453410.185 [CTD_Seabird](INFO): Powering down 2024-06-03T22:23:35.215Z,1717453415.215 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-06-03T22:23:35.215Z,1717453415.215 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-06-03T22:23:35.215Z,1717453415.215 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T22:23:35.284Z,1717453415.284 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T22:23:35.952Z,1717453415.952 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T22:23:35.953Z,1717453415.953 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-06-03T22:23:37.081Z,1717453417.081 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15 degree 2024-06-03T22:23:38.731Z,1717453418.731 [DataOverHttps](INFO): Sending 204 bytes from file Logs/20240428T022833/Courier0687.lzma 2024-06-03T22:23:39.730Z,1717453419.730 [DataOverHttps](INFO): Moved sent file to Logs/20240428T022833/Courier0687.lzma.bak 2024-06-03T22:23:39.731Z,1717453419.731 [DataOverHttps](INFO): SBD MOMSN=21113022 2024-06-03T22:24:04.495Z,1717453444.495 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 0 degree 2024-06-03T22:24:08.162Z,1717453448.162 [DataOverHttps](INFO): Sending 103 bytes from file Logs/20240428T022833/Courier0690.lzma 2024-06-03T22:24:09.162Z,1717453449.162 [DataOverHttps](INFO): Moved sent file to Logs/20240428T022833/Courier0690.lzma.bak 2024-06-03T22:24:09.162Z,1717453449.162 [DataOverHttps](INFO): SBD MOMSN=21113027 2024-06-03T22:24:26.729Z,1717453466.729 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20240428T022833/Courier0693.lzma 2024-06-03T22:24:27.730Z,1717453467.730 [DataOverHttps](INFO): Moved sent file to Logs/20240428T022833/Courier0693.lzma.bak 2024-06-03T22:24:27.730Z,1717453467.730 [DataOverHttps](INFO): SBD MOMSN=21113030 2024-06-03T22:24:29.735Z,1717453469.735 [Startup:StartupSatComms:B](INFO): Timed out from 2024-06-03T22:23:29.4Z 2024-06-03T22:24:29.735Z,1717453469.735 [Startup:StartupSatComms:B] Stopped 2024-06-03T22:24:29.735Z,1717453469.735 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-06-03T22:24:29.735Z,1717453469.735 [Startup:StartupSatComms] Stopped 2024-06-03T22:24:29.736Z,1717453469.736 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-06-03T22:24:29.737Z,1717453469.737 [Startup](INFO): Completed Startup 2024-06-03T22:24:29.737Z,1717453469.737 [MissionManager](INFO): Startup is completed. 2024-06-03T22:24:29.737Z,1717453469.737 [MissionManager](INFO): Uninitializing Mission Startup 2024-06-03T22:24:29.737Z,1717453469.737 [Startup] Stopped 2024-06-03T22:24:29.737Z,1717453469.737 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-06-03T22:24:29.737Z,1717453469.737 [Startup:A.GoToSurface] Stopped 2024-06-03T22:24:29.737Z,1717453469.737 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-06-03T22:24:30.145Z,1717453470.145 [MissionManager](IMPORTANT): Started mission Default 2024-06-03T22:24:30.146Z,1717453470.146 [Default] Running Loop=1 2024-06-03T22:24:30.146Z,1717453470.146 [Default](DEBUG): Aggregate::initialize Default 2024-06-03T22:24:30.146Z,1717453470.146 [Default:B.GoToSurface] Running Loop=1 2024-06-03T22:24:30.146Z,1717453470.146 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-06-03T22:24:30.146Z,1717453470.146 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-06-03T22:24:30.147Z,1717453470.147 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-06-03T22:24:30.147Z,1717453470.147 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-06-03T22:24:30.147Z,1717453470.147 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-06-03T22:24:30.147Z,1717453470.147 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-06-03T22:24:30.148Z,1717453470.148 [Default:A.Wait] Running Loop=1 2024-06-03T22:24:30.148Z,1717453470.148 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-06-03T22:24:32.535Z,1717453472.535 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-03T22:24:39.403Z,1717453479.403 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-03T22:24:40.409Z,1717453480.409 [CommandExec](IMPORTANT): got command failComponent 2024-06-03T22:24:40.409Z,1717453480.409 [CommandExec](IMPORTANT): Failed components: 2024-06-03T22:24:40.409Z,1717453480.409 [CommandExec](IMPORTANT): CTD_Seabird: Communications Fault 2024-06-03T22:24:40.409Z,1717453480.409 [CommandExec](IMPORTANT): WetLabsBB2FL: Communications Fault 2024-06-03T22:24:43.481Z,1717453483.481 [Default:A.Wait](INFO): Done Waiting. 2024-06-03T22:24:43.481Z,1717453483.481 [Default:A.Wait] Stopped 2024-06-03T22:24:43.481Z,1717453483.481 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-06-03T22:24:43.878Z,1717453483.878 [Default:CheckIn] Running Loop=1 2024-06-03T22:24:43.878Z,1717453483.878 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-03T22:24:43.878Z,1717453483.878 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-03T22:24:44.294Z,1717453484.294 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-06-03T22:24:55.159Z,1717453495.159 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-03T22:24:55.683Z,1717453495.683 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15 degree 2024-06-03T22:25:03.697Z,1717453503.697 [CommandExec](IMPORTANT): got command restart application 2024-06-03T22:25:04.700Z,1717453504.700 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T22:25:04.700Z,1717453504.700 [CommandExec](INFO): Uninitializing the command executive. 2024-06-03T22:25:04.700Z,1717453504.700 [CommandExec](INFO): Uninitializing the command scheduler. 2024-06-03T22:25:04.701Z,1717453504.701 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:04.840Z,1717453504.840 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-06-03T22:25:04.840Z,1717453504.840 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-06-03T22:25:04.840Z,1717453504.840 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:04.841Z,1717453504.841 [NavChartDb](INFO): Join timeout helper Thread ID is 711 2024-06-03T22:25:05.036Z,1717453505.036 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T22:25:05.036Z,1717453505.036 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:05.040Z,1717453505.040 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-06-03T22:25:05.040Z,1717453505.040 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:05.041Z,1717453505.041 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 712 2024-06-03T22:25:05.176Z,1717453505.176 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T22:25:05.177Z,1717453505.177 [WetLabsBB2FL](INFO): Powering down 2024-06-03T22:25:05.177Z,1717453505.177 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:05.180Z,1717453505.180 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-06-03T22:25:05.180Z,1717453505.180 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:05.181Z,1717453505.181 [CTD_Seabird](INFO): Join timeout helper Thread ID is 713 2024-06-03T22:25:05.264Z,1717453505.264 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T22:25:05.264Z,1717453505.264 [CTD_Seabird](INFO): Powering down 2024-06-03T22:25:05.276Z,1717453505.276 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:05.285Z,1717453505.285 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-06-03T22:25:05.285Z,1717453505.285 [DAT ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:05.286Z,1717453505.286 [DAT](INFO): Join timeout helper Thread ID is 714 2024-06-03T22:25:05.332Z,1717453505.332 [DAT](INFO): Powering down 2024-06-03T22:25:05.405Z,1717453505.405 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T22:25:05.405Z,1717453505.405 [DAT](INFO): Powering down 2024-06-03T22:25:05.406Z,1717453505.406 [DAT ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:05.416Z,1717453505.416 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-06-03T22:25:05.416Z,1717453505.416 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:05.417Z,1717453505.417 [Radio_Surface](INFO): Join timeout helper Thread ID is 715 2024-06-03T22:25:05.768Z,1717453505.768 [Radio_Surface](INFO): Powering down 2024-06-03T22:25:05.769Z,1717453505.769 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T22:25:05.769Z,1717453505.769 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:05.773Z,1717453505.773 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-06-03T22:25:05.773Z,1717453505.773 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:05.773Z,1717453505.773 [Onboard](INFO): Join timeout helper Thread ID is 716 2024-06-03T22:25:06.100Z,1717453506.100 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-06-03T22:25:09.256Z,1717453509.256 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T22:25:09.257Z,1717453509.257 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:09.277Z,1717453509.277 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-06-03T22:25:09.277Z,1717453509.277 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:09.277Z,1717453509.277 [DataOverHttps](INFO): Join timeout helper Thread ID is 717 2024-06-03T22:25:10.116Z,1717453510.116 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T22:25:10.117Z,1717453510.117 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.137Z,1717453510.137 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-06-03T22:25:10.137Z,1717453510.137 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.137Z,1717453510.137 [BackseatComponent](INFO): Join timeout helper Thread ID is 718 2024-06-03T22:25:10.292Z,1717453510.292 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T22:25:10.293Z,1717453510.293 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.301Z,1717453510.301 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-06-03T22:25:10.301Z,1717453510.301 [logger ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.301Z,1717453510.301 [logger](INFO): Join timeout helper Thread ID is 719 2024-06-03T22:25:10.328Z,1717453510.328 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T22:25:10.328Z,1717453510.328 [logger ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.341Z,1717453510.341 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-06-03T22:25:10.341Z,1717453510.341 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.341Z,1717453510.341 [CommandLine](INFO): Join timeout helper Thread ID is 720 2024-06-03T22:25:10.376Z,1717453510.376 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T22:25:10.377Z,1717453510.377 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.381Z,1717453510.381 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-06-03T22:25:10.381Z,1717453510.381 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.381Z,1717453510.381 [CommandExec](INFO): Join timeout helper Thread ID is 721 2024-06-03T22:25:10.382Z,1717453510.382 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-06-03T22:25:10.383Z,1717453510.383 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.383Z,1717453510.383 [controlThread](INFO): Join timeout helper Thread ID is 722 2024-06-03T22:25:10.504Z,1717453510.504 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T22:25:10.505Z,1717453510.505 [controlThread](DEBUG): Uninitializing ControlThread 2024-06-03T22:25:10.506Z,1717453510.506 [NAL9602](INFO): Powering down 2024-06-03T22:25:10.507Z,1717453510.507 [Sonardyne_Nano](INFO): Powering down 2024-06-03T22:25:10.629Z,1717453510.629 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-06-03T22:25:10.630Z,1717453510.630 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-06-03T22:25:10.630Z,1717453510.630 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-06-03T22:25:10.631Z,1717453510.631 [MissionManager](INFO): Uninitializing Mission Default 2024-06-03T22:25:10.631Z,1717453510.631 [Default] Stopped 2024-06-03T22:25:10.631Z,1717453510.631 [Default](DEBUG): Aggregate::uninitialize Default 2024-06-03T22:25:10.631Z,1717453510.631 [Default:B.GoToSurface] Stopped 2024-06-03T22:25:10.631Z,1717453510.631 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-06-03T22:25:10.631Z,1717453510.631 [Default:CheckIn] Stopped 2024-06-03T22:25:10.631Z,1717453510.631 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-03T22:25:10.631Z,1717453510.631 [Default:CheckIn:Read_GPS] Stopped 2024-06-03T22:25:10.634Z,1717453510.634 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-06-03T22:25:10.635Z,1717453510.635 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-06-03T22:25:10.635Z,1717453510.635 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-06-03T22:25:10.635Z,1717453510.635 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-06-03T22:25:10.636Z,1717453510.636 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-06-03T22:25:10.636Z,1717453510.636 [BuoyancyServo](INFO): Powering down 2024-06-03T22:25:10.648Z,1717453510.648 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-06-03T22:25:10.648Z,1717453510.648 [MassServo](INFO): Powering down 2024-06-03T22:25:10.649Z,1717453510.649 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-06-03T22:25:10.649Z,1717453510.649 [ThrusterHE](INFO): Powering down 2024-06-03T22:25:10.650Z,1717453510.650 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-06-03T22:25:10.650Z,1717453510.650 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-06-03T22:25:10.651Z,1717453510.651 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-06-03T22:25:10.651Z,1717453510.651 [CBIT](DEBUG): Powering off loads. 2024-06-03T22:25:10.664Z,1717453510.664 [CBIT](DEBUG): Disabling WDT. 2024-06-03T22:25:10.676Z,1717453510.676 [CBIT](DEBUG): Opening all GF detection circuits. 2024-06-03T22:25:10.677Z,1717453510.677 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.721Z,1717453510.721 [DAT ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.727Z,1717453510.727 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.729Z,1717453510.729 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.735Z,1717453510.735 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.780Z,1717453510.780 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.817Z,1717453510.817 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.821Z,1717453510.821 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.855Z,1717453510.855 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-06-03T22:25:10.922Z,1717453510.922 [logger ThreadHandler](INFO): Thread cancelled.