2024-06-28T00:47:30.049Z,1719535650.049 [Supervisor](DEBUG): Initializing supervisor. 2024-06-28T00:47:30.053Z,1719535650.053 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-06-28T00:47:30.054Z,1719535650.054 [SyncHandler](INFO): Protected caller Thread ID is 836 2024-06-28T00:47:30.054Z,1719535650.054 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-06-28T00:47:30.055Z,1719535650.055 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-06-28T00:47:30.055Z,1719535650.055 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 837 2024-06-28T00:47:30.059Z,1719535650.059 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-06-28T00:47:30.077Z,1719535650.077 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-06-28T00:47:30.078Z,1719535650.078 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-06-28T00:47:30.078Z,1719535650.078 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 838 2024-06-28T00:47:30.082Z,1719535650.082 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-06-28T00:47:30.083Z,1719535650.083 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-06-28T00:47:30.083Z,1719535650.083 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 839 2024-06-28T00:47:30.085Z,1719535650.085 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-06-28T00:47:30.086Z,1719535650.086 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-06-28T00:47:30.087Z,1719535650.087 [logger ThreadHandler](INFO): Protected caller Thread ID is 840 2024-06-28T00:47:30.090Z,1719535650.090 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-06-28T00:47:30.090Z,1719535650.090 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-06-28T00:47:30.095Z,1719535650.095 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-06-28T00:47:30.586Z,1719535650.586 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-06-28T00:47:30.586Z,1719535650.586 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-06-28T00:47:30.831Z,1719535650.831 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-06-28T00:47:30.833Z,1719535650.833 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-06-28T00:47:30.928Z,1719535650.928 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-06-28T00:47:31.182Z,1719535651.182 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-06-28T00:47:31.183Z,1719535651.183 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-06-28T00:47:31.274Z,1719535651.274 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-06-28T00:47:31.381Z,1719535651.381 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-06-28T00:47:31.383Z,1719535651.383 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-06-28T00:47:31.768Z,1719535651.768 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-06-28T00:47:31.769Z,1719535651.769 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-06-28T00:47:31.915Z,1719535651.915 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-06-28T00:47:31.916Z,1719535651.916 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-06-28T00:47:32.475Z,1719535652.475 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-06-28T00:47:32.477Z,1719535652.477 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-06-28T00:47:32.681Z,1719535652.681 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-06-28T00:47:32.682Z,1719535652.682 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-06-28T00:47:33.112Z,1719535653.112 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-06-28T00:47:33.113Z,1719535653.113 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-06-28T00:47:33.423Z,1719535653.423 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-06-28T00:47:33.425Z,1719535653.425 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-06-28T00:47:33.959Z,1719535653.959 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-06-28T00:47:33.978Z,1719535653.978 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-06-28T00:47:34.942Z,1719535654.942 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-06-28T00:47:34.944Z,1719535654.944 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-06-28T00:47:35.319Z,1719535655.319 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-06-28T00:47:35.321Z,1719535655.321 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-06-28T00:47:35.568Z,1719535655.568 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-06-28T00:47:35.570Z,1719535655.570 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/ 2024-06-28T00:47:35.574Z,1719535655.574 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg 2024-06-28T00:47:35.705Z,1719535655.705 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg 2024-06-28T00:47:35.800Z,1719535655.800 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg 2024-06-28T00:47:35.951Z,1719535655.951 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg 2024-06-28T00:47:36.049Z,1719535656.049 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg 2024-06-28T00:47:36.323Z,1719535656.323 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-06-28T00:47:36.324Z,1719535656.324 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg 2024-06-28T00:47:36.442Z,1719535656.442 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg 2024-06-28T00:47:36.561Z,1719535656.561 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg 2024-06-28T00:47:36.669Z,1719535656.669 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg 2024-06-28T00:47:36.831Z,1719535656.831 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg 2024-06-28T00:47:36.941Z,1719535656.941 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg 2024-06-28T00:47:37.038Z,1719535657.038 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-06-28T00:47:37.047Z,1719535657.047 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-06-28T00:47:37.064Z,1719535657.064 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-06-28T00:47:37.064Z,1719535657.064 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-06-28T00:47:37.212Z,1719535657.212 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-06-28T00:47:37.213Z,1719535657.213 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-06-28T00:47:37.283Z,1719535657.283 [VerticalControl](DEBUG): Construct VerticalControl. 2024-06-28T00:47:37.343Z,1719535657.343 [VerticalControl] Loaded 2024-06-28T00:47:37.343Z,1719535657.343 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-06-28T00:47:37.346Z,1719535657.346 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-06-28T00:47:37.394Z,1719535657.394 [HorizontalControl] Loaded 2024-06-28T00:47:37.394Z,1719535657.394 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-06-28T00:47:37.397Z,1719535657.397 [SpeedControl](DEBUG): Construct SpeedControl. 2024-06-28T00:47:37.400Z,1719535657.400 [SpeedControl] Loaded 2024-06-28T00:47:37.400Z,1719535657.400 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-06-28T00:47:37.403Z,1719535657.403 [LoopControl](DEBUG): Construct LoopControl. 2024-06-28T00:47:37.403Z,1719535657.403 [LoopControl] Loaded 2024-06-28T00:47:37.403Z,1719535657.403 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-06-28T00:47:37.404Z,1719535657.404 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-06-28T00:47:37.404Z,1719535657.404 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-06-28T00:47:37.587Z,1719535657.587 [BuoyancyServo] Loaded 2024-06-28T00:47:37.588Z,1719535657.588 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-06-28T00:47:37.609Z,1719535657.609 [ElevatorServo] Loaded 2024-06-28T00:47:37.610Z,1719535657.610 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-06-28T00:47:37.630Z,1719535657.630 [MassServo] Loaded 2024-06-28T00:47:37.631Z,1719535657.631 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-06-28T00:47:37.650Z,1719535657.650 [RudderServo] Loaded 2024-06-28T00:47:37.651Z,1719535657.651 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-06-28T00:47:37.667Z,1719535657.667 [ThrusterHE] Loaded 2024-06-28T00:47:37.667Z,1719535657.667 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-06-28T00:47:37.668Z,1719535657.668 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-06-28T00:47:37.668Z,1719535657.668 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-06-28T00:47:37.739Z,1719535657.739 [DepthRateCalculator] Loaded 2024-06-28T00:47:37.740Z,1719535657.740 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-06-28T00:47:37.744Z,1719535657.744 [PitchRateCalculator] Loaded 2024-06-28T00:47:37.745Z,1719535657.745 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-06-28T00:47:37.754Z,1719535657.754 [SpeedCalculator] Loaded 2024-06-28T00:47:37.754Z,1719535657.754 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-06-28T00:47:37.759Z,1719535657.759 [YawRateCalculator] Loaded 2024-06-28T00:47:37.759Z,1719535657.759 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-06-28T00:47:37.777Z,1719535657.777 [ElevatorOffsetCalculator] Loaded 2024-06-28T00:47:37.777Z,1719535657.777 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-06-28T00:47:37.778Z,1719535657.778 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-06-28T00:47:37.779Z,1719535657.779 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-06-28T00:47:37.915Z,1719535657.915 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-06-28T00:47:37.916Z,1719535657.916 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-06-28T00:47:37.929Z,1719535657.929 [NavChart] Loaded 2024-06-28T00:47:37.929Z,1719535657.929 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-06-28T00:47:37.935Z,1719535657.935 [UniversalFixResidualReporter] Loaded 2024-06-28T00:47:37.935Z,1719535657.935 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-06-28T00:47:37.936Z,1719535657.936 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-06-28T00:47:37.936Z,1719535657.936 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-06-28T00:47:38.862Z,1719535658.862 [BackseatComponent] Loaded 2024-06-28T00:47:38.862Z,1719535658.862 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-06-28T00:47:38.863Z,1719535658.863 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4090B4E0 2024-06-28T00:47:38.864Z,1719535658.864 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 922 2024-06-28T00:47:38.866Z,1719535658.866 [LcmUniversalReporter] Loaded 2024-06-28T00:47:38.867Z,1719535658.867 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-06-28T00:47:38.873Z,1719535658.873 [BioacousticsDataBridge] Loaded 2024-06-28T00:47:38.873Z,1719535658.873 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread. 2024-06-28T00:47:40.061Z,1719535660.061 [BPC1] Loaded 2024-06-28T00:47:40.062Z,1719535660.062 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-06-28T00:47:40.245Z,1719535660.245 [DataOverHttps] Loaded 2024-06-28T00:47:40.245Z,1719535660.245 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-06-28T00:47:40.246Z,1719535660.246 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4093B4E0 2024-06-28T00:47:40.247Z,1719535660.247 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 924 2024-06-28T00:47:40.270Z,1719535660.270 [Depth_Keller] Loaded 2024-06-28T00:47:40.270Z,1719535660.270 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-06-28T00:47:40.275Z,1719535660.275 [DropWeight] Loaded 2024-06-28T00:47:40.275Z,1719535660.275 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-06-28T00:47:40.339Z,1719535660.339 [NAL9602] Loaded 2024-06-28T00:47:40.339Z,1719535660.339 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-06-28T00:47:40.369Z,1719535660.369 [Onboard] Loaded 2024-06-28T00:47:40.369Z,1719535660.369 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-06-28T00:47:40.370Z,1719535660.370 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4096B4E0 2024-06-28T00:47:40.371Z,1719535660.371 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 925 2024-06-28T00:47:40.385Z,1719535660.385 [Power24vConverter] Loaded 2024-06-28T00:47:40.385Z,1719535660.385 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-06-28T00:47:40.401Z,1719535660.401 [Radio_Surface] Loaded 2024-06-28T00:47:40.401Z,1719535660.401 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-06-28T00:47:40.402Z,1719535660.402 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4099B4E0 2024-06-28T00:47:40.402Z,1719535660.402 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 926 2024-06-28T00:47:40.417Z,1719535660.417 [Sonardyne_Nano] Loaded 2024-06-28T00:47:40.418Z,1719535660.418 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-06-28T00:47:40.418Z,1719535660.418 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-06-28T00:47:40.419Z,1719535660.419 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-06-28T00:47:40.505Z,1719535660.505 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-06-28T00:47:40.505Z,1719535660.505 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-06-28T00:47:40.713Z,1719535660.713 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-06-28T00:47:40.714Z,1719535660.714 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-06-28T00:47:40.756Z,1719535660.756 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-06-28T00:47:40.757Z,1719535660.757 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-06-28T00:47:40.979Z,1719535660.979 [CTD_Seabird] Loaded 2024-06-28T00:47:40.980Z,1719535660.980 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-06-28T00:47:40.981Z,1719535660.981 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ADB4E0 2024-06-28T00:47:40.981Z,1719535660.981 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 927 2024-06-28T00:47:41.003Z,1719535661.003 [PAR_Licor] Loaded 2024-06-28T00:47:41.003Z,1719535661.003 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-06-28T00:47:41.047Z,1719535661.047 [WetLabsBB2FL] Loaded 2024-06-28T00:47:41.048Z,1719535661.048 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-06-28T00:47:41.049Z,1719535661.049 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B0B4E0 2024-06-28T00:47:41.049Z,1719535661.049 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 928 2024-06-28T00:47:41.050Z,1719535661.050 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-06-28T00:47:41.050Z,1719535661.050 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-06-28T00:47:41.446Z,1719535661.446 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-06-28T00:47:41.448Z,1719535661.448 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-06-28T00:47:41.619Z,1719535661.619 [SBIT](DEBUG): Construct Startup Built In Test. 2024-06-28T00:47:41.630Z,1719535661.630 [SBIT] Loaded 2024-06-28T00:47:41.630Z,1719535661.630 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-06-28T00:47:41.633Z,1719535661.633 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-06-28T00:47:41.646Z,1719535661.646 [IBIT] Loaded 2024-06-28T00:47:41.646Z,1719535661.646 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-06-28T00:47:41.652Z,1719535661.652 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-06-28T00:47:41.757Z,1719535661.757 [CBIT] Loaded 2024-06-28T00:47:41.757Z,1719535661.757 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-06-28T00:47:41.757Z,1719535661.757 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-06-28T00:47:41.764Z,1719535661.764 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-06-28T00:47:41.767Z,1719535661.767 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-06-28T00:47:41.778Z,1719535661.778 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-06-28T00:47:41.779Z,1719535661.779 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0 2024-06-28T00:47:41.779Z,1719535661.779 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 929 2024-06-28T00:47:41.784Z,1719535661.784 [Supervisor](INFO): Main Thread ID is 829 2024-06-28T00:47:41.784Z,1719535661.784 [Supervisor](DEBUG): Running supervisor. 2024-06-28T00:47:41.785Z,1719535661.785 [CommandExec ThreadHandler](INFO): Handler Thread ID is 930 2024-06-28T00:47:41.785Z,1719535661.785 [CommandExec](INFO): Initializing the command executive. 2024-06-28T00:47:41.786Z,1719535661.786 [CommandLine ThreadHandler](INFO): Handler Thread ID is 931 2024-06-28T00:47:41.789Z,1719535661.789 [controlThread ThreadHandler](INFO): Handler Thread ID is 932 2024-06-28T00:47:41.789Z,1719535661.789 [controlThread](DEBUG): Initializing ControlThread 2024-06-28T00:47:41.790Z,1719535661.790 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-06-28T00:47:41.791Z,1719535661.791 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-06-28T00:47:41.792Z,1719535661.792 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-06-28T00:47:41.793Z,1719535661.793 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-06-28T00:47:41.794Z,1719535661.794 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-06-28T00:47:41.794Z,1719535661.794 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-06-28T00:47:41.795Z,1719535661.795 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-06-28T00:47:41.795Z,1719535661.795 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-06-28T00:47:41.795Z,1719535661.795 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-06-28T00:47:41.796Z,1719535661.796 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-06-28T00:47:41.797Z,1719535661.797 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-06-28T00:47:41.804Z,1719535661.804 [SBIT](INFO): Initialize SBIT Component. 2024-06-28T00:47:41.805Z,1719535661.805 [SBIT](IMPORTANT): git: 2024-06-03 2024-06-28T00:47:41.805Z,1719535661.805 [SBIT](INFO): git hash: 7fa19da3a148abf4baea4b65318d99ca26f8c915 2024-06-28T00:47:41.805Z,1719535661.805 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-06-28T00:47:41.806Z,1719535661.806 [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-28T00:47:41.807Z,1719535661.807 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2024-06-28T00:47:41.808Z,1719535661.808 [IBIT](INFO): Initialize IBIT Component. 2024-06-28T00:47:41.809Z,1719535661.809 [CBIT](DEBUG): Initialize CBIT Component. 2024-06-28T00:47:41.810Z,1719535661.810 [logger ThreadHandler](INFO): Handler Thread ID is 933 2024-06-28T00:47:41.820Z,1719535661.820 [CBIT](DEBUG): Initialized mux pins. 2024-06-28T00:47:41.820Z,1719535661.820 [CBIT](DEBUG): Initializing the watchdog timer. 2024-06-28T00:47:41.828Z,1719535661.828 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 934 2024-06-28T00:47:41.841Z,1719535661.841 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 935 2024-06-28T00:47:41.842Z,1719535661.842 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-06-28T00:47:41.844Z,1719535661.844 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-06-28T00:47:41.844Z,1719535661.844 [CBIT](DEBUG): Initializing heartbeat. 2024-06-28T00:47:41.852Z,1719535661.852 [Onboard ThreadHandler](INFO): Handler Thread ID is 936 2024-06-28T00:47:41.870Z,1719535661.870 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 937 2024-06-28T00:47:41.892Z,1719535661.892 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 938 2024-06-28T00:47:41.893Z,1719535661.893 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-06-28T00:47:41.897Z,1719535661.897 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 940 2024-06-28T00:47:41.900Z,1719535661.900 [WetLabsBB2FL](INFO): Powering up 2024-06-28T00:47:41.901Z,1719535661.901 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 942 2024-06-28T00:47:41.909Z,1719535661.909 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-06-28T00:47:41.909Z,1719535661.909 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-06-28T00:47:41.909Z,1719535661.909 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-06-28T00:47:41.909Z,1719535661.909 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-06-28T00:47:41.909Z,1719535661.909 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-06-28T00:47:41.910Z,1719535661.910 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-06-28T00:47:41.910Z,1719535661.910 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-06-28T00:47:41.910Z,1719535661.910 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-06-28T00:47:41.916Z,1719535661.916 [CBIT](DEBUG): Deactivating GF circuits. 2024-06-28T00:47:41.916Z,1719535661.916 [CBIT](DEBUG): Deactivating emergency mode. 2024-06-28T00:47:41.956Z,1719535661.956 [CBIT](DEBUG): Backplane powered. 2024-06-28T00:47:41.957Z,1719535661.957 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-06-28T00:47:41.957Z,1719535661.957 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-06-28T00:47:41.958Z,1719535661.958 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-06-28T00:47:41.963Z,1719535661.963 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-06-28T00:47:42.001Z,1719535662.001 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-06-28T00:47:42.022Z,1719535662.022 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-06-28T00:47:42.050Z,1719535662.050 [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-28T00:47:42.050Z,1719535662.050 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-06-28T00:47:42.050Z,1719535662.050 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-06-28T00:47:42.058Z,1719535662.058 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-06-28T00:47:42.276Z,1719535662.276 [Radio_Surface](INFO): Powering up 2024-06-28T00:47:42.365Z,1719535662.365 [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-28T00:47:42.386Z,1719535662.386 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-06-28T00:47:42.387Z,1719535662.387 [Default:A.Wait](DEBUG): Construct Wait. 2024-06-28T00:47:42.390Z,1719535662.390 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-06-28T00:47:42.427Z,1719535662.427 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-06-28T00:47:42.430Z,1719535662.430 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-06-28T00:47:42.452Z,1719535662.452 [Default:E.Execute](DEBUG): Construct Execute. 2024-06-28T00:47:42.455Z,1719535662.455 [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-28T00:47:42.472Z,1719535662.472 [controlThread](DEBUG): Component order: CycleStarter,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,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, 2024-06-28T00:47:42.515Z,1719535662.515 [Power24vConverter](INFO): Powering up. 2024-06-28T00:47:42.515Z,1719535662.515 [Sonardyne_Nano](INFO): Initializing. 2024-06-28T00:47:42.817Z,1719535662.817 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-06-28T00:47:42.828Z,1719535662.828 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-06-28T00:47:42.829Z,1719535662.829 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-06-28T00:47:42.840Z,1719535662.840 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-06-28T00:47:42.841Z,1719535662.841 [MassServo](DEBUG): Initializing EZServoServo. 2024-06-28T00:47:42.852Z,1719535662.852 [MassServo](DEBUG): Initializing MassServo. 2024-06-28T00:47:42.853Z,1719535662.853 [RudderServo](DEBUG): Initializing EZServoServo. 2024-06-28T00:47:42.864Z,1719535662.864 [RudderServo](DEBUG): Initializing RudderServo. 2024-06-28T00:47:42.865Z,1719535662.865 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-06-28T00:47:42.876Z,1719535662.876 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-06-28T00:47:43.038Z,1719535663.038 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-06-28T00:47:43.038Z,1719535663.038 [DropWeight] Hardware Fault, FailCount= 1 2024-06-28T00:47:43.038Z,1719535663.038 [DropWeight](ERROR): Hardware Fault 2024-06-28T00:47:43.084Z,1719535663.084 [CommandExec](FAULT): Scheduling is paused 2024-06-28T00:47:43.085Z,1719535663.085 [CBIT](INFO): Critical error at 20240628T004743 2024-06-28T00:47:43.085Z,1719535663.085 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-06-28T00:47:43.100Z,1719535663.100 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-06-28T00:47:43.100Z,1719535663.100 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-06-28T00:47:43.333Z,1719535663.333 [CBIT](INFO): Critical error at 20240628T004743 2024-06-28T00:47:44.008Z,1719535664.008 [WetLabsBB2FL](INFO): Powering down 2024-06-28T00:47:44.510Z,1719535664.510 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-06-28T00:47:45.724Z,1719535665.724 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2107 2024-06-28T00:47:48.329Z,1719535668.329 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-06-28T00:47:51.866Z,1719535671.866 [CBIT](CRITICAL): Environmental Failure. Press:14.836545 PSI. Humidity:43%. Temp:25 C. ABORTING MISSION 2024-06-28T00:47:52.234Z,1719535672.234 [CBIT](INFO): Critical error at 20240628T004751 2024-06-28T00:48:02.353Z,1719535682.353 [SBIT](IMPORTANT): Beginning Startup BIT 2024-06-28T00:48:02.357Z,1719535682.357 [CBIT](IMPORTANT): Beginning ground fault scan 2024-06-28T00:48:10.365Z,1719535690.365 [NAL9602](INFO): Powering up NAL9602 2024-06-28T00:48:13.250Z,1719535693.250 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.018017 CHAN A1 (24V): -0.007416 CHAN A2 (12V): -0.003937 CHAN A3 (5V): -0.003123 CHAN B0 (3.3V): -0.000960 CHAN B1 (3.15aV): -0.001235 CHAN B2 (3.15bV): -0.001120 CHAN B3 (GND): -0.000216 OPEN: 0.004840 Full Scale: +/- 1 mA 2024-06-28T00:48:15.654Z,1719535695.654 [SBIT](ERROR): Could not read massPosReader_. 2024-06-28T00:48:21.277Z,1719535701.277 [NAL9602](INFO): NAL9602 initialized 2024-06-28T00:48:49.337Z,1719535729.337 [CommandExec](IMPORTANT): got command restart system 2024-06-28T00:48:51.436Z,1719535731.436 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-28T00:48:51.436Z,1719535731.436 [CommandExec](INFO): Uninitializing the command executive. 2024-06-28T00:48:51.436Z,1719535731.436 [CommandExec](INFO): Uninitializing the command scheduler. 2024-06-28T00:48:51.437Z,1719535731.437 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-06-28T00:48:51.580Z,1719535731.580 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-06-28T00:48:51.580Z,1719535731.580 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-06-28T00:48:51.580Z,1719535731.580 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-06-28T00:48:51.581Z,1719535731.581 [NavChartDb](INFO): Join timeout helper Thread ID is 961 2024-06-28T00:48:51.756Z,1719535731.756 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-28T00:48:51.756Z,1719535731.756 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-06-28T00:48:51.764Z,1719535731.764 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-06-28T00:48:51.764Z,1719535731.764 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-06-28T00:48:51.764Z,1719535731.764 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 962 2024-06-28T00:48:51.960Z,1719535731.960 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-28T00:48:51.960Z,1719535731.960 [WetLabsBB2FL](INFO): Powering down 2024-0