2024-06-24T18:37:59.270Z,1719254279.270 [Supervisor](DEBUG): Initializing supervisor. 2024-06-24T18:37:59.275Z,1719254279.275 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-06-24T18:37:59.276Z,1719254279.276 [SyncHandler](INFO): Protected caller Thread ID is 2287 2024-06-24T18:37:59.276Z,1719254279.276 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-06-24T18:37:59.277Z,1719254279.277 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-06-24T18:37:59.278Z,1719254279.278 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2288 2024-06-24T18:37:59.282Z,1719254279.282 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-06-24T18:37:59.299Z,1719254279.299 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-06-24T18:37:59.300Z,1719254279.300 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-06-24T18:37:59.301Z,1719254279.301 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 2289 2024-06-24T18:37:59.305Z,1719254279.305 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-06-24T18:37:59.306Z,1719254279.306 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-06-24T18:37:59.306Z,1719254279.306 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2290 2024-06-24T18:37:59.308Z,1719254279.308 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-06-24T18:37:59.309Z,1719254279.309 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-06-24T18:37:59.309Z,1719254279.309 [logger ThreadHandler](INFO): Protected caller Thread ID is 2291 2024-06-24T18:37:59.313Z,1719254279.313 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-06-24T18:37:59.313Z,1719254279.313 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-06-24T18:37:59.315Z,1719254279.315 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-06-24T18:37:59.468Z,1719254279.468 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-06-24T18:37:59.468Z,1719254279.468 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-06-24T18:38:00.261Z,1719254280.261 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-06-24T18:38:00.262Z,1719254280.262 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-06-24T18:38:00.511Z,1719254280.511 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-06-24T18:38:00.512Z,1719254280.512 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-06-24T18:38:00.603Z,1719254280.603 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-06-24T18:38:00.748Z,1719254280.748 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-06-24T18:38:00.749Z,1719254280.749 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-06-24T18:38:00.841Z,1719254280.841 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-06-24T18:38:00.962Z,1719254280.962 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-06-24T18:38:00.963Z,1719254280.963 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-06-24T18:38:01.381Z,1719254281.381 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-06-24T18:38:01.381Z,1719254281.381 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-06-24T18:38:01.977Z,1719254281.977 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-06-24T18:38:01.978Z,1719254281.978 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-06-24T18:38:02.428Z,1719254282.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-06-24T18:38:02.429Z,1719254282.429 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-06-24T18:38:02.633Z,1719254282.633 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-06-24T18:38:02.634Z,1719254282.634 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-06-24T18:38:03.192Z,1719254283.192 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-06-24T18:38:03.193Z,1719254283.193 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-06-24T18:38:03.501Z,1719254283.501 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-06-24T18:38:03.501Z,1719254283.501 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-06-24T18:38:03.747Z,1719254283.747 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-06-24T18:38:03.748Z,1719254283.748 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-06-24T18:38:04.143Z,1719254284.143 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-06-24T18:38:04.144Z,1719254284.144 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-06-24T18:38:04.513Z,1719254284.513 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-06-24T18:38:04.515Z,1719254284.515 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-06-24T18:38:04.516Z,1719254284.516 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-06-24T18:38:04.612Z,1719254284.612 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-06-24T18:38:04.795Z,1719254284.795 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg 2024-06-24T18:38:04.903Z,1719254284.903 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-06-24T18:38:05.025Z,1719254285.025 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-06-24T18:38:05.123Z,1719254285.123 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-06-24T18:38:05.232Z,1719254285.232 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-06-24T18:38:05.357Z,1719254285.357 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-06-24T18:38:05.632Z,1719254285.632 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-06-24T18:38:05.633Z,1719254285.633 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-06-24T18:38:05.740Z,1719254285.740 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-06-24T18:38:05.845Z,1719254285.845 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-06-24T18:38:06.001Z,1719254286.001 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-06-24T18:38:06.114Z,1719254286.114 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2024-06-24T18:38:06.114Z,1719254286.114 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-06-24T18:38:06.130Z,1719254286.130 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-06-24T18:38:06.247Z,1719254286.247 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-06-24T18:38:06.248Z,1719254286.248 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-06-24T18:38:06.303Z,1719254286.303 [VerticalControl](DEBUG): Construct VerticalControl. 2024-06-24T18:38:06.361Z,1719254286.361 [VerticalControl] Loaded 2024-06-24T18:38:06.362Z,1719254286.362 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-06-24T18:38:06.365Z,1719254286.365 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-06-24T18:38:06.410Z,1719254286.410 [HorizontalControl] Loaded 2024-06-24T18:38:06.411Z,1719254286.411 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-06-24T18:38:06.413Z,1719254286.413 [SpeedControl](DEBUG): Construct SpeedControl. 2024-06-24T18:38:06.416Z,1719254286.416 [SpeedControl] Loaded 2024-06-24T18:38:06.416Z,1719254286.416 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-06-24T18:38:06.419Z,1719254286.419 [LoopControl](DEBUG): Construct LoopControl. 2024-06-24T18:38:06.419Z,1719254286.419 [LoopControl] Loaded 2024-06-24T18:38:06.420Z,1719254286.420 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-06-24T18:38:06.420Z,1719254286.420 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-06-24T18:38:06.420Z,1719254286.420 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-06-24T18:38:06.471Z,1719254286.471 [DepthRateCalculator] Loaded 2024-06-24T18:38:06.471Z,1719254286.471 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-06-24T18:38:06.476Z,1719254286.476 [PitchRateCalculator] Loaded 2024-06-24T18:38:06.476Z,1719254286.476 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-06-24T18:38:06.486Z,1719254286.486 [SpeedCalculator] Loaded 2024-06-24T18:38:06.486Z,1719254286.486 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-06-24T18:38:06.491Z,1719254286.491 [YawRateCalculator] Loaded 2024-06-24T18:38:06.491Z,1719254286.491 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-06-24T18:38:06.508Z,1719254286.508 [ElevatorOffsetCalculator] Loaded 2024-06-24T18:38:06.509Z,1719254286.509 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-06-24T18:38:06.509Z,1719254286.509 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-06-24T18:38:06.510Z,1719254286.510 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-06-24T18:38:06.537Z,1719254286.537 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-06-24T18:38:06.537Z,1719254286.537 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-06-24T18:38:06.594Z,1719254286.594 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-06-24T18:38:06.594Z,1719254286.594 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-06-24T18:38:06.940Z,1719254286.940 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-06-24T18:38:06.940Z,1719254286.940 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-06-24T18:38:07.377Z,1719254287.377 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-06-24T18:38:07.378Z,1719254287.378 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-06-24T18:38:08.131Z,1719254288.131 [AHRS_M2] Loaded 2024-06-24T18:38:08.132Z,1719254288.132 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-06-24T18:38:08.171Z,1719254288.171 [BackseatComponent] Loaded 2024-06-24T18:38:08.171Z,1719254288.171 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-06-24T18:38:08.172Z,1719254288.172 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409C54E0 2024-06-24T18:38:08.172Z,1719254288.172 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 2376 2024-06-24T18:38:08.175Z,1719254288.175 [LcmUniversalReporter] Loaded 2024-06-24T18:38:08.175Z,1719254288.175 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-06-24T18:38:08.980Z,1719254288.980 [BPC1] Loaded 2024-06-24T18:38:08.980Z,1719254288.980 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-06-24T18:38:09.051Z,1719254289.051 [DataOverHttps] Loaded 2024-06-24T18:38:09.052Z,1719254289.052 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-06-24T18:38:09.053Z,1719254289.053 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409F54E0 2024-06-24T18:38:09.053Z,1719254289.053 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2377 2024-06-24T18:38:09.076Z,1719254289.076 [Depth_Keller] Loaded 2024-06-24T18:38:09.076Z,1719254289.076 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-06-24T18:38:09.081Z,1719254289.081 [DropWeight] Loaded 2024-06-24T18:38:09.081Z,1719254289.081 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-06-24T18:38:09.145Z,1719254289.145 [NAL9602] Loaded 2024-06-24T18:38:09.145Z,1719254289.145 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-06-24T18:38:09.175Z,1719254289.175 [Onboard] Loaded 2024-06-24T18:38:09.176Z,1719254289.176 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-06-24T18:38:09.177Z,1719254289.177 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A254E0 2024-06-24T18:38:09.177Z,1719254289.177 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2378 2024-06-24T18:38:09.191Z,1719254289.191 [Power24vConverter] Loaded 2024-06-24T18:38:09.191Z,1719254289.191 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-06-24T18:38:09.207Z,1719254289.207 [Radio_Surface] Loaded 2024-06-24T18:38:09.207Z,1719254289.207 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-06-24T18:38:09.208Z,1719254289.208 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A554E0 2024-06-24T18:38:09.208Z,1719254289.208 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2379 2024-06-24T18:38:09.256Z,1719254289.256 [RDI_Pathfinder] Loaded 2024-06-24T18:38:09.256Z,1719254289.256 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-06-24T18:38:09.271Z,1719254289.271 [Sonardyne_Nano] Loaded 2024-06-24T18:38:09.271Z,1719254289.271 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-06-24T18:38:09.365Z,1719254289.365 [DAT] Loaded 2024-06-24T18:38:09.365Z,1719254289.365 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-06-24T18:38:09.366Z,1719254289.366 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A854E0 2024-06-24T18:38:09.367Z,1719254289.367 [DAT ThreadHandler](INFO): Protected caller Thread ID is 2380 2024-06-24T18:38:09.367Z,1719254289.367 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-06-24T18:38:09.368Z,1719254289.368 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-06-24T18:38:09.480Z,1719254289.480 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-06-24T18:38:09.480Z,1719254289.480 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-06-24T18:38:09.494Z,1719254289.494 [NavChart] Loaded 2024-06-24T18:38:09.494Z,1719254289.494 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-06-24T18:38:09.499Z,1719254289.499 [UniversalFixResidualReporter] Loaded 2024-06-24T18:38:09.500Z,1719254289.500 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-06-24T18:38:09.500Z,1719254289.500 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-06-24T18:38:09.501Z,1719254289.501 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-06-24T18:38:09.644Z,1719254289.644 [SBIT](DEBUG): Construct Startup Built In Test. 2024-06-24T18:38:09.653Z,1719254289.653 [SBIT] Loaded 2024-06-24T18:38:09.653Z,1719254289.653 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-06-24T18:38:09.656Z,1719254289.656 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-06-24T18:38:09.669Z,1719254289.669 [IBIT] Loaded 2024-06-24T18:38:09.669Z,1719254289.669 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-06-24T18:38:09.675Z,1719254289.675 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-06-24T18:38:09.779Z,1719254289.779 [CBIT] Loaded 2024-06-24T18:38:09.779Z,1719254289.779 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-06-24T18:38:09.779Z,1719254289.779 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-06-24T18:38:09.780Z,1719254289.780 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-06-24T18:38:09.915Z,1719254289.915 [BuoyancyServo] Loaded 2024-06-24T18:38:09.916Z,1719254289.916 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-06-24T18:38:09.939Z,1719254289.939 [ElevatorServo] Loaded 2024-06-24T18:38:09.939Z,1719254289.939 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-06-24T18:38:09.968Z,1719254289.968 [DockingStepper] Loaded 2024-06-24T18:38:09.969Z,1719254289.969 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2024-06-24T18:38:09.990Z,1719254289.990 [MassServo] Loaded 2024-06-24T18:38:09.990Z,1719254289.990 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-06-24T18:38:10.011Z,1719254290.011 [RudderServo] Loaded 2024-06-24T18:38:10.011Z,1719254290.011 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-06-24T18:38:10.030Z,1719254290.030 [ThrusterServo] Loaded 2024-06-24T18:38:10.030Z,1719254290.030 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-06-24T18:38:10.031Z,1719254290.031 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-06-24T18:38:10.031Z,1719254290.031 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-06-24T18:38:10.041Z,1719254290.041 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-06-24T18:38:10.042Z,1719254290.042 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-06-24T18:38:10.219Z,1719254290.219 [CTD_Seabird] Loaded 2024-06-24T18:38:10.219Z,1719254290.219 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-06-24T18:38:10.220Z,1719254290.220 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BD94E0 2024-06-24T18:38:10.221Z,1719254290.221 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2381 2024-06-24T18:38:10.243Z,1719254290.243 [PAR_Licor] Loaded 2024-06-24T18:38:10.244Z,1719254290.244 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-06-24T18:38:10.288Z,1719254290.288 [WetLabsBB2FL] Loaded 2024-06-24T18:38:10.288Z,1719254290.288 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-06-24T18:38:10.289Z,1719254290.289 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C094E0 2024-06-24T18:38:10.290Z,1719254290.290 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2382 2024-06-24T18:38:10.311Z,1719254290.311 [WetLabsUBAT] Loaded 2024-06-24T18:38:10.311Z,1719254290.311 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2024-06-24T18:38:10.312Z,1719254290.312 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C394E0 2024-06-24T18:38:10.313Z,1719254290.313 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 2383 2024-06-24T18:38:10.313Z,1719254290.313 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-06-24T18:38:10.320Z,1719254290.320 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-06-24T18:38:10.323Z,1719254290.323 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-06-24T18:38:10.334Z,1719254290.334 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-06-24T18:38:10.335Z,1719254290.335 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C694E0 2024-06-24T18:38:10.335Z,1719254290.335 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2384 2024-06-24T18:38:10.339Z,1719254290.339 [Supervisor](INFO): Main Thread ID is 2131 2024-06-24T18:38:10.340Z,1719254290.340 [Supervisor](DEBUG): Running supervisor. 2024-06-24T18:38:10.340Z,1719254290.340 [CommandExec ThreadHandler](INFO): Handler Thread ID is 2385 2024-06-24T18:38:10.341Z,1719254290.341 [CommandExec](INFO): Initializing the command executive. 2024-06-24T18:38:10.342Z,1719254290.342 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2386 2024-06-24T18:38:10.344Z,1719254290.344 [controlThread ThreadHandler](INFO): Handler Thread ID is 2387 2024-06-24T18:38:10.345Z,1719254290.345 [controlThread](DEBUG): Initializing ControlThread 2024-06-24T18:38:10.346Z,1719254290.346 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-06-24T18:38:10.347Z,1719254290.347 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-06-24T18:38:10.348Z,1719254290.348 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-06-24T18:38:10.348Z,1719254290.348 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-06-24T18:38:10.349Z,1719254290.349 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-06-24T18:38:10.349Z,1719254290.349 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-06-24T18:38:10.349Z,1719254290.349 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-06-24T18:38:10.350Z,1719254290.350 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-06-24T18:38:10.350Z,1719254290.350 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-06-24T18:38:10.356Z,1719254290.356 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-06-24T18:38:10.357Z,1719254290.357 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-06-24T18:38:10.357Z,1719254290.357 [SBIT](INFO): Initialize SBIT Component. 2024-06-24T18:38:10.358Z,1719254290.358 [SBIT](IMPORTANT): git: 2024-06-14_A 2024-06-24T18:38:10.358Z,1719254290.358 [SBIT](INFO): git hash: 90384bcf3876045306bf8b12c7409f70f96e52e4 2024-06-24T18:38:10.358Z,1719254290.358 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-06-24T18:38:10.359Z,1719254290.359 [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-06-24T18:38:10.360Z,1719254290.360 [SBIT](INFO): Beginning SBIT in 107.000000 seconds. 2024-06-24T18:38:10.361Z,1719254290.361 [IBIT](INFO): Initialize IBIT Component. 2024-06-24T18:38:10.362Z,1719254290.362 [CBIT](DEBUG): Initialize CBIT Component. 2024-06-24T18:38:10.363Z,1719254290.363 [logger ThreadHandler](INFO): Handler Thread ID is 2388 2024-06-24T18:38:10.374Z,1719254290.374 [CBIT](DEBUG): Initialized mux pins. 2024-06-24T18:38:10.374Z,1719254290.374 [CBIT](DEBUG): Initializing the watchdog timer. 2024-06-24T18:38:10.382Z,1719254290.382 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 2389 2024-06-24T18:38:10.394Z,1719254290.394 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2390 2024-06-24T18:38:10.396Z,1719254290.396 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-06-24T18:38:10.398Z,1719254290.398 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-06-24T18:38:10.398Z,1719254290.398 [CBIT](DEBUG): Initializing heartbeat. 2024-06-24T18:38:10.406Z,1719254290.406 [Onboard ThreadHandler](INFO): Handler Thread ID is 2391 2024-06-24T18:38:10.424Z,1719254290.424 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2392 2024-06-24T18:38:10.443Z,1719254290.443 [DAT ThreadHandler](INFO): Handler Thread ID is 2393 2024-06-24T18:38:10.444Z,1719254290.444 [DAT](INFO): Powering up 2024-06-24T18:38:10.444Z,1719254290.444 [DAT](DEBUG): Initializing DAT. 2024-06-24T18:38:10.447Z,1719254290.447 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2395 2024-06-24T18:38:10.448Z,1719254290.448 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-06-24T18:38:10.451Z,1719254290.451 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2397 2024-06-24T18:38:10.454Z,1719254290.454 [WetLabsBB2FL](INFO): Powering up 2024-06-24T18:38:10.456Z,1719254290.456 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 2399 2024-06-24T18:38:10.459Z,1719254290.459 [WetLabsUBAT](INFO): Powering up 2024-06-24T18:38:10.460Z,1719254290.460 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2401 2024-06-24T18:38:10.463Z,1719254290.463 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-06-24T18:38:10.463Z,1719254290.463 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-06-24T18:38:10.464Z,1719254290.464 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-06-24T18:38:10.464Z,1719254290.464 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-06-24T18:38:10.464Z,1719254290.464 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-06-24T18:38:10.464Z,1719254290.464 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-06-24T18:38:10.464Z,1719254290.464 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-06-24T18:38:10.464Z,1719254290.464 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-06-24T18:38:10.470Z,1719254290.470 [CBIT](DEBUG): Deactivating GF circuits. 2024-06-24T18:38:10.470Z,1719254290.470 [CBIT](DEBUG): Deactivating emergency mode. 2024-06-24T18:38:10.510Z,1719254290.510 [CBIT](DEBUG): Backplane powered. 2024-06-24T18:38:10.515Z,1719254290.515 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-06-24T18:38:10.515Z,1719254290.515 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-06-24T18:38:10.516Z,1719254290.516 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-06-24T18:38:10.517Z,1719254290.517 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-06-24T18:38:10.581Z,1719254290.581 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-06-24T18:38:10.590Z,1719254290.590 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-06-24T18:38:10.610Z,1719254290.610 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-06-24T18:38:10.634Z,1719254290.634 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-06-24T18:38:10.635Z,1719254290.635 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-06-24T18:38:10.636Z,1719254290.636 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-06-24T18:38:10.846Z,1719254290.846 [Radio_Surface](INFO): Powering up 2024-06-24T18:38:10.929Z,1719254290.929 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-06-24T18:38:10.951Z,1719254290.951 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-06-24T18:38:10.953Z,1719254290.953 [Default:A.Wait](DEBUG): Construct Wait. 2024-06-24T18:38:10.963Z,1719254290.963 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-06-24T18:38:10.989Z,1719254290.989 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-06-24T18:38:11.016Z,1719254291.016 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-06-24T18:38:11.022Z,1719254291.022 [Default:E.Execute](DEBUG): Construct Execute. 2024-06-24T18:38:11.053Z,1719254291.053 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-06-24T18:38:11.058Z,1719254291.058 [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-06-24T18:38:11.074Z,1719254291.074 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-06-24T18:38:11.140Z,1719254291.140 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993022 m 2024-06-24T18:38:11.141Z,1719254291.141 [Power24vConverter](INFO): Powering up. 2024-06-24T18:38:11.141Z,1719254291.141 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-06-24T18:38:11.155Z,1719254291.155 [Sonardyne_Nano](INFO): Initializing. 2024-06-24T18:38:11.183Z,1719254291.183 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-06-24T18:38:11.212Z,1719254291.212 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-06-24T18:38:11.218Z,1719254291.218 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-06-24T18:38:11.219Z,1719254291.219 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-06-24T18:38:11.230Z,1719254291.230 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-06-24T18:38:11.231Z,1719254291.231 [DockingStepper](INFO): Start 2024-06-24T18:38:11.231Z,1719254291.231 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-06-24T18:38:11.238Z,1719254291.238 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-06-24T18:38:11.239Z,1719254291.239 [MassServo](DEBUG): Initializing EZServoServo. 2024-06-24T18:38:11.246Z,1719254291.246 [MassServo](DEBUG): Initializing MassServo. 2024-06-24T18:38:11.247Z,1719254291.247 [RudderServo](DEBUG): Initializing EZServoServo. 2024-06-24T18:38:11.254Z,1719254291.254 [RudderServo](DEBUG): Initializing RudderServo. 2024-06-24T18:38:11.255Z,1719254291.255 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-06-24T18:38:11.263Z,1719254291.263 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-06-24T18:38:11.511Z,1719254291.511 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-06-24T18:38:11.512Z,1719254291.512 [DropWeight] Hardware Fault, FailCount= 1 2024-06-24T18:38:11.512Z,1719254291.512 [DropWeight](ERROR): Hardware Fault 2024-06-24T18:38:11.535Z,1719254291.535 [DockingStepper](INFO): Starting 2024-06-24T18:38:11.537Z,1719254291.537 [CommandExec](FAULT): Scheduling is paused 2024-06-24T18:38:11.537Z,1719254291.537 [CBIT](INFO): Critical error at 20240624T183811 2024-06-24T18:38:11.537Z,1719254291.537 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-06-24T18:38:11.548Z,1719254291.548 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-06-24T18:38:11.548Z,1719254291.548 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-06-24T18:38:11.894Z,1719254291.894 [DockingStepper](INFO): Starting 2024-06-24T18:38:11.900Z,1719254291.900 [CBIT](INFO): Critical error at 20240624T183811 2024-06-24T18:38:12.418Z,1719254292.418 [DockingStepper](INFO): Starting 2024-06-24T18:38:12.467Z,1719254292.467 [DockingStepper](INFO): Init string: /1z7654aE13561N3m50 2024-06-24T18:38:12.717Z,1719254292.717 [DockingStepper](INFO): Starting 2024-06-24T18:38:13.066Z,1719254293.066 [WetLabsBB2FL](INFO): Powering down 2024-06-24T18:38:13.088Z,1719254293.088 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-06-24T18:38:13.142Z,1719254293.142 [DockingStepper](INFO): Starting 2024-06-24T18:38:13.524Z,1719254293.524 [DockingStepper](INFO): Starting 2024-06-24T18:38:13.963Z,1719254293.963 [DockingStepper](INFO): Starting 2024-06-24T18:38:13.987Z,1719254293.987 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-06-24T18:38:14.456Z,1719254294.456 [DockingStepper](INFO): Starting 2024-06-24T18:38:14.743Z,1719254294.743 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103 2024-06-24T18:38:14.906Z,1719254294.906 [DockingStepper](INFO): Commanding positive:44551 2024-06-24T18:38:16.101Z,1719254296.101 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10 2024-06-24T18:38:16.106Z,1719254296.106 [Radio_Surface](INFO): Found local IP address 10.89.10.2 for eth0 2024-06-24T18:38:19.722Z,1719254299.722 [WetLabsUBAT](INFO): Powering down 2024-06-24T18:38:19.810Z,1719254299.810 [DockingStepper](INFO): Pause 2024-06-24T18:38:23.050Z,1719254303.050 [DAT](INFO): DAT read: 2024-06-24T18:38:23.052Z,1719254303.052 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-06-24T18:38:24.815Z,1719254304.815 [DAT](INFO): DAT read: MF Frequency Band 2024-06-24T18:38:24.816Z,1719254304.816 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2024-06-24T18:38:24.817Z,1719254304.817 [DAT](INFO): DAT read: Jun 24 2024 18:38:18 2024-06-24T18:38:25.824Z,1719254305.824 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-06-24T18:38:25.825Z,1719254305.825 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-06-24T18:38:25.825Z,1719254305.825 [DAT](INFO): commRate: 800 2024-06-24T18:38:27.890Z,1719254307.890 [DAT](INFO): entering command mode 2024-06-24T18:38:28.090Z,1719254308.090 [DAT](INFO): DAT read: 2024-06-24T18:38:28.091Z,1719254308.091 [DAT](INFO): DAT read: user:1> 2024-06-24T18:38:28.091Z,1719254308.091 [DAT](INFO): setting verbose to 3 2024-06-24T18:38:28.343Z,1719254308.343 [DAT](INFO): DAT read: user:1> 2024-06-24T18:38:28.344Z,1719254308.344 [DAT](INFO): DAT read: Verbose | 3 2024-06-24T18:38:28.344Z,1719254308.344 [DAT](INFO): set verbose to 3 2024-06-24T18:38:28.344Z,1719254308.344 [DAT](INFO): setting DatVerbose to 27440 2024-06-24T18:38:28.595Z,1719254308.595 [DAT](INFO): DAT read: user:2> 2024-06-24T18:38:28.596Z,1719254308.596 [DAT](INFO): DAT read: DatVerbose | 27440 2024-06-24T18:38:28.596Z,1719254308.596 [DAT](INFO): set DatVerbose to 27440 2024-06-24T18:38:28.596Z,1719254308.596 [DAT](INFO): setting transmit power to 8 2024-06-24T18:38:28.847Z,1719254308.847 [DAT](INFO): DAT read: user:3> 2024-06-24T18:38:28.848Z,1719254308.848 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-06-24T18:38:28.848Z,1719254308.848 [DAT](INFO): set transmit power to 8 2024-06-24T18:38:28.848Z,1719254308.848 [DAT](INFO): setting local address to 10 2024-06-24T18:38:29.099Z,1719254309.099 [DAT](INFO): DAT read: user:4> 2024-06-24T18:38:29.100Z,1719254309.100 [DAT](INFO): DAT read: LocalAddr | 10 2024-06-24T18:38:29.100Z,1719254309.100 [DAT](INFO): set local address to 10 2024-06-24T18:38:29.101Z,1719254309.101 [DAT](INFO): Setting time to: 18:38:29 And date to:6/24/2024 2024-06-24T18:38:29.351Z,1719254309.351 [DAT](INFO): DAT read: user:5> 2024-06-24T18:38:29.352Z,1719254309.352 [DAT](INFO): DAT read: Mon Jun 24, 2024 18:38:29 2024-06-24T18:38:29.352Z,1719254309.352 [DAT](INFO): Local DAT time set to Mon Jun 24, 2024 18:38:29 2024-06-24T18:38:39.535Z,1719254319.535 [NAL9602](INFO): Powering up NAL9602 2024-06-24T18:38:41.518Z,1719254321.518 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:38:50.471Z,1719254330.471 [NAL9602](INFO): NAL9602 initialized 2024-06-24T18:39:12.647Z,1719254352.647 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:39:43.770Z,1719254383.770 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:39:57.930Z,1719254397.930 [SBIT](IMPORTANT): Beginning Startup BIT 2024-06-24T18:39:57.934Z,1719254397.934 [CBIT](IMPORTANT): Beginning ground fault scan 2024-06-24T18:40:08.902Z,1719254408.902 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.000322 CHAN A1 (24V): 0.016560 CHAN A2 (12V): -0.000391 CHAN A3 (5V): -0.000721 CHAN B0 (3.3V): 0.001590 CHAN B1 (3.15aV): -0.000288 CHAN B2 (3.15bV): 0.000316 CHAN B3 (GND): 0.000985 OPEN: 0.005118 Full Scale: +/- 1 mA 2024-06-24T18:40:14.910Z,1719254414.910 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:40:46.034Z,1719254446.034 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:40:51.716Z,1719254451.716 [SBIT](IMPORTANT): SBIT PASSED 2024-06-24T18:40:51.716Z,1719254451.716 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-06-24T18:40:51.717Z,1719254451.717 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count; 2024-06-24T18:40:51.717Z,1719254451.717 [SBIT](IMPORTANT): Dock.lat=36.9033 degree; 2024-06-24T18:40:51.717Z,1719254451.717 [SBIT](IMPORTANT): Dock.lon=-122.119 degree; 2024-06-24T18:40:51.717Z,1719254451.717 [SBIT](IMPORTANT): Dock.transponderCode=50 count; 2024-06-24T18:40:51.717Z,1719254451.717 [SBIT](IMPORTANT): Docked.verbose=1 bool; 2024-06-24T18:40:51.718Z,1719254451.718 [SBIT](IMPORTANT): DockingStepper.slideValue=9700 count; 2024-06-24T18:40:51.718Z,1719254451.718 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 0.300000 liter_per_second; 2024-06-24T18:40:51.722Z,1719254451.722 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=25 ampere_hour; 2024-06-24T18:40:51.722Z,1719254451.722 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt; 2024-06-24T18:40:51.722Z,1719254451.722 [SBIT](IMPORTANT): LineCapture.kiHeadingFinalApproach=0.004 reciprocal_second; 2024-06-24T18:40:51.722Z,1719254451.722 [SBIT](IMPORTANT): LineCapture.kiHeadingTerminalGuidance=0.004 reciprocal_second; 2024-06-24T18:40:51.722Z,1719254451.722 [SBIT](IMPORTANT): LineCapture.navigationGain=3 none; 2024-06-24T18:40:51.723Z,1719254451.723 [SBIT](IMPORTANT): LineCapture.rolloutSpeed=0 meter_per_second; 2024-06-24T18:40:51.723Z,1719254451.723 [SBIT](IMPORTANT): LineCapture.rolloutTimeout=10 minute; 2024-06-24T18:40:51.723Z,1719254451.723 [SBIT](IMPORTANT): LineCapture.searchTimeout=10 minute; 2024-06-24T18:40:51.723Z,1719254451.723 [SBIT](IMPORTANT): LineCapture.shortFinalRange=10 meter; 2024-06-24T18:40:51.723Z,1719254451.723 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=1 bool; 2024-06-24T18:40:51.723Z,1719254451.723 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=439.628257 cubic_centimeter; 2024-06-24T18:40:51.723Z,1719254451.723 [SBIT](IMPORTANT): VerticalControl.massDefault=21.880764 millimeter; 2024-06-24T18:40:52.219Z,1719254452.219 [MissionManager](IMPORTANT): Started mission Startup 2024-06-24T18:40:52.220Z,1719254452.220 [Startup] Running Loop=1 2024-06-24T18:40:52.220Z,1719254452.220 [Startup](DEBUG): Aggregate::initialize Startup 2024-06-24T18:40:52.220Z,1719254452.220 [Startup:A.GoToSurface] Running Loop=1 2024-06-24T18:40:52.220Z,1719254452.220 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-06-24T18:40:52.220Z,1719254452.220 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-06-24T18:40:52.221Z,1719254452.221 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-06-24T18:40:52.221Z,1719254452.221 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-06-24T18:40:52.221Z,1719254452.221 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-06-24T18:40:52.238Z,1719254452.238 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-06-24T18:40:52.238Z,1719254452.238 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-06-24T18:40:52.240Z,1719254452.240 [Startup:StartupSatComms] Running Loop=1 2024-06-24T18:40:52.240Z,1719254452.240 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-06-24T18:40:52.240Z,1719254452.240 [Startup:StartupSatComms:A] Running Loop=1 2024-06-24T18:40:52.514Z,1719254452.514 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-06-24T18:40:55.080Z,1719254455.080 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004623 2024-06-24T18:40:56.078Z,1719254456.078 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:41:09.014Z,1719254469.014 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:41:10.810Z,1719254470.810 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-06-24T18:41:10.810Z,1719254470.810 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-24T18:41:10.836Z,1719254470.836 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-24T18:41:11.144Z,1719254471.144 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-24T18:41:11.144Z,1719254471.144 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-06-24T18:41:19.770Z,1719254479.770 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:41:28.191Z,1719254488.191 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:41:28.879Z,1719254488.879 [CommandExec](IMPORTANT): got command strobe off 2024-06-24T18:41:28.880Z,1719254488.880 [CommandExec](IMPORTANT): Deactivating strobe 2024-06-24T18:41:36.688Z,1719254496.688 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:41:44.616Z,1719254504.616 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-06-24T18:41:45.078Z,1719254505.078 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:41:52.384Z,1719254512.384 [Startup:StartupSatComms:A](INFO): Timed out from 2024-06-24T18:40:52.2Z 2024-06-24T18:41:52.385Z,1719254512.385 [Startup:StartupSatComms:A] Stopped 2024-06-24T18:41:52.385Z,1719254512.385 [Startup:StartupSatComms:B] Running Loop=1 2024-06-24T18:41:52.515Z,1719254512.515 [CommandExec](IMPORTANT): got command docking standby 2024-06-24T18:41:52.516Z,1719254512.516 [CommandExec](IMPORTANT): Switching docking moudle to STANDBY. 2024-06-24T18:41:52.774Z,1719254512.774 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-06-24T18:41:53.147Z,1719254513.147 [DockingStepper](INFO): Resume 2024-06-24T18:41:53.545Z,1719254513.545 [DockingStepper](INFO): Resuming 2024-06-24T18:41:53.941Z,1719254513.941 [DockingStepper](INFO): Start 2024-06-24T18:41:53.942Z,1719254513.942 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-06-24T18:41:54.059Z,1719254514.059 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-06-24T18:41:54.346Z,1719254514.346 [DockingStepper](INFO): Starting 2024-06-24T18:41:54.766Z,1719254514.766 [DockingStepper](INFO): Starting 2024-06-24T18:41:55.162Z,1719254515.162 [DockingStepper](INFO): Starting 2024-06-24T18:41:55.210Z,1719254515.210 [DockingStepper](INFO): Init string: /1z14785aE13561N3m50 2024-06-24T18:41:55.561Z,1719254515.561 [DockingStepper](INFO): Starting 2024-06-24T18:41:55.973Z,1719254515.973 [DockingStepper](INFO): Starting 2024-06-24T18:41:56.384Z,1719254516.384 [DockingStepper](INFO): Starting 2024-06-24T18:41:56.910Z,1719254516.910 [DockingStepper](INFO): Starting 2024-06-24T18:41:56.934Z,1719254516.934 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-06-24T18:41:57.140Z,1719254517.140 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-06-24T18:41:57.218Z,1719254517.218 [DockingStepper](INFO): Starting 2024-06-24T18:42:00.222Z,1719254520.222 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240624T183145/Courier0004.lzma 2024-06-24T18:42:01.224Z,1719254521.224 [DataOverHttps](INFO): Moved sent file to Logs/20240624T183145/Courier0004.lzma.bak 2024-06-24T18:42:01.225Z,1719254521.225 [DataOverHttps](INFO): SBD MOMSN=21267911 2024-06-24T18:42:10.320Z,1719254530.320 [CommandExec](IMPORTANT): got command show variable dockingstepper 2024-06-24T18:42:10.377Z,1719254530.377 [CommandExec](IMPORTANT): DockingStepper.loadAtStartup (bool) 2024-06-24T18:42:10.377Z,1719254530.377 [CommandExec](IMPORTANT): DockingStepper.simulateHardware (bool) 2024-06-24T18:42:10.378Z,1719254530.378 [CommandExec](IMPORTANT): DockingStepper.openValue (count) 2024-06-24T18:42:10.378Z,1719254530.378 [CommandExec](IMPORTANT): DockingStepper.closedValue (count) 2024-06-24T18:42:10.379Z,1719254530.379 [CommandExec](IMPORTANT): DockingStepper.slideValue (count) 2024-06-24T18:42:10.379Z,1719254530.379 [CommandExec](IMPORTANT): DockingStepper.deviationValue (count) 2024-06-24T18:42:10.380Z,1719254530.380 [CommandExec](IMPORTANT): DockingStepper.currLimit (percent) 2024-06-24T18:42:10.380Z,1719254530.380 [CommandExec](IMPORTANT): DockingStepper.velocity (none) 2024-06-24T18:42:10.380Z,1719254530.380 [CommandExec](IMPORTANT): DockingStepper.powerOnTimeout (second) 2024-06-24T18:42:10.448Z,1719254530.448 [CommandExec](IMPORTANT): DockingStepper.loadControl (none) 2024-06-24T18:42:10.449Z,1719254530.449 [CommandExec](IMPORTANT): DockingStepper.uart (none) 2024-06-24T18:42:10.449Z,1719254530.449 [CommandExec](IMPORTANT): DockingStepper.baud (bit_per_second) 2024-06-24T18:42:10.471Z,1719254530.471 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-06-24T18:42:10.696Z,1719254530.696 [CommandExec](IMPORTANT): DockingStepper.enableBroadcast (bool) 2024-06-24T18:42:10.697Z,1719254530.697 [CommandExec](IMPORTANT): DockingStepper.component_voltage (volt) 2024-06-24T18:42:10.697Z,1719254530.697 [CommandExec](IMPORTANT): DockingStepper.component_avgVoltage (volt) 2024-06-24T18:42:10.698Z,1719254530.698 [CommandExec](IMPORTANT): DockingStepper.component_current (milliampere) 2024-06-24T18:42:10.699Z,1719254530.699 [CommandExec](IMPORTANT): DockingStepper.component_avgCurrent (milliampere) 2024-06-24T18:42:10.699Z,1719254530.699 [CommandExec](IMPORTANT): DockingStepper.component_discreteIn (bool) 2024-06-24T18:42:10.699Z,1719254530.699 [CommandExec](IMPORTANT): DockingStepper.armValue (count) 2024-06-24T18:42:10.700Z,1719254530.700 [CommandExec](IMPORTANT): DockingStepper.cableValue (count) 2024-06-24T18:42:17.946Z,1719254537.946 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20240624T183759/Courier0000.lzma 2024-06-24T18:42:18.948Z,1719254538.948 [DataOverHttps](INFO): Moved sent file to Logs/20240624T183759/Courier0000.lzma.bak 2024-06-24T18:42:18.948Z,1719254538.948 [DataOverHttps](INFO): SBD MOMSN=21267913 2024-06-24T18:42:23.207Z,1719254543.207 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-06-24T18:42:27.824Z,1719254547.824 [CommandExec](IMPORTANT): got command report mod DockingStepper.armValue 2024-06-24T18:42:27.861Z,1719254547.861 [Reporter](INFO): DockingStepper.armValue 14784 count 2024-06-24T18:42:28.224Z,1719254548.224 [Reporter](INFO): DockingStepper.armValue 14783 count 2024-06-24T18:42:28.647Z,1719254548.647 [Reporter](INFO): DockingStepper.armValue 14780 count 2024-06-24T18:42:29.055Z,1719254549.055 [Reporter](INFO): DockingStepper.armValue 14782 count 2024-06-24T18:42:29.432Z,1719254549.432 [Reporter](INFO): DockingStepper.armValue 14784 count 2024-06-24T18:42:29.839Z,1719254549.839 [Reporter](INFO): DockingStepper.armValue 14782 count 2024-06-24T18:42:30.800Z,1719254550.800 [Reporter](INFO): DockingStepper.armValue 14783 count 2024-06-24T18:42:31.096Z,1719254551.096 [Reporter](INFO): DockingStepper.armValue 14782 count 2024-06-24T18:42:31.455Z,1719254551.455 [Reporter](INFO): DockingStepper.armValue 14781 count 2024-06-24T18:42:31.864Z,1719254551.864 [Reporter](INFO): DockingStepper.armValue 14783 count 2024-06-24T18:42:32.244Z,1719254552.244 [Reporter](INFO): DockingStepper.armValue 14779 count 2024-06-24T18:42:32.708Z,1719254552.708 [Reporter](INFO): DockingStepper.armValue 14783 count 2024-06-24T18:42:33.920Z,1719254553.920 [Reporter](INFO): DockingStepper.armValue 14780 count 2024-06-24T18:42:34.312Z,1719254554.312 [Reporter](INFO): DockingStepper.armValue 14782 count 2024-06-24T18:42:34.712Z,1719254554.712 [Reporter](INFO): DockingStepper.armValue 14780 count 2024-06-24T18:42:35.124Z,1719254555.124 [Reporter](INFO): DockingStepper.armValue 14783 count 2024-06-24T18:42:35.515Z,1719254555.515 [Reporter](INFO): DockingStepper.armValue 14779 count 2024-06-24T18:42:35.924Z,1719254555.924 [Reporter](INFO): DockingStepper.armValue 14777 count 2024-06-24T18:42:36.316Z,1719254556.316 [Reporter](INFO): DockingStepper.armValue 14783 count 2024-06-24T18:42:36.840Z,1719254556.840 [Reporter](INFO): DockingStepper.armValue 14780 count 2024-06-24T18:42:36.943Z,1719254556.943 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-06-24T18:42:37.169Z,1719254557.169 [Reporter](INFO): DockingStepper.armValue 14783 count 2024-06-24T18:42:37.536Z,1719254557.536 [Reporter](INFO): DockingStepper.armValue 14777 count 2024-06-24T18:42:37.883Z,1719254557.883 [DataOverHttps](INFO): Sending 475 bytes from file Logs/20240624T183145/Express0005.lzma 2024-06-24T18:42:37.928Z,1719254557.928 [Reporter](INFO): DockingStepper.armValue 14781 count 2024-06-24T18:42:38.884Z,1719254558.884 [DataOverHttps](INFO): Moved sent file to Logs/20240624T183145/Express0005.lzma.bak 2024-06-24T18:42:38.884Z,1719254558.884 [DataOverHttps](INFO): SBD MOMSN=21267918 2024-06-24T18:42:39.016Z,1719254559.016 [Reporter](INFO): DockingStepper.armValue 14783 count 2024-06-24T18:42:39.296Z,1719254559.296 [Reporter](INFO): DockingStepper.armValue 14846 count 2024-06-24T18:42:39.623Z,1719254559.623 [Reporter](INFO): DockingStepper.armValue 14815 count 2024-06-24T18:42:40.068Z,1719254560.068 [Reporter](INFO): DockingStepper.armValue 14783 count 2024-06-24T18:42:40.464Z,1719254560.464 [Reporter](INFO): DockingStepper.armValue 14735 count 2024-06-24T18:42:40.875Z,1719254560.875 [Reporter](INFO): DockingStepper.armValue 14799 count 2024-06-24T18:42:41.200Z,1719254561.200 [Reporter](INFO): DockingStepper.armValue 14783 count 2024-06-24T18:42:41.607Z,1719254561.607 [Reporter](INFO): DockingStepper.armValue 14756 count 2024-06-24T18:42:42.024Z,1719254562.024 [Reporter](INFO): DockingStepper.armValue 14736 count 2024-06-24T18:42:42.448Z,1719254562.448 [Reporter](INFO): DockingStepper.armValue 14735 count 2024-06-24T18:42:42.917Z,1719254562.917 [Reporter](INFO): DockingStepper.armValue 14783 count 2024-06-24T18:42:43.271Z,1719254563.271 [Reporter](INFO): DockingStepper.armValue 14811 count 2024-06-24T18:42:43.645Z,1719254563.645 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:42:44.056Z,1719254564.056 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:42:44.467Z,1719254564.467 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:42:44.935Z,1719254564.935 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:42:45.265Z,1719254565.265 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:42:45.665Z,1719254565.665 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:42:46.120Z,1719254566.120 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:42:46.453Z,1719254566.453 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:42:46.916Z,1719254566.916 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:42:47.276Z,1719254567.276 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:42:48.932Z,1719254568.932 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:42:49.308Z,1719254569.308 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:42:49.712Z,1719254569.712 [Reporter](INFO): DockingStepper.armValue 14772 count 2024-06-24T18:42:50.124Z,1719254570.124 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:42:50.335Z,1719254570.335 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-06-24T18:42:50.941Z,1719254570.941 [Reporter](INFO): DockingStepper.armValue 14770 count 2024-06-24T18:42:51.335Z,1719254571.335 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:42:52.387Z,1719254572.387 [Startup:StartupSatComms:B](INFO): Timed out from 2024-06-24T18:41:52.4Z 2024-06-24T18:42:52.387Z,1719254572.387 [Startup:StartupSatComms:B] Stopped 2024-06-24T18:42:52.387Z,1719254572.387 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-06-24T18:42:52.388Z,1719254572.388 [Startup:StartupSatComms] Stopped 2024-06-24T18:42:52.388Z,1719254572.388 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-06-24T18:42:52.389Z,1719254572.389 [Startup](INFO): Completed Startup 2024-06-24T18:42:52.389Z,1719254572.389 [MissionManager](INFO): Startup is completed. 2024-06-24T18:42:52.389Z,1719254572.389 [MissionManager](INFO): Uninitializing Mission Startup 2024-06-24T18:42:52.389Z,1719254572.389 [Startup] Stopped 2024-06-24T18:42:52.389Z,1719254572.389 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-06-24T18:42:52.389Z,1719254572.389 [Startup:A.GoToSurface] Stopped 2024-06-24T18:42:52.389Z,1719254572.389 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-06-24T18:42:52.544Z,1719254572.544 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:42:52.827Z,1719254572.827 [MissionManager](IMPORTANT): Started mission Default 2024-06-24T18:42:52.827Z,1719254572.827 [Default] Running Loop=1 2024-06-24T18:42:52.827Z,1719254572.827 [Default](DEBUG): Aggregate::initialize Default 2024-06-24T18:42:52.827Z,1719254572.827 [Default:B.GoToSurface] Running Loop=1 2024-06-24T18:42:52.827Z,1719254572.827 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-06-24T18:42:52.828Z,1719254572.828 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-06-24T18:42:52.828Z,1719254572.828 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-06-24T18:42:52.828Z,1719254572.828 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-06-24T18:42:52.828Z,1719254572.828 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-06-24T18:42:52.829Z,1719254572.829 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-06-24T18:42:52.829Z,1719254572.829 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-06-24T18:42:52.829Z,1719254572.829 [Default:A.Wait] Running Loop=1 2024-06-24T18:42:52.829Z,1719254572.829 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-06-24T18:42:53.408Z,1719254573.408 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:42:53.764Z,1719254573.764 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:42:54.164Z,1719254574.164 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:42:54.568Z,1719254574.568 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:42:55.760Z,1719254575.760 [DataOverHttps](INFO): Sending 1256 bytes from file Logs/20240624T183759/Express0001.lzma 2024-06-24T18:42:56.024Z,1719254576.024 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:42:56.204Z,1719254576.204 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:42:56.760Z,1719254576.760 [DataOverHttps](INFO): Moved sent file to Logs/20240624T183759/Express0001.lzma.bak 2024-06-24T18:42:56.760Z,1719254576.760 [DataOverHttps](INFO): SBD MOMSN=21267938 2024-06-24T18:42:57.035Z,1719254577.035 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:42:57.688Z,1719254577.688 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:42:57.868Z,1719254577.868 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:42:58.699Z,1719254578.699 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:00.320Z,1719254580.320 [Reporter](INFO): DockingStepper.armValue 14771 count 2024-06-24T18:43:01.140Z,1719254581.140 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:01.512Z,1719254581.512 [Reporter](INFO): DockingStepper.armValue 14770 count 2024-06-24T18:43:01.928Z,1719254581.928 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:02.368Z,1719254582.368 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:02.843Z,1719254582.843 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:02.947Z,1719254582.947 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-06-24T18:43:03.187Z,1719254583.187 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:03.552Z,1719254583.552 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:43:03.981Z,1719254583.981 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:04.408Z,1719254584.408 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:05.032Z,1719254585.032 [Reporter](INFO): DockingStepper.armValue 14770 count 2024-06-24T18:43:05.237Z,1719254585.237 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:05.605Z,1719254585.605 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:05.864Z,1719254585.864 [Default:A.Wait](INFO): Done Waiting. 2024-06-24T18:43:05.865Z,1719254585.865 [Default:A.Wait] Stopped 2024-06-24T18:43:05.865Z,1719254585.865 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-06-24T18:43:06.270Z,1719254586.270 [Default:CheckIn] Running Loop=1 2024-06-24T18:43:06.270Z,1719254586.270 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-24T18:43:06.270Z,1719254586.270 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-24T18:43:06.411Z,1719254586.411 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:06.713Z,1719254586.713 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-06-24T18:43:06.778Z,1719254586.778 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:43:08.028Z,1719254588.028 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:08.429Z,1719254588.429 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:08.880Z,1719254588.880 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:09.680Z,1719254589.680 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:10.484Z,1719254590.484 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:43:10.912Z,1719254590.912 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:11.276Z,1719254591.276 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:12.088Z,1719254592.088 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:12.496Z,1719254592.496 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:43:12.516Z,1719254592.516 [CommandExec](IMPORTANT): got command show variable closedvalue 2024-06-24T18:43:12.579Z,1719254592.579 [CommandExec](IMPORTANT): DockingStepper.closedValue (count) 2024-06-24T18:43:12.945Z,1719254592.945 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:13.284Z,1719254593.284 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:43:13.752Z,1719254593.752 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:14.132Z,1719254594.132 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:15.329Z,1719254595.329 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:15.784Z,1719254595.784 [Reporter](INFO): DockingStepper.armValue 14770 count 2024-06-24T18:43:15.947Z,1719254595.947 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-06-24T18:43:15.982Z,1719254595.982 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:43:16.185Z,1719254596.185 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:16.587Z,1719254596.587 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:43:16.951Z,1719254596.951 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:17.724Z,1719254597.724 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:18.176Z,1719254598.176 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:43:18.568Z,1719254598.568 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:18.988Z,1719254598.988 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:19.365Z,1719254599.365 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:20.611Z,1719254600.611 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:21.052Z,1719254601.052 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:21.388Z,1719254601.388 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:21.780Z,1719254601.780 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:22.668Z,1719254602.668 [Reporter](INFO): DockingStepper.armValue 14770 count 2024-06-24T18:43:23.032Z,1719254603.032 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:23.400Z,1719254603.400 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:23.836Z,1719254603.836 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:24.299Z,1719254604.299 [CommandExec](IMPORTANT): got command get DockingStepper.closedValue 2024-06-24T18:43:24.300Z,1719254604.300 [CommandExec](IMPORTANT): DockingStepper.closedValue 16500 count 2024-06-24T18:43:24.692Z,1719254604.692 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:25.047Z,1719254605.047 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:25.467Z,1719254605.467 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:43:25.840Z,1719254605.840 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:26.151Z,1719254606.151 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:43:27.092Z,1719254607.092 [Reporter](INFO): DockingStepper.armValue 14770 count 2024-06-24T18:43:27.432Z,1719254607.432 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:27.828Z,1719254607.828 [Reporter](INFO): DockingStepper.armValue 14770 count 2024-06-24T18:43:28.264Z,1719254608.264 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:28.674Z,1719254608.674 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:29.279Z,1719254609.279 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-06-24T18:43:31.108Z,1719254611.108 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:31.472Z,1719254611.472 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:31.884Z,1719254611.884 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:32.284Z,1719254612.284 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:33.480Z,1719254613.480 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:34.788Z,1719254614.788 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:35.043Z,1719254615.043 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:43:35.960Z,1719254615.960 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:36.303Z,1719254616.303 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:36.712Z,1719254616.712 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:37.208Z,1719254617.208 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:37.940Z,1719254617.940 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:43:38.340Z,1719254618.340 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:39.180Z,1719254619.180 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:43:39.562Z,1719254619.562 [Reporter](INFO): DockingStepper.armValue 14769 count 2024-06-24T18:43:40.076Z,1719254620.076 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:43:40.219Z,1719254620.219 [CommandExec](IMPORTANT): got command report clear 2024-06-24T18:43:41.803Z,1719254621.803 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-06-24T18:43:44.018Z,1719254624.018 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:43:44.920Z,1719254624.920 [CommandExec](IMPORTANT): got command show variable dockingstepper 2024-06-24T18:43:44.967Z,1719254624.967 [CommandExec](IMPORTANT): DockingStepper.loadAtStartup (bool) 2024-06-24T18:43:44.967Z,1719254624.967 [CommandExec](IMPORTANT): DockingStepper.simulateHardware (bool) 2024-06-24T18:43:44.967Z,1719254624.967 [CommandExec](IMPORTANT): DockingStepper.openValue (count) 2024-06-24T18:43:44.968Z,1719254624.968 [CommandExec](IMPORTANT): DockingStepper.closedValue (count) 2024-06-24T18:43:44.968Z,1719254624.968 [CommandExec](IMPORTANT): DockingStepper.slideValue (count) 2024-06-24T18:43:44.968Z,1719254624.968 [CommandExec](IMPORTANT): DockingStepper.deviationValue (count) 2024-06-24T18:43:44.969Z,1719254624.969 [CommandExec](IMPORTANT): DockingStepper.currLimit (percent) 2024-06-24T18:43:44.969Z,1719254624.969 [CommandExec](IMPORTANT): DockingStepper.velocity (none) 2024-06-24T18:43:44.969Z,1719254624.969 [CommandExec](IMPORTANT): DockingStepper.powerOnTimeout (second) 2024-06-24T18:43:44.991Z,1719254624.991 [CommandExec](IMPORTANT): DockingStepper.loadControl (none) 2024-06-24T18:43:44.992Z,1719254624.992 [CommandExec](IMPORTANT): DockingStepper.uart (none) 2024-06-24T18:43:44.992Z,1719254624.992 [CommandExec](IMPORTANT): DockingStepper.baud (bit_per_second) 2024-06-24T18:43:45.224Z,1719254625.224 [CommandExec](IMPORTANT): DockingStepper.enableBroadcast (bool) 2024-06-24T18:43:45.225Z,1719254625.225 [CommandExec](IMPORTANT): DockingStepper.component_voltage (volt) 2024-06-24T18:43:45.225Z,1719254625.225 [CommandExec](IMPORTANT): DockingStepper.component_avgVoltage (volt) 2024-06-24T18:43:45.225Z,1719254625.225 [CommandExec](IMPORTANT): DockingStepper.component_current (milliampere) 2024-06-24T18:43:45.231Z,1719254625.231 [CommandExec](IMPORTANT): DockingStepper.component_avgCurrent (milliampere) 2024-06-24T18:43:45.233Z,1719254625.233 [CommandExec](IMPORTANT): DockingStepper.component_discreteIn (bool) 2024-06-24T18:43:45.239Z,1719254625.239 [CommandExec](IMPORTANT): DockingStepper.armValue (count) 2024-06-24T18:43:45.239Z,1719254625.239 [CommandExec](IMPORTANT): DockingStepper.cableValue (count) 2024-06-24T18:43:52.750Z,1719254632.750 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:43:53.939Z,1719254633.939 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-06-24T18:43:54.316Z,1719254634.316 [CommandExec](IMPORTANT): got command show variable dock 2024-06-24T18:43:54.331Z,1719254634.331 [CommandExec](IMPORTANT): Dock.docking_state_cmd (enum) 2024-06-24T18:43:54.331Z,1719254634.331 [CommandExec](IMPORTANT): Dock.docking_state (enum) 2024-06-24T18:43:54.381Z,1719254634.381 [CommandExec](IMPORTANT): Radio_Surface.manageDockNetwork (bool) 2024-06-24T18:43:54.396Z,1719254634.396 [CommandExec](IMPORTANT): Dock.lat (angular_degree) 2024-06-24T18:43:54.396Z,1719254634.396 [CommandExec](IMPORTANT): Dock.lon (angular_degree) 2024-06-24T18:43:54.396Z,1719254634.396 [CommandExec](IMPORTANT): Dock.depth (meter) 2024-06-24T18:43:54.397Z,1719254634.397 [CommandExec](IMPORTANT): Dock.transponderCode (count) 2024-06-24T18:43:54.397Z,1719254634.397 [CommandExec](IMPORTANT): Docked.dockingDepthOffset (meter) 2024-06-24T18:43:54.397Z,1719254634.397 [CommandExec](IMPORTANT): Docked.dockRange (meter) 2024-06-24T18:43:54.398Z,1719254634.398 [CommandExec](IMPORTANT): Docked.dockPitch (degree) 2024-06-24T18:43:54.406Z,1719254634.406 [CommandExec](IMPORTANT): Docked.detachTimeout (second) 2024-06-24T18:43:54.406Z,1719254634.406 [CommandExec](IMPORTANT): Docked.dockTimeout (second) 2024-06-24T18:43:54.407Z,1719254634.407 [CommandExec](IMPORTANT): Docked.dataTimeout (second) 2024-06-24T18:43:54.407Z,1719254634.407 [CommandExec](IMPORTANT): Docked.rangeTimeout (second) 2024-06-24T18:43:54.407Z,1719254634.407 [CommandExec](IMPORTANT): Docked.verbose (bool) 2024-06-24T18:43:54.409Z,1719254634.409 [CommandExec](IMPORTANT): SetNav.dockRange (meter) 2024-06-24T18:43:54.409Z,1719254634.409 [CommandExec](IMPORTANT): Undock.undockDepth (meter) 2024-06-24T18:43:54.409Z,1719254634.409 [CommandExec](IMPORTANT): Undock.undockRange (meter) 2024-06-24T18:43:54.419Z,1719254634.419 [CommandExec](IMPORTANT): Undock.undockTimeout (second) 2024-06-24T18:43:54.419Z,1719254634.419 [CommandExec](IMPORTANT): Undock.reverseThrustTimeout (second) 2024-06-24T18:43:54.419Z,1719254634.419 [CommandExec](IMPORTANT): Undock.verbose (bool) 2024-06-24T18:43:54.426Z,1719254634.426 [CommandExec](IMPORTANT): DockingServo.loadAtStartup (bool) 2024-06-24T18:43:54.427Z,1719254634.427 [CommandExec](IMPORTANT): DockingServo.simulateHardware (bool) 2024-06-24T18:43:54.427Z,1719254634.427 [CommandExec](IMPORTANT): DockingServo.countsPerDeg (count_per_angular_degree) 2024-06-24T18:43:54.427Z,1719254634.427 [CommandExec](IMPORTANT): DockingServo.currLimit (percent) 2024-06-24T18:43:54.428Z,1719254634.428 [CommandExec](IMPORTANT): DockingServo.deviationAngle (angular_degree) 2024-06-24T18:43:54.428Z,1719254634.428 [CommandExec](IMPORTANT): DockingServo.limitHi (count) 2024-06-24T18:43:54.428Z,1719254634.428 [CommandExec](IMPORTANT): DockingServo.limitLo (count) 2024-06-24T18:43:54.429Z,1719254634.429 [CommandExec](IMPORTANT): DockingServo.mtrCenter (count) 2024-06-24T18:43:54.429Z,1719254634.429 [CommandExec](IMPORTANT): DockingServo.offsetAngle (degree) 2024-06-24T18:43:54.430Z,1719254634.430 [CommandExec](IMPORTANT): DockingServo.pidW (count) 2024-06-24T18:43:54.442Z,1719254634.442 [CommandExec](IMPORTANT): DockingServo.pidX (count) 2024-06-24T18:43:54.443Z,1719254634.443 [CommandExec](IMPORTANT): DockingServo.pidY (count) 2024-06-24T18:43:54.443Z,1719254634.443 [CommandExec](IMPORTANT): DockingServo.powerOnTimeout (second) 2024-06-24T18:43:54.444Z,1719254634.444 [CommandExec](IMPORTANT): DockingServo.openAngle (degree) 2024-06-24T18:43:54.444Z,1719254634.444 [CommandExec](IMPORTANT): DockingServo.closedAngle (degree) 2024-06-24T18:43:54.444Z,1719254634.444 [CommandExec](IMPORTANT): DockingStepper.loadAtStartup (bool) 2024-06-24T18:43:54.445Z,1719254634.445 [CommandExec](IMPORTANT): DockingStepper.simulateHardware (bool) 2024-06-24T18:43:54.445Z,1719254634.445 [CommandExec](IMPORTANT): DockingStepper.openValue (count) 2024-06-24T18:43:54.446Z,1719254634.446 [CommandExec](IMPORTANT): DockingStepper.closedValue (count) 2024-06-24T18:43:54.451Z,1719254634.451 [CommandExec](IMPORTANT): DockingStepper.slideValue (count) 2024-06-24T18:43:54.451Z,1719254634.451 [CommandExec](IMPORTANT): DockingStepper.deviationValue (count) 2024-06-24T18:43:54.452Z,1719254634.452 [CommandExec](IMPORTANT): DockingStepper.currLimit (percent) 2024-06-24T18:43:54.452Z,1719254634.452 [CommandExec](IMPORTANT): DockingStepper.velocity (none) 2024-06-24T18:43:54.452Z,1719254634.452 [CommandExec](IMPORTANT): DockingStepper.powerOnTimeout (second) 2024-06-24T18:43:54.500Z,1719254634.500 [CommandExec](IMPORTANT): DockingServo.loadControl (none) 2024-06-24T18:43:54.500Z,1719254634.500 [CommandExec](IMPORTANT): DockingServo.uart (none) 2024-06-24T18:43:54.501Z,1719254634.501 [CommandExec](IMPORTANT): DockingServo.baud (bit_per_second) 2024-06-24T18:43:54.501Z,1719254634.501 [CommandExec](IMPORTANT): DockingStepper.loadControl (none) 2024-06-24T18:43:54.502Z,1719254634.502 [CommandExec](IMPORTANT): DockingStepper.uart (none) 2024-06-24T18:43:54.507Z,1719254634.507 [CommandExec](IMPORTANT): DockingStepper.baud (bit_per_second) 2024-06-24T18:43:54.714Z,1719254634.714 [CommandExec](IMPORTANT): DockingStepper.enableBroadcast (bool) 2024-06-24T18:43:54.715Z,1719254634.715 [CommandExec](IMPORTANT): DockingStepper.component_voltage (volt) 2024-06-24T18:43:54.715Z,1719254634.715 [CommandExec](IMPORTANT): DockingStepper.component_avgVoltage (volt) 2024-06-24T18:43:54.716Z,1719254634.716 [CommandExec](IMPORTANT): DockingStepper.component_current (milliampere) 2024-06-24T18:43:54.716Z,1719254634.716 [CommandExec](IMPORTANT): DockingStepper.component_avgCurrent (milliampere) 2024-06-24T18:43:54.716Z,1719254634.716 [CommandExec](IMPORTANT): DockingStepper.component_discreteIn (bool) 2024-06-24T18:43:54.717Z,1719254634.717 [CommandExec](IMPORTANT): DockingStepper.armValue (count) 2024-06-24T18:43:54.717Z,1719254634.717 [CommandExec](IMPORTANT): Dock.dock_cable_present (bool) 2024-06-24T18:43:54.717Z,1719254634.717 [CommandExec](IMPORTANT): Dock.dock_voltage_present (bool) 2024-06-24T18:43:54.718Z,1719254634.718 [CommandExec](IMPORTANT): DockingStepper.cableValue (count) 2024-06-24T18:43:55.157Z,1719254635.157 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-06-24T18:44:02.115Z,1719254642.115 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:44:11.022Z,1719254651.022 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:44:11.822Z,1719254651.822 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-06-24T18:44:11.822Z,1719254651.822 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-24T18:44:11.970Z,1719254651.970 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-24T18:44:12.375Z,1719254652.375 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-24T18:44:12.375Z,1719254652.375 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-06-24T18:44:14.246Z,1719254654.246 [CommandExec](IMPORTANT): got command get Dock.docking_state 2024-06-24T18:44:14.247Z,1719254654.247 [CommandExec](IMPORTANT): Dock.docking_state 1 enum 2024-06-24T18:44:20.450Z,1719254660.450 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:44:29.304Z,1719254669.304 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:44:38.154Z,1719254678.154 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:44:46.938Z,1719254686.938 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:44:55.740Z,1719254695.740 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:45:03.659Z,1719254703.659 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:45:12.450Z,1719254712.450 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:45:21.442Z,1719254721.442 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:45:30.266Z,1719254730.266 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:45:39.091Z,1719254739.091 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:45:48.034Z,1719254748.034 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:45:55.247Z,1719254755.247 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2024-06-24T18:45:56.822Z,1719254756.822 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:46:05.870Z,1719254765.870 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:46:14.911Z,1719254774.911 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:46:22.419Z,1719254782.419 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-24T18:46:23.598Z,1719254783.598 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:46:28.675Z,1719254788.675 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-24T18:46:32.406Z,1719254792.406 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:46:37.552Z,1719254797.552 [BPC1](ERROR): Battery stick #7 (s/n: 02BB) reported TERMINATE_CHARGE_ALARM. Status code: 0x42D0. 2024-06-24T18:46:37.552Z,1719254797.552 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 4. 2024-06-24T18:46:37.564Z,1719254797.564 [BPC1](INFO): Received data from all battery sticks. 2024-06-24T18:46:41.339Z,1719254801.339 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:46:50.175Z,1719254810.175 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:46:58.942Z,1719254818.942 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:47:07.635Z,1719254827.635 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:47:12.889Z,1719254832.889 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-06-24T18:47:12.890Z,1719254832.890 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-24T18:47:13.059Z,1719254833.059 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-24T18:47:13.423Z,1719254833.423 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-24T18:47:13.424Z,1719254833.424 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-06-24T18:47:16.490Z,1719254836.490 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:47:25.286Z,1719254845.286 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:47:34.080Z,1719254854.080 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:47:42.830Z,1719254862.830 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:47:51.566Z,1719254871.566 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:48:00.366Z,1719254880.366 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:48:06.416Z,1719254886.416 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-06-24T18:43:06.3Z 2024-06-24T18:48:06.416Z,1719254886.416 [Default:CheckIn:Read_GPS] Stopped 2024-06-24T18:48:06.416Z,1719254886.416 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-24T18:48:06.843Z,1719254886.843 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-06-24T18:48:07.460Z,1719254887.460 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240624T183759/Courier0004.lzma 2024-06-24T18:48:08.208Z,1719254888.208 [DataOverHttps](INFO): Moved sent file to Logs/20240624T183759/Courier0004.lzma.bak 2024-06-24T18:48:08.208Z,1719254888.208 [DataOverHttps](INFO): SBD MOMSN=21267988 2024-06-24T18:48:25.455Z,1719254905.455 [DataOverHttps](INFO): Sending 1195 bytes from file Logs/20240624T183759/Express0005.lzma 2024-06-24T18:48:26.456Z,1719254906.456 [DataOverHttps](INFO): Moved sent file to Logs/20240624T183759/Express0005.lzma.bak 2024-06-24T18:48:26.456Z,1719254906.456 [DataOverHttps](INFO): SBD MOMSN=21267990 2024-06-24T18:48:28.188Z,1719254908.188 [Default:CheckIn:Read_Iridium] Stopped 2024-06-24T18:48:28.188Z,1719254908.188 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-24T18:48:28.188Z,1719254908.188 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-24T18:48:36.286Z,1719254916.286 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:48:45.106Z,1719254925.106 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:48:52.215Z,1719254932.215 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-06-24T18:48:52.215Z,1719254932.215 [NAL9602] Data Fault, FailCount= 1 2024-06-24T18:48:52.215Z,1719254932.215 [NAL9602](ERROR): Data Fault 2024-06-24T18:48:52.471Z,1719254932.471 [CBIT](ERROR): Data Fault in component: NAL9602 2024-06-24T18:48:52.625Z,1719254932.625 [NAL9602](INFO): Powering down 2024-06-24T18:48:53.585Z,1719254933.585 [CBIT](INFO): Clearing failed state for component NAL9602 2024-06-24T18:48:53.585Z,1719254933.585 [NAL9602] No Fault, FailCount= 1 2024-06-24T18:48:53.814Z,1719254933.814 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:49:02.647Z,1719254942.647 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:49:11.542Z,1719254951.542 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:49:20.394Z,1719254960.394 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:49:22.967Z,1719254962.967 [NAL9602](INFO): Powering up NAL9602 2024-06-24T18:49:29.171Z,1719254969.171 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:49:33.927Z,1719254973.927 [NAL9602](INFO): NAL9602 initialized 2024-06-24T18:49:37.927Z,1719254977.927 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:49:47.588Z,1719254987.588 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:49:51.967Z,1719254991.967 [CommandExec](IMPORTANT): got command get DockingStepper.closedValue 2024-06-24T18:49:51.968Z,1719254991.968 [CommandExec](IMPORTANT): DockingStepper.closedValue 16500 count 2024-06-24T18:49:58.083Z,1719254998.083 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:50:07.091Z,1719255007.091 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:50:11.198Z,1719255011.198 [CommandExec](IMPORTANT): got command report mod DockingStepper.armValue 2024-06-24T18:50:11.300Z,1719255011.300 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:11.587Z,1719255011.587 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:12.003Z,1719255012.003 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:12.392Z,1719255012.392 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:12.845Z,1719255012.845 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:13.224Z,1719255013.224 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:13.612Z,1719255013.612 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:13.871Z,1719255013.871 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-06-24T18:50:13.871Z,1719255013.871 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-24T18:50:14.041Z,1719255014.041 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-24T18:50:14.043Z,1719255014.043 [Reporter](INFO): DockingStepper.armValue 14764 count 2024-06-24T18:50:14.420Z,1719255014.420 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-24T18:50:14.420Z,1719255014.420 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-06-24T18:50:14.421Z,1719255014.421 [Reporter](INFO): DockingStepper.armValue 14763 count 2024-06-24T18:50:14.868Z,1719255014.868 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:15.264Z,1719255015.264 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:15.607Z,1719255015.607 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:16.008Z,1719255016.008 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:16.440Z,1719255016.440 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:50:16.826Z,1719255016.826 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:50:16.868Z,1719255016.868 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:17.635Z,1719255017.635 [Reporter](INFO): DockingStepper.armValue 14764 count 2024-06-24T18:50:18.036Z,1719255018.036 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:18.515Z,1719255018.515 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:19.264Z,1719255019.264 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:20.079Z,1719255020.079 [Reporter](INFO): DockingStepper.armValue 14759 count 2024-06-24T18:50:20.504Z,1719255020.504 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:20.924Z,1719255020.924 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:21.288Z,1719255021.288 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:21.709Z,1719255021.709 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:22.111Z,1719255022.111 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:50:22.496Z,1719255022.496 [Reporter](INFO): DockingStepper.armValue 14764 count 2024-06-24T18:50:22.948Z,1719255022.948 [Reporter](INFO): DockingStepper.armValue 14763 count 2024-06-24T18:50:23.764Z,1719255023.764 [Reporter](INFO): DockingStepper.armValue 14761 count 2024-06-24T18:50:24.184Z,1719255024.184 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:24.644Z,1719255024.644 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:25.031Z,1719255025.031 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:25.380Z,1719255025.380 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:25.783Z,1719255025.783 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:50:25.810Z,1719255025.810 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:50:26.229Z,1719255026.229 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:26.600Z,1719255026.600 [Reporter](INFO): DockingStepper.armValue 14764 count 2024-06-24T18:50:27.020Z,1719255027.020 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:27.415Z,1719255027.415 [Reporter](INFO): DockingStepper.armValue 14760 count 2024-06-24T18:50:27.812Z,1719255027.812 [Reporter](INFO): DockingStepper.armValue 14764 count 2024-06-24T18:50:28.504Z,1719255028.504 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:28.728Z,1719255028.728 [Reporter](INFO): DockingStepper.armValue 14761 count 2024-06-24T18:50:29.144Z,1719255029.144 [Reporter](INFO): DockingStepper.armValue 14762 count 2024-06-24T18:50:29.499Z,1719255029.499 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:30.331Z,1719255030.331 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:30.720Z,1719255030.720 [Reporter](INFO): DockingStepper.armValue 14759 count 2024-06-24T18:50:31.168Z,1719255031.168 [Reporter](INFO): DockingStepper.armValue 14762 count 2024-06-24T18:50:31.539Z,1719255031.539 [Reporter](INFO): DockingStepper.armValue 14764 count 2024-06-24T18:50:32.216Z,1719255032.216 [Reporter](INFO): DockingStepper.armValue 14763 count 2024-06-24T18:50:32.420Z,1719255032.420 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:32.844Z,1719255032.844 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:33.656Z,1719255033.656 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:34.003Z,1719255034.003 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:34.420Z,1719255034.420 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:34.632Z,1719255034.632 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:50:34.872Z,1719255034.872 [Reporter](INFO): DockingStepper.armValue 14763 count 2024-06-24T18:50:35.240Z,1719255035.240 [Reporter](INFO): DockingStepper.armValue 14761 count 2024-06-24T18:50:35.612Z,1719255035.612 [Reporter](INFO): DockingStepper.armValue 14755 count 2024-06-24T18:50:36.016Z,1719255036.016 [Reporter](INFO): DockingStepper.armValue 14762 count 2024-06-24T18:50:36.436Z,1719255036.436 [Reporter](INFO): DockingStepper.armValue 14759 count 2024-06-24T18:50:36.921Z,1719255036.921 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:37.649Z,1719255037.649 [Reporter](INFO): DockingStepper.armValue 14763 count 2024-06-24T18:50:38.074Z,1719255038.074 [Reporter](INFO): DockingStepper.armValue 14755 count 2024-06-24T18:50:38.475Z,1719255038.475 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:38.916Z,1719255038.916 [Reporter](INFO): DockingStepper.armValue 14763 count 2024-06-24T18:50:39.272Z,1719255039.272 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:39.671Z,1719255039.671 [Reporter](INFO): DockingStepper.armValue 14759 count 2024-06-24T18:50:40.088Z,1719255040.088 [Reporter](INFO): DockingStepper.armValue 14756 count 2024-06-24T18:50:40.503Z,1719255040.503 [Reporter](INFO): DockingStepper.armValue 14760 count 2024-06-24T18:50:40.923Z,1719255040.923 [Reporter](INFO): DockingStepper.armValue 14755 count 2024-06-24T18:50:41.291Z,1719255041.291 [Reporter](INFO): DockingStepper.armValue 14762 count 2024-06-24T18:50:42.917Z,1719255042.917 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:43.288Z,1719255043.288 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:43.530Z,1719255043.530 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:50:43.724Z,1719255043.724 [Reporter](INFO): DockingStepper.armValue 14768 count 2024-06-24T18:50:44.404Z,1719255044.404 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:44.669Z,1719255044.669 [Reporter](INFO): DockingStepper.armValue 14756 count 2024-06-24T18:50:44.992Z,1719255044.992 [Reporter](INFO): DockingStepper.armValue 14764 count 2024-06-24T18:50:45.669Z,1719255045.669 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:45.877Z,1719255045.877 [Reporter](INFO): DockingStepper.armValue 14762 count 2024-06-24T18:50:46.686Z,1719255046.686 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:47.096Z,1719255047.096 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:47.492Z,1719255047.492 [Reporter](INFO): DockingStepper.armValue 14762 count 2024-06-24T18:50:47.869Z,1719255047.869 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:48.716Z,1719255048.716 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:49.130Z,1719255049.130 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:49.559Z,1719255049.559 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:49.969Z,1719255049.969 [Reporter](INFO): DockingStepper.armValue 14764 count 2024-06-24T18:50:50.356Z,1719255050.356 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:50.713Z,1719255050.713 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:51.208Z,1719255051.208 [Reporter](INFO): DockingStepper.armValue 14759 count 2024-06-24T18:50:51.501Z,1719255051.501 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:51.919Z,1719255051.919 [Reporter](INFO): DockingStepper.armValue 14758 count 2024-06-24T18:50:52.314Z,1719255052.314 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-06-24T18:50:52.340Z,1719255052.340 [Reporter](INFO): DockingStepper.armValue 14760 count 2024-06-24T18:50:52.728Z,1719255052.728 [Reporter](INFO): DockingStepper.armValue 14764 count 2024-06-24T18:50:53.176Z,1719255053.176 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:53.600Z,1719255053.600 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:53.916Z,1719255053.916 [Reporter](INFO): DockingStepper.armValue 14764 count 2024-06-24T18:50:54.341Z,1719255054.341 [Reporter](INFO): DockingStepper.armValue 14767 count 2024-06-24T18:50:55.365Z,1719255055.365 [Reporter](INFO): DockingStepper.armValue 14766 count 2024-06-24T18:50:55.623Z,1719255055.623 [Reporter](INFO): DockingStepper.armValue 14757 count 2024-06-24T18:50:56.011Z,1719255056.011 [Reporter](INFO): DockingStepper.armValue 14760 count 2024-06-24T18:50:56.895Z,1719255056.895 [Reporter](INFO): DockingStepper.armValue 14765 count 2024-06-24T18:50:57.088Z,1719255057.088 [CommandExec](IMPORTANT): got command report clear