2022-08-02T22:03:55.936Z,1659477835.936 [Supervisor](DEBUG): Initializing supervisor. 2022-08-02T22:03:55.940Z,1659477835.940 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2022-08-02T22:03:55.941Z,1659477835.941 [SyncHandler](INFO): Protected caller Thread ID is 832 2022-08-02T22:03:55.941Z,1659477835.941 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2022-08-02T22:03:55.942Z,1659477835.942 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2022-08-02T22:03:55.942Z,1659477835.942 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 833 2022-08-02T22:03:55.946Z,1659477835.946 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2022-08-02T22:03:55.964Z,1659477835.964 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2022-08-02T22:03:55.965Z,1659477835.965 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2022-08-02T22:03:55.965Z,1659477835.965 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 834 2022-08-02T22:03:55.969Z,1659477835.969 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2022-08-02T22:03:55.970Z,1659477835.970 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2022-08-02T22:03:55.971Z,1659477835.971 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 835 2022-08-02T22:03:55.973Z,1659477835.973 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2022-08-02T22:03:55.974Z,1659477835.974 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2022-08-02T22:03:55.974Z,1659477835.974 [logger ThreadHandler](INFO): Protected caller Thread ID is 836 2022-08-02T22:03:55.978Z,1659477835.978 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2022-08-02T22:03:55.978Z,1659477835.978 [Supervisor](INFO): Looking for Config files in directory: Config/ 2022-08-02T22:03:55.981Z,1659477835.981 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2022-08-02T22:03:56.285Z,1659477836.285 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2022-08-02T22:03:56.287Z,1659477836.287 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2022-08-02T22:03:56.916Z,1659477836.916 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2022-08-02T22:03:56.917Z,1659477836.917 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2022-08-02T22:03:57.025Z,1659477837.025 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2022-08-02T22:03:57.027Z,1659477837.027 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2022-08-02T22:03:57.505Z,1659477837.505 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2022-08-02T22:03:57.507Z,1659477837.507 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2022-08-02T22:03:57.602Z,1659477837.602 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2022-08-02T22:03:57.604Z,1659477837.604 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2022-08-02T22:03:57.685Z,1659477837.685 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2022-08-02T22:03:58.043Z,1659477838.043 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2022-08-02T22:03:58.044Z,1659477838.044 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2022-08-02T22:03:58.259Z,1659477838.259 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2022-08-02T22:03:58.261Z,1659477838.261 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2022-08-02T22:03:58.395Z,1659477838.395 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2022-08-02T22:03:58.396Z,1659477838.396 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2022-08-02T22:03:58.619Z,1659477838.619 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2022-08-02T22:03:58.620Z,1659477838.620 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2022-08-02T22:03:59.094Z,1659477839.094 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2022-08-02T22:03:59.096Z,1659477839.096 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2022-08-02T22:03:59.487Z,1659477839.487 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2022-08-02T22:03:59.490Z,1659477839.490 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2022-08-02T22:04:00.027Z,1659477840.027 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2022-08-02T22:04:00.411Z,1659477840.411 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2022-08-02T22:04:00.411Z,1659477840.411 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2022-08-02T22:04:00.621Z,1659477840.621 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2022-08-02T22:04:00.622Z,1659477840.622 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2022-08-02T22:04:00.901Z,1659477840.901 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2022-08-02T22:04:00.903Z,1659477840.903 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/ 2022-08-02T22:04:00.908Z,1659477840.908 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg 2022-08-02T22:04:01.017Z,1659477841.017 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg 2022-08-02T22:04:01.164Z,1659477841.164 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg 2022-08-02T22:04:01.252Z,1659477841.252 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg 2022-08-02T22:04:01.335Z,1659477841.335 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg 2022-08-02T22:04:01.448Z,1659477841.448 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg 2022-08-02T22:04:01.624Z,1659477841.624 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg 2022-08-02T22:04:01.884Z,1659477841.884 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2022-08-02T22:04:01.885Z,1659477841.885 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg 2022-08-02T22:04:02.012Z,1659477842.012 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg 2022-08-02T22:04:02.105Z,1659477842.105 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg 2022-08-02T22:04:02.208Z,1659477842.208 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg 2022-08-02T22:04:02.305Z,1659477842.305 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2022-08-02T22:04:02.309Z,1659477842.309 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2022-08-02T22:04:02.428Z,1659477842.428 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2022-08-02T22:04:02.429Z,1659477842.429 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2022-08-02T22:04:02.445Z,1659477842.445 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2022-08-02T22:04:02.445Z,1659477842.445 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2022-08-02T22:04:02.514Z,1659477842.514 [DepthRateCalculator] Loaded 2022-08-02T22:04:02.514Z,1659477842.514 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2022-08-02T22:04:02.520Z,1659477842.520 [PitchRateCalculator] Loaded 2022-08-02T22:04:02.520Z,1659477842.520 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2022-08-02T22:04:02.531Z,1659477842.531 [SpeedCalculator] Loaded 2022-08-02T22:04:02.531Z,1659477842.531 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2022-08-02T22:04:02.536Z,1659477842.536 [YawRateCalculator] Loaded 2022-08-02T22:04:02.536Z,1659477842.536 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2022-08-02T22:04:02.557Z,1659477842.557 [ElevatorOffsetCalculator] Loaded 2022-08-02T22:04:02.557Z,1659477842.557 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2022-08-02T22:04:02.558Z,1659477842.558 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2022-08-02T22:04:02.558Z,1659477842.558 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2022-08-02T22:04:02.626Z,1659477842.626 [VerticalControl](DEBUG): Construct VerticalControl. 2022-08-02T22:04:02.681Z,1659477842.681 [VerticalControl] Loaded 2022-08-02T22:04:02.681Z,1659477842.681 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2022-08-02T22:04:02.684Z,1659477842.684 [HorizontalControl](DEBUG): Construct HorizontalControl. 2022-08-02T22:04:02.725Z,1659477842.725 [HorizontalControl] Loaded 2022-08-02T22:04:02.725Z,1659477842.725 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2022-08-02T22:04:02.727Z,1659477842.727 [SpeedControl](DEBUG): Construct SpeedControl. 2022-08-02T22:04:02.730Z,1659477842.730 [SpeedControl] Loaded 2022-08-02T22:04:02.730Z,1659477842.730 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2022-08-02T22:04:02.733Z,1659477842.733 [LoopControl](DEBUG): Construct LoopControl. 2022-08-02T22:04:02.733Z,1659477842.733 [LoopControl] Loaded 2022-08-02T22:04:02.733Z,1659477842.733 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2022-08-02T22:04:02.734Z,1659477842.734 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2022-08-02T22:04:02.735Z,1659477842.735 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2022-08-02T22:04:02.869Z,1659477842.869 [DeadReckonUsingMultipleVelocitySources] Loaded 2022-08-02T22:04:02.869Z,1659477842.869 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2022-08-02T22:04:02.883Z,1659477842.883 [NavChart] Loaded 2022-08-02T22:04:02.883Z,1659477842.883 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2022-08-02T22:04:02.889Z,1659477842.889 [UniversalFixResidualReporter] Loaded 2022-08-02T22:04:02.889Z,1659477842.889 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2022-08-02T22:04:02.890Z,1659477842.890 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2022-08-02T22:04:02.890Z,1659477842.890 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2022-08-02T22:04:03.071Z,1659477843.071 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2022-08-02T22:04:03.071Z,1659477843.071 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2022-08-02T22:04:03.794Z,1659477843.794 [AHRS_M2] Loaded 2022-08-02T22:04:03.794Z,1659477843.794 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2022-08-02T22:04:04.043Z,1659477844.043 [BackseatComponent] Loaded 2022-08-02T22:04:04.043Z,1659477844.043 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2022-08-02T22:04:04.045Z,1659477844.045 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408E34E0 2022-08-02T22:04:04.045Z,1659477844.045 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 918 2022-08-02T22:04:04.048Z,1659477844.048 [LcmUniversalReporter] Loaded 2022-08-02T22:04:04.048Z,1659477844.048 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2022-08-02T22:04:04.248Z,1659477844.248 [DataOverHttps] Loaded 2022-08-02T22:04:04.248Z,1659477844.248 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2022-08-02T22:04:04.263Z,1659477844.263 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409134E0 2022-08-02T22:04:04.264Z,1659477844.264 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 919 2022-08-02T22:04:04.304Z,1659477844.304 [Depth_Keller] Loaded 2022-08-02T22:04:04.304Z,1659477844.304 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2022-08-02T22:04:04.309Z,1659477844.309 [DropWeight] Loaded 2022-08-02T22:04:04.310Z,1659477844.310 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2022-08-02T22:04:04.596Z,1659477844.596 [DVL_micro] Loaded 2022-08-02T22:04:04.596Z,1659477844.596 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2022-08-02T22:04:04.825Z,1659477844.825 [NAL9602] Loaded 2022-08-02T22:04:04.825Z,1659477844.825 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2022-08-02T22:04:04.968Z,1659477844.968 [Onboard] Loaded 2022-08-02T22:04:04.968Z,1659477844.968 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2022-08-02T22:04:04.969Z,1659477844.969 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409434E0 2022-08-02T22:04:04.969Z,1659477844.969 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 920 2022-08-02T22:04:04.994Z,1659477844.994 [Power24vConverter] Loaded 2022-08-02T22:04:04.994Z,1659477844.994 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2022-08-02T22:04:05.030Z,1659477845.030 [Radio_Surface] Loaded 2022-08-02T22:04:05.030Z,1659477845.030 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2022-08-02T22:04:05.031Z,1659477845.031 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409734E0 2022-08-02T22:04:05.031Z,1659477845.031 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 921 2022-08-02T22:04:05.155Z,1659477845.155 [DAT] Loaded 2022-08-02T22:04:05.155Z,1659477845.155 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2022-08-02T22:04:05.156Z,1659477845.156 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409A34E0 2022-08-02T22:04:05.156Z,1659477845.156 [DAT ThreadHandler](INFO): Protected caller Thread ID is 922 2022-08-02T22:04:05.157Z,1659477845.157 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2022-08-02T22:04:05.157Z,1659477845.157 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2022-08-02T22:04:05.434Z,1659477845.434 [BuoyancyServo] Loaded 2022-08-02T22:04:05.435Z,1659477845.435 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2022-08-02T22:04:05.455Z,1659477845.455 [ElevatorServo] Loaded 2022-08-02T22:04:05.455Z,1659477845.455 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2022-08-02T22:04:05.474Z,1659477845.474 [MassServo] Loaded 2022-08-02T22:04:05.475Z,1659477845.475 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2022-08-02T22:04:05.493Z,1659477845.493 [RudderServo] Loaded 2022-08-02T22:04:05.493Z,1659477845.493 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2022-08-02T22:04:05.508Z,1659477845.508 [ThrusterHE] Loaded 2022-08-02T22:04:05.508Z,1659477845.508 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2022-08-02T22:04:05.509Z,1659477845.509 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2022-08-02T22:04:05.509Z,1659477845.509 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2022-08-02T22:04:05.590Z,1659477845.590 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2022-08-02T22:04:05.591Z,1659477845.591 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2022-08-02T22:04:05.632Z,1659477845.632 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2022-08-02T22:04:05.633Z,1659477845.633 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2022-08-02T22:04:05.993Z,1659477845.993 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2022-08-02T22:04:05.993Z,1659477845.993 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2022-08-02T22:04:06.206Z,1659477846.206 [CTD_Seabird] Loaded 2022-08-02T22:04:06.207Z,1659477846.207 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2022-08-02T22:04:06.208Z,1659477846.208 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B2F4E0 2022-08-02T22:04:06.208Z,1659477846.208 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 923 2022-08-02T22:04:06.241Z,1659477846.241 [ESPComponent] Loaded 2022-08-02T22:04:06.241Z,1659477846.241 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2022-08-02T22:04:06.261Z,1659477846.261 [PAR_Licor] Loaded 2022-08-02T22:04:06.261Z,1659477846.261 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2022-08-02T22:04:06.291Z,1659477846.291 [WetLabsBB2FL] Loaded 2022-08-02T22:04:06.292Z,1659477846.292 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2022-08-02T22:04:06.293Z,1659477846.293 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B5F4E0 2022-08-02T22:04:06.293Z,1659477846.293 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 924 2022-08-02T22:04:06.294Z,1659477846.294 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2022-08-02T22:04:06.296Z,1659477846.296 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2022-08-02T22:04:06.460Z,1659477846.460 [SBIT](DEBUG): Construct Startup Built In Test. 2022-08-02T22:04:06.469Z,1659477846.469 [SBIT] Loaded 2022-08-02T22:04:06.470Z,1659477846.470 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2022-08-02T22:04:06.473Z,1659477846.473 [IBIT](DEBUG): Construct Initiated Built In Test. 2022-08-02T22:04:06.486Z,1659477846.486 [IBIT] Loaded 2022-08-02T22:04:06.486Z,1659477846.486 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2022-08-02T22:04:06.492Z,1659477846.492 [CBIT](DEBUG): Construct Continuous Built In Test. 2022-08-02T22:04:06.716Z,1659477846.716 [CBIT] Loaded 2022-08-02T22:04:06.716Z,1659477846.716 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2022-08-02T22:04:06.717Z,1659477846.717 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2022-08-02T22:04:06.723Z,1659477846.723 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2022-08-02T22:04:06.725Z,1659477846.725 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2022-08-02T22:04:06.736Z,1659477846.736 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2022-08-02T22:04:06.737Z,1659477846.737 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BCD4E0 2022-08-02T22:04:06.738Z,1659477846.738 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 925 2022-08-02T22:04:06.742Z,1659477846.742 [Supervisor](INFO): Main Thread ID is 828 2022-08-02T22:04:06.742Z,1659477846.742 [Supervisor](DEBUG): Running supervisor. 2022-08-02T22:04:06.743Z,1659477846.743 [CommandExec ThreadHandler](INFO): Handler Thread ID is 926 2022-08-02T22:04:06.744Z,1659477846.744 [CommandExec](INFO): Initializing the command executive. 2022-08-02T22:04:06.745Z,1659477846.745 [CommandLine ThreadHandler](INFO): Handler Thread ID is 927 2022-08-02T22:04:06.747Z,1659477846.747 [controlThread ThreadHandler](INFO): Handler Thread ID is 928 2022-08-02T22:04:06.748Z,1659477846.748 [controlThread](DEBUG): Initializing ControlThread 2022-08-02T22:04:06.748Z,1659477846.748 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2022-08-02T22:04:06.749Z,1659477846.749 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2022-08-02T22:04:06.749Z,1659477846.749 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2022-08-02T22:04:06.750Z,1659477846.750 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2022-08-02T22:04:06.750Z,1659477846.750 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2022-08-02T22:04:06.750Z,1659477846.750 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2022-08-02T22:04:06.752Z,1659477846.752 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2022-08-02T22:04:06.753Z,1659477846.753 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2022-08-02T22:04:06.753Z,1659477846.753 [LoopControl](DEBUG): Initialize LoopControlComponent. 2022-08-02T22:04:06.754Z,1659477846.754 [NavChart](DEBUG): Initialize NavChart Navigation. 2022-08-02T22:04:06.755Z,1659477846.755 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2022-08-02T22:04:06.764Z,1659477846.764 [SBIT](INFO): Initialize SBIT Component. 2022-08-02T22:04:06.765Z,1659477846.765 [SBIT](IMPORTANT): git: 2022-07-12 2022-08-02T22:04:06.765Z,1659477846.765 [SBIT](INFO): git hash: 408c10c89e37b6415b142bbb9b5f0322e6ebba66 2022-08-02T22:04:06.765Z,1659477846.765 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2022-08-02T22:04:06.766Z,1659477846.766 [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 2022-08-02T22:04:06.767Z,1659477846.767 [SBIT](INFO): Beginning SBIT in 39.000000 seconds. 2022-08-02T22:04:06.768Z,1659477846.768 [IBIT](INFO): Initialize IBIT Component. 2022-08-02T22:04:06.769Z,1659477846.769 [CBIT](DEBUG): Initialize CBIT Component. 2022-08-02T22:04:06.770Z,1659477846.770 [logger ThreadHandler](INFO): Handler Thread ID is 929 2022-08-02T22:04:06.780Z,1659477846.780 [CBIT](DEBUG): Initialized mux pins. 2022-08-02T22:04:06.780Z,1659477846.780 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2022-08-02T22:04:06.780Z,1659477846.780 [CBIT](DEBUG): Initializing the watchdog timer. 2022-08-02T22:04:06.788Z,1659477846.788 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 930 2022-08-02T22:04:06.800Z,1659477846.800 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 931 2022-08-02T22:04:06.801Z,1659477846.801 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2022-08-02T22:04:06.804Z,1659477846.804 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2022-08-02T22:04:06.804Z,1659477846.804 [CBIT](DEBUG): Initializing heartbeat. 2022-08-02T22:04:06.812Z,1659477846.812 [Onboard ThreadHandler](INFO): Handler Thread ID is 932 2022-08-02T22:04:06.830Z,1659477846.830 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 933 2022-08-02T22:04:06.852Z,1659477846.852 [DAT ThreadHandler](INFO): Handler Thread ID is 934 2022-08-02T22:04:06.853Z,1659477846.853 [DAT](INFO): Powering up 2022-08-02T22:04:06.853Z,1659477846.853 [DAT](DEBUG): Initializing DAT. 2022-08-02T22:04:06.857Z,1659477846.857 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 936 2022-08-02T22:04:06.858Z,1659477846.858 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2022-08-02T22:04:06.861Z,1659477846.861 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 938 2022-08-02T22:04:06.864Z,1659477846.864 [WetLabsBB2FL](INFO): Powering up 2022-08-02T22:04:06.866Z,1659477846.866 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 940 2022-08-02T22:04:06.873Z,1659477846.873 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2022-08-02T22:04:06.873Z,1659477846.873 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2022-08-02T22:04:06.874Z,1659477846.874 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2022-08-02T22:04:06.874Z,1659477846.874 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2022-08-02T22:04:06.874Z,1659477846.874 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2022-08-02T22:04:06.874Z,1659477846.874 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2022-08-02T22:04:06.874Z,1659477846.874 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2022-08-02T22:04:06.874Z,1659477846.874 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2022-08-02T22:04:06.875Z,1659477846.875 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA69M.000 2022-08-02T22:04:06.875Z,1659477846.875 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA69M.000 2022-08-02T22:04:06.876Z,1659477846.876 [CBIT](DEBUG): Deactivating GF circuits. 2022-08-02T22:04:06.876Z,1659477846.876 [CBIT](DEBUG): Deactivating emergency mode. 2022-08-02T22:04:06.912Z,1659477846.912 [CBIT](DEBUG): Backplane powered. 2022-08-02T22:04:06.913Z,1659477846.913 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2022-08-02T22:04:06.948Z,1659477846.948 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2022-08-02T22:04:06.976Z,1659477846.976 [MissionManager](DEBUG): 2022-08-02T22:04:06.977Z,1659477846.977 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2022-08-02T22:04:07.061Z,1659477847.061 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2022-08-02T22:04:07.062Z,1659477847.062 [Default:A.Wait](DEBUG): Construct Wait. 2022-08-02T22:04:07.085Z,1659477847.085 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2022-08-02T22:04:07.109Z,1659477847.109 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2022-08-02T22:04:07.127Z,1659477847.127 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2022-08-02T22:04:07.157Z,1659477847.157 [Default:E.Execute](DEBUG): Construct Execute. 2022-08-02T22:04:07.172Z,1659477847.172 [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 2022-08-02T22:04:07.177Z,1659477847.177 [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, 2022-08-02T22:04:07.188Z,1659477847.188 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-08-02T22:04:07.236Z,1659477847.236 [Radio_Surface](INFO): Powering up 2022-08-02T22:04:07.345Z,1659477847.345 [Power24vConverter](INFO): Powering up. 2022-08-02T22:04:07.390Z,1659477847.390 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2022-08-02T22:04:07.396Z,1659477847.396 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2022-08-02T22:04:07.397Z,1659477847.397 [ElevatorServo](DEBUG): Initializing EZServoServo. 2022-08-02T22:04:07.404Z,1659477847.404 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2022-08-02T22:04:07.405Z,1659477847.405 [MassServo](DEBUG): Initializing EZServoServo. 2022-08-02T22:04:07.412Z,1659477847.412 [MassServo](DEBUG): Initializing MassServo. 2022-08-02T22:04:07.413Z,1659477847.413 [RudderServo](DEBUG): Initializing EZServoServo. 2022-08-02T22:04:07.420Z,1659477847.420 [RudderServo](DEBUG): Initializing RudderServo. 2022-08-02T22:04:07.421Z,1659477847.421 [ThrusterHE](DEBUG): Initializing EZServoServo. 2022-08-02T22:04:07.428Z,1659477847.428 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2022-08-02T22:04:07.637Z,1659477847.637 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2022-08-02T22:04:07.637Z,1659477847.637 [DropWeight] Hardware Fault, FailCount= 1 2022-08-02T22:04:07.637Z,1659477847.637 [DropWeight](ERROR): Hardware Fault 2022-08-02T22:04:07.675Z,1659477847.675 [CommandExec](FAULT): Scheduling is paused 2022-08-02T22:04:07.675Z,1659477847.675 [CBIT](INFO): Critical error at 20220802T220407 2022-08-02T22:04:07.684Z,1659477847.684 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2022-08-02T22:04:07.686Z,1659477847.686 [CBIT](ERROR): Hardware Fault in component: DropWeight 2022-08-02T22:04:07.687Z,1659477847.687 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2022-08-02T22:04:08.336Z,1659477848.336 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2022-08-02T22:04:08.336Z,1659477848.336 [RudderServo](FAULT): Rudder failed to initialize 2022-08-02T22:04:08.336Z,1659477848.336 [RudderServo] Communications Fault, FailCount= 1 2022-08-02T22:04:08.336Z,1659477848.336 [RudderServo](ERROR): Communications Fault 2022-08-02T22:04:08.338Z,1659477848.338 [CBIT](INFO): Critical error at 20220802T220407 2022-08-02T22:04:08.340Z,1659477848.340 [CBIT](ERROR): Communications Fault in component: RudderServo 2022-08-02T22:04:08.545Z,1659477848.545 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-08-02T22:04:08.545Z,1659477848.545 [RudderServo](INFO): Powering down 2022-08-02T22:04:09.239Z,1659477849.239 [RudderServo](DEBUG): Initializing EZServoServo. 2022-08-02T22:04:09.357Z,1659477849.357 [RudderServo](DEBUG): Initializing RudderServo. 2022-08-02T22:04:09.361Z,1659477849.361 [CBIT](INFO): Clearing failed state for component RudderServo 2022-08-02T22:04:09.361Z,1659477849.361 [RudderServo] No Fault, FailCount= 1 2022-08-02T22:04:10.740Z,1659477850.740 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-08-02T22:04:11.152Z,1659477851.152 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-08-02T22:04:11.556Z,1659477851.556 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-08-02T22:04:11.992Z,1659477851.992 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-08-02T22:04:12.152Z,1659477852.152 [WetLabsBB2FL] Communications Fault, FailCount= 1 2022-08-02T22:04:12.152Z,1659477852.152 [WetLabsBB2FL](ERROR): Communications Fault 2022-08-02T22:04:12.464Z,1659477852.464 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-08-02T22:04:12.594Z,1659477852.594 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-08-02T22:04:12.652Z,1659477852.652 [WetLabsBB2FL](INFO): Powering down 2022-08-02T22:04:12.928Z,1659477852.928 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-08-02T22:04:13.364Z,1659477853.364 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-08-02T22:04:13.544Z,1659477853.544 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-08-02T22:04:13.544Z,1659477853.544 [WetLabsBB2FL] No Fault, FailCount= 1 2022-08-02T22:04:13.872Z,1659477853.872 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-08-02T22:04:13.888Z,1659477853.888 [WetLabsBB2FL](INFO): Powering up 2022-08-02T22:04:13.984Z,1659477853.984 [RudderServo](FAULT): Overload Error 2022-08-02T22:04:13.984Z,1659477853.984 [RudderServo] Hardware Fault, FailCount= 2 2022-08-02T22:04:13.984Z,1659477853.984 [RudderServo](ERROR): Hardware Fault 2022-08-02T22:04:14.133Z,1659477854.133 [CBIT](ERROR): Hardware Fault in component: RudderServo 2022-08-02T22:04:14.456Z,1659477854.456 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2022-08-02T22:04:14.536Z,1659477854.536 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-08-02T22:04:14.537Z,1659477854.537 [RudderServo](INFO): Powering down 2022-08-02T22:04:15.272Z,1659477855.272 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2022-08-02T22:04:15.417Z,1659477855.417 [RudderServo](DEBUG): Initializing EZServoServo. 2022-08-02T22:04:15.540Z,1659477855.540 [RudderServo](DEBUG): Initializing RudderServo. 2022-08-02T22:04:15.545Z,1659477855.545 [CBIT](INFO): Clearing failed state for component RudderServo 2022-08-02T22:04:15.545Z,1659477855.545 [RudderServo] No Fault, FailCount= 2 2022-08-02T22:04:15.652Z,1659477855.652 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2022-08-02T22:04:16.452Z,1659477856.452 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:16.856Z,1659477856.856 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:17.488Z,1659477857.488 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:17.892Z,1659477857.892 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:18.372Z,1659477858.372 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:18.816Z,1659477858.816 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:19.125Z,1659477859.125 [CommandExec](IMPORTANT): got command quit 2022-08-02T22:04:19.160Z,1659477859.160 [WetLabsBB2FL] Communications Fault, FailCount= 2 2022-08-02T22:04:19.160Z,1659477859.160 [WetLabsBB2FL](ERROR): Communications Fault 2022-08-02T22:04:19.304Z,1659477859.304 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:19.393Z,1659477859.393 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2022-08-02T22:04:19.660Z,1659477859.660 [WetLabsBB2FL](INFO): Powering down 2022-08-02T22:04:19.724Z,1659477859.724 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:19.908Z,1659477859.908 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2022-08-02T22:04:19.908Z,1659477859.908 [CTD_Seabird] Communications Fault, FailCount= 1 2022-08-02T22:04:19.908Z,1659477859.908 [CTD_Seabird](ERROR): Communications Fault 2022-08-02T22:04:20.128Z,1659477860.128 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2022-08-02T22:04:20.128Z,1659477860.128 [CommandExec](INFO): Uninitializing the command executive. 2022-08-02T22:04:20.128Z,1659477860.128 [CommandExec](INFO): Uninitializing the command scheduler. 2022-08-02T22:04:20.128Z,1659477860.128 [CommandExec ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:20.144Z,1659477860.144 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:20.144Z,1659477860.144 [AHRS_M2](FAULT): Failed to initialize within timeout. 2022-08-02T22:04:20.144Z,1659477860.144 [AHRS_M2] Communications Fault, FailCount= 1 2022-08-02T22:04:20.144Z,1659477860.144 [AHRS_M2](ERROR): Communications Fault 2022-08-02T22:04:20.152Z,1659477860.152 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2022-08-02T22:04:20.152Z,1659477860.152 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2022-08-02T22:04:20.152Z,1659477860.152 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:20.153Z,1659477860.153 [NavChartDb](INFO): Join timeout helper Thread ID is 952 2022-08-02T22:04:20.265Z,1659477860.265 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2022-08-02T22:04:20.265Z,1659477860.265 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2022-08-02T22:04:20.271Z,1659477860.271 [AHRS_M2](INFO): Powering down 2022-08-02T22:04:20.313Z,1659477860.313 [CTD_Seabird](INFO): Powering down 2022-08-02T22:04:20.576Z,1659477860.576 [RudderServo](FAULT): Overload Error 2022-08-02T22:04:20.577Z,1659477860.577 [RudderServo] Hardware Fault, FailCount= 3 2022-08-02T22:04:20.577Z,1659477860.577 [RudderServo](ERROR): Hardware Fault 2022-08-02T22:04:20.605Z,1659477860.605 [CBIT](ERROR): Hardware Fault in component: RudderServo 2022-08-02T22:04:20.605Z,1659477860.605 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2022-08-02T22:04:20.605Z,1659477860.605 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2022-08-02T22:04:20.605Z,1659477860.605 [WetLabsBB2FL] No Fault, FailCount= 2 2022-08-02T22:04:20.761Z,1659477860.761 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-08-02T22:04:20.761Z,1659477860.761 [RudderServo](INFO): Powering down 2022-08-02T22:04:20.763Z,1659477860.763 [CBIT](INFO): Critical error at 20220802T220420 2022-08-02T22:04:20.873Z,1659477860.873 [WetLabsBB2FL](INFO): Powering up 2022-08-02T22:04:21.124Z,1659477861.124 [CBIT](INFO): Clearing failed state for component AHRS_M2 2022-08-02T22:04:21.124Z,1659477861.124 [AHRS_M2] No Fault, FailCount= 1 2022-08-02T22:04:21.144Z,1659477861.144 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2022-08-02T22:04:21.144Z,1659477861.144 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:21.148Z,1659477861.148 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2022-08-02T22:04:21.148Z,1659477861.148 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:21.148Z,1659477861.148 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 954 2022-08-02T22:04:21.222Z,1659477861.222 [DAT](INFO): commRate: 800 2022-08-02T22:04:21.472Z,1659477861.472 [WetLabsBB2FL](INFO): Powering down 2022-08-02T22:04:21.481Z,1659477861.481 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-08-02T22:04:21.482Z,1659477861.482 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2022-08-02T22:04:21.482Z,1659477861.482 [WetLabsBB2FL](INFO): Powering down 2022-08-02T22:04:21.483Z,1659477861.483 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:21.492Z,1659477861.492 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2022-08-02T22:04:21.492Z,1659477861.492 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:21.492Z,1659477861.492 [CTD_Seabird](INFO): Join timeout helper Thread ID is 956 2022-08-02T22:04:21.569Z,1659477861.569 [RudderServo](DEBUG): Initializing EZServoServo. 2022-08-02T22:04:21.656Z,1659477861.656 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2022-08-02T22:04:21.656Z,1659477861.656 [CTD_Seabird](INFO): Powering down 2022-08-02T22:04:21.668Z,1659477861.668 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:21.685Z,1659477861.685 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2022-08-02T22:04:21.685Z,1659477861.685 [DAT ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:21.685Z,1659477861.685 [DAT](INFO): Join timeout helper Thread ID is 959 2022-08-02T22:04:21.686Z,1659477861.686 [RudderServo](DEBUG): Initializing RudderServo. 2022-08-02T22:04:21.690Z,1659477861.690 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2022-08-02T22:04:21.690Z,1659477861.690 [CTD_Seabird] No Fault, FailCount= 1 2022-08-02T22:04:21.736Z,1659477861.736 [DAT](INFO): Powering down 2022-08-02T22:04:21.808Z,1659477861.808 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2022-08-02T22:04:21.808Z,1659477861.808 [DAT](INFO): Powering down 2022-08-02T22:04:21.809Z,1659477861.809 [DAT ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:21.812Z,1659477861.812 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2022-08-02T22:04:21.812Z,1659477861.812 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:21.812Z,1659477861.812 [Radio_Surface](INFO): Join timeout helper Thread ID is 960 2022-08-02T22:04:22.184Z,1659477862.184 [Radio_Surface](INFO): Powering down 2022-08-02T22:04:22.185Z,1659477862.185 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2022-08-02T22:04:22.185Z,1659477862.185 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:22.189Z,1659477862.189 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2022-08-02T22:04:22.189Z,1659477862.189 [Onboard ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:22.189Z,1659477862.189 [Onboard](INFO): Join timeout helper Thread ID is 961 2022-08-02T22:04:25.040Z,1659477865.040 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:25.049Z,1659477865.049 [DVL_micro](FAULT): Failed to initialize within timeout. 2022-08-02T22:04:25.049Z,1659477865.049 [DVL_micro] Communications Fault, FailCount= 1 2022-08-02T22:04:25.049Z,1659477865.049 [DVL_micro](ERROR): Communications Fault 2022-08-02T22:04:25.064Z,1659477865.064 [CBIT](ERROR): Communications Fault in component: DVL_micro 2022-08-02T22:04:25.440Z,1659477865.440 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:25.520Z,1659477865.520 [DVL_micro](INFO): Powering down 2022-08-02T22:04:25.880Z,1659477865.880 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:26.260Z,1659477866.260 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:26.287Z,1659477866.287 [CBIT](INFO): Clearing failed state for component DVL_micro 2022-08-02T22:04:26.287Z,1659477866.287 [DVL_micro] No Fault, FailCount= 1 2022-08-02T22:04:26.672Z,1659477866.672 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:26.828Z,1659477866.828 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2022-08-02T22:04:26.829Z,1659477866.829 [Onboard ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:26.837Z,1659477866.837 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2022-08-02T22:04:26.837Z,1659477866.837 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:26.837Z,1659477866.837 [DataOverHttps](INFO): Join timeout helper Thread ID is 963 2022-08-02T22:04:26.880Z,1659477866.880 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2022-08-02T22:04:26.881Z,1659477866.881 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:26.901Z,1659477866.901 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2022-08-02T22:04:26.901Z,1659477866.901 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:26.901Z,1659477866.901 [BackseatComponent](INFO): Join timeout helper Thread ID is 964 2022-08-02T22:04:27.004Z,1659477867.004 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2022-08-02T22:04:27.004Z,1659477867.004 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:27.021Z,1659477867.021 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2022-08-02T22:04:27.021Z,1659477867.021 [logger ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:27.021Z,1659477867.021 [logger](INFO): Join timeout helper Thread ID is 965 2022-08-02T22:04:27.048Z,1659477867.048 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2022-08-02T22:04:27.048Z,1659477867.048 [logger ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:27.061Z,1659477867.061 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2022-08-02T22:04:27.061Z,1659477867.061 [CommandLine ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:27.061Z,1659477867.061 [CommandLine](INFO): Join timeout helper Thread ID is 966 2022-08-02T22:04:27.068Z,1659477867.068 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:27.156Z,1659477867.156 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2022-08-02T22:04:27.156Z,1659477867.156 [CommandLine ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:27.165Z,1659477867.165 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2022-08-02T22:04:27.165Z,1659477867.165 [CommandExec ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:27.165Z,1659477867.165 [CommandExec](INFO): Join timeout helper Thread ID is 967 2022-08-02T22:04:27.166Z,1659477867.166 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2022-08-02T22:04:27.167Z,1659477867.167 [controlThread ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:27.167Z,1659477867.167 [controlThread](INFO): Join timeout helper Thread ID is 968 2022-08-02T22:04:27.484Z,1659477867.484 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout 2022-08-02T22:04:27.509Z,1659477867.509 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2022-08-02T22:04:27.509Z,1659477867.509 [controlThread](DEBUG): Uninitializing ControlThread 2022-08-02T22:04:27.509Z,1659477867.509 [AHRS_M2](INFO): Powering down 2022-08-02T22:04:27.652Z,1659477867.652 [DVL_micro](INFO): Powering down 2022-08-02T22:04:27.653Z,1659477867.653 [NAL9602](INFO): Powering down 2022-08-02T22:04:27.656Z,1659477867.656 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2022-08-02T22:04:27.657Z,1659477867.657 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2022-08-02T22:04:27.657Z,1659477867.657 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2022-08-02T22:04:27.658Z,1659477867.658 [MissionManager](INFO): Uninitializing Mission Default 2022-08-02T22:04:27.660Z,1659477867.660 [MissionManager](INFO): Uninitializing Mission Startup 2022-08-02T22:04:27.661Z,1659477867.661 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2022-08-02T22:04:27.662Z,1659477867.662 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2022-08-02T22:04:27.662Z,1659477867.662 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2022-08-02T22:04:27.662Z,1659477867.662 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2022-08-02T22:04:27.663Z,1659477867.663 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2022-08-02T22:04:27.663Z,1659477867.663 [BuoyancyServo](INFO): Powering down 2022-08-02T22:04:27.676Z,1659477867.676 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2022-08-02T22:04:27.676Z,1659477867.676 [ElevatorServo](INFO): Powering down 2022-08-02T22:04:27.677Z,1659477867.677 [MassServo](DEBUG): Uninitialize Mass Servo. 2022-08-02T22:04:27.677Z,1659477867.677 [MassServo](INFO): Powering down 2022-08-02T22:04:27.678Z,1659477867.678 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-08-02T22:04:27.678Z,1659477867.678 [RudderServo](INFO): Powering down 2022-08-02T22:04:27.679Z,1659477867.679 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2022-08-02T22:04:27.679Z,1659477867.679 [ThrusterHE](INFO): Powering down 2022-08-02T22:04:27.680Z,1659477867.680 [SBIT](DEBUG): Uninitialize SBIT Component. 2022-08-02T22:04:27.680Z,1659477867.680 [IBIT](DEBUG): Uninitialize IBIT Component. 2022-08-02T22:04:27.680Z,1659477867.680 [CBIT](DEBUG): Uninitialize CBIT Component. 2022-08-02T22:04:27.681Z,1659477867.681 [CBIT](DEBUG): Powering off loads. 2022-08-02T22:04:27.692Z,1659477867.692 [CBIT](DEBUG): Disabling WDT. 2022-08-02T22:04:27.704Z,1659477867.704 [CBIT](DEBUG): Opening all GF detection circuits. 2022-08-02T22:04:27.705Z,1659477867.705 [controlThread ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:27.759Z,1659477867.759 [DAT ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:27.764Z,1659477867.764 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:27.766Z,1659477867.766 [Onboard ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:27.773Z,1659477867.773 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:27.780Z,1659477867.780 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:28.063Z,1659477868.063 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:28.067Z,1659477868.067 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:28.089Z,1659477868.089 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2022-08-02T22:04:28.147Z,1659477868.147 [logger ThreadHandler](INFO): Thread cancelled.