2024-10-31T19:21:27.485Z,1730402487.485 [Supervisor](DEBUG): Initializing supervisor. 2024-10-31T19:21:27.490Z,1730402487.490 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-10-31T19:21:27.491Z,1730402487.491 [SyncHandler](INFO): Protected caller Thread ID is 2804 2024-10-31T19:21:27.491Z,1730402487.491 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-10-31T19:21:27.492Z,1730402487.492 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-10-31T19:21:27.492Z,1730402487.492 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2805 2024-10-31T19:21:27.496Z,1730402487.496 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-10-31T19:21:27.514Z,1730402487.514 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-10-31T19:21:27.515Z,1730402487.515 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-10-31T19:21:27.515Z,1730402487.515 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 2806 2024-10-31T19:21:27.519Z,1730402487.519 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-10-31T19:21:27.520Z,1730402487.520 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-10-31T19:21:27.521Z,1730402487.521 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2807 2024-10-31T19:21:27.523Z,1730402487.523 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-10-31T19:21:27.524Z,1730402487.524 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-10-31T19:21:27.524Z,1730402487.524 [logger ThreadHandler](INFO): Protected caller Thread ID is 2808 2024-10-31T19:21:27.527Z,1730402487.527 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-10-31T19:21:27.528Z,1730402487.528 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-10-31T19:21:27.530Z,1730402487.530 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-10-31T19:21:27.639Z,1730402487.639 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-10-31T19:21:27.639Z,1730402487.639 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-10-31T19:21:28.500Z,1730402488.500 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-10-31T19:21:28.501Z,1730402488.501 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-10-31T19:21:28.746Z,1730402488.746 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-10-31T19:21:28.747Z,1730402488.747 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-10-31T19:21:28.837Z,1730402488.837 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-10-31T19:21:28.980Z,1730402488.980 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-10-31T19:21:28.980Z,1730402488.980 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-10-31T19:21:29.073Z,1730402489.073 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-10-31T19:21:29.194Z,1730402489.194 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-10-31T19:21:29.194Z,1730402489.194 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-10-31T19:21:29.612Z,1730402489.612 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-10-31T19:21:29.613Z,1730402489.613 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-10-31T19:21:30.165Z,1730402490.165 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-10-31T19:21:30.166Z,1730402490.166 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-10-31T19:21:30.400Z,1730402490.400 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-10-31T19:21:30.401Z,1730402490.401 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-10-31T19:21:30.601Z,1730402490.601 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-10-31T19:21:30.602Z,1730402490.602 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-10-31T19:21:31.165Z,1730402491.165 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-10-31T19:21:31.166Z,1730402491.166 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-10-31T19:21:31.473Z,1730402491.473 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-10-31T19:21:31.473Z,1730402491.473 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-10-31T19:21:31.719Z,1730402491.719 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-10-31T19:21:31.720Z,1730402491.720 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-10-31T19:21:32.147Z,1730402492.147 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-10-31T19:21:32.148Z,1730402492.148 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-10-31T19:21:33.148Z,1730402493.148 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-10-31T19:21:33.150Z,1730402493.150 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-10-31T19:21:33.151Z,1730402493.151 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-10-31T19:21:33.249Z,1730402493.249 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-10-31T19:21:33.432Z,1730402493.432 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Dock.cfg 2024-10-31T19:21:33.550Z,1730402493.550 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg 2024-10-31T19:21:33.658Z,1730402493.658 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-10-31T19:21:33.778Z,1730402493.778 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-10-31T19:21:33.876Z,1730402493.876 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-10-31T19:21:33.983Z,1730402493.983 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-10-31T19:21:34.108Z,1730402494.108 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-10-31T19:21:34.384Z,1730402494.384 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-10-31T19:21:34.385Z,1730402494.385 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-10-31T19:21:34.491Z,1730402494.491 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-10-31T19:21:34.597Z,1730402494.597 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-10-31T19:21:34.752Z,1730402494.752 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-10-31T19:21:34.864Z,1730402494.864 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2024-10-31T19:21:34.864Z,1730402494.864 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-10-31T19:21:34.880Z,1730402494.880 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-10-31T19:21:34.990Z,1730402494.990 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-10-31T19:21:34.991Z,1730402494.991 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-10-31T19:21:35.044Z,1730402495.044 [VerticalControl](DEBUG): Construct VerticalControl. 2024-10-31T19:21:35.102Z,1730402495.102 [VerticalControl] Loaded 2024-10-31T19:21:35.102Z,1730402495.102 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-10-31T19:21:35.105Z,1730402495.105 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-10-31T19:21:35.151Z,1730402495.151 [HorizontalControl] Loaded 2024-10-31T19:21:35.151Z,1730402495.151 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-10-31T19:21:35.154Z,1730402495.154 [SpeedControl](DEBUG): Construct SpeedControl. 2024-10-31T19:21:35.156Z,1730402495.156 [SpeedControl] Loaded 2024-10-31T19:21:35.157Z,1730402495.157 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-10-31T19:21:35.159Z,1730402495.159 [LoopControl](DEBUG): Construct LoopControl. 2024-10-31T19:21:35.160Z,1730402495.160 [LoopControl] Loaded 2024-10-31T19:21:35.160Z,1730402495.160 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-10-31T19:21:35.160Z,1730402495.160 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-10-31T19:21:35.161Z,1730402495.161 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-10-31T19:21:35.210Z,1730402495.210 [DepthRateCalculator] Loaded 2024-10-31T19:21:35.210Z,1730402495.210 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-10-31T19:21:35.215Z,1730402495.215 [PitchRateCalculator] Loaded 2024-10-31T19:21:35.215Z,1730402495.215 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-10-31T19:21:35.225Z,1730402495.225 [SpeedCalculator] Loaded 2024-10-31T19:21:35.225Z,1730402495.225 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-10-31T19:21:35.230Z,1730402495.230 [YawRateCalculator] Loaded 2024-10-31T19:21:35.230Z,1730402495.230 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-10-31T19:21:35.248Z,1730402495.248 [ElevatorOffsetCalculator] Loaded 2024-10-31T19:21:35.248Z,1730402495.248 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-10-31T19:21:35.249Z,1730402495.249 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-10-31T19:21:35.249Z,1730402495.249 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-10-31T19:21:35.276Z,1730402495.276 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-10-31T19:21:35.277Z,1730402495.277 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-10-31T19:21:35.333Z,1730402495.333 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-10-31T19:21:35.334Z,1730402495.334 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-10-31T19:21:35.663Z,1730402495.663 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-10-31T19:21:35.663Z,1730402495.663 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-10-31T19:21:35.831Z,1730402495.831 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-10-31T19:21:35.832Z,1730402495.832 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-10-31T19:21:36.269Z,1730402496.269 [AHRS_M2] Loaded 2024-10-31T19:21:36.269Z,1730402496.269 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-10-31T19:21:36.308Z,1730402496.308 [BackseatComponent] Loaded 2024-10-31T19:21:36.308Z,1730402496.308 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-10-31T19:21:36.309Z,1730402496.309 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409C34E0 2024-10-31T19:21:36.309Z,1730402496.309 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 2897 2024-10-31T19:21:36.312Z,1730402496.312 [LcmUniversalReporter] Loaded 2024-10-31T19:21:36.312Z,1730402496.312 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-10-31T19:21:37.117Z,1730402497.117 [BPC1] Loaded 2024-10-31T19:21:37.117Z,1730402497.117 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-10-31T19:21:37.208Z,1730402497.208 [DAT] Loaded 2024-10-31T19:21:37.208Z,1730402497.208 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-10-31T19:21:37.209Z,1730402497.209 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409F34E0 2024-10-31T19:21:37.210Z,1730402497.210 [DAT ThreadHandler](INFO): Protected caller Thread ID is 2898 2024-10-31T19:21:37.283Z,1730402497.283 [DataOverHttps] Loaded 2024-10-31T19:21:37.284Z,1730402497.284 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-10-31T19:21:37.285Z,1730402497.285 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A234E0 2024-10-31T19:21:37.285Z,1730402497.285 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2899 2024-10-31T19:21:37.308Z,1730402497.308 [Depth_Keller] Loaded 2024-10-31T19:21:37.308Z,1730402497.308 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-10-31T19:21:37.372Z,1730402497.372 [NAL9602] Loaded 2024-10-31T19:21:37.373Z,1730402497.373 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-10-31T19:21:37.402Z,1730402497.402 [Onboard] Loaded 2024-10-31T19:21:37.402Z,1730402497.402 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-10-31T19:21:37.403Z,1730402497.403 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A534E0 2024-10-31T19:21:37.404Z,1730402497.404 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2900 2024-10-31T19:21:37.417Z,1730402497.417 [Power24vConverter] Loaded 2024-10-31T19:21:37.418Z,1730402497.418 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-10-31T19:21:37.432Z,1730402497.432 [Radio_Surface] Loaded 2024-10-31T19:21:37.432Z,1730402497.432 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-10-31T19:21:37.434Z,1730402497.434 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A834E0 2024-10-31T19:21:37.434Z,1730402497.434 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2901 2024-10-31T19:21:37.480Z,1730402497.480 [RDI_Pathfinder] Loaded 2024-10-31T19:21:37.480Z,1730402497.480 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-10-31T19:21:37.495Z,1730402497.495 [Sonardyne_Nano] Loaded 2024-10-31T19:21:37.495Z,1730402497.495 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-10-31T19:21:37.496Z,1730402497.496 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-10-31T19:21:37.496Z,1730402497.496 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-10-31T19:21:37.840Z,1730402497.840 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-10-31T19:21:37.840Z,1730402497.840 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-10-31T19:21:37.922Z,1730402497.922 [NavChart] Loaded 2024-10-31T19:21:37.922Z,1730402497.922 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-10-31T19:21:37.927Z,1730402497.927 [UniversalFixResidualReporter] Loaded 2024-10-31T19:21:37.928Z,1730402497.928 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-10-31T19:21:37.928Z,1730402497.928 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-10-31T19:21:37.941Z,1730402497.941 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-10-31T19:21:38.128Z,1730402498.128 [SBIT](DEBUG): Construct Startup Built In Test. 2024-10-31T19:21:38.137Z,1730402498.137 [SBIT] Loaded 2024-10-31T19:21:38.137Z,1730402498.137 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-10-31T19:21:38.140Z,1730402498.140 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-10-31T19:21:38.152Z,1730402498.152 [IBIT] Loaded 2024-10-31T19:21:38.152Z,1730402498.152 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-10-31T19:21:38.158Z,1730402498.158 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-10-31T19:21:38.262Z,1730402498.262 [CBIT] Loaded 2024-10-31T19:21:38.262Z,1730402498.262 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-10-31T19:21:38.263Z,1730402498.263 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-10-31T19:21:38.263Z,1730402498.263 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-10-31T19:21:38.397Z,1730402498.397 [BuoyancyServo] Loaded 2024-10-31T19:21:38.397Z,1730402498.397 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-10-31T19:21:38.420Z,1730402498.420 [ElevatorServo] Loaded 2024-10-31T19:21:38.420Z,1730402498.420 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-10-31T19:21:38.450Z,1730402498.450 [DockingStepper] Loaded 2024-10-31T19:21:38.450Z,1730402498.450 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2024-10-31T19:21:38.471Z,1730402498.471 [MassServo] Loaded 2024-10-31T19:21:38.472Z,1730402498.472 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-10-31T19:21:38.492Z,1730402498.492 [RudderServo] Loaded 2024-10-31T19:21:38.492Z,1730402498.492 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-10-31T19:21:38.511Z,1730402498.511 [ThrusterServo] Loaded 2024-10-31T19:21:38.511Z,1730402498.511 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-10-31T19:21:38.511Z,1730402498.511 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-10-31T19:21:38.512Z,1730402498.512 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-10-31T19:21:38.522Z,1730402498.522 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-10-31T19:21:38.523Z,1730402498.523 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-10-31T19:21:38.702Z,1730402498.702 [CTD_Seabird] Loaded 2024-10-31T19:21:38.703Z,1730402498.703 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-10-31T19:21:38.704Z,1730402498.704 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BD74E0 2024-10-31T19:21:38.704Z,1730402498.704 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2902 2024-10-31T19:21:38.726Z,1730402498.726 [PAR_Licor] Loaded 2024-10-31T19:21:38.727Z,1730402498.727 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-10-31T19:21:38.770Z,1730402498.770 [WetLabsBB2FL] Loaded 2024-10-31T19:21:38.771Z,1730402498.771 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-10-31T19:21:38.772Z,1730402498.772 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0 2024-10-31T19:21:38.772Z,1730402498.772 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2903 2024-10-31T19:21:38.793Z,1730402498.793 [WetLabsUBAT] Loaded 2024-10-31T19:21:38.793Z,1730402498.793 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2024-10-31T19:21:38.794Z,1730402498.794 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0 2024-10-31T19:21:38.794Z,1730402498.794 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 2904 2024-10-31T19:21:38.795Z,1730402498.795 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-10-31T19:21:38.801Z,1730402498.801 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-10-31T19:21:38.804Z,1730402498.804 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-10-31T19:21:38.816Z,1730402498.816 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-10-31T19:21:38.817Z,1730402498.817 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C674E0 2024-10-31T19:21:38.817Z,1730402498.817 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2905 2024-10-31T19:21:38.822Z,1730402498.822 [Supervisor](INFO): Main Thread ID is 2803 2024-10-31T19:21:38.822Z,1730402498.822 [Supervisor](DEBUG): Running supervisor. 2024-10-31T19:21:38.822Z,1730402498.822 [CommandExec ThreadHandler](INFO): Handler Thread ID is 2906 2024-10-31T19:21:38.823Z,1730402498.823 [CommandExec](INFO): Initializing the command executive. 2024-10-31T19:21:38.824Z,1730402498.824 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2907 2024-10-31T19:21:38.826Z,1730402498.826 [controlThread ThreadHandler](INFO): Handler Thread ID is 2908 2024-10-31T19:21:38.827Z,1730402498.827 [controlThread](DEBUG): Initializing ControlThread 2024-10-31T19:21:38.828Z,1730402498.828 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-10-31T19:21:38.829Z,1730402498.829 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-10-31T19:21:38.830Z,1730402498.830 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-10-31T19:21:38.830Z,1730402498.830 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-10-31T19:21:38.831Z,1730402498.831 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-10-31T19:21:38.831Z,1730402498.831 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-10-31T19:21:38.831Z,1730402498.831 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-10-31T19:21:38.832Z,1730402498.832 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-10-31T19:21:38.832Z,1730402498.832 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-10-31T19:21:38.838Z,1730402498.838 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-10-31T19:21:38.839Z,1730402498.839 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-10-31T19:21:38.839Z,1730402498.839 [SBIT](INFO): Initialize SBIT Component. 2024-10-31T19:21:38.839Z,1730402498.839 [SBIT](IMPORTANT): git: 2024-09-16-6-g0ff0875e7 2024-10-31T19:21:38.840Z,1730402498.840 [SBIT](INFO): git hash: 0ff0875e7d61407625f072951f853bf2f0176185 2024-10-31T19:21:38.840Z,1730402498.840 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-10-31T19:21:38.841Z,1730402498.841 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-10-31T19:21:38.842Z,1730402498.842 [SBIT](INFO): Beginning SBIT in 114.000000 seconds. 2024-10-31T19:21:38.843Z,1730402498.843 [IBIT](INFO): Initialize IBIT Component. 2024-10-31T19:21:38.843Z,1730402498.843 [CBIT](DEBUG): Initialize CBIT Component. 2024-10-31T19:21:38.844Z,1730402498.844 [logger ThreadHandler](INFO): Handler Thread ID is 2909 2024-10-31T19:21:38.857Z,1730402498.857 [CBIT](DEBUG): Initialized mux pins. 2024-10-31T19:21:38.857Z,1730402498.857 [CBIT](DEBUG): Initializing the watchdog timer. 2024-10-31T19:21:38.861Z,1730402498.861 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 2910 2024-10-31T19:21:38.869Z,1730402498.869 [DAT ThreadHandler](INFO): Handler Thread ID is 2911 2024-10-31T19:21:38.870Z,1730402498.870 [DAT](INFO): Powering up 2024-10-31T19:21:38.870Z,1730402498.870 [DAT](DEBUG): Initializing DAT. 2024-10-31T19:21:38.881Z,1730402498.881 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-10-31T19:21:38.882Z,1730402498.882 [CBIT](DEBUG): Initializing heartbeat. 2024-10-31T19:21:38.882Z,1730402498.882 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2913 2024-10-31T19:21:38.884Z,1730402498.884 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-10-31T19:21:38.893Z,1730402498.893 [Onboard ThreadHandler](INFO): Handler Thread ID is 2914 2024-10-31T19:21:38.923Z,1730402498.923 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2915 2024-10-31T19:21:38.937Z,1730402498.937 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2916 2024-10-31T19:21:38.938Z,1730402498.938 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-10-31T19:21:38.942Z,1730402498.942 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2918 2024-10-31T19:21:38.945Z,1730402498.945 [WetLabsBB2FL](INFO): Powering up 2024-10-31T19:21:38.947Z,1730402498.947 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 2920 2024-10-31T19:21:38.949Z,1730402498.949 [WetLabsUBAT](INFO): Powering up 2024-10-31T19:21:38.951Z,1730402498.951 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2922 2024-10-31T19:21:38.953Z,1730402498.953 [CBIT](DEBUG): Deactivating GF circuits. 2024-10-31T19:21:38.953Z,1730402498.953 [CBIT](DEBUG): Deactivating emergency mode. 2024-10-31T19:21:38.955Z,1730402498.955 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-10-31T19:21:38.955Z,1730402498.955 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-10-31T19:21:38.955Z,1730402498.955 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-10-31T19:21:38.955Z,1730402498.955 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-10-31T19:21:38.955Z,1730402498.955 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-10-31T19:21:38.955Z,1730402498.955 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-10-31T19:21:38.956Z,1730402498.956 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-10-31T19:21:38.956Z,1730402498.956 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-10-31T19:21:38.993Z,1730402498.993 [CBIT](DEBUG): Backplane powered. 2024-10-31T19:21:38.998Z,1730402498.998 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-10-31T19:21:38.998Z,1730402498.998 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl 2024-10-31T19:21:38.999Z,1730402498.999 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl 2024-10-31T19:21:38.000Z,1730402499.000 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl 2024-10-31T19:21:39.014Z,1730402499.014 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into: 2024-10-31T19:21:39.015Z,1730402499.015 [MissionManager](ERROR): Top node has no child nodes: Mission 2024-10-31T19:21:39.015Z,1730402499.015 [MissionManager](ERROR): Could not load startup mission. 2024-10-31T19:21:39.015Z,1730402499.015 [MissionManager](INFO): Loading Mission from file: Missions/underIce/DefaultWithUndock.tl 2024-10-31T19:21:39.015Z,1730402499.015 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/DefaultWithUndock.tl 2024-10-31T19:21:39.017Z,1730402499.017 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/DefaultWithUndock.tl 2024-10-31T19:21:39.325Z,1730402499.325 [Radio_Surface](INFO): Powering up 2024-10-31T19:21:39.573Z,1730402499.573 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/DefaultWithUndock.tl translated into: 0 6 10 1 3 30 Timed out while trying to detach from dock at current depth of . Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-10-31T19:21:39.613Z,1730402499.613 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min 2024-10-31T19:21:39.634Z,1730402499.634 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 6.000000 h 2024-10-31T19:21:39.638Z,1730402499.638 [MissionManager](INFO): DefineArg DefaultWithUndock.TransponderCode = 50 count 2024-10-31T19:21:39.654Z,1730402499.654 [MissionManager](INFO): DefineArg DefaultWithUndock.TrackingUpdatePeriod = 10.000000 s 2024-10-31T19:21:39.658Z,1730402499.658 [MissionManager](INFO): DefineArg DefaultWithUndock.NumberOfPings = 1.000000 count 2024-10-31T19:21:39.685Z,1730402499.685 [MissionManager](INFO): DefineArg DefaultWithUndock.DriftTimeout = 3.000000 min 2024-10-31T19:21:39.687Z,1730402499.687 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait. 2024-10-31T19:21:39.824Z,1730402499.824 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Construct. 2024-10-31T19:21:39.824Z,1730402499.824 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2024-10-31T19:21:39.898Z,1730402499.898 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-10-31T19:21:39.920Z,1730402499.920 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-10-31T19:21:39.951Z,1730402499.951 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-10-31T19:21:39.957Z,1730402499.957 [DefaultWithUndock:E.Execute](DEBUG): Construct Execute. 2024-10-31T19:21:39.977Z,1730402499.977 [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 DefaultWithUndock { arguments { ElapsedSinceDefaultStarted = 0 minute DetachTimeout = 6 hour """ Maximum time duration for the vehicle to detach form the dock. """ TransponderCode = Dock:Dock.transponderCode """ Dock transponder address. """ TrackingUpdatePeriod = 10 second """ Time duration between acoustic range queries while the mission is detaching from the dock. """ NumberOfPings = 1 count """ Number of pings requested each time. """ DriftTimeout = 3 minute """ How long to allow vehicle to drift away from dock before retrying reverse """ } 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 = 30 second } aggregate LeaveDock { run in sequence timeout duration=DetachTimeout { syslog important "Timed out while trying to detach from dock at current depth of " + Universal:depth~meter + "." } # Acoustic tracking directives behavior Estimation:TrackAcousticContact { run while ( Universal:depth > Control:VerticalControl.surfaceThreshold ) set contactLabelSetting = TransponderCode set numberOfSamplesSetting = NumberOfPings set updatePeriodSetting = TrackingUpdatePeriod } # Leave the dock behavior Dock:Undock { run in sequence set driftTimeout = DriftTimeout } } aggregate SurfaceDefault { run in sequence # This mission assumes open water so from here on it's the same old default that's always used 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=P2H { 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-10-31T19:21:39.989Z,1730402499.989 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-10-31T19:21:39.997Z,1730402499.997 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-10-31T19:21:40.075Z,1730402500.075 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993022 m 2024-10-31T19:21:40.075Z,1730402500.075 [Power24vConverter](INFO): Powering up. 2024-10-31T19:21:40.076Z,1730402500.076 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-10-31T19:21:40.078Z,1730402500.078 [Sonardyne_Nano](INFO): Initializing. 2024-10-31T19:21:40.106Z,1730402500.106 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-10-31T19:21:40.131Z,1730402500.131 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-10-31T19:21:40.137Z,1730402500.137 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-10-31T19:21:40.138Z,1730402500.138 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-10-31T19:21:40.145Z,1730402500.145 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-10-31T19:21:40.146Z,1730402500.146 [DockingStepper](INFO): Start 2024-10-31T19:21:40.146Z,1730402500.146 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-10-31T19:21:40.153Z,1730402500.153 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-10-31T19:21:40.154Z,1730402500.154 [MassServo](DEBUG): Initializing EZServoServo. 2024-10-31T19:21:40.161Z,1730402500.161 [MassServo](DEBUG): Initializing MassServo. 2024-10-31T19:21:40.162Z,1730402500.162 [RudderServo](DEBUG): Initializing EZServoServo. 2024-10-31T19:21:40.169Z,1730402500.169 [RudderServo](DEBUG): Initializing RudderServo. 2024-10-31T19:21:40.170Z,1730402500.170 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-10-31T19:21:40.177Z,1730402500.177 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-10-31T19:21:40.452Z,1730402500.452 [DockingStepper](INFO): Starting 2024-10-31T19:21:40.824Z,1730402500.824 [DockingStepper](INFO): Starting 2024-10-31T19:21:41.361Z,1730402501.361 [DockingStepper](INFO): Starting 2024-10-31T19:21:41.410Z,1730402501.410 [DockingStepper](INFO): Init string: /1z16352aE13561N3m50 2024-10-31T19:21:41.558Z,1730402501.558 [WetLabsBB2FL](INFO): Powering down 2024-10-31T19:21:41.663Z,1730402501.663 [DockingStepper](INFO): Starting 2024-10-31T19:21:42.015Z,1730402502.015 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-10-31T19:21:42.068Z,1730402502.068 [DockingStepper](INFO): Starting 2024-10-31T19:21:42.506Z,1730402502.506 [DockingStepper](INFO): Starting 2024-10-31T19:21:42.922Z,1730402502.922 [DockingStepper](INFO): Starting 2024-10-31T19:21:42.946Z,1730402502.946 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-10-31T19:21:43.360Z,1730402503.360 [DockingStepper](INFO): Starting 2024-10-31T19:21:43.669Z,1730402503.669 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103 2024-10-31T19:21:43.786Z,1730402503.786 [DockingStepper](INFO): Commanding negative:8927 2024-10-31T19:21:45.076Z,1730402505.076 [DockingStepper](INFO): Pause 2024-10-31T19:21:45.974Z,1730402505.974 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2024-10-31T19:21:48.201Z,1730402508.201 [WetLabsUBAT](INFO): Powering down 2024-10-31T19:21:51.982Z,1730402511.982 [DAT](INFO): DAT read: 2024-10-31T19:21:51.983Z,1730402511.983 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-10-31T19:21:52.731Z,1730402512.731 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004813 2024-10-31T19:21:53.746Z,1730402513.746 [DAT](INFO): DAT read: MF Frequency Band 2024-10-31T19:21:53.747Z,1730402513.747 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2024-10-31T19:21:53.748Z,1730402513.748 [DAT](INFO): DAT read: Oct 30 2024 23:21:40 2024-10-31T19:21:55.006Z,1730402515.006 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-10-31T19:21:55.007Z,1730402515.007 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP 2024-10-31T19:21:55.007Z,1730402515.007 [DAT](INFO): commRate: 600 2024-10-31T19:21:57.073Z,1730402517.073 [DAT](INFO): entering command mode 2024-10-31T19:21:57.274Z,1730402517.274 [DAT](INFO): DAT read: 2024-10-31T19:21:57.274Z,1730402517.274 [DAT](INFO): DAT read: user:1> 2024-10-31T19:21:57.274Z,1730402517.274 [DAT](INFO): setting verbose to 3 2024-10-31T19:21:57.525Z,1730402517.525 [DAT](INFO): DAT read: user:1> 2024-10-31T19:21:57.526Z,1730402517.526 [DAT](INFO): DAT read: Verbose | 3 2024-10-31T19:21:57.527Z,1730402517.527 [DAT](INFO): set verbose to 3 2024-10-31T19:21:57.527Z,1730402517.527 [DAT](INFO): setting DatVerbose to 27440 2024-10-31T19:21:57.778Z,1730402517.778 [DAT](INFO): DAT read: user:2> 2024-10-31T19:21:57.779Z,1730402517.779 [DAT](INFO): DAT read: DatVerbose | 27440 2024-10-31T19:21:57.779Z,1730402517.779 [DAT](INFO): set DatVerbose to 27440 2024-10-31T19:21:57.779Z,1730402517.779 [DAT](INFO): setting transmit power to 8 2024-10-31T19:21:58.030Z,1730402518.030 [DAT](INFO): DAT read: user:3> 2024-10-31T19:21:58.031Z,1730402518.031 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-10-31T19:21:58.031Z,1730402518.031 [DAT](INFO): set transmit power to 8 2024-10-31T19:21:58.031Z,1730402518.031 [DAT](INFO): setting local address to 10 2024-10-31T19:21:58.282Z,1730402518.282 [DAT](INFO): DAT read: user:4> 2024-10-31T19:21:58.282Z,1730402518.282 [DAT](INFO): DAT read: LocalAddr | 10 2024-10-31T19:21:58.283Z,1730402518.283 [DAT](INFO): set local address to 10 2024-10-31T19:21:58.284Z,1730402518.284 [DAT](INFO): Setting time to: 19:21:58 And date to:10/31/2024 2024-10-31T19:21:58.534Z,1730402518.534 [DAT](INFO): DAT read: user:5> 2024-10-31T19:21:58.535Z,1730402518.535 [DAT](INFO): DAT read: Thu Oct 31, 2024 19:21:58 2024-10-31T19:21:58.535Z,1730402518.535 [DAT](INFO): Local DAT time set to Thu Oct 31, 2024 19:21:58 2024-10-31T19:22:07.648Z,1730402527.648 [NAL9602](INFO): Powering up NAL9602 2024-10-31T19:22:13.814Z,1730402533.814 [CommandExec](IMPORTANT): got command failComponent 2024-10-31T19:22:13.814Z,1730402533.814 [CommandExec](IMPORTANT): Failed components: 2024-10-31T19:22:13.814Z,1730402533.814 [CommandExec](IMPORTANT): No failed Components. 2024-10-31T19:22:18.542Z,1730402538.542 [NAL9602](INFO): NAL9602 initialized 2024-10-31T19:22:21.926Z,1730402541.926 [CommandExec](IMPORTANT): got command restart application 2024-10-31T19:22:22.929Z,1730402542.929 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-10-31T19:22:22.929Z,1730402542.929 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-31T19:22:22.929Z,1730402542.929 [CommandExec](INFO): Uninitializing the command executive. 2024-10-31T19:22:22.930Z,1730402542.930 [CommandExec](INFO): Uninitializing the command scheduler. 2024-10-31T19:22:22.930Z,1730402542.930 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:23.093Z,1730402543.093 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-10-31T19:22:23.093Z,1730402543.093 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-10-31T19:22:23.093Z,1730402543.093 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:23.094Z,1730402543.094 [NavChartDb](INFO): Join timeout helper Thread ID is 2932 2024-10-31T19:22:23.911Z,1730402543.911 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-31T19:22:23.911Z,1730402543.911 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:23.913Z,1730402543.913 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2024-10-31T19:22:23.913Z,1730402543.913 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:23.914Z,1730402543.914 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 2933 2024-10-31T19:22:24.069Z,1730402544.069 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-31T19:22:24.069Z,1730402544.069 [WetLabsUBAT](INFO): Powering down 2024-10-31T19:22:24.070Z,1730402544.070 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:24.085Z,1730402544.085 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-10-31T19:22:24.085Z,1730402544.085 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:24.085Z,1730402544.085 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2934 2024-10-31T19:22:24.305Z,1730402544.305 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-31T19:22:24.305Z,1730402544.305 [WetLabsBB2FL](INFO): Powering down 2024-10-31T19:22:24.306Z,1730402544.306 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:24.314Z,1730402544.314 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-10-31T19:22:24.315Z,1730402544.315 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:24.315Z,1730402544.315 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2935 2024-10-31T19:22:25.125Z,1730402545.125 [CTD_Seabird](INFO): Powering down 2024-10-31T19:22:25.137Z,1730402545.137 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-31T19:22:25.137Z,1730402545.137 [CTD_Seabird](INFO): Powering down 2024-10-31T19:22:25.149Z,1730402545.149 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:25.170Z,1730402545.170 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-10-31T19:22:25.170Z,1730402545.170 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:25.171Z,1730402545.171 [Radio_Surface](INFO): Join timeout helper Thread ID is 2936 2024-10-31T19:22:25.381Z,1730402545.381 [Radio_Surface](INFO): Powering down 2024-10-31T19:22:25.382Z,1730402545.382 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-31T19:22:25.382Z,1730402545.382 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:25.414Z,1730402545.414 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-10-31T19:22:25.414Z,1730402545.414 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:25.414Z,1730402545.414 [Onboard](INFO): Join timeout helper Thread ID is 2937 2024-10-31T19:22:27.065Z,1730402547.065 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-10-31T19:22:28.953Z,1730402548.953 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-31T19:22:28.953Z,1730402548.953 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:28.974Z,1730402548.974 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-10-31T19:22:28.974Z,1730402548.974 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:28.974Z,1730402548.974 [DataOverHttps](INFO): Join timeout helper Thread ID is 2938 2024-10-31T19:22:29.073Z,1730402549.073 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-31T19:22:29.073Z,1730402549.073 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:29.094Z,1730402549.094 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-10-31T19:22:29.094Z,1730402549.094 [DAT ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:29.094Z,1730402549.094 [DAT](INFO): Join timeout helper Thread ID is 2939 2024-10-31T19:22:29.277Z,1730402549.277 [DAT](INFO): Powering down 2024-10-31T19:22:29.346Z,1730402549.346 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-31T19:22:29.346Z,1730402549.346 [DAT](INFO): Powering down 2024-10-31T19:22:29.347Z,1730402549.347 [DAT ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:29.358Z,1730402549.358 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-10-31T19:22:29.358Z,1730402549.358 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:29.358Z,1730402549.358 [BackseatComponent](INFO): Join timeout helper Thread ID is 2940 2024-10-31T19:22:29.365Z,1730402549.365 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-31T19:22:29.366Z,1730402549.366 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:29.389Z,1730402549.389 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-10-31T19:22:29.389Z,1730402549.389 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:29.390Z,1730402549.390 [logger](INFO): Join timeout helper Thread ID is 2941 2024-10-31T19:22:29.405Z,1730402549.405 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-31T19:22:29.405Z,1730402549.405 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:29.422Z,1730402549.422 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-10-31T19:22:29.422Z,1730402549.422 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:29.422Z,1730402549.422 [CommandLine](INFO): Join timeout helper Thread ID is 2942 2024-10-31T19:22:29.509Z,1730402549.509 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-31T19:22:29.509Z,1730402549.509 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:29.526Z,1730402549.526 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-10-31T19:22:29.526Z,1730402549.526 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:29.526Z,1730402549.526 [CommandExec](INFO): Join timeout helper Thread ID is 2943 2024-10-31T19:22:29.527Z,1730402549.527 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-10-31T19:22:29.527Z,1730402549.527 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:29.528Z,1730402549.528 [controlThread](INFO): Join timeout helper Thread ID is 2944 2024-10-31T19:22:29.833Z,1730402549.833 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-31T19:22:29.833Z,1730402549.833 [controlThread](DEBUG): Uninitializing ControlThread 2024-10-31T19:22:29.834Z,1730402549.834 [AHRS_M2](INFO): Powering down 2024-10-31T19:22:29.906Z,1730402549.906 [NAL9602](INFO): Powering down 2024-10-31T19:22:29.977Z,1730402549.977 [RDI_Pathfinder](INFO): Powering down 2024-10-31T19:22:29.978Z,1730402549.978 [Sonardyne_Nano](INFO): Powering down 2024-10-31T19:22:30.098Z,1730402550.098 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-10-31T19:22:30.098Z,1730402550.098 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-10-31T19:22:30.099Z,1730402550.099 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-10-31T19:22:30.099Z,1730402550.099 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock 2024-10-31T19:22:30.107Z,1730402550.107 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-10-31T19:22:30.107Z,1730402550.107 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-10-31T19:22:30.107Z,1730402550.107 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-10-31T19:22:30.108Z,1730402550.108 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-10-31T19:22:30.108Z,1730402550.108 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-10-31T19:22:30.108Z,1730402550.108 [BuoyancyServo](INFO): Powering down 2024-10-31T19:22:30.121Z,1730402550.121 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-10-31T19:22:30.121Z,1730402550.121 [ElevatorServo](INFO): Powering down 2024-10-31T19:22:30.122Z,1730402550.122 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-10-31T19:22:30.122Z,1730402550.122 [DockingStepper](INFO): Powering down 2024-10-31T19:22:30.123Z,1730402550.123 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-10-31T19:22:30.123Z,1730402550.123 [MassServo](INFO): Powering down 2024-10-31T19:22:30.124Z,1730402550.124 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-10-31T19:22:30.124Z,1730402550.124 [RudderServo](INFO): Powering down 2024-10-31T19:22:30.125Z,1730402550.125 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2024-10-31T19:22:30.125Z,1730402550.125 [ThrusterServo](INFO): Powering down 2024-10-31T19:22:30.126Z,1730402550.126 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-10-31T19:22:30.126Z,1730402550.126 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-10-31T19:22:30.126Z,1730402550.126 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-10-31T19:22:30.126Z,1730402550.126 [CBIT](DEBUG): Powering off loads. 2024-10-31T19:22:30.137Z,1730402550.137 [CBIT](DEBUG): Disabling WDT. 2024-10-31T19:22:30.149Z,1730402550.149 [CBIT](DEBUG): Opening all GF detection circuits. 2024-10-31T19:22:30.150Z,1730402550.150 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:30.213Z,1730402550.213 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:30.216Z,1730402550.216 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:30.221Z,1730402550.221 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:30.227Z,1730402550.227 [DAT ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:30.267Z,1730402550.267 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:30.562Z,1730402550.562 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:30.564Z,1730402550.564 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:30.568Z,1730402550.568 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:30.576Z,1730402550.576 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-31T19:22:30.639Z,1730402550.639 [logger ThreadHandler](INFO): Thread cancelled.