2024-05-22T14:49:20.065Z,1716389360.065 [Supervisor](DEBUG): Initializing supervisor. 2024-05-22T14:49:20.069Z,1716389360.069 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-05-22T14:49:20.070Z,1716389360.070 [SyncHandler](INFO): Protected caller Thread ID is 9390 2024-05-22T14:49:20.070Z,1716389360.070 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-05-22T14:49:20.071Z,1716389360.071 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-05-22T14:49:20.071Z,1716389360.071 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9391 2024-05-22T14:49:20.075Z,1716389360.075 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-05-22T14:49:20.093Z,1716389360.093 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-05-22T14:49:20.094Z,1716389360.094 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-05-22T14:49:20.094Z,1716389360.094 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 9392 2024-05-22T14:49:20.098Z,1716389360.098 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-05-22T14:49:20.099Z,1716389360.099 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-05-22T14:49:20.099Z,1716389360.099 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9393 2024-05-22T14:49:20.102Z,1716389360.102 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-05-22T14:49:20.102Z,1716389360.102 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-05-22T14:49:20.103Z,1716389360.103 [logger ThreadHandler](INFO): Protected caller Thread ID is 9394 2024-05-22T14:49:20.106Z,1716389360.106 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-05-22T14:49:20.107Z,1716389360.107 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-05-22T14:49:20.108Z,1716389360.108 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-05-22T14:49:20.388Z,1716389360.388 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-05-22T14:49:20.388Z,1716389360.388 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-05-22T14:49:20.482Z,1716389360.482 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-05-22T14:49:21.038Z,1716389361.038 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-05-22T14:49:21.039Z,1716389361.039 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-05-22T14:49:21.476Z,1716389361.476 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-05-22T14:49:21.477Z,1716389361.477 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-05-22T14:49:21.589Z,1716389361.589 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-05-22T14:49:21.590Z,1716389361.590 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-05-22T14:49:22.013Z,1716389362.013 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-05-22T14:49:22.014Z,1716389362.014 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-05-22T14:49:22.243Z,1716389362.243 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-05-22T14:49:22.244Z,1716389362.244 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-05-22T14:49:22.790Z,1716389362.790 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-05-22T14:49:22.791Z,1716389362.791 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-05-22T14:49:22.939Z,1716389362.939 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-05-22T14:49:22.939Z,1716389362.939 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-05-22T14:49:23.031Z,1716389363.031 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-05-22T14:49:23.889Z,1716389363.889 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-05-22T14:49:23.890Z,1716389363.890 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-05-22T14:49:24.284Z,1716389364.284 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-05-22T14:49:24.285Z,1716389364.285 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-05-22T14:49:24.499Z,1716389364.499 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-05-22T14:49:24.500Z,1716389364.500 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-05-22T14:49:24.626Z,1716389364.626 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-05-22T14:49:24.627Z,1716389364.627 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-05-22T14:49:24.869Z,1716389364.869 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-05-22T14:49:24.870Z,1716389364.870 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-05-22T14:49:25.311Z,1716389365.311 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-05-22T14:49:25.313Z,1716389365.313 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2024-05-22T14:49:25.314Z,1716389365.314 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg 2024-05-22T14:49:25.462Z,1716389365.462 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2024-05-22T14:49:25.884Z,1716389365.884 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2024-05-22T14:49:26.001Z,1716389366.001 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg 2024-05-22T14:49:26.098Z,1716389366.098 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2024-05-22T14:49:26.213Z,1716389366.213 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2024-05-22T14:49:26.319Z,1716389366.319 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2024-05-22T14:49:26.446Z,1716389366.446 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2024-05-22T14:49:26.613Z,1716389366.613 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2024-05-22T14:49:26.766Z,1716389366.766 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2024-05-22T14:49:26.889Z,1716389366.889 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg 2024-05-22T14:49:27.163Z,1716389367.163 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-05-22T14:49:27.165Z,1716389367.165 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/ 2024-05-22T14:49:27.165Z,1716389367.165 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-05-22T14:49:27.175Z,1716389367.175 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-05-22T14:49:27.227Z,1716389367.227 [VerticalControl](DEBUG): Construct VerticalControl. 2024-05-22T14:49:27.287Z,1716389367.287 [VerticalControl] Loaded 2024-05-22T14:49:27.287Z,1716389367.287 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-05-22T14:49:27.290Z,1716389367.290 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-05-22T14:49:27.337Z,1716389367.337 [HorizontalControl] Loaded 2024-05-22T14:49:27.337Z,1716389367.337 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-05-22T14:49:27.339Z,1716389367.339 [SpeedControl](DEBUG): Construct SpeedControl. 2024-05-22T14:49:27.342Z,1716389367.342 [SpeedControl] Loaded 2024-05-22T14:49:27.343Z,1716389367.343 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-05-22T14:49:27.345Z,1716389367.345 [LoopControl](DEBUG): Construct LoopControl. 2024-05-22T14:49:27.346Z,1716389367.346 [LoopControl] Loaded 2024-05-22T14:49:27.346Z,1716389367.346 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-05-22T14:49:27.346Z,1716389367.346 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-05-22T14:49:27.347Z,1716389367.347 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-05-22T14:49:27.357Z,1716389367.357 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-05-22T14:49:27.357Z,1716389367.357 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-05-22T14:49:27.529Z,1716389367.529 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-05-22T14:49:27.530Z,1716389367.530 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-05-22T14:49:27.661Z,1716389367.661 [BuoyancyServo] Loaded 2024-05-22T14:49:27.662Z,1716389367.662 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-05-22T14:49:27.681Z,1716389367.681 [ElevatorServo] Loaded 2024-05-22T14:49:27.681Z,1716389367.681 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-05-22T14:49:27.700Z,1716389367.700 [MassServo] Loaded 2024-05-22T14:49:27.700Z,1716389367.700 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-05-22T14:49:27.718Z,1716389367.718 [RudderServo] Loaded 2024-05-22T14:49:27.719Z,1716389367.719 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-05-22T14:49:27.733Z,1716389367.733 [ThrusterHE] Loaded 2024-05-22T14:49:27.734Z,1716389367.734 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-05-22T14:49:27.734Z,1716389367.734 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-05-22T14:49:27.735Z,1716389367.735 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-05-22T14:49:27.845Z,1716389367.845 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-05-22T14:49:27.846Z,1716389367.846 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-05-22T14:49:27.859Z,1716389367.859 [NavChart] Loaded 2024-05-22T14:49:27.859Z,1716389367.859 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-05-22T14:49:27.865Z,1716389367.865 [UniversalFixResidualReporter] Loaded 2024-05-22T14:49:27.865Z,1716389367.865 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-05-22T14:49:27.866Z,1716389367.866 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-05-22T14:49:27.866Z,1716389367.866 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-05-22T14:49:27.922Z,1716389367.922 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-05-22T14:49:27.922Z,1716389367.922 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-05-22T14:49:28.361Z,1716389368.361 [AHRS_M2] Loaded 2024-05-22T14:49:28.361Z,1716389368.361 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-05-22T14:49:29.167Z,1716389369.167 [BPC1] Loaded 2024-05-22T14:49:29.167Z,1716389369.167 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-05-22T14:49:29.237Z,1716389369.237 [DataOverHttps] Loaded 2024-05-22T14:49:29.238Z,1716389369.238 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-05-22T14:49:29.239Z,1716389369.239 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409314E0 2024-05-22T14:49:29.239Z,1716389369.239 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 9477 2024-05-22T14:49:29.260Z,1716389369.260 [Depth_Keller] Loaded 2024-05-22T14:49:29.260Z,1716389369.260 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-05-22T14:49:29.265Z,1716389369.265 [DropWeight] Loaded 2024-05-22T14:49:29.265Z,1716389369.265 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-05-22T14:49:29.327Z,1716389369.327 [NAL9602] Loaded 2024-05-22T14:49:29.327Z,1716389369.327 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-05-22T14:49:29.357Z,1716389369.357 [Onboard] Loaded 2024-05-22T14:49:29.358Z,1716389369.358 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-05-22T14:49:29.359Z,1716389369.359 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409614E0 2024-05-22T14:49:29.359Z,1716389369.359 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 9478 2024-05-22T14:49:29.372Z,1716389369.372 [Power24vConverter] Loaded 2024-05-22T14:49:29.373Z,1716389369.373 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-05-22T14:49:29.388Z,1716389369.388 [Radio_Surface] Loaded 2024-05-22T14:49:29.388Z,1716389369.388 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-05-22T14:49:29.389Z,1716389369.389 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409914E0 2024-05-22T14:49:29.389Z,1716389369.389 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9479 2024-05-22T14:49:29.402Z,1716389369.402 [Sonardyne_Nano] Loaded 2024-05-22T14:49:29.403Z,1716389369.403 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-05-22T14:49:29.494Z,1716389369.494 [DAT] Loaded 2024-05-22T14:49:29.494Z,1716389369.494 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-05-22T14:49:29.495Z,1716389369.495 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409C14E0 2024-05-22T14:49:29.496Z,1716389369.496 [DAT ThreadHandler](INFO): Protected caller Thread ID is 9480 2024-05-22T14:49:29.496Z,1716389369.496 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-05-22T14:49:29.497Z,1716389369.497 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-05-22T14:49:29.546Z,1716389369.546 [DepthRateCalculator] Loaded 2024-05-22T14:49:29.546Z,1716389369.546 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-05-22T14:49:29.551Z,1716389369.551 [PitchRateCalculator] Loaded 2024-05-22T14:49:29.552Z,1716389369.552 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-05-22T14:49:29.560Z,1716389369.560 [SpeedCalculator] Loaded 2024-05-22T14:49:29.561Z,1716389369.561 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-05-22T14:49:29.565Z,1716389369.565 [YawRateCalculator] Loaded 2024-05-22T14:49:29.565Z,1716389369.565 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-05-22T14:49:29.583Z,1716389369.583 [ElevatorOffsetCalculator] Loaded 2024-05-22T14:49:29.584Z,1716389369.584 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-05-22T14:49:29.584Z,1716389369.584 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-05-22T14:49:29.585Z,1716389369.585 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-05-22T14:49:29.722Z,1716389369.722 [CANONSampler] Loaded 2024-05-22T14:49:29.722Z,1716389369.722 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread. 2024-05-22T14:49:29.782Z,1716389369.782 [CTD_Seabird] Loaded 2024-05-22T14:49:29.782Z,1716389369.782 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-05-22T14:49:29.783Z,1716389369.783 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A7D4E0 2024-05-22T14:49:29.783Z,1716389369.783 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 9481 2024-05-22T14:49:29.805Z,1716389369.805 [PAR_Licor] Loaded 2024-05-22T14:49:29.805Z,1716389369.805 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-05-22T14:49:29.847Z,1716389369.847 [WetLabsBB2FL] Loaded 2024-05-22T14:49:29.848Z,1716389369.848 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-05-22T14:49:29.849Z,1716389369.849 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AAD4E0 2024-05-22T14:49:29.849Z,1716389369.849 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 9482 2024-05-22T14:49:29.850Z,1716389369.850 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-05-22T14:49:29.850Z,1716389369.850 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-05-22T14:49:29.876Z,1716389369.876 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-05-22T14:49:29.877Z,1716389369.877 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-05-22T14:49:30.213Z,1716389370.213 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-05-22T14:49:30.214Z,1716389370.214 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-05-22T14:49:30.354Z,1716389370.354 [SBIT](DEBUG): Construct Startup Built In Test. 2024-05-22T14:49:30.365Z,1716389370.365 [SBIT] Loaded 2024-05-22T14:49:30.365Z,1716389370.365 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-05-22T14:49:30.368Z,1716389370.368 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-05-22T14:49:30.381Z,1716389370.381 [IBIT] Loaded 2024-05-22T14:49:30.381Z,1716389370.381 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-05-22T14:49:30.387Z,1716389370.387 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-05-22T14:49:30.516Z,1716389370.516 [CBIT] Loaded 2024-05-22T14:49:30.516Z,1716389370.516 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-05-22T14:49:30.528Z,1716389370.528 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-05-22T14:49:30.529Z,1716389370.529 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-05-22T14:49:30.800Z,1716389370.800 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-05-22T14:49:30.907Z,1716389370.907 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-05-22T14:49:30.909Z,1716389370.909 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-05-22T14:49:30.922Z,1716389370.922 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-05-22T14:49:30.923Z,1716389370.923 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0 2024-05-22T14:49:30.924Z,1716389370.924 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9483 2024-05-22T14:49:30.928Z,1716389370.928 [Supervisor](INFO): Main Thread ID is 9389 2024-05-22T14:49:30.928Z,1716389370.928 [Supervisor](DEBUG): Running supervisor. 2024-05-22T14:49:30.929Z,1716389370.929 [CommandExec ThreadHandler](INFO): Handler Thread ID is 9484 2024-05-22T14:49:30.930Z,1716389370.930 [CommandExec](INFO): Initializing the command executive. 2024-05-22T14:49:30.931Z,1716389370.931 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9485 2024-05-22T14:49:30.934Z,1716389370.934 [controlThread ThreadHandler](INFO): Handler Thread ID is 9486 2024-05-22T14:49:30.934Z,1716389370.934 [controlThread](DEBUG): Initializing ControlThread 2024-05-22T14:49:30.935Z,1716389370.935 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-05-22T14:49:30.936Z,1716389370.936 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-05-22T14:49:30.937Z,1716389370.937 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-05-22T14:49:30.938Z,1716389370.938 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-05-22T14:49:30.940Z,1716389370.940 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-05-22T14:49:30.940Z,1716389370.940 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-05-22T14:49:30.947Z,1716389370.947 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-05-22T14:49:30.947Z,1716389370.947 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-05-22T14:49:30.947Z,1716389370.947 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-05-22T14:49:30.948Z,1716389370.948 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-05-22T14:49:30.948Z,1716389370.948 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-05-22T14:49:30.953Z,1716389370.953 [SBIT](INFO): Initialize SBIT Component. 2024-05-22T14:49:30.954Z,1716389370.954 [SBIT](IMPORTANT): git: 2024-04-26_A 2024-05-22T14:49:30.954Z,1716389370.954 [SBIT](INFO): git hash: 26b86b0032c96ca2fff2505cfdfca7953dc64339 2024-05-22T14:49:30.954Z,1716389370.954 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-05-22T14:49:30.955Z,1716389370.955 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-05-22T14:49:30.956Z,1716389370.956 [SBIT](INFO): Beginning SBIT in 33.000000 seconds. 2024-05-22T14:49:30.957Z,1716389370.957 [IBIT](INFO): Initialize IBIT Component. 2024-05-22T14:49:30.958Z,1716389370.958 [CBIT](DEBUG): Initialize CBIT Component. 2024-05-22T14:49:30.959Z,1716389370.959 [logger ThreadHandler](INFO): Handler Thread ID is 9487 2024-05-22T14:49:30.969Z,1716389370.969 [CBIT](DEBUG): Initialized mux pins. 2024-05-22T14:49:30.969Z,1716389370.969 [CBIT](DEBUG): Initializing the watchdog timer. 2024-05-22T14:49:30.977Z,1716389370.977 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 9488 2024-05-22T14:49:30.979Z,1716389370.979 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-05-22T14:49:30.993Z,1716389370.993 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-05-22T14:49:30.993Z,1716389370.993 [CBIT](DEBUG): Initializing heartbeat. 2024-05-22T14:49:30.994Z,1716389370.994 [Onboard ThreadHandler](INFO): Handler Thread ID is 9489 2024-05-22T14:49:31.029Z,1716389371.029 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9490 2024-05-22T14:49:31.037Z,1716389371.037 [DAT ThreadHandler](INFO): Handler Thread ID is 9491 2024-05-22T14:49:31.038Z,1716389371.038 [DAT](INFO): Powering up 2024-05-22T14:49:31.038Z,1716389371.038 [DAT](DEBUG): Initializing DAT. 2024-05-22T14:49:31.042Z,1716389371.042 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 9493 2024-05-22T14:49:31.043Z,1716389371.043 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-05-22T14:49:31.046Z,1716389371.046 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 9495 2024-05-22T14:49:31.049Z,1716389371.049 [WetLabsBB2FL](INFO): Powering up 2024-05-22T14:49:31.051Z,1716389371.051 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9497 2024-05-22T14:49:31.054Z,1716389371.054 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-05-22T14:49:31.054Z,1716389371.054 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-05-22T14:49:31.054Z,1716389371.054 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-05-22T14:49:31.055Z,1716389371.055 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-05-22T14:49:31.055Z,1716389371.055 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-05-22T14:49:31.055Z,1716389371.055 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-05-22T14:49:31.055Z,1716389371.055 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-05-22T14:49:31.055Z,1716389371.055 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-05-22T14:49:31.065Z,1716389371.065 [CBIT](DEBUG): Deactivating GF circuits. 2024-05-22T14:49:31.066Z,1716389371.066 [CBIT](DEBUG): Deactivating emergency mode. 2024-05-22T14:49:31.105Z,1716389371.105 [CBIT](DEBUG): Backplane powered. 2024-05-22T14:49:31.105Z,1716389371.105 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-05-22T14:49:31.106Z,1716389371.106 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-05-22T14:49:31.107Z,1716389371.107 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-05-22T14:49:31.108Z,1716389371.108 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-05-22T14:49:31.157Z,1716389371.157 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-05-22T14:49:31.173Z,1716389371.173 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-05-22T14:49:31.209Z,1716389371.209 [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-05-22T14:49:31.210Z,1716389371.210 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-05-22T14:49:31.210Z,1716389371.210 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-05-22T14:49:31.211Z,1716389371.211 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-05-22T14:49:31.433Z,1716389371.433 [Radio_Surface](INFO): Powering up 2024-05-22T14:49:31.546Z,1716389371.546 [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-05-22T14:49:31.565Z,1716389371.565 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-05-22T14:49:31.573Z,1716389371.573 [Default:A.Wait](DEBUG): Construct Wait. 2024-05-22T14:49:31.575Z,1716389371.575 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-05-22T14:49:31.604Z,1716389371.604 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-05-22T14:49:31.623Z,1716389371.623 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-05-22T14:49:31.649Z,1716389371.649 [Default:E.Execute](DEBUG): Construct Execute. 2024-05-22T14:49:31.652Z,1716389371.652 [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-05-22T14:49:31.656Z,1716389371.656 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,CANONSampler,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,Reporter,LogSplitter, 2024-05-22T14:49:31.668Z,1716389371.668 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-05-22T14:49:31.740Z,1716389371.740 [Power24vConverter](INFO): Powering up. 2024-05-22T14:49:31.741Z,1716389371.741 [Sonardyne_Nano](INFO): Initializing. 2024-05-22T14:49:31.761Z,1716389371.761 [CANONSampler](INFO): Powering down 2024-05-22T14:49:31.796Z,1716389371.796 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-05-22T14:49:31.817Z,1716389371.817 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-05-22T14:49:31.818Z,1716389371.818 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-22T14:49:31.825Z,1716389371.825 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-22T14:49:31.826Z,1716389371.826 [MassServo](DEBUG): Initializing EZServoServo. 2024-05-22T14:49:31.833Z,1716389371.833 [MassServo](DEBUG): Initializing MassServo. 2024-05-22T14:49:31.834Z,1716389371.834 [RudderServo](DEBUG): Initializing EZServoServo. 2024-05-22T14:49:31.841Z,1716389371.841 [RudderServo](DEBUG): Initializing RudderServo. 2024-05-22T14:49:31.842Z,1716389371.842 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-05-22T14:49:31.849Z,1716389371.849 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-05-22T14:49:33.157Z,1716389373.157 [WetLabsBB2FL](INFO): Powering down 2024-05-22T14:49:33.687Z,1716389373.687 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-05-22T14:49:35.334Z,1716389375.334 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2109 2024-05-22T14:49:35.751Z,1716389375.751 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-05-22T14:49:37.578Z,1716389377.578 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-05-22T14:49:43.637Z,1716389383.637 [DAT](INFO): DAT read: 2024-05-22T14:49:43.639Z,1716389383.639 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-05-22T14:49:44.911Z,1716389384.911 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004747 2024-05-22T14:49:45.404Z,1716389385.404 [DAT](INFO): DAT read: MF Frequency Band 2024-05-22T14:49:45.654Z,1716389385.654 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-05-22T14:49:45.655Z,1716389385.655 [DAT](INFO): DAT read: May 22 2024 00:13:03 2024-05-22T14:49:46.662Z,1716389386.662 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-05-22T14:49:46.663Z,1716389386.663 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC 2024-05-22T14:49:46.663Z,1716389386.663 [DAT](INFO): commRate: 1200 2024-05-22T14:49:48.729Z,1716389388.729 [DAT](INFO): entering command mode 2024-05-22T14:49:48.929Z,1716389388.929 [DAT](INFO): DAT read: 2024-05-22T14:49:48.930Z,1716389388.930 [DAT](INFO): DAT read: user:1> 2024-05-22T14:49:48.930Z,1716389388.930 [DAT](INFO): setting verbose to 3 2024-05-22T14:49:49.182Z,1716389389.182 [DAT](INFO): DAT read: user:1> 2024-05-22T14:49:49.183Z,1716389389.183 [DAT](INFO): DAT read: Verbose | 3 2024-05-22T14:49:49.183Z,1716389389.183 [DAT](INFO): set verbose to 3 2024-05-22T14:49:49.183Z,1716389389.183 [DAT](INFO): setting DatVerbose to 27440 2024-05-22T14:49:49.434Z,1716389389.434 [DAT](INFO): DAT read: user:2> 2024-05-22T14:49:49.435Z,1716389389.435 [DAT](INFO): DAT read: DatVerbose | 27440 2024-05-22T14:49:49.435Z,1716389389.435 [DAT](INFO): set DatVerbose to 27440 2024-05-22T14:49:49.435Z,1716389389.435 [DAT](INFO): setting transmit power to 8 2024-05-22T14:49:49.685Z,1716389389.685 [DAT](INFO): DAT read: user:3> 2024-05-22T14:49:49.686Z,1716389389.686 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-05-22T14:49:49.687Z,1716389389.687 [DAT](INFO): set transmit power to 8 2024-05-22T14:49:49.687Z,1716389389.687 [DAT](INFO): setting local address to 8 2024-05-22T14:49:49.938Z,1716389389.938 [DAT](INFO): DAT read: user:4> 2024-05-22T14:49:49.939Z,1716389389.939 [DAT](INFO): DAT read: LocalAddr | 8 2024-05-22T14:49:49.939Z,1716389389.939 [DAT](INFO): set local address to 8 2024-05-22T14:49:49.940Z,1716389389.940 [DAT](INFO): Setting time to: 14:49:49 And date to:5/22/2024 2024-05-22T14:49:50.193Z,1716389390.193 [DAT](INFO): DAT read: user:5> 2024-05-22T14:49:50.195Z,1716389390.195 [DAT](INFO): DAT read: Wed May 22, 2024 14:49:49 2024-05-22T14:49:50.195Z,1716389390.195 [DAT](INFO): Local DAT time set to Wed May 22, 2024 14:49:49 2024-05-22T14:49:59.546Z,1716389399.546 [NAL9602](INFO): Powering up NAL9602 2024-05-22T14:50:04.439Z,1716389404.439 [SBIT](IMPORTANT): Beginning Startup BIT 2024-05-22T14:50:04.452Z,1716389404.452 [CBIT](IMPORTANT): Beginning ground fault scan 2024-05-22T14:50:10.455Z,1716389410.455 [NAL9602](INFO): NAL9602 initialized 2024-05-22T14:50:15.342Z,1716389415.342 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan. 2024-05-22T14:50:15.769Z,1716389415.769 [CBIT](IMPORTANT): Beginning ground fault scan 2024-05-22T14:50:18.650Z,1716389418.650 [CommandExec](IMPORTANT): got command failComponent 2024-05-22T14:50:18.650Z,1716389418.650 [CommandExec](IMPORTANT): Failed components: 2024-05-22T14:50:18.650Z,1716389418.650 [CommandExec](IMPORTANT): No failed Components. 2024-05-22T14:50:27.154Z,1716389427.154 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan. 2024-05-22T14:50:27.561Z,1716389427.561 [CBIT](IMPORTANT): Beginning ground fault scan 2024-05-22T14:50:38.418Z,1716389438.418 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan. 2024-05-22T14:50:38.418Z,1716389438.418 [CBIT](IMPORTANT): Ground fault scan returned out of bounds value in succession 3 times. Will re-run scan on normal schedule. 2024-05-22T14:50:50.043Z,1716389450.043 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-22T14:50:58.546Z,1716389458.546 [SBIT](IMPORTANT): SBIT PASSED 2024-05-22T14:50:58.547Z,1716389458.547 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-05-22T14:50:58.548Z,1716389458.548 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=20 count; 2024-05-22T14:50:58.548Z,1716389458.548 [SBIT](IMPORTANT): Express linearApproximation PowerOnly.component_avgCurrent_loadControl 50.000000 milliampere; 2024-05-22T14:50:58.548Z,1716389458.548 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=20 ampere_hour; 2024-05-22T14:50:58.548Z,1716389458.548 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt; 2024-05-22T14:50:58.548Z,1716389458.548 [SBIT](IMPORTANT): Normal all WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water; 2024-05-22T14:50:58.548Z,1716389458.548 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=0 bool; 2024-05-22T14:50:58.548Z,1716389458.548 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=1 bool; 2024-05-22T14:50:58.548Z,1716389458.548 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=111.682691 cubic_centimeter; 2024-05-22T14:50:58.548Z,1716389458.548 [SBIT](IMPORTANT): VerticalControl.massDefault=3.304286 millimeter; 2024-05-22T14:50:58.956Z,1716389458.956 [MissionManager](IMPORTANT): Started mission Startup 2024-05-22T14:50:58.956Z,1716389458.956 [Startup] Running Loop=1 2024-05-22T14:50:58.956Z,1716389458.956 [Startup](DEBUG): Aggregate::initialize Startup 2024-05-22T14:50:58.956Z,1716389458.956 [Startup:A.GoToSurface] Running Loop=1 2024-05-22T14:50:58.956Z,1716389458.956 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-05-22T14:50:58.957Z,1716389458.957 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-05-22T14:50:58.958Z,1716389458.958 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-05-22T14:50:58.959Z,1716389458.959 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-05-22T14:50:58.959Z,1716389458.959 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-05-22T14:50:58.959Z,1716389458.959 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-05-22T14:50:58.961Z,1716389458.961 [Startup:StartupSatComms] Running Loop=1 2024-05-22T14:50:58.961Z,1716389458.961 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-05-22T14:50:58.961Z,1716389458.961 [Startup:StartupSatComms:A] Running Loop=1 2024-05-22T14:50:59.356Z,1716389459.356 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-05-22T14:51:07.152Z,1716389467.152 [CommandLine](INFO): End of History 2024-05-22T14:51:07.152Z,1716389467.152 [CommandLine](INFO): End of History 2024-05-22T14:51:07.153Z,1716389467.153 [CommandLine](INFO): End of History 2024-05-22T14:51:07.258Z,1716389467.258 [CommandLine](INFO): End of History 2024-05-22T14:51:07.259Z,1716389467.259 [CommandLine](INFO): End of History 2024-05-22T14:51:07.259Z,1716389467.259 [CommandLine](INFO): End of History 2024-05-22T14:51:07.260Z,1716389467.260 [CommandLine](INFO): End of History 2024-05-22T14:51:07.398Z,1716389467.398 [CommandLine](INFO): End of History 2024-05-22T14:51:07.398Z,1716389467.398 [CommandLine](INFO): End of History 2024-05-22T14:51:07.399Z,1716389467.399 [CommandLine](INFO): End of History 2024-05-22T14:51:07.400Z,1716389467.400 [CommandLine](INFO): End of History 2024-05-22T14:51:09.031Z,1716389469.031 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-22T14:51:15.145Z,1716389475.145 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-05-22T14:51:38.901Z,1716389498.901 [CommandExec](IMPORTANT): got command failComponent 2024-05-22T14:51:38.902Z,1716389498.902 [CommandExec](IMPORTANT): Failed components: 2024-05-22T14:51:38.902Z,1716389498.902 [CommandExec](IMPORTANT): No failed Components. 2024-05-22T14:51:41.812Z,1716389501.812 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-05-22T14:51:42.646Z,1716389502.646 [CommandExec](IMPORTANT): got command gfscan 2024-05-22T14:51:43.010Z,1716389503.010 [CBIT](IMPORTANT): Beginning ground fault scan 2024-05-22T14:51:53.918Z,1716389513.918 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.002160 CHAN A1 (24V): 0.000819 CHAN A2 (12V): -0.001967 CHAN A3 (5V): -0.001586 CHAN B0 (3.3V): 0.000119 CHAN B1 (3.15aV): -0.000157 CHAN B2 (3.15bV): -0.000001 CHAN B3 (GND): 0.000155 OPEN: -0.000071 Full Scale: +/- 1 mA 2024-05-22T14:51:59.163Z,1716389519.163 [Startup:StartupSatComms:A](INFO): Timed out from 2024-05-22T14:50:58.0Z 2024-05-22T14:51:59.163Z,1716389519.163 [Startup:StartupSatComms:A] Stopped 2024-05-22T14:51:59.163Z,1716389519.163 [Startup:StartupSatComms:B] Running Loop=1 2024-05-22T14:51:59.579Z,1716389519.579 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-05-22T14:52:05.893Z,1716389525.893 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240520T233229/Courier0505.lzma 2024-05-22T14:52:06.895Z,1716389526.895 [DataOverHttps](INFO): Moved sent file to Logs/20240520T233229/Courier0505.lzma.bak 2024-05-22T14:52:06.895Z,1716389526.895 [DataOverHttps](INFO): SBD MOMSN=21068311 2024-05-22T14:52:22.581Z,1716389542.581 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240522T000527/Courier0000.lzma 2024-05-22T14:52:23.583Z,1716389543.583 [DataOverHttps](INFO): Moved sent file to Logs/20240522T000527/Courier0000.lzma.bak 2024-05-22T14:52:23.583Z,1716389543.583 [DataOverHttps](INFO): SBD MOMSN=21068316 2024-05-22T14:52:31.210Z,1716389551.210 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-05-22T14:52:31.211Z,1716389551.211 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-22T14:52:31.222Z,1716389551.222 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-22T14:52:31.610Z,1716389551.610 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-22T14:52:31.610Z,1716389551.610 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-05-22T14:52:39.273Z,1716389559.273 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240522T144920/Courier0000.lzma 2024-05-22T14:52:40.275Z,1716389560.275 [DataOverHttps](INFO): Moved sent file to Logs/20240522T144920/Courier0000.lzma.bak 2024-05-22T14:52:40.275Z,1716389560.275 [DataOverHttps](INFO): SBD MOMSN=21068326 2024-05-22T14:52:55.909Z,1716389575.909 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20240520T233229/Express0506.lzma 2024-05-22T14:52:56.911Z,1716389576.911 [DataOverHttps](INFO): Moved sent file to Logs/20240520T233229/Express0506.lzma.bak 2024-05-22T14:52:56.911Z,1716389576.911 [DataOverHttps](INFO): SBD MOMSN=21068329 2024-05-22T14:52:59.467Z,1716389579.467 [Startup:StartupSatComms:B](IN