2024-07-13T18:51:17.863Z,1720896677.863 [Supervisor](DEBUG): Initializing supervisor. 2024-07-13T18:51:17.867Z,1720896677.867 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-07-13T18:51:17.868Z,1720896677.868 [SyncHandler](INFO): Protected caller Thread ID is 7410 2024-07-13T18:51:17.868Z,1720896677.868 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-07-13T18:51:17.869Z,1720896677.869 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-07-13T18:51:17.869Z,1720896677.869 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7411 2024-07-13T18:51:17.873Z,1720896677.873 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-07-13T18:51:17.890Z,1720896677.890 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-07-13T18:51:17.891Z,1720896677.891 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-07-13T18:51:17.891Z,1720896677.891 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 7412 2024-07-13T18:51:17.896Z,1720896677.896 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-07-13T18:51:17.896Z,1720896677.896 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-07-13T18:51:17.897Z,1720896677.897 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7413 2024-07-13T18:51:17.899Z,1720896677.899 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-07-13T18:51:17.900Z,1720896677.900 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-07-13T18:51:17.900Z,1720896677.900 [logger ThreadHandler](INFO): Protected caller Thread ID is 7414 2024-07-13T18:51:17.904Z,1720896677.904 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-07-13T18:51:17.904Z,1720896677.904 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-07-13T18:51:17.906Z,1720896677.906 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-07-13T18:51:18.018Z,1720896678.018 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-07-13T18:51:18.019Z,1720896678.019 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-07-13T18:51:18.943Z,1720896678.943 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-07-13T18:51:18.943Z,1720896678.943 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-07-13T18:51:19.195Z,1720896679.195 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-07-13T18:51:19.195Z,1720896679.195 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-07-13T18:51:19.289Z,1720896679.289 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-07-13T18:51:19.439Z,1720896679.439 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-07-13T18:51:19.439Z,1720896679.439 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-07-13T18:51:19.535Z,1720896679.535 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-07-13T18:51:19.657Z,1720896679.657 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-07-13T18:51:19.657Z,1720896679.657 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-07-13T18:51:20.077Z,1720896680.077 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-07-13T18:51:20.077Z,1720896680.077 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-07-13T18:51:20.651Z,1720896680.651 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-07-13T18:51:20.651Z,1720896680.651 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-07-13T18:51:20.896Z,1720896680.896 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-07-13T18:51:20.896Z,1720896680.896 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-07-13T18:51:21.104Z,1720896681.104 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-07-13T18:51:21.104Z,1720896681.104 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-07-13T18:51:21.671Z,1720896681.671 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-07-13T18:51:21.672Z,1720896681.672 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-07-13T18:51:21.983Z,1720896681.983 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-07-13T18:51:21.984Z,1720896681.984 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-07-13T18:51:22.348Z,1720896682.348 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-07-13T18:51:22.348Z,1720896682.348 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-07-13T18:51:22.746Z,1720896682.746 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-07-13T18:51:22.747Z,1720896682.747 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-07-13T18:51:23.245Z,1720896683.245 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-07-13T18:51:23.247Z,1720896683.247 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-07-13T18:51:23.248Z,1720896683.248 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-07-13T18:51:23.560Z,1720896683.560 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-07-13T18:51:23.954Z,1720896683.954 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg 2024-07-13T18:51:24.109Z,1720896684.109 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-07-13T18:51:24.231Z,1720896684.231 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-07-13T18:51:24.330Z,1720896684.330 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-07-13T18:51:24.439Z,1720896684.439 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-07-13T18:51:24.566Z,1720896684.566 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-07-13T18:51:24.843Z,1720896684.843 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-07-13T18:51:24.843Z,1720896684.843 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-07-13T18:51:24.951Z,1720896684.951 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-07-13T18:51:25.058Z,1720896685.058 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-07-13T18:51:25.215Z,1720896685.215 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-07-13T18:51:25.330Z,1720896685.330 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2024-07-13T18:51:25.330Z,1720896685.330 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-07-13T18:51:25.346Z,1720896685.346 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-07-13T18:51:25.491Z,1720896685.491 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-07-13T18:51:25.491Z,1720896685.491 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-07-13T18:51:25.560Z,1720896685.560 [VerticalControl](DEBUG): Construct VerticalControl. 2024-07-13T18:51:25.618Z,1720896685.618 [VerticalControl] Loaded 2024-07-13T18:51:25.619Z,1720896685.619 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-07-13T18:51:25.621Z,1720896685.621 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-07-13T18:51:25.667Z,1720896685.667 [HorizontalControl] Loaded 2024-07-13T18:51:25.668Z,1720896685.668 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-07-13T18:51:25.670Z,1720896685.670 [SpeedControl](DEBUG): Construct SpeedControl. 2024-07-13T18:51:25.673Z,1720896685.673 [SpeedControl] Loaded 2024-07-13T18:51:25.673Z,1720896685.673 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-07-13T18:51:25.676Z,1720896685.676 [LoopControl](DEBUG): Construct LoopControl. 2024-07-13T18:51:25.676Z,1720896685.676 [LoopControl] Loaded 2024-07-13T18:51:25.676Z,1720896685.676 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-07-13T18:51:25.677Z,1720896685.677 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-07-13T18:51:25.677Z,1720896685.677 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-07-13T18:51:25.743Z,1720896685.743 [DepthRateCalculator] Loaded 2024-07-13T18:51:25.743Z,1720896685.743 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-07-13T18:51:25.748Z,1720896685.748 [PitchRateCalculator] Loaded 2024-07-13T18:51:25.748Z,1720896685.748 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-07-13T18:51:25.758Z,1720896685.758 [SpeedCalculator] Loaded 2024-07-13T18:51:25.758Z,1720896685.758 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-07-13T18:51:25.762Z,1720896685.762 [YawRateCalculator] Loaded 2024-07-13T18:51:25.762Z,1720896685.762 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-07-13T18:51:25.780Z,1720896685.780 [ElevatorOffsetCalculator] Loaded 2024-07-13T18:51:25.780Z,1720896685.780 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-07-13T18:51:25.781Z,1720896685.781 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-07-13T18:51:25.781Z,1720896685.781 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-07-13T18:51:25.820Z,1720896685.820 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-07-13T18:51:25.820Z,1720896685.820 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-07-13T18:51:25.902Z,1720896685.902 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-07-13T18:51:25.902Z,1720896685.902 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-07-13T18:51:26.295Z,1720896686.295 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-07-13T18:51:26.295Z,1720896686.295 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-07-13T18:51:26.504Z,1720896686.504 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-07-13T18:51:26.504Z,1720896686.504 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-07-13T18:51:27.225Z,1720896687.225 [AHRS_M2] Loaded 2024-07-13T18:51:27.226Z,1720896687.226 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-07-13T18:51:27.264Z,1720896687.264 [BackseatComponent] Loaded 2024-07-13T18:51:27.264Z,1720896687.264 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-07-13T18:51:27.265Z,1720896687.265 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409C54E0 2024-07-13T18:51:27.266Z,1720896687.266 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 7500 2024-07-13T18:51:27.269Z,1720896687.269 [LcmUniversalReporter] Loaded 2024-07-13T18:51:27.269Z,1720896687.269 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-07-13T18:51:28.080Z,1720896688.080 [BPC1] Loaded 2024-07-13T18:51:28.080Z,1720896688.080 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-07-13T18:51:28.173Z,1720896688.173 [DataOverHttps] Loaded 2024-07-13T18:51:28.173Z,1720896688.173 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-07-13T18:51:28.174Z,1720896688.174 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409F54E0 2024-07-13T18:51:28.174Z,1720896688.174 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7501 2024-07-13T18:51:28.197Z,1720896688.197 [Depth_Keller] Loaded 2024-07-13T18:51:28.197Z,1720896688.197 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-07-13T18:51:28.202Z,1720896688.202 [DropWeight] Loaded 2024-07-13T18:51:28.202Z,1720896688.202 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-07-13T18:51:28.265Z,1720896688.265 [NAL9602] Loaded 2024-07-13T18:51:28.265Z,1720896688.265 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-07-13T18:51:28.295Z,1720896688.295 [Onboard] Loaded 2024-07-13T18:51:28.295Z,1720896688.295 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-07-13T18:51:28.296Z,1720896688.296 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A254E0 2024-07-13T18:51:28.297Z,1720896688.297 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7502 2024-07-13T18:51:28.310Z,1720896688.310 [Power24vConverter] Loaded 2024-07-13T18:51:28.310Z,1720896688.310 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-07-13T18:51:28.326Z,1720896688.326 [Radio_Surface] Loaded 2024-07-13T18:51:28.326Z,1720896688.326 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-07-13T18:51:28.330Z,1720896688.330 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A554E0 2024-07-13T18:51:28.330Z,1720896688.330 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7503 2024-07-13T18:51:28.417Z,1720896688.417 [RDI_Pathfinder] Loaded 2024-07-13T18:51:28.417Z,1720896688.417 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-07-13T18:51:28.486Z,1720896688.486 [Sonardyne_Nano] Loaded 2024-07-13T18:51:28.487Z,1720896688.487 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-07-13T18:51:28.842Z,1720896688.842 [DAT] Loaded 2024-07-13T18:51:28.842Z,1720896688.842 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-07-13T18:51:28.843Z,1720896688.843 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A854E0 2024-07-13T18:51:28.844Z,1720896688.844 [DAT ThreadHandler](INFO): Protected caller Thread ID is 7504 2024-07-13T18:51:28.844Z,1720896688.844 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-07-13T18:51:28.845Z,1720896688.845 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-07-13T18:51:29.167Z,1720896689.167 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-07-13T18:51:29.168Z,1720896689.168 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-07-13T18:51:29.181Z,1720896689.181 [NavChart] Loaded 2024-07-13T18:51:29.181Z,1720896689.181 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-07-13T18:51:29.187Z,1720896689.187 [UniversalFixResidualReporter] Loaded 2024-07-13T18:51:29.187Z,1720896689.187 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-07-13T18:51:29.187Z,1720896689.187 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-07-13T18:51:29.188Z,1720896689.188 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-07-13T18:51:29.356Z,1720896689.356 [SBIT](DEBUG): Construct Startup Built In Test. 2024-07-13T18:51:29.364Z,1720896689.364 [SBIT] Loaded 2024-07-13T18:51:29.365Z,1720896689.365 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-07-13T18:51:29.368Z,1720896689.368 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-07-13T18:51:29.380Z,1720896689.380 [IBIT] Loaded 2024-07-13T18:51:29.380Z,1720896689.380 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-07-13T18:51:29.386Z,1720896689.386 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-07-13T18:51:29.490Z,1720896689.490 [CBIT] Loaded 2024-07-13T18:51:29.490Z,1720896689.490 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-07-13T18:51:29.490Z,1720896689.490 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-07-13T18:51:29.491Z,1720896689.491 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-07-13T18:51:29.652Z,1720896689.652 [BuoyancyServo] Loaded 2024-07-13T18:51:29.652Z,1720896689.652 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-07-13T18:51:29.675Z,1720896689.675 [ElevatorServo] Loaded 2024-07-13T18:51:29.675Z,1720896689.675 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-07-13T18:51:29.704Z,1720896689.704 [DockingStepper] Loaded 2024-07-13T18:51:29.705Z,1720896689.705 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2024-07-13T18:51:29.726Z,1720896689.726 [MassServo] Loaded 2024-07-13T18:51:29.726Z,1720896689.726 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-07-13T18:51:29.746Z,1720896689.746 [RudderServo] Loaded 2024-07-13T18:51:29.747Z,1720896689.747 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-07-13T18:51:29.765Z,1720896689.765 [ThrusterServo] Loaded 2024-07-13T18:51:29.765Z,1720896689.765 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-07-13T18:51:29.766Z,1720896689.766 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-07-13T18:51:29.766Z,1720896689.766 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-07-13T18:51:29.780Z,1720896689.780 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-07-13T18:51:29.781Z,1720896689.781 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-07-13T18:51:30.004Z,1720896690.004 [CTD_Seabird] Loaded 2024-07-13T18:51:30.004Z,1720896690.004 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-07-13T18:51:30.005Z,1720896690.005 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BD94E0 2024-07-13T18:51:30.005Z,1720896690.005 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7505 2024-07-13T18:51:30.028Z,1720896690.028 [PAR_Licor] Loaded 2024-07-13T18:51:30.028Z,1720896690.028 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-07-13T18:51:30.072Z,1720896690.072 [WetLabsBB2FL] Loaded 2024-07-13T18:51:30.072Z,1720896690.072 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-07-13T18:51:30.073Z,1720896690.073 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C094E0 2024-07-13T18:51:30.073Z,1720896690.073 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7506 2024-07-13T18:51:30.094Z,1720896690.094 [WetLabsUBAT] Loaded 2024-07-13T18:51:30.095Z,1720896690.095 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2024-07-13T18:51:30.096Z,1720896690.096 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C394E0 2024-07-13T18:51:30.096Z,1720896690.096 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 7507 2024-07-13T18:51:30.096Z,1720896690.096 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-07-13T18:51:30.103Z,1720896690.103 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-07-13T18:51:30.105Z,1720896690.105 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-07-13T18:51:30.117Z,1720896690.117 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-07-13T18:51:30.118Z,1720896690.118 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C694E0 2024-07-13T18:51:30.118Z,1720896690.118 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7508 2024-07-13T18:51:30.122Z,1720896690.122 [Supervisor](INFO): Main Thread ID is 7409 2024-07-13T18:51:30.122Z,1720896690.122 [Supervisor](DEBUG): Running supervisor. 2024-07-13T18:51:30.123Z,1720896690.123 [CommandExec ThreadHandler](INFO): Handler Thread ID is 7509 2024-07-13T18:51:30.124Z,1720896690.124 [CommandExec](INFO): Initializing the command executive. 2024-07-13T18:51:30.125Z,1720896690.125 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7510 2024-07-13T18:51:30.128Z,1720896690.128 [controlThread ThreadHandler](INFO): Handler Thread ID is 7511 2024-07-13T18:51:30.129Z,1720896690.129 [controlThread](DEBUG): Initializing ControlThread 2024-07-13T18:51:30.130Z,1720896690.130 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-07-13T18:51:30.131Z,1720896690.131 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-07-13T18:51:30.132Z,1720896690.132 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-07-13T18:51:30.132Z,1720896690.132 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-07-13T18:51:30.133Z,1720896690.133 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-07-13T18:51:30.133Z,1720896690.133 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-07-13T18:51:30.133Z,1720896690.133 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-07-13T18:51:30.134Z,1720896690.134 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-07-13T18:51:30.134Z,1720896690.134 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-07-13T18:51:30.141Z,1720896690.141 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-07-13T18:51:30.141Z,1720896690.141 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-07-13T18:51:30.142Z,1720896690.142 [SBIT](INFO): Initialize SBIT Component. 2024-07-13T18:51:30.142Z,1720896690.142 [SBIT](IMPORTANT): git: 2024-06-14_A 2024-07-13T18:51:30.142Z,1720896690.142 [SBIT](INFO): git hash: 90384bcf3876045306bf8b12c7409f70f96e52e4 2024-07-13T18:51:30.143Z,1720896690.143 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-07-13T18:51:30.144Z,1720896690.144 [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-07-13T18:51:30.145Z,1720896690.145 [SBIT](INFO): Beginning SBIT in 107.000000 seconds. 2024-07-13T18:51:30.145Z,1720896690.145 [IBIT](INFO): Initialize IBIT Component. 2024-07-13T18:51:30.146Z,1720896690.146 [CBIT](DEBUG): Initialize CBIT Component. 2024-07-13T18:51:30.147Z,1720896690.147 [logger ThreadHandler](INFO): Handler Thread ID is 7512 2024-07-13T18:51:30.158Z,1720896690.158 [CBIT](DEBUG): Initialized mux pins. 2024-07-13T18:51:30.158Z,1720896690.158 [CBIT](DEBUG): Initializing the watchdog timer. 2024-07-13T18:51:30.167Z,1720896690.167 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 7513 2024-07-13T18:51:30.179Z,1720896690.179 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7514 2024-07-13T18:51:30.181Z,1720896690.181 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-07-13T18:51:30.182Z,1720896690.182 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-07-13T18:51:30.183Z,1720896690.183 [CBIT](DEBUG): Initializing heartbeat. 2024-07-13T18:51:30.191Z,1720896690.191 [Onboard ThreadHandler](INFO): Handler Thread ID is 7515 2024-07-13T18:51:30.208Z,1720896690.208 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7516 2024-07-13T18:51:30.228Z,1720896690.228 [DAT ThreadHandler](INFO): Handler Thread ID is 7517 2024-07-13T18:51:30.229Z,1720896690.229 [DAT](INFO): Powering up 2024-07-13T18:51:30.229Z,1720896690.229 [DAT](DEBUG): Initializing DAT. 2024-07-13T18:51:30.232Z,1720896690.232 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7519 2024-07-13T18:51:30.233Z,1720896690.233 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-07-13T18:51:30.240Z,1720896690.240 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7521 2024-07-13T18:51:30.243Z,1720896690.243 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 7523 2024-07-13T18:51:30.245Z,1720896690.245 [WetLabsBB2FL](INFO): Powering up 2024-07-13T18:51:30.247Z,1720896690.247 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7525 2024-07-13T18:51:30.249Z,1720896690.249 [WetLabsUBAT](INFO): Powering up 2024-07-13T18:51:30.253Z,1720896690.253 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-07-13T18:51:30.253Z,1720896690.253 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-07-13T18:51:30.253Z,1720896690.253 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-07-13T18:51:30.253Z,1720896690.253 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-07-13T18:51:30.254Z,1720896690.254 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-07-13T18:51:30.254Z,1720896690.254 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-07-13T18:51:30.254Z,1720896690.254 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-07-13T18:51:30.254Z,1720896690.254 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-07-13T18:51:30.254Z,1720896690.254 [CBIT](DEBUG): Deactivating GF circuits. 2024-07-13T18:51:30.255Z,1720896690.255 [CBIT](DEBUG): Deactivating emergency mode. 2024-07-13T18:51:30.294Z,1720896690.294 [CBIT](DEBUG): Backplane powered. 2024-07-13T18:51:30.299Z,1720896690.299 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-07-13T18:51:30.300Z,1720896690.300 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-07-13T18:51:30.300Z,1720896690.300 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-07-13T18:51:30.301Z,1720896690.301 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-07-13T18:51:30.365Z,1720896690.365 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-07-13T18:51:30.369Z,1720896690.369 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-07-13T18:51:30.417Z,1720896690.417 [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-07-13T18:51:30.418Z,1720896690.418 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-07-13T18:51:30.418Z,1720896690.418 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-07-13T18:51:30.419Z,1720896690.419 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-07-13T18:51:30.630Z,1720896690.630 [Radio_Surface](INFO): Powering up 2024-07-13T18:51:30.713Z,1720896690.713 [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-07-13T18:51:30.749Z,1720896690.749 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-07-13T18:51:30.751Z,1720896690.751 [Default:A.Wait](DEBUG): Construct Wait. 2024-07-13T18:51:30.753Z,1720896690.753 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-07-13T18:51:30.801Z,1720896690.801 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-07-13T18:51:30.812Z,1720896690.812 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-07-13T18:51:30.825Z,1720896690.825 [Default:E.Execute](DEBUG): Construct Execute. 2024-07-13T18:51:30.839Z,1720896690.839 [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-07-13T18:51:30.855Z,1720896690.855 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,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-07-13T18:51:30.875Z,1720896690.875 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-07-13T18:51:30.943Z,1720896690.943 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1650.297119 decibar, 0.000000 m 2024-07-13T18:51:30.944Z,1720896690.944 [Power24vConverter](INFO): Powering up. 2024-07-13T18:51:30.945Z,1720896690.945 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-07-13T18:51:30.951Z,1720896690.951 [Sonardyne_Nano](INFO): Initializing. 2024-07-13T18:51:31.003Z,1720896691.003 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-07-13T18:51:31.026Z,1720896691.026 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-07-13T18:51:31.042Z,1720896691.042 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-07-13T18:51:31.043Z,1720896691.043 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-07-13T18:51:31.051Z,1720896691.051 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-07-13T18:51:31.052Z,1720896691.052 [DockingStepper](INFO): Start 2024-07-13T18:51:31.052Z,1720896691.052 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-07-13T18:51:31.059Z,1720896691.059 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-07-13T18:51:31.060Z,1720896691.060 [MassServo](DEBUG): Initializing EZServoServo. 2024-07-13T18:51:31.067Z,1720896691.067 [MassServo](DEBUG): Initializing MassServo. 2024-07-13T18:51:31.067Z,1720896691.067 [RudderServo](DEBUG): Initializing EZServoServo. 2024-07-13T18:51:31.075Z,1720896691.075 [RudderServo](DEBUG): Initializing RudderServo. 2024-07-13T18:51:31.075Z,1720896691.075 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-07-13T18:51:31.083Z,1720896691.083 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-07-13T18:51:31.304Z,1720896691.304 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-07-13T18:51:31.304Z,1720896691.304 [DropWeight] Hardware Fault, FailCount= 1 2024-07-13T18:51:31.304Z,1720896691.304 [DropWeight](ERROR): Hardware Fault 2024-07-13T18:51:31.331Z,1720896691.331 [DockingStepper](INFO): Starting 2024-07-13T18:51:31.333Z,1720896691.333 [CommandExec](FAULT): Scheduling is paused 2024-07-13T18:51:31.334Z,1720896691.334 [CBIT](INFO): Critical error at 20240713T185131 2024-07-13T18:51:31.334Z,1720896691.334 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-07-13T18:51:31.345Z,1720896691.345 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-07-13T18:51:31.345Z,1720896691.345 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-07-13T18:51:31.691Z,1720896691.691 [DockingStepper](INFO): Starting 2024-07-13T18:51:31.693Z,1720896691.693 [CBIT](INFO): Critical error at 20240713T185131 2024-07-13T18:51:32.219Z,1720896692.219 [DockingStepper](INFO): Starting 2024-07-13T18:51:32.268Z,1720896692.268 [DockingStepper](INFO): Init string: /1z16368aE13561N3m50 2024-07-13T18:51:32.520Z,1720896692.520 [DockingStepper](INFO): Starting 2024-07-13T18:51:32.854Z,1720896692.854 [WetLabsBB2FL](INFO): Powering down 2024-07-13T18:51:32.885Z,1720896692.885 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-07-13T18:51:32.974Z,1720896692.974 [DockingStepper](INFO): Starting 2024-07-13T18:51:33.310Z,1720896693.310 [DockingStepper](INFO): Starting 2024-07-13T18:51:33.799Z,1720896693.799 [DockingStepper](INFO): Starting 2024-07-13T18:51:33.823Z,1720896693.823 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-07-13T18:51:34.296Z,1720896694.296 [DockingStepper](INFO): Starting 2024-07-13T18:51:34.539Z,1720896694.539 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103 2024-07-13T18:51:34.980Z,1720896694.980 [DockingStepper](INFO): Pause 2024-07-13T18:51:35.883Z,1720896695.883 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10 2024-07-13T18:51:35.884Z,1720896695.884 [Radio_Surface](INFO): Found local IP address 10.89.10.2 for eth0 2024-07-13T18:51:36.667Z,1720896696.667 [RudderServo](FAULT): Overload Error 2024-07-13T18:51:36.667Z,1720896696.667 [RudderServo] Hardware Fault, FailCount= 1 2024-07-13T18:51:36.667Z,1720896696.667 [RudderServo](ERROR): Hardware Fault 2024-07-13T18:51:36.671Z,1720896696.671 [CBIT](ERROR): Hardware Fault in component: RudderServo 2024-07-13T18:51:37.096Z,1720896697.096 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-07-13T18:51:37.096Z,1720896697.096 [RudderServo](INFO): Powering down 2024-07-13T18:51:37.908Z,1720896697.908 [RudderServo](DEBUG): Initializing EZServoServo. 2024-07-13T18:51:38.027Z,1720896698.027 [RudderServo](DEBUG): Initializing RudderServo. 2024-07-13T18:51:38.032Z,1720896698.032 [CBIT](INFO): Clearing failed state for component RudderServo 2024-07-13T18:51:38.032Z,1720896698.032 [RudderServo] No Fault, FailCount= 1 2024-07-13T18:51:39.519Z,1720896699.519 [WetLabsUBAT](INFO): Powering down 2024-07-13T18:51:43.067Z,1720896703.067 [RudderServo](FAULT): Overload Error 2024-07-13T18:51:43.067Z,1720896703.067 [RudderServo] Hardware Fault, FailCount= 2 2024-07-13T18:51:43.067Z,1720896703.067 [RudderServo](ERROR): Hardware Fault 2024-07-13T18:51:43.088Z,1720896703.088 [DAT](INFO): DAT read: 2024-07-13T18:51:43.090Z,1720896703.090 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-07-13T18:51:43.095Z,1720896703.095 [CBIT](ERROR): Hardware Fault in component: RudderServo 2024-07-13T18:51:43.479Z,1720896703.479 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-07-13T18:51:43.479Z,1720896703.479 [RudderServo](INFO): Powering down 2024-07-13T18:51:44.255Z,1720896704.255 [RudderServo](DEBUG): Initializing EZServoServo. 2024-07-13T18:51:44.376Z,1720896704.376 [RudderServo](DEBUG): Initializing RudderServo. 2024-07-13T18:51:44.380Z,1720896704.380 [CBIT](INFO): Clearing failed state for component RudderServo 2024-07-13T18:51:44.380Z,1720896704.380 [RudderServo] No Fault, FailCount= 2 2024-07-13T18:51:44.851Z,1720896704.851 [DAT](INFO): DAT read: MF Frequency Band 2024-07-13T18:51:44.853Z,1720896704.853 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2024-07-13T18:51:44.853Z,1720896704.853 [DAT](INFO): DAT read: Jul 11 2024 20:57:30 2024-07-13T18:51:44.932Z,1720896704.932 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004106 2024-07-13T18:51:45.859Z,1720896705.859 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-07-13T18:51:45.861Z,1720896705.861 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-07-13T18:51:45.861Z,1720896705.861 [DAT](INFO): commRate: 800 2024-07-13T18:51:45.931Z,1720896705.931 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:51:47.927Z,1720896707.927 [DAT](INFO): entering command mode 2024-07-13T18:51:48.127Z,1720896708.127 [DAT](INFO): DAT read: 2024-07-13T18:51:48.127Z,1720896708.127 [DAT](INFO): DAT read: user:1> 2024-07-13T18:51:48.128Z,1720896708.128 [DAT](INFO): setting verbose to 3 2024-07-13T18:51:48.379Z,1720896708.379 [DAT](INFO): DAT read: user:1> 2024-07-13T18:51:48.380Z,1720896708.380 [DAT](INFO): DAT read: Verbose | 3 2024-07-13T18:51:48.380Z,1720896708.380 [DAT](INFO): set verbose to 3 2024-07-13T18:51:48.381Z,1720896708.381 [DAT](INFO): setting DatVerbose to 27440 2024-07-13T18:51:48.631Z,1720896708.631 [DAT](INFO): DAT read: user:2> 2024-07-13T18:51:48.632Z,1720896708.632 [DAT](INFO): DAT read: DatVerbose | 27440 2024-07-13T18:51:48.632Z,1720896708.632 [DAT](INFO): set DatVerbose to 27440 2024-07-13T18:51:48.633Z,1720896708.633 [DAT](INFO): setting transmit power to 8 2024-07-13T18:51:48.883Z,1720896708.883 [DAT](INFO): DAT read: user:3> 2024-07-13T18:51:48.884Z,1720896708.884 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-07-13T18:51:48.884Z,1720896708.884 [DAT](INFO): set transmit power to 8 2024-07-13T18:51:48.885Z,1720896708.885 [DAT](INFO): setting local address to 10 2024-07-13T18:51:49.135Z,1720896709.135 [DAT](INFO): DAT read: user:4> 2024-07-13T18:51:49.136Z,1720896709.136 [DAT](INFO): DAT read: LocalAddr | 10 2024-07-13T18:51:49.136Z,1720896709.136 [DAT](INFO): set local address to 10 2024-07-13T18:51:49.138Z,1720896709.138 [DAT](INFO): Setting time to: 18:51:49 And date to:7/13/2024 2024-07-13T18:51:49.264Z,1720896709.264 [CommandExec](IMPORTANT): got command docking arm 2024-07-13T18:51:49.264Z,1720896709.264 [CommandExec](IMPORTANT): Switching docking moudle to ARM. 2024-07-13T18:51:49.387Z,1720896709.387 [DAT](INFO): DAT read: user:5> 2024-07-13T18:51:49.388Z,1720896709.388 [DAT](INFO): DAT read: Sat Jul 13, 2024 18:51:49 2024-07-13T18:51:49.388Z,1720896709.388 [DAT](INFO): Local DAT time set to Sat Jul 13, 2024 18:51:49 2024-07-13T18:51:49.555Z,1720896709.555 [RudderServo](FAULT): Overload Error 2024-07-13T18:51:49.555Z,1720896709.555 [RudderServo] Hardware Fault, FailCount= 3 2024-07-13T18:51:49.555Z,1720896709.555 [RudderServo](ERROR): Hardware Fault 2024-07-13T18:51:49.583Z,1720896709.583 [CBIT](ERROR): Hardware Fault in component: RudderServo 2024-07-13T18:51:49.583Z,1720896709.583 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2024-07-13T18:51:49.898Z,1720896709.898 [DockingStepper](INFO): Resume 2024-07-13T18:51:49.936Z,1720896709.936 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-07-13T18:51:49.936Z,1720896709.936 [RudderServo](INFO): Powering down 2024-07-13T18:51:49.939Z,1720896709.939 [CBIT](INFO): Critical error at 20240713T185149 2024-07-13T18:51:50.302Z,1720896710.302 [DockingStepper](INFO): Resuming 2024-07-13T18:51:50.786Z,1720896710.786 [DockingStepper](INFO): Start 2024-07-13T18:51:50.786Z,1720896710.786 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-07-13T18:51:50.904Z,1720896710.904 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-07-13T18:51:50.931Z,1720896710.931 [RudderServo](DEBUG): Initializing EZServoServo. 2024-07-13T18:51:51.051Z,1720896711.051 [RudderServo](DEBUG): Initializing RudderServo. 2024-07-13T18:51:51.109Z,1720896711.109 [DockingStepper](INFO): Starting 2024-07-13T18:51:51.524Z,1720896711.524 [DockingStepper](INFO): Starting 2024-07-13T18:51:51.932Z,1720896711.932 [DockingStepper](INFO): Starting 2024-07-13T18:51:51.983Z,1720896711.983 [DockingStepper](INFO): Init string: /1z16368aE13561N3m50 2024-07-13T18:51:52.329Z,1720896712.329 [DockingStepper](INFO): Starting 2024-07-13T18:51:52.792Z,1720896712.792 [DockingStepper](INFO): Starting 2024-07-13T18:51:53.152Z,1720896713.152 [DockingStepper](INFO): Starting 2024-07-13T18:51:53.522Z,1720896713.522 [DockingStepper](INFO): Starting 2024-07-13T18:51:53.571Z,1720896713.571 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-07-13T18:51:53.956Z,1720896713.956 [DockingStepper](INFO): Starting 2024-07-13T18:51:54.341Z,1720896714.341 [DockingStepper](INFO): Changing to mode: 2 2024-07-13T18:51:54.342Z,1720896714.342 [DockingStepper](INFO): Armed mode. 2024-07-13T18:51:54.402Z,1720896714.402 [DockingStepper](INFO): Commanding negative:54599 2024-07-13T18:51:58.340Z,1720896718.340 [NAL9602](INFO): Powering up NAL9602 2024-07-13T18:52:02.931Z,1720896722.931 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:52:09.248Z,1720896729.248 [NAL9602](INFO): NAL9602 initialized 2024-07-13T18:52:15.971Z,1720896735.971 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:52:28.987Z,1720896748.987 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:52:29.516Z,1720896749.516 [NAL9602](INFO): SBD MO Status=2, MOMSN=38156, MT Status=2, MTMSN=0 2024-07-13T18:52:29.517Z,1720896749.517 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-07-13T18:52:38.047Z,1720896758.047 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-13T18:52:47.687Z,1720896767.687 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:52:48.681Z,1720896768.681 [NAL9602](INFO): SBD MO Status=0, MOMSN=38156, MT Status=0, MTMSN=0 2024-07-13T18:52:48.681Z,1720896768.681 [NAL9602](INFO): No messages in MT queue 2024-07-13T18:52:53.126Z,1720896773.126 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-13T18:53:00.527Z,1720896780.527 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:53:04.858Z,1720896784.858 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185303.00,A,3648.15044,N,12147.19503,W,0.447,101.05,130724,,,A*73 2024-07-13T18:53:04.861Z,1720896784.861 [NAL9602](INFO): GPS fix at 20240713T185303: (36.802507, -121.786584) 2024-07-13T18:53:08.518Z,1720896788.518 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-13T18:53:12.175Z,1720896792.175 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:53:17.636Z,1720896797.636 [SBIT](IMPORTANT): Beginning Startup BIT 2024-07-13T18:53:17.697Z,1720896797.697 [CBIT](IMPORTANT): Beginning ground fault scan 2024-07-13T18:53:21.831Z,1720896801.831 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:53:23.915Z,1720896803.915 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-13T18:53:28.609Z,1720896808.609 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.008197 CHAN A1 (24V): 0.004282 CHAN A2 (12V): -0.005397 CHAN A3 (5V): -0.002218 CHAN B0 (3.3V): 0.000825 CHAN B1 (3.15aV): -0.000808 CHAN B2 (3.15bV): -0.000702 CHAN B3 (GND): 0.001936 OPEN: 0.004529 Full Scale: +/- 1 mA 2024-07-13T18:53:31.076Z,1720896811.076 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-07-13T18:53:32.847Z,1720896812.847 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:53:37.251Z,1720896817.251 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-13T18:53:38.980Z,1720896818.980 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-13T18:53:42.263Z,1720896822.263 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:53:51.747Z,1720896831.747 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:53:54.323Z,1720896834.323 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-13T18:53:57.337Z,1720896837.337 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-07-13T18:53:57.337Z,1720896837.337 [SBIT](FAULT): Control surface position failure. 2024-07-13T18:54:00.831Z,1720896840.831 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:54:10.059Z,1720896850.059 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:54:11.036Z,1720896851.036 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-07-13T18:54:11.037Z,1720896851.037 [SBIT](FAULT): Control surface position failure. 2024-07-13T18:54:11.436Z,1720896851.436 [SBIT](CRITICAL): SBIT FAILED 2024-07-13T18:54:11.436Z,1720896851.436 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-07-13T18:54:11.437Z,1720896851.437 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count; 2024-07-13T18:54:11.437Z,1720896851.437 [SBIT](IMPORTANT): Dock.lat=36.9033 degree; 2024-07-13T18:54:11.437Z,1720896851.437 [SBIT](IMPORTANT): Dock.lon=-122.119 degree; 2024-07-13T18:54:11.437Z,1720896851.437 [SBIT](IMPORTANT): Dock.transponderCode=50 count; 2024-07-13T18:54:11.437Z,1720896851.437 [SBIT](IMPORTANT): Docked.verbose=1 bool; 2024-07-13T18:54:11.437Z,1720896851.437 [SBIT](IMPORTANT): DockingStepper.slideValue=9700 count; 2024-07-13T18:54:11.438Z,1720896851.438 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 0.300000 liter_per_second; 2024-07-13T18:54:11.438Z,1720896851.438 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=25 ampere_hour; 2024-07-13T18:54:11.438Z,1720896851.438 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt; 2024-07-13T18:54:11.438Z,1720896851.438 [SBIT](IMPORTANT): LineCapture.kiHeadingFinalApproach=0.004 reciprocal_second; 2024-07-13T18:54:11.438Z,1720896851.438 [SBIT](IMPORTANT): LineCapture.kiHeadingTerminalGuidance=0.004 reciprocal_second; 2024-07-13T18:54:11.443Z,1720896851.443 [SBIT](IMPORTANT): LineCapture.navigationGain=3 none; 2024-07-13T18:54:11.443Z,1720896851.443 [SBIT](IMPORTANT): LineCapture.rolloutSpeed=0 meter_per_second; 2024-07-13T18:54:11.443Z,1720896851.443 [SBIT](IMPORTANT): LineCapture.rolloutTimeout=10 minute; 2024-07-13T18:54:11.443Z,1720896851.443 [SBIT](IMPORTANT): LineCapture.searchTimeout=10 minute; 2024-07-13T18:54:11.443Z,1720896851.443 [SBIT](IMPORTANT): LineCapture.shortFinalRange=10 meter; 2024-07-13T18:54:11.443Z,1720896851.443 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=1 bool; 2024-07-13T18:54:11.444Z,1720896851.444 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=439.628257 cubic_centimeter; 2024-07-13T18:54:11.444Z,1720896851.444 [SBIT](IMPORTANT): VerticalControl.massDefault=21.880764 millimeter; 2024-07-13T18:54:11.450Z,1720896851.450 [CBIT](INFO): Critical error at 20240713T185411 2024-07-13T18:54:11.731Z,1720896851.731 [MissionManager](IMPORTANT): Started mission Startup 2024-07-13T18:54:11.732Z,1720896851.732 [Startup] Running Loop=1 2024-07-13T18:54:11.732Z,1720896851.732 [Startup](DEBUG): Aggregate::initialize Startup 2024-07-13T18:54:11.732Z,1720896851.732 [Startup:A.GoToSurface] Running Loop=1 2024-07-13T18:54:11.732Z,1720896851.732 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-07-13T18:54:11.732Z,1720896851.732 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-07-13T18:54:11.733Z,1720896851.733 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-07-13T18:54:11.733Z,1720896851.733 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-07-13T18:54:11.733Z,1720896851.733 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-07-13T18:54:11.734Z,1720896851.734 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-07-13T18:54:11.734Z,1720896851.734 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-07-13T18:54:11.748Z,1720896851.748 [Startup:StartupSatComms] Running Loop=1 2024-07-13T18:54:11.748Z,1720896851.748 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-07-13T18:54:11.748Z,1720896851.748 [Startup:StartupSatComms:A] Running Loop=1 2024-07-13T18:54:12.163Z,1720896852.163 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-07-13T18:54:13.733Z,1720896853.733 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185412.00,A,3648.15046,N,12147.20298,W,0.369,101.05,130724,,,D*77 2024-07-13T18:54:13.743Z,1720896853.743 [NAL9602](INFO): GPS fix at 20240713T185412: (36.802508, -121.786716) 2024-07-13T18:54:13.787Z,1720896853.787 [Startup:StartupSatComms:A] Stopped 2024-07-13T18:54:13.787Z,1720896853.787 [Startup:StartupSatComms:B] Running Loop=1 2024-07-13T18:54:14.175Z,1720896854.175 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-07-13T18:54:20.028Z,1720896860.028 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20240711T174651/Courier0037.lzma 2024-07-13T18:54:21.033Z,1720896861.033 [DataOverHttps](INFO): Moved sent file to Logs/20240711T174651/Courier0037.lzma.bak 2024-07-13T18:54:21.033Z,1720896861.033 [DataOverHttps](INFO): SBD MOMSN=21352799 2024-07-13T18:54:43.666Z,1720896883.666 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240711T174651/Courier0040.lzma 2024-07-13T18:54:44.669Z,1720896884.669 [DataOverHttps](INFO): Moved sent file to Logs/20240711T174651/Courier0040.lzma.bak 2024-07-13T18:54:44.670Z,1720896884.670 [DataOverHttps](INFO): SBD MOMSN=21352804 2024-07-13T18:54:50.001Z,1720896890.001 [NAL9602](INFO): SBD MO Status=2, MOMSN=38157, MT Status=2, MTMSN=0 2024-07-13T18:54:50.001Z,1720896890.001 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-07-13T18:54:59.697Z,1720896899.697 [NAL9602](INFO): SBD MO Status=0, MOMSN=38157, MT Status=0, MTMSN=0 2024-07-13T18:54:59.697Z,1720896899.697 [NAL9602](INFO): No messages in MT queue 2024-07-13T18:55:02.191Z,1720896902.191 [DataOverHttps](INFO): Sending 400 bytes from file Logs/20240713T185117/Courier0000.lzma 2024-07-13T18:55:03.192Z,1720896903.192 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Courier0000.lzma.bak 2024-07-13T18:55:03.192Z,1720896903.192 [DataOverHttps](INFO): SBD MOMSN=21352806 2024-07-13T18:55:13.848Z,1720896913.848 [Startup:StartupSatComms:B](INFO): Timed out from 2024-07-13T18:54:13.8Z 2024-07-13T18:55:13.848Z,1720896913.848 [Startup:StartupSatComms:B] Stopped 2024-07-13T18:55:13.848Z,1720896913.848 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-07-13T18:55:13.848Z,1720896913.848 [Startup:StartupSatComms] Stopped 2024-07-13T18:55:13.848Z,1720896913.848 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-07-13T18:55:13.849Z,1720896913.849 [Startup](INFO): Completed Startup 2024-07-13T18:55:13.849Z,1720896913.849 [MissionManager](INFO): Startup is completed. 2024-07-13T18:55:13.849Z,1720896913.849 [MissionManager](INFO): Uninitializing Mission Startup 2024-07-13T18:55:13.849Z,1720896913.849 [Startup] Stopped 2024-07-13T18:55:13.849Z,1720896913.849 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-07-13T18:55:13.849Z,1720896913.849 [Startup:A.GoToSurface] Stopped 2024-07-13T18:55:13.849Z,1720896913.849 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-07-13T18:55:14.256Z,1720896914.256 [MissionManager](IMPORTANT): Started mission Default 2024-07-13T18:55:14.256Z,1720896914.256 [Default] Running Loop=1 2024-07-13T18:55:14.256Z,1720896914.256 [Default](DEBUG): Aggregate::initialize Default 2024-07-13T18:55:14.256Z,1720896914.256 [Default:B.GoToSurface] Running Loop=1 2024-07-13T18:55:14.256Z,1720896914.256 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-07-13T18:55:14.256Z,1720896914.256 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-07-13T18:55:14.257Z,1720896914.257 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-07-13T18:55:14.257Z,1720896914.257 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-07-13T18:55:14.257Z,1720896914.257 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-07-13T18:55:14.257Z,1720896914.257 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-07-13T18:55:14.258Z,1720896914.258 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-07-13T18:55:14.258Z,1720896914.258 [Default:A.Wait] Running Loop=1 2024-07-13T18:55:14.258Z,1720896914.258 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-07-13T18:55:23.656Z,1720896923.656 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240711T174651/Express0038.lzma 2024-07-13T18:55:24.636Z,1720896924.636 [DataOverHttps](INFO): Moved sent file to Logs/20240711T174651/Express0038.lzma.bak 2024-07-13T18:55:24.636Z,1720896924.636 [DataOverHttps](INFO): SBD MOMSN=21352815 2024-07-13T18:55:25.639Z,1720896925.639 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:55:27.593Z,1720896927.593 [Default:A.Wait](INFO): Done Waiting. 2024-07-13T18:55:27.593Z,1720896927.593 [Default:A.Wait] Stopped 2024-07-13T18:55:27.593Z,1720896927.593 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-07-13T18:55:28.016Z,1720896928.016 [Default:CheckIn] Running Loop=1 2024-07-13T18:55:28.016Z,1720896928.016 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-13T18:55:28.016Z,1720896928.016 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-13T18:55:28.596Z,1720896928.596 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-07-13T18:55:30.001Z,1720896930.001 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185528.00,A,3648.14986,N,12147.22491,W,0.136,142.09,130724,,,D*75 2024-07-13T18:55:30.004Z,1720896930.004 [NAL9602](INFO): GPS fix at 20240713T185528: (36.802498, -121.787082) 2024-07-13T18:55:30.031Z,1720896930.031 [Default:CheckIn:Read_GPS] Stopped 2024-07-13T18:55:30.031Z,1720896930.031 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-13T18:55:30.543Z,1720896930.543 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-07-13T18:55:42.199Z,1720896942.199 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240713T185117/Courier0004.lzma 2024-07-13T18:55:43.200Z,1720896943.200 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Courier0004.lzma.bak 2024-07-13T18:55:43.200Z,1720896943.200 [DataOverHttps](INFO): SBD MOMSN=21352818 2024-07-13T18:55:50.548Z,1720896950.548 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 0.00, 0.00, 0.00 2024-07-13T18:56:02.268Z,1720896962.268 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-13T18:56:03.062Z,1720896963.062 [DataOverHttps](INFO): Sending 94 bytes from file Logs/20240711T174651/Express0041.lzma 2024-07-13T18:56:04.065Z,1720896964.065 [DataOverHttps](INFO): Moved sent file to Logs/20240711T174651/Express0041.lzma.bak 2024-07-13T18:56:04.065Z,1720896964.065 [DataOverHttps](INFO): SBD MOMSN=21352821 2024-07-13T18:56:23.304Z,1720896983.304 [DataOverHttps](INFO): Sending 1358 bytes from file Logs/20240713T185117/Express0001.lzma 2024-07-13T18:56:24.304Z,1720896984.304 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Express0001.lzma.bak 2024-07-13T18:56:24.304Z,1720896984.304 [DataOverHttps](INFO): SBD MOMSN=21352824 2024-07-13T18:56:28.139Z,1720896988.139 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-13T18:56:36.522Z,1720896996.522 [DockingStepper](ERROR): getADC uart error serial timeout 2024-07-13T18:56:36.523Z,1720896996.523 [DockingStepper](FAULT): uart error - getPosition..serial timeout 2024-07-13T18:56:36.523Z,1720896996.523 [DockingStepper] Communications Fault, FailCount= 1 2024-07-13T18:56:36.523Z,1720896996.523 [DockingStepper](ERROR): Communications Fault 2024-07-13T18:56:36.543Z,1720896996.543 [CBIT](ERROR): Communications Fault in component: DockingStepper 2024-07-13T18:56:37.009Z,1720896997.009 [DockingStepper](INFO): Stop 2024-07-13T18:56:37.009Z,1720896997.009 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-07-13T18:56:37.009Z,1720896997.009 [DockingStepper](INFO): Powering down 2024-07-13T18:56:37.297Z,1720896997.297 [DockingStepper](INFO): Stopping 2024-07-13T18:56:37.601Z,1720896997.601 [DockingStepper](INFO): Stopped 2024-07-13T18:56:37.610Z,1720896997.610 [CBIT](INFO): Clearing failed state for component DockingStepper 2024-07-13T18:56:37.610Z,1720896997.610 [DockingStepper] No Fault, FailCount= 1 2024-07-13T18:56:37.991Z,1720896997.991 [DockingStepper](INFO): Start 2024-07-13T18:56:37.991Z,1720896997.991 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-07-13T18:56:38.124Z,1720896998.124 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-07-13T18:56:38.422Z,1720896998.422 [DockingStepper](INFO): Starting 2024-07-13T18:56:38.976Z,1720896998.976 [DockingStepper](INFO): Starting 2024-07-13T18:56:39.196Z,1720896999.196 [DockingStepper](INFO): Starting 2024-07-13T18:56:39.239Z,1720896999.239 [DockingStepper](INFO): Init string: /1z7633aE13561N3m50 2024-07-13T18:56:39.619Z,1720896999.619 [DockingStepper](INFO): Starting 2024-07-13T18:56:40.004Z,1720897000.004 [DockingStepper](INFO): Starting 2024-07-13T18:56:40.384Z,1720897000.384 [DockingStepper](INFO): Starting 2024-07-13T18:56:40.918Z,1720897000.918 [DockingStepper](INFO): Starting 2024-07-13T18:56:40.979Z,1720897000.979 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-07-13T18:56:41.162Z,1720897001.162 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-13T18:56:41.238Z,1720897001.238 [DockingStepper](INFO): Starting 2024-07-13T18:56:41.667Z,1720897001.667 [DockingStepper](INFO): Commanding positive:54512 2024-07-13T18:56:49.054Z,1720897009.054 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20240713T185117/Express0005.lzma 2024-07-13T18:56:50.057Z,1720897010.057 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Express0005.lzma.bak 2024-07-13T18:56:50.057Z,1720897010.057 [DataOverHttps](INFO): SBD MOMSN=21352864 2024-07-13T18:56:52.911Z,1720897012.911 [Default:CheckIn:Read_Iridium] Stopped 2024-07-13T18:56:52.912Z,1720897012.912 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-13T18:56:52.912Z,1720897012.912 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-13T18:56:53.678Z,1720897013.678 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-13T18:57:07.001Z,1720897027.001 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-13T18:57:12.367Z,1720897032.367 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:57:19.557Z,1720897039.557 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-13T18:57:21.915Z,1720897041.915 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:57:31.243Z,1720897051.243 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:57:32.049Z,1720897052.049 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-13T18:57:40.251Z,1720897060.251 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:57:44.649Z,1720897064.649 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-13T18:57:49.664Z,1720897069.664 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:57:57.933Z,1720897077.933 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-13T18:57:58.859Z,1720897078.859 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:58:07.890Z,1720897087.890 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:58:10.699Z,1720897090.699 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-13T18:58:17.083Z,1720897097.083 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:58:23.023Z,1720897103.023 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-13T18:58:30.088Z,1720897110.088 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:58:35.665Z,1720897115.665 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-13T18:58:40.779Z,1720897120.779 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:58:48.594Z,1720897128.594 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-13T18:58:49.863Z,1720897129.863 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:58:56.680Z,1720897136.680 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 4. 2024-07-13T18:58:56.683Z,1720897136.683 [BPC1](INFO): Received data from all battery sticks. 2024-07-13T18:58:59.135Z,1720897139.135 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:59:08.127Z,1720897148.127 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:59:17.347Z,1720897157.347 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:59:26.331Z,1720897166.331 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:59:35.404Z,1720897175.404 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:59:44.595Z,1720897184.595 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T18:59:53.403Z,1720897193.403 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:00:02.579Z,1720897202.579 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:00:11.515Z,1720897211.515 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:00:20.620Z,1720897220.620 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:00:29.551Z,1720897229.551 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:00:38.651Z,1720897238.651 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:00:47.580Z,1720897247.580 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:00:56.763Z,1720897256.763 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:01:05.795Z,1720897265.795 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:01:18.255Z,1720897278.255 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:01:27.351Z,1720897287.351 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:01:35.094Z,1720897295.094 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-07-13T19:01:36.341Z,1720897296.341 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:01:45.555Z,1720897305.555 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:01:53.401Z,1720897313.401 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-07-13T19:01:53.401Z,1720897313.401 [Default:CheckIn:C.Wait] Stopped 2024-07-13T19:01:53.402Z,1720897313.402 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-13T19:01:53.402Z,1720897313.402 [Default:CheckIn:D] Running Loop=1 2024-07-13T19:01:53.873Z,1720897313.873 [Default:CheckIn:D] Stopped 2024-07-13T19:01:53.873Z,1720897313.873 [Default:CheckIn:E] Running Loop=1 2024-07-13T19:01:54.285Z,1720897314.285 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 6.660283 min 2024-07-13T19:01:54.285Z,1720897314.285 [Default:CheckIn:E] Stopped 2024-07-13T19:01:54.285Z,1720897314.285 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-07-13T19:01:54.285Z,1720897314.285 [Default:CheckIn] Stopped 2024-07-13T19:01:54.285Z,1720897314.285 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-13T19:01:54.286Z,1720897314.286 [Default:CheckIn](INFO): Running loop #2 2024-07-13T19:01:54.286Z,1720897314.286 [Default:CheckIn] Running Loop=2 2024-07-13T19:01:54.286Z,1720897314.286 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-13T19:01:54.286Z,1720897314.286 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-13T19:01:54.671Z,1720897314.671 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:01:56.373Z,1720897316.373 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190154.00,A,3648.14753,N,12147.22827,W,0.019,155.86,130724,,,D*74 2024-07-13T19:01:56.376Z,1720897316.376 [NAL9602](INFO): GPS fix at 20240713T190154: (36.802459, -121.787138) 2024-07-13T19:01:56.388Z,1720897316.388 [Default:CheckIn:Read_GPS] Stopped 2024-07-13T19:01:56.388Z,1720897316.388 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-13T19:02:02.175Z,1720897322.175 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20240713T185117/Courier0007.lzma 2024-07-13T19:02:03.272Z,1720897323.272 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Courier0007.lzma.bak 2024-07-13T19:02:03.273Z,1720897323.273 [DataOverHttps](INFO): SBD MOMSN=21352867 2024-07-13T19:02:06.720Z,1720897326.720 [CommandExec](IMPORTANT): got command docking arm 2024-07-13T19:02:06.720Z,1720897326.720 [CommandExec](IMPORTANT): Switching docking moudle to ARM. 2024-07-13T19:02:10.741Z,1720897330.741 [NAL9602](INFO): SBD MO Status=0, MOMSN=38158, MT Status=0, MTMSN=0 2024-07-13T19:02:10.741Z,1720897330.741 [NAL9602](INFO): No messages in MT queue 2024-07-13T19:02:24.957Z,1720897344.957 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20240713T185117/Express0008.lzma 2024-07-13T19:02:25.956Z,1720897345.956 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Express0008.lzma.bak 2024-07-13T19:02:25.957Z,1720897345.957 [DataOverHttps](INFO): SBD MOMSN=21352871 2024-07-13T19:02:31.155Z,1720897351.155 [DockingStepper](ERROR): getADC uart error serial timeout 2024-07-13T19:02:31.155Z,1720897351.155 [DockingStepper](FAULT): uart error - getPosition..serial timeout 2024-07-13T19:02:31.155Z,1720897351.155 [DockingStepper] Communications Fault, FailCount= 1 2024-07-13T19:02:31.155Z,1720897351.155 [DockingStepper](ERROR): Communications Fault 2024-07-13T19:02:31.159Z,1720897351.159 [CBIT](ERROR): Communications Fault in component: DockingStepper 2024-07-13T19:02:31.493Z,1720897351.493 [DockingStepper](INFO): Stop 2024-07-13T19:02:31.493Z,1720897351.493 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-07-13T19:02:31.494Z,1720897351.494 [DockingStepper](INFO): Powering down 2024-07-13T19:02:31.889Z,1720897351.889 [DockingStepper](INFO): Stopping 2024-07-13T19:02:32.271Z,1720897352.271 [Default:CheckIn:Read_Iridium] Stopped 2024-07-13T19:02:32.271Z,1720897352.271 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-13T19:02:32.271Z,1720897352.271 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-13T19:02:32.285Z,1720897352.285 [DockingStepper](INFO): Stopped 2024-07-13T19:02:32.317Z,1720897352.317 [CBIT](INFO): Clearing failed state for component DockingStepper 2024-07-13T19:02:32.317Z,1720897352.317 [DockingStepper] No Fault, FailCount= 1 2024-07-13T19:02:32.770Z,1720897352.770 [DockingStepper](INFO): Start 2024-07-13T19:02:32.770Z,1720897352.770 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-07-13T19:02:32.883Z,1720897352.883 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-07-13T19:02:33.109Z,1720897353.109 [DockingStepper](INFO): Starting 2024-07-13T19:02:33.509Z,1720897353.509 [DockingStepper](INFO): Starting 2024-07-13T19:02:33.940Z,1720897353.940 [DockingStepper](INFO): Starting 2024-07-13T19:02:33.991Z,1720897353.991 [DockingStepper](INFO): Init string: /1z16319aE13561N3m50 2024-07-13T19:02:34.332Z,1720897354.332 [DockingStepper](INFO): Starting 2024-07-13T19:02:34.810Z,1720897354.810 [DockingStepper](INFO): Starting 2024-07-13T19:02:35.116Z,1720897355.116 [DockingStepper](INFO): Starting 2024-07-13T19:02:35.539Z,1720897355.539 [DockingStepper](INFO): Starting 2024-07-13T19:02:35.569Z,1720897355.569 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-07-13T19:02:35.902Z,1720897355.902 [DockingStepper](INFO): Starting 2024-07-13T19:02:41.202Z,1720897361.202 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-13T19:02:52.851Z,1720897372.851 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:03:01.847Z,1720897381.847 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:03:11.104Z,1720897391.104 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:03:13.884Z,1720897393.884 [CommandExec](IMPORTANT): got command docking arm 2024-07-13T19:03:13.884Z,1720897393.884 [CommandExec](IMPORTANT): Switching docking moudle to ARM. 2024-07-13T19:03:20.131Z,1720897400.131 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:03:29.367Z,1720897409.367 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:03:38.275Z,1720897418.275 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:03:47.447Z,1720897427.447 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:03:56.443Z,1720897436.443 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:04:05.563Z,1720897445.563 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:04:17.730Z,1720897457.730 [DockingStepper](ERROR): getADC uart error serial timeout 2024-07-13T19:04:17.731Z,1720897457.731 [DockingStepper](FAULT): uart error - getPosition..serial timeout 2024-07-13T19:04:17.731Z,1720897457.731 [DockingStepper] Communications Fault, FailCount= 1 2024-07-13T19:04:17.731Z,1720897457.731 [DockingStepper](ERROR): Communications Fault 2024-07-13T19:04:17.735Z,1720897457.735 [CBIT](ERROR): Communications Fault in component: DockingStepper 2024-07-13T19:04:18.046Z,1720897458.046 [DockingStepper](INFO): Stop 2024-07-13T19:04:18.046Z,1720897458.046 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-07-13T19:04:18.046Z,1720897458.046 [DockingStepper](INFO): Powering down 2024-07-13T19:04:18.454Z,1720897458.454 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:04:18.525Z,1720897458.525 [DockingStepper](INFO): Stopping 2024-07-13T19:04:18.921Z,1720897458.921 [DockingStepper](INFO): Stopped 2024-07-13T19:04:18.933Z,1720897458.933 [CBIT](INFO): Clearing failed state for component DockingStepper 2024-07-13T19:04:18.933Z,1720897458.933 [DockingStepper] No Fault, FailCount= 1 2024-07-13T19:04:19.253Z,1720897459.253 [DockingStepper](INFO): Start 2024-07-13T19:04:19.254Z,1720897459.254 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-07-13T19:04:19.373Z,1720897459.373 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-07-13T19:04:19.661Z,1720897459.661 [DockingStepper](INFO): Starting 2024-07-13T19:04:20.085Z,1720897460.085 [DockingStepper](INFO): Starting 2024-07-13T19:04:20.537Z,1720897460.537 [DockingStepper](INFO): Starting 2024-07-13T19:04:20.587Z,1720897460.587 [DockingStepper](INFO): Init string: /1z16320aE13561N3m50 2024-07-13T19:04:20.976Z,1720897460.976 [DockingStepper](INFO): Starting 2024-07-13T19:04:21.307Z,1720897461.307 [DockingStepper](INFO): Starting 2024-07-13T19:04:21.713Z,1720897461.713 [DockingStepper](INFO): Starting 2024-07-13T19:04:22.125Z,1720897462.125 [DockingStepper](INFO): Starting 2024-07-13T19:04:22.147Z,1720897462.147 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-07-13T19:04:22.542Z,1720897462.542 [DockingStepper](INFO): Starting 2024-07-13T19:04:28.432Z,1720897468.432 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:04:37.591Z,1720897477.591 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:04:46.579Z,1720897486.579 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:04:55.699Z,1720897495.699 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:05:05.887Z,1720897505.887 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:05:14.859Z,1720897514.859 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:05:24.083Z,1720897524.083 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:05:33.039Z,1720897533.039 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:05:42.095Z,1720897542.095 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:05:50.999Z,1720897550.999 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:06:00.207Z,1720897560.207 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:06:09.159Z,1720897569.159 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:06:18.235Z,1720897578.235 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:06:27.298Z,1720897587.298 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:06:31.443Z,1720897591.443 [CBIT](INFO): Clearing failed state for component DropWeight 2024-07-13T19:06:31.443Z,1720897591.443 [DropWeight] No Fault, FailCount= 1 2024-07-13T19:06:36.280Z,1720897596.280 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:06:49.211Z,1720897609.211 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:06:49.883Z,1720897609.883 [CBIT](INFO): Clearing failed state for component RudderServo 2024-07-13T19:06:49.883Z,1720897609.883 [RudderServo] No Fault, FailCount= 3 2024-07-13T19:07:01.935Z,1720897621.935 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:07:11.087Z,1720897631.087 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:07:20.500Z,1720897640.500 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:07:29.695Z,1720897649.695 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:07:32.948Z,1720897652.948 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-07-13T19:07:32.949Z,1720897652.949 [Default:CheckIn:C.Wait] Stopped 2024-07-13T19:07:32.949Z,1720897652.949 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-13T19:07:32.949Z,1720897652.949 [Default:CheckIn:D] Running Loop=1 2024-07-13T19:07:33.335Z,1720897653.335 [Default:CheckIn:D] Stopped 2024-07-13T19:07:33.335Z,1720897653.335 [Default:CheckIn:E] Running Loop=1 2024-07-13T19:07:33.776Z,1720897653.776 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.317993 min 2024-07-13T19:07:33.776Z,1720897653.776 [Default:CheckIn:E] Stopped 2024-07-13T19:07:33.777Z,1720897653.777 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-07-13T19:07:33.777Z,1720897653.777 [Default:CheckIn] Stopped 2024-07-13T19:07:33.777Z,1720897653.777 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-13T19:07:33.777Z,1720897653.777 [Default:CheckIn](INFO): Running loop #3 2024-07-13T19:07:33.777Z,1720897653.777 [Default:CheckIn] Running Loop=3 2024-07-13T19:07:33.777Z,1720897653.777 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-13T19:07:33.777Z,1720897653.777 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-13T19:07:35.737Z,1720897655.737 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190735.00,A,3648.14465,N,12147.22506,W,0.272,189.05,130724,,,D*78 2024-07-13T19:07:35.747Z,1720897655.747 [NAL9602](INFO): GPS fix at 20240713T190735: (36.802411, -121.787084) 2024-07-13T19:07:35.766Z,1720897655.766 [Default:CheckIn:Read_GPS] Stopped 2024-07-13T19:07:35.766Z,1720897655.766 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-13T19:07:37.734Z,1720897657.734 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240713T185117/Courier0010.lzma 2024-07-13T19:07:38.740Z,1720897658.740 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Courier0010.lzma.bak 2024-07-13T19:07:38.740Z,1720897658.740 [DataOverHttps](INFO): SBD MOMSN=21352875 2024-07-13T19:07:48.145Z,1720897668.145 [NAL9602](INFO): SBD MO Status=0, MOMSN=38159, MT Status=0, MTMSN=0 2024-07-13T19:07:48.145Z,1720897668.145 [NAL9602](INFO): No messages in MT queue 2024-07-13T19:07:58.594Z,1720897678.594 [DataOverHttps](INFO): Sending 240 bytes from file Logs/20240713T185117/Express0011.lzma 2024-07-13T19:07:59.596Z,1720897679.596 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Express0011.lzma.bak 2024-07-13T19:07:59.597Z,1720897679.597 [DataOverHttps](INFO): SBD MOMSN=21352878 2024-07-13T19:08:02.644Z,1720897682.644 [Default:CheckIn:Read_Iridium] Stopped 2024-07-13T19:08:02.644Z,1720897682.644 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-13T19:08:02.644Z,1720897682.644 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-13T19:08:18.743Z,1720897698.743 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-13T19:08:22.351Z,1720897702.351 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:08:31.871Z,1720897711.871 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:08:41.015Z,1720897721.015 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:08:54.546Z,1720897734.546 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:09:03.663Z,1720897743.663 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:09:12.939Z,1720897752.939 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:09:22.291Z,1720897762.291 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:09:31.535Z,1720897771.535 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:09:41.008Z,1720897781.008 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:09:50.191Z,1720897790.191 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:09:59.631Z,1720897799.631 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:10:12.687Z,1720897812.687 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:10:23.031Z,1720897823.031 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:10:32.411Z,1720897832.411 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:10:41.587Z,1720897841.587 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:10:50.995Z,1720897850.995 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:11:00.183Z,1720897860.183 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:11:09.491Z,1720897869.491 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:11:18.880Z,1720897878.880 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:11:28.031Z,1720897888.031 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:11:37.531Z,1720897897.531 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:11:46.735Z,1720897906.735 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:11:56.075Z,1720897916.075 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:12:05.203Z,1720897925.203 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:12:14.468Z,1720897934.468 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:12:23.616Z,1720897943.616 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:12:36.379Z,1720897956.379 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:12:36.769Z,1720897956.769 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, +0 +0.00, +0.00, 0.00,1253.97 2024-07-13T19:12:46.995Z,1720897966.995 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:12:56.115Z,1720897976.115 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:12:59.804Z,1720897979.804 [CommandExec](IMPORTANT): got command docking arm 2024-07-13T19:12:59.804Z,1720897979.804 [CommandExec](IMPORTANT): Switching docking moudle to ARM. 2024-07-13T19:13:03.361Z,1720897983.361 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-07-13T19:13:03.361Z,1720897983.361 [Default:CheckIn:C.Wait] Stopped 2024-07-13T19:13:03.361Z,1720897983.361 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-13T19:13:03.361Z,1720897983.361 [Default:CheckIn:D] Running Loop=1 2024-07-13T19:13:03.775Z,1720897983.775 [Default:CheckIn:D] Stopped 2024-07-13T19:13:03.775Z,1720897983.775 [Default:CheckIn:E] Running Loop=1 2024-07-13T19:13:04.163Z,1720897984.163 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 17.825323 min 2024-07-13T19:13:04.163Z,1720897984.163 [Default:CheckIn:E] Stopped 2024-07-13T19:13:04.163Z,1720897984.163 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-07-13T19:13:04.163Z,1720897984.163 [Default:CheckIn] Stopped 2024-07-13T19:13:04.163Z,1720897984.163 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-13T19:13:04.163Z,1720897984.163 [Default:CheckIn](INFO): Running loop #4 2024-07-13T19:13:04.163Z,1720897984.163 [Default:CheckIn] Running Loop=4 2024-07-13T19:13:04.163Z,1720897984.163 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-13T19:13:04.164Z,1720897984.164 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-13T19:13:05.655Z,1720897985.655 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:13:06.169Z,1720897986.169 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191305.00,A,3648.14649,N,12147.22789,W,0.194,189.05,130724,,,D*7C 2024-07-13T19:13:06.172Z,1720897986.172 [NAL9602](INFO): GPS fix at 20240713T191305: (36.802442, -121.787132) 2024-07-13T19:13:06.183Z,1720897986.183 [Default:CheckIn:Read_GPS] Stopped 2024-07-13T19:13:06.183Z,1720897986.183 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-13T19:13:14.079Z,1720897994.079 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240713T185117/Courier0013.lzma 2024-07-13T19:13:15.081Z,1720897995.081 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Courier0013.lzma.bak 2024-07-13T19:13:15.081Z,1720897995.081 [DataOverHttps](INFO): SBD MOMSN=21352888 2024-07-13T19:13:19.386Z,1720897999.386 [NAL9602](INFO): SBD MO Status=0, MOMSN=38160, MT Status=0, MTMSN=0 2024-07-13T19:13:19.387Z,1720897999.387 [NAL9602](INFO): No messages in MT queue 2024-07-13T19:13:35.279Z,1720898015.279 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20240713T185117/Express0014.lzma 2024-07-13T19:13:36.281Z,1720898016.281 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Express0014.lzma.bak 2024-07-13T19:13:36.281Z,1720898016.281 [DataOverHttps](INFO): SBD MOMSN=21352891 2024-07-13T19:13:39.586Z,1720898019.586 [Default:CheckIn:Read_Iridium] Stopped 2024-07-13T19:13:39.586Z,1720898019.586 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-13T19:13:39.586Z,1720898019.586 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-13T19:13:49.915Z,1720898029.915 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-13T19:13:59.075Z,1720898039.075 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:14:12.131Z,1720898052.131 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:14:22.595Z,1720898062.595 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:14:31.871Z,1720898071.871 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:14:41.227Z,1720898081.227 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:14:50.363Z,1720898090.363 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:14:51.912Z,1720898091.912 [CommandExec](IMPORTANT): got command docking arm 2024-07-13T19:14:51.912Z,1720898091.912 [CommandExec](IMPORTANT): Switching docking moudle to ARM. 2024-07-13T19:14:59.832Z,1720898099.832 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:15:09.211Z,1720898109.211 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:15:16.929Z,1720898116.929 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,24071311163767,35.0, +21.6, 5.9, 0 2024-07-13T19:15:18.347Z,1720898118.347 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:15:26.603Z,1720898126.603 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 0.00, 0.00, 0.00 2024-07-13T19:15:27.959Z,1720898127.959 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:15:37.243Z,1720898137.243 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:15:46.611Z,1720898146.611 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:15:55.859Z,1720898155.859 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:16:06.539Z,1720898166.539 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:16:19.331Z,1720898179.331 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:16:28.539Z,1720898188.539 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:16:37.963Z,1720898197.963 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:16:47.231Z,1720898207.231 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:16:56.583Z,1720898216.583 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:17:06.023Z,1720898226.023 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:17:15.163Z,1720898235.163 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:17:24.755Z,1720898244.755 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:17:33.940Z,1720898253.940 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:17:43.247Z,1720898263.247 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:17:52.407Z,1720898272.407 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:18:01.803Z,1720898281.803 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:18:10.806Z,1720898290.806 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 0.00, 0.00, 0.-32768,V 2024-07-13T19:18:13.175Z,1720898293.175 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:18:25.175Z,1720898305.175 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:18:34.439Z,1720898314.439 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:18:40.133Z,1720898320.133 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-07-13T19:18:40.133Z,1720898320.133 [Default:CheckIn:C.Wait] Stopped 2024-07-13T19:18:40.133Z,1720898320.133 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-13T19:18:40.133Z,1720898320.133 [Default:CheckIn:D] Running Loop=1 2024-07-13T19:18:40.612Z,1720898320.612 [Default:CheckIn:D] Stopped 2024-07-13T19:18:40.612Z,1720898320.612 [Default:CheckIn:E] Running Loop=1 2024-07-13T19:18:40.922Z,1720898320.922 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 23.439268 min 2024-07-13T19:18:40.922Z,1720898320.922 [Default:CheckIn:E] Stopped 2024-07-13T19:18:40.922Z,1720898320.922 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-07-13T19:18:40.922Z,1720898320.922 [Default:CheckIn] Stopped 2024-07-13T19:18:40.923Z,1720898320.923 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-13T19:18:40.923Z,1720898320.923 [Default:CheckIn](INFO): Running loop #5 2024-07-13T19:18:40.923Z,1720898320.923 [Default:CheckIn] Running Loop=5 2024-07-13T19:18:40.923Z,1720898320.923 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-13T19:18:40.923Z,1720898320.923 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-13T19:18:43.053Z,1720898323.053 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191842.00,A,3648.14603,N,12147.22707,W,0.136,189.05,130724,,,D*74 2024-07-13T19:18:43.056Z,1720898323.056 [NAL9602](INFO): GPS fix at 20240713T191842: (36.802434, -121.787118) 2024-07-13T19:18:43.068Z,1720898323.068 [Default:CheckIn:Read_GPS] Stopped 2024-07-13T19:18:43.068Z,1720898323.068 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-13T19:18:52.432Z,1720898332.432 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240713T185117/Courier0016.lzma 2024-07-13T19:18:53.429Z,1720898333.429 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Courier0016.lzma.bak 2024-07-13T19:18:53.429Z,1720898333.429 [DataOverHttps](INFO): SBD MOMSN=21352897 2024-07-13T19:18:59.533Z,1720898339.533 [NAL9602](INFO): SBD MO Status=0, MOMSN=38161, MT Status=0, MTMSN=0 2024-07-13T19:18:59.533Z,1720898339.533 [NAL9602](INFO): No messages in MT queue 2024-07-13T19:19:13.171Z,1720898353.171 [DataOverHttps](INFO): Sending 185 bytes from file Logs/20240713T185117/Express0017.lzma 2024-07-13T19:19:14.172Z,1720898354.172 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Express0017.lzma.bak 2024-07-13T19:19:14.172Z,1720898354.172 [DataOverHttps](INFO): SBD MOMSN=21352901 2024-07-13T19:19:17.512Z,1720898357.512 [Default:CheckIn:Read_Iridium] Stopped 2024-07-13T19:19:17.512Z,1720898357.512 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-13T19:19:17.512Z,1720898357.512 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-13T19:19:30.003Z,1720898370.003 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-13T19:19:36.987Z,1720898376.987 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:19:46.243Z,1720898386.243 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:19:55.935Z,1720898395.935 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:20:08.155Z,1720898408.155 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:20:19.239Z,1720898419.239 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:20:28.651Z,1720898428.651 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:20:37.795Z,1720898437.795 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:20:47.207Z,1720898447.207 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:20:56.432Z,1720898456.432 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:21:05.816Z,1720898465.816 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:21:14.975Z,1720898474.975 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:21:24.275Z,1720898484.275 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:21:33.495Z,1720898493.495 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:21:42.883Z,1720898502.883 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:21:52.323Z,1720898512.323 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:22:01.575Z,1720898521.575 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:22:11.056Z,1720898531.056 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:22:20.251Z,1720898540.251 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:22:29.591Z,1720898549.591 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:22:40.331Z,1720898560.331 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:22:49.547Z,1720898569.547 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:22:59.119Z,1720898579.119 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:23:11.711Z,1720898591.711 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:23:22.224Z,1720898602.224 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:23:31.819Z,1720898611.819 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:23:40.975Z,1720898620.975 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:23:50.363Z,1720898630.363 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:23:59.639Z,1720898639.639 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:24:09.547Z,1720898649.547 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:24:18.217Z,1720898658.217 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-07-13T19:24:18.217Z,1720898658.217 [Default:CheckIn:C.Wait] Stopped 2024-07-13T19:24:18.217Z,1720898658.217 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-13T19:24:18.217Z,1720898658.217 [Default:CheckIn:D] Running Loop=1 2024-07-13T19:24:18.745Z,1720898658.745 [Default:CheckIn:D] Stopped 2024-07-13T19:24:18.745Z,1720898658.745 [Default:CheckIn:E] Running Loop=1 2024-07-13T19:24:19.013Z,1720898659.013 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 29.074815 min 2024-07-13T19:24:19.013Z,1720898659.013 [Default:CheckIn:E] Stopped 2024-07-13T19:24:19.013Z,1720898659.013 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-07-13T19:24:19.013Z,1720898659.013 [Default:CheckIn] Stopped 2024-07-13T19:24:19.013Z,1720898659.013 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-13T19:24:19.014Z,1720898659.014 [Default:CheckIn](INFO): Running loop #6 2024-07-13T19:24:19.014Z,1720898659.014 [Default:CheckIn] Running Loop=6 2024-07-13T19:24:19.014Z,1720898659.014 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-13T19:24:19.014Z,1720898659.014 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-13T19:24:20.994Z,1720898660.994 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192420.00,A,3648.14636,N,12147.22467,W,0.117,189.05,130724,,,D*7F 2024-07-13T19:24:20.997Z,1720898660.997 [NAL9602](INFO): GPS fix at 20240713T192420: (36.802439, -121.787078) 2024-07-13T19:24:21.008Z,1720898661.008 [Default:CheckIn:Read_GPS] Stopped 2024-07-13T19:24:21.008Z,1720898661.008 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-13T19:24:30.798Z,1720898670.798 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240713T185117/Courier0019.lzma 2024-07-13T19:24:31.800Z,1720898671.800 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Courier0019.lzma.bak 2024-07-13T19:24:31.801Z,1720898671.801 [DataOverHttps](INFO): SBD MOMSN=21352906 2024-07-13T19:24:39.157Z,1720898679.157 [NAL9602](INFO): SBD MO Status=2, MOMSN=38162, MT Status=2, MTMSN=0 2024-07-13T19:24:39.157Z,1720898679.157 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-07-13T19:24:51.696Z,1720898691.696 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20240713T185117/Express0020.lzma 2024-07-13T19:24:52.693Z,1720898692.693 [DataOverHttps](INFO): Moved sent file to Logs/20240713T185117/Express0020.lzma.bak 2024-07-13T19:24:52.693Z,1720898692.693 [DataOverHttps](INFO): SBD MOMSN=21352909 2024-07-13T19:24:55.627Z,1720898695.627 [Default:CheckIn:Read_Iridium] Stopped 2024-07-13T19:24:55.627Z,1720898695.627 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-13T19:24:55.627Z,1720898695.627 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-13T19:25:15.476Z,1720898715.476 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:25:20.669Z,1720898720.669 [NAL9602](INFO): SBD MO Status=0, MOMSN=38162, MT Status=0, MTMSN=0 2024-07-13T19:25:20.669Z,1720898720.669 [NAL9602](INFO): No messages in MT queue 2024-07-13T19:25:24.747Z,1720898724.747 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:25:34.480Z,1720898734.480 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:25:43.643Z,1720898743.643 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:25:51.436Z,1720898751.436 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-13T19:25:53.147Z,1720898753.147 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:26:03.167Z,1720898763.167 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:26:16.476Z,1720898776.476 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:26:26.039Z,1720898786.039 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:26:35.267Z,1720898795.267 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:26:44.616Z,1720898804.616 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:26:53.803Z,1720898813.803 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:27:03.138Z,1720898823.138 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:27:12.551Z,1720898832.551 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:27:21.687Z,1720898841.687 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:27:31.115Z,1720898851.115 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:27:40.255Z,1720898860.255 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:27:49.733Z,1720898869.733 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:27:58.935Z,1720898878.935 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:28:08.315Z,1720898888.315 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:28:17.543Z,1720898897.543 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:28:26.883Z,1720898906.883 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:28:36.299Z,1720898916.299 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:28:45.651Z,1720898925.651 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:28:59.347Z,1720898939.347 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:29:09.059Z,1720898949.059 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:29:18.283Z,1720898958.283 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:29:27.783Z,1720898967.783 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:29:36.982Z,1720898976.982 [CommandExec](IMPORTANT): got command restart system 2024-07-13T19:29:36.999Z,1720898976.999 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-07-13T19:29:39.067Z,1720898979.067 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-13T19:29:39.067Z,1720898979.067 [CommandExec](INFO): Uninitializing the command executive. 2024-07-13T19:29:39.067Z,1720898979.067 [CommandExec](INFO): Uninitializing the command scheduler. 2024-07-13T19:29:39.067Z,1720898979.067 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-07-13T19:29:39.170Z,1720898979.170 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-07-13T19:29:39.171Z,1720898979.171 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-07-13T19:29:39.171Z,1720898979.171 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-07-13T19:29:39.172Z,1720898979.172 [NavChartDb](INFO): Join timeout helper Thread ID is 7636 2024-07-13T19:29:39.263Z,1720898979.263 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-13T19:29:39.263Z,1720898979.263 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-07-13T19:29:39.271Z,1720898979.271 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2024-07-13T19:29:39.271Z,1720898979.271 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-07-13T19:29:39.271Z,1720898979.271 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 7637 2024-07-13T19:29:39.272Z,1720898979.272 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-13T19:29:39.272Z,1720898979.272 [WetLabsUBAT](INFO): Powering down 2024-07-13T19:29:39.273Z,1720898979.273 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-07-13T19:29:39.273Z,1720898979.273 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-07-13T19:29:39.273Z,1720898979.273 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-07-13T19:29:39.274Z,1720898979.274 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7638 2024-07-13T19:29:39.475Z,1720898979.475 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-13T19:29:39.476Z,1720898979.476 [WetLabsBB2FL](INFO): Powering down 2024-07-13T19:29:39.477Z,1720898979.477 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-07-13T19:29:39.487Z,1720898979.487 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-07-13T19:29:39.487Z,1720898979.487 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-07-13T19:29:39.487Z,1720898979.487 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7639 2024-07-13T19:29:40.379Z,1720898980.379 [CTD_Seabird](INFO): Powering down 2024-07-13T19:29:40.391Z,1720898980.391 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-13T19:29:40.392Z,1720898980.392 [CTD_Seabird](INFO): Powering down 2024-07-13T19:29:40.407Z,1720898980.407 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-07-13T19:29:40.427Z,1720898980.427 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-07-13T19:29:40.428Z,1720898980.428 [DAT ThreadHandler](INFO): Thread cancelled. 2024-07-13T19:29:40.429Z,1720898980.429 [DAT](INFO): Join timeout helper Thread ID is 7640 2024-07-13T19:29:40.563Z,1720898980.563 [DAT](INFO): Powering down 2024-07-13T19:29:40.631Z,1720898980.631 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-13T19:29:40.631Z,1720898980.631 [DAT](INFO): Powering down 2024-07-13T19:29:40.632Z,1720898980.632 [DAT ThreadHandler](INFO): Thread cancelled. 2024-07-13T19:29:40.644Z,1720898980.644 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-07-13T19:29:40.644Z,1720898980.644 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-07-13T19:29:40.645Z,1720898980.645 [Radio_Surface](INFO): Join timeout helper Thread ID is 7641 2024-07-13T19:29:40.679Z,1720898980.679 [Radio_Surface](INFO): Powering down 2024-07-13T19:29:40.691Z,1720898980.691 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-13T19:29:40.692Z,1720898980.692 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-07-13T19:29:40.704Z,1720898980.704 [ComponentRegistry](INFO): Shutting down