2023-02-21T17:56:33.262Z,1677002193.262 [Supervisor](DEBUG): Initializing supervisor.
2023-02-21T17:56:33.267Z,1677002193.267 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-02-21T17:56:33.268Z,1677002193.268 [SyncHandler](INFO): Protected caller Thread ID is 6742
2023-02-21T17:56:33.268Z,1677002193.268 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-02-21T17:56:33.270Z,1677002193.270 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-02-21T17:56:33.270Z,1677002193.270 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6743
2023-02-21T17:56:33.274Z,1677002193.274 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-02-21T17:56:33.291Z,1677002193.291 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-02-21T17:56:33.292Z,1677002193.292 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-02-21T17:56:33.293Z,1677002193.293 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6744
2023-02-21T17:56:33.297Z,1677002193.297 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-02-21T17:56:33.298Z,1677002193.298 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-02-21T17:56:33.298Z,1677002193.298 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6745
2023-02-21T17:56:33.300Z,1677002193.300 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-02-21T17:56:33.301Z,1677002193.301 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-02-21T17:56:33.301Z,1677002193.301 [logger ThreadHandler](INFO): Protected caller Thread ID is 6746
2023-02-21T17:56:33.305Z,1677002193.305 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-02-21T17:56:33.305Z,1677002193.305 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-02-21T17:56:33.307Z,1677002193.307 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-02-21T17:56:33.401Z,1677002193.401 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-02-21T17:56:33.401Z,1677002193.401 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-02-21T17:56:33.608Z,1677002193.608 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-02-21T17:56:33.609Z,1677002193.609 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-02-21T17:56:33.852Z,1677002193.852 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-02-21T17:56:33.853Z,1677002193.853 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-02-21T17:56:33.957Z,1677002193.957 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-02-21T17:56:33.958Z,1677002193.958 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-02-21T17:56:34.762Z,1677002194.762 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-02-21T17:56:34.763Z,1677002194.763 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-02-21T17:56:35.221Z,1677002195.221 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-02-21T17:56:35.222Z,1677002195.222 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-02-21T17:56:35.685Z,1677002195.685 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-02-21T17:56:35.685Z,1677002195.685 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-02-21T17:56:36.065Z,1677002196.065 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-02-21T17:56:36.065Z,1677002196.065 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-02-21T17:56:36.375Z,1677002196.375 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-02-21T17:56:36.376Z,1677002196.376 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-02-21T17:56:36.728Z,1677002196.728 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-02-21T17:56:36.729Z,1677002196.729 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-02-21T17:56:36.944Z,1677002196.944 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-02-21T17:56:36.945Z,1677002196.945 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-02-21T17:56:37.079Z,1677002197.079 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-02-21T17:56:37.080Z,1677002197.080 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-02-21T17:56:37.159Z,1677002197.159 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-02-21T17:56:37.237Z,1677002197.237 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-02-21T17:56:37.419Z,1677002197.419 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-02-21T17:56:37.420Z,1677002197.420 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-02-21T17:56:37.635Z,1677002197.635 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-02-21T17:56:37.637Z,1677002197.637 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2023-02-21T17:56:37.638Z,1677002197.638 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2023-02-21T17:56:37.720Z,1677002197.720 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2023-02-21T17:56:37.974Z,1677002197.974 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-02-21T17:56:37.975Z,1677002197.975 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2023-02-21T17:56:38.070Z,1677002198.070 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2023-02-21T17:56:38.222Z,1677002198.222 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2023-02-21T17:56:38.393Z,1677002198.393 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2023-02-21T17:56:38.476Z,1677002198.476 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2023-02-21T17:56:38.579Z,1677002198.579 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2023-02-21T17:56:38.680Z,1677002198.680 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2023-02-21T17:56:38.829Z,1677002198.829 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2023-02-21T17:56:38.928Z,1677002198.928 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2023-02-21T17:56:39.024Z,1677002199.024 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2023-02-21T17:56:39.025Z,1677002199.025 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-02-21T17:56:39.040Z,1677002199.040 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-02-21T17:56:39.185Z,1677002199.185 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-02-21T17:56:39.185Z,1677002199.185 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-02-21T17:56:39.341Z,1677002199.341 [BuoyancyServo] Loaded
2023-02-21T17:56:39.341Z,1677002199.341 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-02-21T17:56:39.362Z,1677002199.362 [ElevatorServo] Loaded
2023-02-21T17:56:39.362Z,1677002199.362 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-02-21T17:56:39.381Z,1677002199.381 [MassServo] Loaded
2023-02-21T17:56:39.382Z,1677002199.382 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-02-21T17:56:39.401Z,1677002199.401 [RudderServo] Loaded
2023-02-21T17:56:39.402Z,1677002199.402 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-02-21T17:56:39.417Z,1677002199.417 [ThrusterHE] Loaded
2023-02-21T17:56:39.417Z,1677002199.417 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-02-21T17:56:39.417Z,1677002199.417 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-02-21T17:56:39.418Z,1677002199.418 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-02-21T17:56:39.558Z,1677002199.558 [SBIT](DEBUG): Construct Startup Built In Test.
2023-02-21T17:56:39.572Z,1677002199.572 [SBIT] Loaded
2023-02-21T17:56:39.573Z,1677002199.573 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-02-21T17:56:39.575Z,1677002199.575 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-02-21T17:56:39.595Z,1677002199.595 [IBIT] Loaded
2023-02-21T17:56:39.596Z,1677002199.596 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-02-21T17:56:39.601Z,1677002199.601 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-02-21T17:56:39.814Z,1677002199.814 [CBIT] Loaded
2023-02-21T17:56:39.814Z,1677002199.814 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-02-21T17:56:39.814Z,1677002199.814 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-02-21T17:56:39.815Z,1677002199.815 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-02-21T17:56:40.095Z,1677002200.095 [ESPComponent] Loaded
2023-02-21T17:56:40.095Z,1677002200.095 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2023-02-21T17:56:40.115Z,1677002200.115 [PAR_Licor] Loaded
2023-02-21T17:56:40.115Z,1677002200.115 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-02-21T17:56:40.116Z,1677002200.116 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-02-21T17:56:40.117Z,1677002200.117 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-02-21T17:56:40.278Z,1677002200.278 [DepthRateCalculator] Loaded
2023-02-21T17:56:40.278Z,1677002200.278 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-02-21T17:56:40.283Z,1677002200.283 [PitchRateCalculator] Loaded
2023-02-21T17:56:40.295Z,1677002200.295 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-02-21T17:56:40.328Z,1677002200.328 [SpeedCalculator] Loaded
2023-02-21T17:56:40.328Z,1677002200.328 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-02-21T17:56:40.333Z,1677002200.333 [YawRateCalculator] Loaded
2023-02-21T17:56:40.333Z,1677002200.333 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-02-21T17:56:40.460Z,1677002200.460 [ElevatorOffsetCalculator] Loaded
2023-02-21T17:56:40.461Z,1677002200.461 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-02-21T17:56:40.461Z,1677002200.461 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-02-21T17:56:40.462Z,1677002200.462 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-02-21T17:56:40.559Z,1677002200.559 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-02-21T17:56:40.560Z,1677002200.560 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-02-21T17:56:40.774Z,1677002200.774 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-02-21T17:56:40.774Z,1677002200.774 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-02-21T17:56:40.882Z,1677002200.882 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-02-21T17:56:40.882Z,1677002200.882 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-02-21T17:56:40.895Z,1677002200.895 [NavChart] Loaded
2023-02-21T17:56:40.896Z,1677002200.896 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-02-21T17:56:40.901Z,1677002200.901 [UniversalFixResidualReporter] Loaded
2023-02-21T17:56:40.901Z,1677002200.901 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-02-21T17:56:40.902Z,1677002200.902 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-02-21T17:56:40.902Z,1677002200.902 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-02-21T17:56:41.312Z,1677002201.312 [AHRS_M2] Loaded
2023-02-21T17:56:41.312Z,1677002201.312 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-02-21T17:56:41.346Z,1677002201.346 [BackseatComponent] Loaded
2023-02-21T17:56:41.346Z,1677002201.346 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-02-21T17:56:41.347Z,1677002201.347 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409C44E0
2023-02-21T17:56:41.347Z,1677002201.347 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 6828
2023-02-21T17:56:41.350Z,1677002201.350 [LcmUniversalReporter] Loaded
2023-02-21T17:56:41.351Z,1677002201.351 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-02-21T17:56:41.367Z,1677002201.367 [BPC1](INFO): BPC1A: got serial number for stick 1: 0C1E
2023-02-21T17:56:41.368Z,1677002201.368 [BPC1](INFO): BPC1A: got serial number for stick 2: 0481
2023-02-21T17:56:41.369Z,1677002201.369 [BPC1](INFO): BPC1A: got serial number for stick 3: 047B
2023-02-21T17:56:41.370Z,1677002201.370 [BPC1](INFO): BPC1A: got serial number for stick 4: 0464
2023-02-21T17:56:41.371Z,1677002201.371 [BPC1](INFO): BPC1A: got serial number for stick 5: 045C
2023-02-21T17:56:41.372Z,1677002201.372 [BPC1](INFO): BPC1A: got serial number for stick 6: 046A
2023-02-21T17:56:41.372Z,1677002201.372 [BPC1](INFO): BPC1A: got serial number for stick 7: 045A
2023-02-21T17:56:41.373Z,1677002201.373 [BPC1](INFO): BPC1A: got serial number for stick 8: 0487
2023-02-21T17:56:41.373Z,1677002201.373 [BPC1](INFO): BPC1A: marked stick 8 as reserve.
2023-02-21T17:56:41.374Z,1677002201.374 [BPC1](INFO): BPC1A: got serial number for stick 9: 03FE
2023-02-21T17:56:41.375Z,1677002201.375 [BPC1](INFO): BPC1A: got serial number for stick 10: 0465
2023-02-21T17:56:41.376Z,1677002201.376 [BPC1](INFO): BPC1A: got serial number for stick 11: 046B
2023-02-21T17:56:41.377Z,1677002201.377 [BPC1](INFO): BPC1A: got serial number for stick 12: 0445
2023-02-21T17:56:41.377Z,1677002201.377 [BPC1](INFO): BPC1A: got serial number for stick 13: 040D
2023-02-21T17:56:41.378Z,1677002201.378 [BPC1](INFO): BPC1A: got serial number for stick 14: 04AA
2023-02-21T17:56:41.379Z,1677002201.379 [BPC1](INFO): BPC1A: got serial number for stick 15: 049A
2023-02-21T17:56:41.379Z,1677002201.379 [BPC1](INFO): BPC1A: got serial number for stick 16: 04C6
2023-02-21T17:56:41.380Z,1677002201.380 [BPC1](INFO): BPC1A: marked stick 16 as reserve.
2023-02-21T17:56:41.380Z,1677002201.380 [BPC1](INFO): BPC1A: got serial number for stick 17: 0486
2023-02-21T17:56:41.381Z,1677002201.381 [BPC1](INFO): BPC1A: got serial number for stick 18: 0442
2023-02-21T17:56:41.382Z,1677002201.382 [BPC1](INFO): BPC1A: got serial number for stick 19: 0457
2023-02-21T17:56:41.383Z,1677002201.383 [BPC1](INFO): BPC1A: got serial number for stick 20: 0455
2023-02-21T17:56:41.384Z,1677002201.384 [BPC1](INFO): BPC1A: got serial number for stick 21: 04C0
2023-02-21T17:56:41.384Z,1677002201.384 [BPC1](INFO): BPC1A: got serial number for stick 22: 0459
2023-02-21T17:56:41.385Z,1677002201.385 [BPC1](INFO): BPC1A: got serial number for stick 23: 045F
2023-02-21T17:56:41.386Z,1677002201.386 [BPC1](INFO): BPC1A: got serial number for stick 24: 0449
2023-02-21T17:56:41.386Z,1677002201.386 [BPC1](INFO): BPC1A: marked stick 24 as reserve.
2023-02-21T17:56:41.387Z,1677002201.387 [BPC1](INFO): BPC1A: got serial number for stick 25: 0441
2023-02-21T17:56:41.387Z,1677002201.387 [BPC1](INFO): BPC1A: got serial number for stick 26: 0460
2023-02-21T17:56:41.388Z,1677002201.388 [BPC1](INFO): BPC1A: got serial number for stick 27: 04A8
2023-02-21T17:56:41.389Z,1677002201.389 [BPC1](INFO): BPC1A: got serial number for stick 28: 04BF
2023-02-21T17:56:41.390Z,1677002201.390 [BPC1](INFO): BPC1A: got serial number for stick 29: 045D
2023-02-21T17:56:41.390Z,1677002201.390 [BPC1](INFO): BPC1A: got serial number for stick 30: 04A4
2023-02-21T17:56:41.391Z,1677002201.391 [BPC1](INFO): BPC1A: got serial number for stick 31: 04D9
2023-02-21T17:56:41.393Z,1677002201.393 [BPC1](INFO): BPC1B: got serial number for stick 32: 0BE5
2023-02-21T17:56:41.393Z,1677002201.393 [BPC1](INFO): BPC1B: got serial number for stick 33: 0124
2023-02-21T17:56:41.394Z,1677002201.394 [BPC1](INFO): BPC1B: got serial number for stick 34: 0162
2023-02-21T17:56:41.395Z,1677002201.395 [BPC1](INFO): BPC1B: got serial number for stick 35: 017A
2023-02-21T17:56:41.396Z,1677002201.396 [BPC1](INFO): BPC1B: got serial number for stick 36: 0495
2023-02-21T17:56:41.396Z,1677002201.396 [BPC1](INFO): BPC1B: got serial number for stick 37: 0458
2023-02-21T17:56:41.397Z,1677002201.397 [BPC1](INFO): BPC1B: got serial number for stick 38: 0139
2023-02-21T17:56:41.398Z,1677002201.398 [BPC1](INFO): BPC1B: got serial number for stick 39: 00F0
2023-02-21T17:56:41.398Z,1677002201.398 [BPC1](INFO): BPC1B: marked stick 39 as reserve.
2023-02-21T17:56:41.399Z,1677002201.399 [BPC1](INFO): BPC1B: got serial number for stick 40: 0451
2023-02-21T17:56:41.400Z,1677002201.400 [BPC1](INFO): BPC1B: got serial number for stick 41: 049E
2023-02-21T17:56:41.401Z,1677002201.401 [BPC1](INFO): BPC1B: got serial number for stick 42: 04A2
2023-02-21T17:56:41.401Z,1677002201.401 [BPC1](INFO): BPC1B: got serial number for stick 43: 044F
2023-02-21T17:56:41.402Z,1677002201.402 [BPC1](INFO): BPC1B: got serial number for stick 44: 047F
2023-02-21T17:56:41.403Z,1677002201.403 [BPC1](INFO): BPC1B: got serial number for stick 45: 0496
2023-02-21T17:56:41.403Z,1677002201.403 [BPC1](INFO): BPC1B: got serial number for stick 46: 04CE
2023-02-21T17:56:41.404Z,1677002201.404 [BPC1](INFO): BPC1B: got serial number for stick 47: 04A5
2023-02-21T17:56:41.404Z,1677002201.404 [BPC1](INFO): BPC1B: marked stick 47 as reserve.
2023-02-21T17:56:41.405Z,1677002201.405 [BPC1](INFO): BPC1B: got serial number for stick 48: 04D7
2023-02-21T17:56:41.406Z,1677002201.406 [BPC1](INFO): BPC1B: got serial number for stick 49: 04CA
2023-02-21T17:56:41.407Z,1677002201.407 [BPC1](INFO): BPC1B: got serial number for stick 50: 04A1
2023-02-21T17:56:41.408Z,1677002201.408 [BPC1](INFO): BPC1B: got serial number for stick 51: 049B
2023-02-21T17:56:41.408Z,1677002201.408 [BPC1](INFO): BPC1B: got serial number for stick 52: 04BD
2023-02-21T17:56:41.409Z,1677002201.409 [BPC1](INFO): BPC1B: got serial number for stick 53: 0494
2023-02-21T17:56:41.410Z,1677002201.410 [BPC1](INFO): BPC1B: got serial number for stick 54: 0466
2023-02-21T17:56:41.410Z,1677002201.410 [BPC1](INFO): BPC1B: got serial number for stick 55: 0447
2023-02-21T17:56:41.411Z,1677002201.411 [BPC1](INFO): BPC1B: marked stick 55 as reserve.
2023-02-21T17:56:41.411Z,1677002201.411 [BPC1](INFO): BPC1B: got serial number for stick 56: 0480
2023-02-21T17:56:41.412Z,1677002201.412 [BPC1](INFO): BPC1B: got serial number for stick 57: 04A3
2023-02-21T17:56:41.413Z,1677002201.413 [BPC1](INFO): BPC1B: got serial number for stick 58: 04C5
2023-02-21T17:56:41.413Z,1677002201.413 [BPC1](INFO): BPC1B: got serial number for stick 59: 046D
2023-02-21T17:56:41.414Z,1677002201.414 [BPC1](INFO): BPC1B: got serial number for stick 60: 0409
2023-02-21T17:56:41.415Z,1677002201.415 [BPC1](INFO): BPC1B: got serial number for stick 61: 04D3
2023-02-21T17:56:41.416Z,1677002201.416 [BPC1](INFO): BPC1B: got serial number for stick 62: 0493
2023-02-21T17:56:42.088Z,1677002202.088 [BPC1] Loaded
2023-02-21T17:56:42.089Z,1677002202.089 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-02-21T17:56:42.163Z,1677002202.163 [DataOverHttps] Loaded
2023-02-21T17:56:42.164Z,1677002202.164 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-02-21T17:56:42.164Z,1677002202.164 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409F44E0
2023-02-21T17:56:42.165Z,1677002202.165 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6829
2023-02-21T17:56:42.185Z,1677002202.185 [Depth_Keller] Loaded
2023-02-21T17:56:42.185Z,1677002202.185 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-02-21T17:56:42.204Z,1677002202.204 [MultiRay] Loaded
2023-02-21T17:56:42.204Z,1677002202.204 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread.
2023-02-21T17:56:42.263Z,1677002202.263 [NAL9602] Loaded
2023-02-21T17:56:42.263Z,1677002202.263 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-02-21T17:56:42.288Z,1677002202.288 [Onboard] Loaded
2023-02-21T17:56:42.288Z,1677002202.288 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-02-21T17:56:42.289Z,1677002202.289 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A244E0
2023-02-21T17:56:42.290Z,1677002202.290 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6830
2023-02-21T17:56:42.301Z,1677002202.301 [Power24vConverter] Loaded
2023-02-21T17:56:42.302Z,1677002202.302 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-02-21T17:56:42.315Z,1677002202.315 [Radio_Surface] Loaded
2023-02-21T17:56:42.315Z,1677002202.315 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-02-21T17:56:42.316Z,1677002202.316 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A544E0
2023-02-21T17:56:42.316Z,1677002202.316 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6831
2023-02-21T17:56:42.407Z,1677002202.407 [DAT] Loaded
2023-02-21T17:56:42.407Z,1677002202.407 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2023-02-21T17:56:42.408Z,1677002202.408 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A844E0
2023-02-21T17:56:42.409Z,1677002202.409 [DAT ThreadHandler](INFO): Protected caller Thread ID is 6832
2023-02-21T17:56:42.409Z,1677002202.409 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-02-21T17:56:42.410Z,1677002202.410 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-02-21T17:56:42.466Z,1677002202.466 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-02-21T17:56:42.467Z,1677002202.467 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-02-21T17:56:42.516Z,1677002202.516 [VerticalControl](DEBUG): Construct VerticalControl.
2023-02-21T17:56:42.566Z,1677002202.566 [VerticalControl] Loaded
2023-02-21T17:56:42.566Z,1677002202.566 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-02-21T17:56:42.569Z,1677002202.569 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-02-21T17:56:42.605Z,1677002202.605 [HorizontalControl] Loaded
2023-02-21T17:56:42.605Z,1677002202.605 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-02-21T17:56:42.608Z,1677002202.608 [SpeedControl](DEBUG): Construct SpeedControl.
2023-02-21T17:56:42.610Z,1677002202.610 [SpeedControl] Loaded
2023-02-21T17:56:42.610Z,1677002202.610 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-02-21T17:56:42.613Z,1677002202.613 [LoopControl](DEBUG): Construct LoopControl.
2023-02-21T17:56:42.613Z,1677002202.613 [LoopControl] Loaded
2023-02-21T17:56:42.613Z,1677002202.613 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-02-21T17:56:42.614Z,1677002202.614 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-02-21T17:56:42.614Z,1677002202.614 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-02-21T17:56:42.625Z,1677002202.625 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-02-21T17:56:42.625Z,1677002202.625 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-02-21T17:56:42.923Z,1677002202.923 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-02-21T17:56:42.929Z,1677002202.929 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-02-21T17:56:42.932Z,1677002202.932 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-02-21T17:56:42.943Z,1677002202.943 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-02-21T17:56:42.944Z,1677002202.944 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B7E4E0
2023-02-21T17:56:42.945Z,1677002202.945 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6833
2023-02-21T17:56:42.949Z,1677002202.949 [Supervisor](INFO): Main Thread ID is 6340
2023-02-21T17:56:42.949Z,1677002202.949 [Supervisor](DEBUG): Running supervisor.
2023-02-21T17:56:42.950Z,1677002202.950 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6834
2023-02-21T17:56:42.950Z,1677002202.950 [CommandExec](INFO): Initializing the command executive.
2023-02-21T17:56:42.952Z,1677002202.952 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6835
2023-02-21T17:56:42.954Z,1677002202.954 [controlThread ThreadHandler](INFO): Handler Thread ID is 6836
2023-02-21T17:56:42.954Z,1677002202.954 [controlThread](DEBUG): Initializing ControlThread
2023-02-21T17:56:42.956Z,1677002202.956 [SBIT](INFO): Initialize SBIT Component.
2023-02-21T17:56:42.957Z,1677002202.957 [SBIT](IMPORTANT): git: 2023-02-15A-1-g98c560e2e
2023-02-21T17:56:42.957Z,1677002202.957 [SBIT](INFO): git hash: 98c560e2e862bfc439cbc2881c3a6b20e1bb1b72
2023-02-21T17:56:42.957Z,1677002202.957 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-02-21T17:56:42.959Z,1677002202.959 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-02-21T17:56:42.960Z,1677002202.960 [SBIT](INFO): Beginning SBIT in 46.000000 seconds.
2023-02-21T17:56:42.960Z,1677002202.960 [IBIT](INFO): Initialize IBIT Component.
2023-02-21T17:56:42.961Z,1677002202.961 [CBIT](DEBUG): Initialize CBIT Component.
2023-02-21T17:56:42.962Z,1677002202.962 [logger ThreadHandler](INFO): Handler Thread ID is 6837
2023-02-21T17:56:42.972Z,1677002202.972 [CBIT](DEBUG): Initialized mux pins.
2023-02-21T17:56:42.972Z,1677002202.972 [CBIT](DEBUG): Initializing the watchdog timer.
2023-02-21T17:56:42.980Z,1677002202.980 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 6838
2023-02-21T17:56:42.995Z,1677002202.995 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-02-21T17:56:42.996Z,1677002202.996 [CBIT](DEBUG): Initializing heartbeat.
2023-02-21T17:56:42.997Z,1677002202.997 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6839
2023-02-21T17:56:42.998Z,1677002202.998 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-02-21T17:56:43.008Z,1677002203.008 [Onboard ThreadHandler](INFO): Handler Thread ID is 6840
2023-02-21T17:56:43.025Z,1677002203.025 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6841
2023-02-21T17:56:43.048Z,1677002203.048 [DAT ThreadHandler](INFO): Handler Thread ID is 6842
2023-02-21T17:56:43.049Z,1677002203.049 [DAT](INFO): Powering up
2023-02-21T17:56:43.049Z,1677002203.049 [DAT](DEBUG): Initializing DAT.
2023-02-21T17:56:43.054Z,1677002203.054 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6844
2023-02-21T17:56:43.056Z,1677002203.056 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-02-21T17:56:43.056Z,1677002203.056 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-02-21T17:56:43.056Z,1677002203.056 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-02-21T17:56:43.057Z,1677002203.057 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-02-21T17:56:43.057Z,1677002203.057 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-02-21T17:56:43.057Z,1677002203.057 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-02-21T17:56:43.057Z,1677002203.057 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-02-21T17:56:43.057Z,1677002203.057 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-02-21T17:56:43.057Z,1677002203.057 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA69M.000
2023-02-21T17:56:43.058Z,1677002203.058 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA69M.000
2023-02-21T17:56:43.068Z,1677002203.068 [CBIT](DEBUG): Deactivating GF circuits.
2023-02-21T17:56:43.068Z,1677002203.068 [CBIT](DEBUG): Deactivating emergency mode.
2023-02-21T17:56:43.104Z,1677002203.104 [CBIT](DEBUG): Backplane powered.
2023-02-21T17:56:43.108Z,1677002203.108 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-02-21T17:56:43.108Z,1677002203.108 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-02-21T17:56:43.109Z,1677002203.109 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-02-21T17:56:43.109Z,1677002203.109 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-02-21T17:56:43.109Z,1677002203.109 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-02-21T17:56:43.111Z,1677002203.111 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-02-21T17:56:43.111Z,1677002203.111 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-02-21T17:56:43.117Z,1677002203.117 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-02-21T17:56:43.118Z,1677002203.118 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-02-21T17:56:43.119Z,1677002203.119 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-02-21T17:56:43.120Z,1677002203.120 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-02-21T17:56:43.121Z,1677002203.121 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-02-21T17:56:43.159Z,1677002203.159 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-02-21T17:56:43.194Z,1677002203.194 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2023-02-21T17:56:43.195Z,1677002203.195 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-02-21T17:56:43.311Z,1677002203.311 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-02-21T17:56:43.312Z,1677002203.312 [Default:A.Wait](DEBUG): Construct Wait.
2023-02-21T17:56:43.315Z,1677002203.315 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-02-21T17:56:43.354Z,1677002203.354 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-02-21T17:56:43.357Z,1677002203.357 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-02-21T17:56:43.379Z,1677002203.379 [Default:E.Execute](DEBUG): Construct Execute.
2023-02-21T17:56:43.382Z,1677002203.382 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P4H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2023-02-21T17:56:43.408Z,1677002203.408 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,MultiRay,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-02-21T17:56:43.432Z,1677002203.432 [Radio_Surface](INFO): Powering up
2023-02-21T17:56:43.441Z,1677002203.441 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-02-21T17:56:43.520Z,1677002203.520 [Depth_Keller](ERROR): Pressure reading out of range: 1895.444336 decibar
2023-02-21T17:56:43.521Z,1677002203.521 [MultiRay](INFO): Powering up MultiRay Lights
2023-02-21T17:56:43.568Z,1677002203.568 [Power24vConverter](INFO): Powering up.
2023-02-21T17:56:43.576Z,1677002203.576 [DepthRateCalculator](ERROR): Depth measurement is not active
2023-02-21T17:56:43.606Z,1677002203.606 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-02-21T17:56:43.612Z,1677002203.612 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-02-21T17:56:43.613Z,1677002203.613 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-02-21T17:56:43.620Z,1677002203.620 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-02-21T17:56:43.621Z,1677002203.621 [MassServo](DEBUG): Initializing EZServoServo.
2023-02-21T17:56:43.628Z,1677002203.628 [MassServo](DEBUG): Initializing MassServo.
2023-02-21T17:56:43.629Z,1677002203.629 [RudderServo](DEBUG): Initializing EZServoServo.
2023-02-21T17:56:43.636Z,1677002203.636 [RudderServo](DEBUG): Initializing RudderServo.
2023-02-21T17:56:43.637Z,1677002203.637 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-02-21T17:56:43.644Z,1677002203.644 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-02-21T17:56:44.576Z,1677002204.576 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2023-02-21T17:56:44.576Z,1677002204.576 [RudderServo](FAULT): Rudder failed to initialize
2023-02-21T17:56:44.576Z,1677002204.576 [RudderServo] Communications Fault, FailCount= 1
2023-02-21T17:56:44.576Z,1677002204.576 [RudderServo](ERROR): Communications Fault
2023-02-21T17:56:44.580Z,1677002204.580 [CBIT](ERROR): Communications Fault in component: RudderServo
2023-02-21T17:56:45.025Z,1677002205.025 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-02-21T17:56:45.025Z,1677002205.025 [RudderServo](INFO): Powering down
2023-02-21T17:56:45.468Z,1677002205.468 [RudderServo](DEBUG): Initializing EZServoServo.
2023-02-21T17:56:45.589Z,1677002205.589 [RudderServo](DEBUG): Initializing RudderServo.
2023-02-21T17:56:45.592Z,1677002205.592 [CBIT](INFO): Clearing failed state for component RudderServo
2023-02-21T17:56:45.593Z,1677002205.593 [RudderServo] No Fault, FailCount= 1
2023-02-21T17:56:49.324Z,1677002209.324 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-02-21T17:56:54.644Z,1677002214.644 [DAT](INFO): DAT read: 

2023-02-21T17:56:54.646Z,1677002214.646 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2023-02-21T17:56:56.156Z,1677002216.156 [DAT](INFO): DAT read: MF Frequency Band

2023-02-21T17:56:56.158Z,1677002216.158 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2023-02-21T17:56:56.158Z,1677002216.158 [DAT](INFO): DAT read: Feb 21 2023 17:56:51 

2023-02-21T17:56:57.417Z,1677002217.417 [DAT](INFO): DAT read: Features enabled [Bearing]

2023-02-21T17:56:57.418Z,1677002217.418 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2023-02-21T17:56:57.418Z,1677002217.418 [DAT](INFO): commRate: 1200
2023-02-21T17:56:59.484Z,1677002219.484 [DAT](INFO): entering command mode
2023-02-21T17:56:59.684Z,1677002219.684 [DAT](INFO): DAT read: 

2023-02-21T17:56:59.685Z,1677002219.685 [DAT](INFO): DAT read: user:1>

2023-02-21T17:56:59.685Z,1677002219.685 [DAT](INFO): setting verbose to 3
2023-02-21T17:56:59.936Z,1677002219.936 [DAT](INFO): DAT read: user:1>

2023-02-21T17:56:59.937Z,1677002219.937 [DAT](INFO): DAT read: Verbose         | 3           

2023-02-21T17:56:59.938Z,1677002219.938 [DAT](INFO): set verbose to 3
2023-02-21T17:56:59.938Z,1677002219.938 [DAT](INFO): setting DatVerbose to 27440
2023-02-21T17:57:00.188Z,1677002220.188 [DAT](INFO): DAT read: user:2>

2023-02-21T17:57:00.189Z,1677002220.189 [DAT](INFO): DAT read: DatVerbose      | 27440       

2023-02-21T17:57:00.190Z,1677002220.190 [DAT](INFO): set DatVerbose to 27440
2023-02-21T17:57:00.190Z,1677002220.190 [DAT](INFO): setting transmit power to 8
2023-02-21T17:57:00.440Z,1677002220.440 [DAT](INFO): DAT read: user:3>

2023-02-21T17:57:00.441Z,1677002220.441 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2023-02-21T17:57:00.442Z,1677002220.442 [DAT](INFO): set transmit power to 8
2023-02-21T17:57:00.442Z,1677002220.442 [DAT](INFO): setting local address to 4
2023-02-21T17:57:00.692Z,1677002220.692 [DAT](INFO): DAT read: user:4>

2023-02-21T17:57:00.693Z,1677002220.693 [DAT](INFO): DAT read: LocalAddr       | 4           

2023-02-21T17:57:00.694Z,1677002220.694 [DAT](INFO): set local address to 4
2023-02-21T17:57:00.695Z,1677002220.695 [DAT](INFO): Setting time to: 17:57:0 And date to:2/21/2023
2023-02-21T17:57:00.944Z,1677002220.944 [DAT](INFO): DAT read: user:5>

2023-02-21T17:57:00.945Z,1677002220.945 [DAT](INFO): DAT read: Tue Feb 21, 2023  17:57:00  

2023-02-21T17:57:00.945Z,1677002220.945 [DAT](INFO): Local DAT time set to Tue Feb 21, 2023  17:57:00  

2023-02-21T17:57:12.529Z,1677002232.529 [NAL9602](INFO): Powering up NAL9602
2023-02-21T17:57:23.437Z,1677002243.437 [NAL9602](INFO): NAL9602 initialized
2023-02-21T17:57:29.506Z,1677002249.506 [SBIT](IMPORTANT): Beginning Startup BIT
2023-02-21T17:57:29.510Z,1677002249.510 [CBIT](IMPORTANT): Beginning ground fault scan
2023-02-21T17:57:40.519Z,1677002260.519 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.005922
CHAN A1 (24V): 0.001293
CHAN A2 (12V): -0.004991
CHAN A3 (5V): -0.002737
CHAN B0 (3.3V): -0.001175
CHAN B1 (3.15aV): -0.001344
CHAN B2 (3.15bV): -0.001385
CHAN B3 (GND): 0.000427
OPEN: 0.006700
Full Scale: +/- 1 mA
2023-02-21T17:57:42.522Z,1677002262.522 [SBIT](FAULT): Rudder: EXPECTED:15.000000 ACTUAL:14.527149
2023-02-21T17:57:44.452Z,1677002264.452 [BPC1](INFO): BPC1A: initialized.
2023-02-21T17:57:44.464Z,1677002264.464 [BPC1](INFO): BPC1B: initialized.
2023-02-21T17:57:46.057Z,1677002266.057 [BPC1](INFO): BPC1A: sending IBPS break.
2023-02-21T17:57:46.057Z,1677002266.057 [BPC1](INFO): BPC1B: sending IBPS break.
2023-02-21T17:57:50.500Z,1677002270.500 [BPC1](INFO): BPC1A: validating data format.
2023-02-21T17:57:50.536Z,1677002270.536 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2023-02-21T17:57:50.536Z,1677002270.536 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2023-02-21T17:57:50.537Z,1677002270.537 [BPC1](INFO): BPC1B: validating data format.
2023-02-21T17:57:50.553Z,1677002270.553 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2023-02-21T17:57:50.553Z,1677002270.553 [BPC1](INFO): BPC1B: got valid message (1824 bytes).
2023-02-21T17:57:50.905Z,1677002270.905 [BPC1](INFO): Looking for stick 018Dto match 0C1E
2023-02-21T17:57:50.905Z,1677002270.905 [BPC1](INFO): Looking for stick 018Dto match 0481
2023-02-21T17:57:50.906Z,1677002270.906 [BPC1](INFO): Looking for stick 018Dto match 047B
2023-02-21T17:57:50.910Z,1677002270.910 [BPC1](INFO): Looking for stick 018Dto match 0464
2023-02-21T17:57:50.912Z,1677002270.912 [BPC1](INFO): Looking for stick 018Dto match 045C
2023-02-21T17:57:50.912Z,1677002270.912 [BPC1](INFO): Looking for stick 018Dto match 046A
2023-02-21T17:57:50.912Z,1677002270.912 [BPC1](INFO): Looking for stick 018Dto match 045A
2023-02-21T17:57:50.913Z,1677002270.913 [BPC1](INFO): Looking for stick 018Dto match 0487
2023-02-21T17:57:50.913Z,1677002270.913 [BPC1](INFO): Looking for stick 018Dto match 03FE
2023-02-21T17:57:50.913Z,1677002270.913 [BPC1](INFO): Looking for stick 018Dto match 0465
2023-02-21T17:57:50.914Z,1677002270.914 [BPC1](INFO): Looking for stick 018Dto match 046B
2023-02-21T17:57:50.914Z,1677002270.914 [BPC1](INFO): Looking for stick 018Dto match 0445
2023-02-21T17:57:50.914Z,1677002270.914 [BPC1](INFO): Looking for stick 018Dto match 040D
2023-02-21T17:57:50.915Z,1677002270.915 [BPC1](INFO): Looking for stick 018Dto match 04AA
2023-02-21T17:57:50.915Z,1677002270.915 [BPC1](INFO): Looking for stick 018Dto match 049A
2023-02-21T17:57:50.915Z,1677002270.915 [BPC1](INFO): Looking for stick 018Dto match 04C6
2023-02-21T17:57:50.916Z,1677002270.916 [BPC1](INFO): Looking for stick 018Dto match 0486
2023-02-21T17:57:50.916Z,1677002270.916 [BPC1](INFO): Looking for stick 018Dto match 0442
2023-02-21T17:57:50.916Z,1677002270.916 [BPC1](INFO): Looking for stick 018Dto match 0457
2023-02-21T17:57:50.917Z,1677002270.917 [BPC1](INFO): Looking for stick 018Dto match 0455
2023-02-21T17:57:50.917Z,1677002270.917 [BPC1](INFO): Looking for stick 018Dto match 04C0
2023-02-21T17:57:50.917Z,1677002270.917 [BPC1](INFO): Looking for stick 018Dto match 0459
2023-02-21T17:57:50.918Z,1677002270.918 [BPC1](INFO): Looking for stick 018Dto match 045F
2023-02-21T17:57:50.918Z,1677002270.918 [BPC1](INFO): Looking for stick 018Dto match 0449
2023-02-21T17:57:50.918Z,1677002270.918 [BPC1](INFO): Looking for stick 018Dto match 0441
2023-02-21T17:57:50.919Z,1677002270.919 [BPC1](INFO): Looking for stick 018Dto match 0460
2023-02-21T17:57:50.919Z,1677002270.919 [BPC1](INFO): Looking for stick 018Dto match 04A8
2023-02-21T17:57:50.919Z,1677002270.919 [BPC1](INFO): Looking for stick 018Dto match 04BF
2023-02-21T17:57:50.920Z,1677002270.920 [BPC1](INFO): Looking for stick 018Dto match 045D
2023-02-21T17:57:50.920Z,1677002270.920 [BPC1](INFO): Looking for stick 018Dto match 04A4
2023-02-21T17:57:50.920Z,1677002270.920 [BPC1](INFO): Looking for stick 018Dto match 04D9
2023-02-21T17:57:50.921Z,1677002270.921 [BPC1](ERROR): BPC1A: No match for serial number 018D in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2023-02-21T17:57:50.922Z,1677002270.922 [BPC1](INFO): Looking for stick 04CCto match 0BE5
2023-02-21T17:57:50.922Z,1677002270.922 [BPC1](INFO): Looking for stick 04CCto match 0124
2023-02-21T17:57:50.923Z,1677002270.923 [BPC1](INFO): Looking for stick 04CCto match 0162
2023-02-21T17:57:50.923Z,1677002270.923 [BPC1](INFO): Looking for stick 04CCto match 017A
2023-02-21T17:57:50.950Z,1677002270.950 [BPC1](INFO): Looking for stick 04CCto match 0495
2023-02-21T17:57:50.951Z,1677002270.951 [BPC1](INFO): Looking for stick 04CCto match 0458
2023-02-21T17:57:50.951Z,1677002270.951 [BPC1](INFO): Looking for stick 04CCto match 0139
2023-02-21T17:57:50.952Z,1677002270.952 [BPC1](INFO): Looking for stick 04CCto match 00F0
2023-02-21T17:57:50.952Z,1677002270.952 [BPC1](INFO): Looking for stick 04CCto match 0451
2023-02-21T17:57:50.953Z,1677002270.953 [BPC1](INFO): Looking for stick 04CCto match 049E
2023-02-21T17:57:50.953Z,1677002270.953 [BPC1](INFO): Looking for stick 04CCto match 04A2
2023-02-21T17:57:50.953Z,1677002270.953 [BPC1](INFO): Looking for stick 04CCto match 044F
2023-02-21T17:57:50.953Z,1677002270.953 [BPC1](INFO): Looking for stick 04CCto match 047F
2023-02-21T17:57:50.954Z,1677002270.954 [BPC1](INFO): Looking for stick 04CCto match 0496
2023-02-21T17:57:50.954Z,1677002270.954 [BPC1](INFO): Looking for stick 04CCto match 04CE
2023-02-21T17:57:50.954Z,1677002270.954 [BPC1](INFO): Looking for stick 04CCto match 04A5
2023-02-21T17:57:50.955Z,1677002270.955 [BPC1](INFO): Looking for stick 04CCto match 04D7
2023-02-21T17:57:50.955Z,1677002270.955 [BPC1](INFO): Looking for stick 04CCto match 04CA
2023-02-21T17:57:50.960Z,1677002270.960 [BPC1](INFO): Looking for stick 04CCto match 04A1
2023-02-21T17:57:50.960Z,1677002270.960 [BPC1](INFO): Looking for stick 04CCto match 049B
2023-02-21T17:57:50.960Z,1677002270.960 [BPC1](INFO): Looking for stick 04CCto match 04BD
2023-02-21T17:57:50.961Z,1677002270.961 [BPC1](INFO): Looking for stick 04CCto match 0494
2023-02-21T17:57:50.961Z,1677002270.961 [BPC1](INFO): Looking for stick 04CCto match 0466
2023-02-21T17:57:50.961Z,1677002270.961 [BPC1](INFO): Looking for stick 04CCto match 0447
2023-02-21T17:57:50.962Z,1677002270.962 [BPC1](INFO): Looking for stick 04CCto match 0480
2023-02-21T17:57:50.962Z,1677002270.962 [BPC1](INFO): Looking for stick 04CCto match 04A3
2023-02-21T17:57:50.962Z,1677002270.962 [BPC1](INFO): Looking for stick 04CCto match 04C5
2023-02-21T17:57:50.963Z,1677002270.963 [BPC1](INFO): Looking for stick 04CCto match 046D
2023-02-21T17:57:50.963Z,1677002270.963 [BPC1](INFO): Looking for stick 04CCto match 0409
2023-02-21T17:57:50.963Z,1677002270.963 [BPC1](INFO): Looking for stick 04CCto match 04D3
2023-02-21T17:57:50.968Z,1677002270.968 [BPC1](INFO): Looking for stick 04CCto match 0493
2023-02-21T17:57:50.969Z,1677002270.969 [BPC1](ERROR): BPC1B: No match for serial number 04CC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-21T17:57:50.969Z,1677002270.969 [BPC1](FAULT): Failed to parse data from all battery packs.
2023-02-21T17:57:50.969Z,1677002270.969 [BPC1] Data Fault, FailCount= 1
2023-02-21T17:57:50.969Z,1677002270.969 [BPC1](ERROR): Data Fault
2023-02-21T17:57:51.031Z,1677002271.031 [CBIT](ERROR): Data Fault in component: BPC1
2023-02-21T17:58:23.247Z,1677002303.247 [SBIT](CRITICAL): SBIT FAILED
2023-02-21T17:58:23.248Z,1677002303.248 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-02-21T17:58:23.249Z,1677002303.249 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool;

2023-02-21T17:58:23.249Z,1677002303.249 [SBIT](IMPORTANT): CBIT.vehicleOpen=1 bool;

2023-02-21T17:58:23.249Z,1677002303.249 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2023-02-21T17:58:23.249Z,1677002303.249 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool;

2023-02-21T17:58:23.249Z,1677002303.249 [SBIT](IMPORTANT): DAT.sbdAddress=-1 enum;

2023-02-21T17:58:23.249Z,1677002303.249 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=0 bool;

2023-02-21T17:58:23.249Z,1677002303.249 [SBIT](IMPORTANT): Depth_Keller.offset=-0.8 decibar;

2023-02-21T17:58:23.249Z,1677002303.249 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2023-02-21T17:58:23.249Z,1677002303.249 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=4 minute;

2023-02-21T17:58:23.250Z,1677002303.250 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;

2023-02-21T17:58:23.250Z,1677002303.250 [SBIT](IMPORTANT): ElevatorServo.offsetAngle=1 degree;

2023-02-21T17:58:23.250Z,1677002303.250 [SBIT](IMPORTANT): Express linearApproximation NAL9602.sigQuality 1.000000 count;

2023-02-21T17:58:23.250Z,1677002303.250 [SBIT](IMPORTANT): Express none WetLabsBB2FL.BackscatteringCoeff470nm;

2023-02-21T17:58:23.250Z,1677002303.250 [SBIT](IMPORTANT): Express none WetLabsBB2FL.BackscatteringCoeff650nm;

2023-02-21T17:58:23.250Z,1677002303.250 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=86.344810 cubic_centimeter;

2023-02-21T17:58:23.250Z,1677002303.250 [SBIT](IMPORTANT): VerticalControl.massDefault=-6.557592 millimeter;

2023-02-21T17:58:23.250Z,1677002303.250 [SBIT](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool;

2023-02-21T17:58:23.252Z,1677002303.252 [CommandExec](FAULT): Scheduling is paused
2023-02-21T17:58:23.252Z,1677002303.252 [CBIT](INFO): Critical error at 20230221T175823
2023-02-21T17:58:23.253Z,1677002303.253 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-02-21T17:58:23.665Z,1677002303.665 [MissionManager](IMPORTANT): Started mission Startup
2023-02-21T17:58:23.666Z,1677002303.666 [Startup] Running Loop=1
2023-02-21T17:58:23.666Z,1677002303.666 [Startup](DEBUG): Aggregate::initialize Startup
2023-02-21T17:58:23.666Z,1677002303.666 [Startup:A.GoToSurface] Running Loop=1
2023-02-21T17:58:23.666Z,1677002303.666 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-02-21T17:58:23.667Z,1677002303.667 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-02-21T17:58:23.668Z,1677002303.668 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-02-21T17:58:23.668Z,1677002303.668 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-02-21T17:58:23.668Z,1677002303.668 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-02-21T17:58:23.669Z,1677002303.669 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-02-21T17:58:23.670Z,1677002303.670 [Startup:StartupSatComms] Running Loop=1
2023-02-21T17:58:23.670Z,1677002303.670 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-02-21T17:58:23.670Z,1677002303.670 [Startup:StartupSatComms:A] Running Loop=1
2023-02-21T17:58:24.072Z,1677002304.072 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-02-21T17:59:23.840Z,1677002363.840 [Startup:StartupSatComms:A](INFO): Timed out from 2023-02-21T17:58:23.7Z
2023-02-21T17:59:23.840Z,1677002363.840 [Startup:StartupSatComms:A] Stopped
2023-02-21T17:59:23.840Z,1677002363.840 [Startup:StartupSatComms:B] Running Loop=1
2023-02-21T17:59:24.242Z,1677002364.242 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-02-21T17:59:25.926Z,1677002365.926 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004799
2023-02-21T17:59:37.463Z,1677002377.463 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230221T175153/Courier0004.lzma
2023-02-21T17:59:38.466Z,1677002378.466 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175153/Courier0004.lzma.bak
2023-02-21T17:59:38.466Z,1677002378.466 [DataOverHttps](INFO): SBD MOMSN=17483817
2023-02-21T17:59:43.266Z,1677002383.266 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-02-21T17:59:43.266Z,1677002383.266 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T17:59:43.339Z,1677002383.339 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T17:59:43.727Z,1677002383.727 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T17:59:43.727Z,1677002383.727 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-02-21T18:00:12.175Z,1677002412.175 [DataOverHttps](INFO): Sending 184 bytes from file Logs/20230221T175633/Courier0000.lzma
2023-02-21T18:00:13.191Z,1677002413.191 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175633/Courier0000.lzma.bak
2023-02-21T18:00:13.192Z,1677002413.192 [DataOverHttps](INFO): SBD MOMSN=17483830
2023-02-21T18:00:24.053Z,1677002424.053 [Startup:StartupSatComms:B](INFO): Timed out from 2023-02-21T17:59:23.8Z
2023-02-21T18:00:24.053Z,1677002424.053 [Startup:StartupSatComms:B] Stopped
2023-02-21T18:00:24.053Z,1677002424.053 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-02-21T18:00:24.053Z,1677002424.053 [Startup:StartupSatComms] Stopped
2023-02-21T18:00:24.053Z,1677002424.053 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-02-21T18:00:24.054Z,1677002424.054 [Startup](INFO): Completed Startup
2023-02-21T18:00:24.054Z,1677002424.054 [MissionManager](INFO): Startup is completed.
2023-02-21T18:00:24.054Z,1677002424.054 [MissionManager](INFO): Uninitializing Mission Startup
2023-02-21T18:00:24.054Z,1677002424.054 [Startup] Stopped
2023-02-21T18:00:24.054Z,1677002424.054 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-02-21T18:00:24.055Z,1677002424.055 [Startup:A.GoToSurface] Stopped
2023-02-21T18:00:24.055Z,1677002424.055 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-02-21T18:00:24.466Z,1677002424.466 [MissionManager](IMPORTANT): Started mission Default
2023-02-21T18:00:24.466Z,1677002424.466 [Default] Running Loop=1
2023-02-21T18:00:24.466Z,1677002424.466 [Default](DEBUG): Aggregate::initialize Default
2023-02-21T18:00:24.466Z,1677002424.466 [Default:B.GoToSurface] Running Loop=1
2023-02-21T18:00:24.466Z,1677002424.466 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-02-21T18:00:24.466Z,1677002424.466 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-02-21T18:00:24.467Z,1677002424.467 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-02-21T18:00:24.467Z,1677002424.467 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-02-21T18:00:24.472Z,1677002424.472 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-02-21T18:00:24.472Z,1677002424.472 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-02-21T18:00:24.472Z,1677002424.472 [Default:A.Wait] Running Loop=1
2023-02-21T18:00:24.472Z,1677002424.472 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-02-21T18:00:37.305Z,1677002437.305 [DataOverHttps](INFO): Sending 1135 bytes from file Logs/20230221T175153/Express0001.lzma
2023-02-21T18:00:37.781Z,1677002437.781 [Default:A.Wait](INFO): Done Waiting.
2023-02-21T18:00:37.781Z,1677002437.781 [Default:A.Wait] Stopped
2023-02-21T18:00:37.781Z,1677002437.781 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-02-21T18:00:38.186Z,1677002438.186 [Default:CheckIn] Running Loop=1
2023-02-21T18:00:38.186Z,1677002438.186 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-02-21T18:00:38.186Z,1677002438.186 [Default:CheckIn:Read_GPS] Running Loop=1
2023-02-21T18:00:38.305Z,1677002438.305 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175153/Express0001.lzma.bak
2023-02-21T18:00:38.306Z,1677002438.306 [DataOverHttps](INFO): SBD MOMSN=17483844
2023-02-21T18:00:38.601Z,1677002438.601 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-02-21T18:02:26.453Z,1677002546.453 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-02-21T18:02:44.265Z,1677002564.265 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-02-21T18:02:44.265Z,1677002564.265 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:02:44.305Z,1677002564.305 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:02:44.716Z,1677002564.716 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:02:44.716Z,1677002564.716 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-02-21T18:05:38.369Z,1677002738.369 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-21T18:00:38.2Z
2023-02-21T18:05:38.370Z,1677002738.370 [Default:CheckIn:Read_GPS] Stopped
2023-02-21T18:05:38.370Z,1677002738.370 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-02-21T18:05:38.785Z,1677002738.785 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-02-21T18:05:45.284Z,1677002745.284 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-02-21T18:05:45.284Z,1677002745.284 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:05:45.338Z,1677002745.338 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:05:45.396Z,1677002745.396 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230221T175633/Courier0004.lzma
2023-02-21T18:05:45.705Z,1677002745.705 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:05:45.705Z,1677002745.705 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-02-21T18:05:46.401Z,1677002746.401 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175633/Courier0004.lzma.bak
2023-02-21T18:05:46.402Z,1677002746.402 [DataOverHttps](INFO): SBD MOMSN=17484002
2023-02-21T18:06:11.283Z,1677002771.283 [DataOverHttps](INFO): Sending 123 bytes from file Logs/20230221T175153/Express0005.lzma
2023-02-21T18:06:12.285Z,1677002772.285 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175153/Express0005.lzma.bak
2023-02-21T18:06:12.286Z,1677002772.286 [DataOverHttps](INFO): SBD MOMSN=17484058
2023-02-21T18:06:35.977Z,1677002795.977 [DataOverHttps](INFO): Sending 1140 bytes from file Logs/20230221T175633/Express0001.lzma
2023-02-21T18:06:36.977Z,1677002796.977 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175633/Express0001.lzma.bak
2023-02-21T18:06:36.978Z,1677002796.978 [DataOverHttps](INFO): SBD MOMSN=17484097
2023-02-21T18:07:04.904Z,1677002824.904 [DataOverHttps](INFO): Sending 194 bytes from file Logs/20230221T175633/Express0005.lzma
2023-02-21T18:07:05.906Z,1677002825.906 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175633/Express0005.lzma.bak
2023-02-21T18:07:05.906Z,1677002825.906 [DataOverHttps](INFO): SBD MOMSN=17484153
2023-02-21T18:07:15.789Z,1677002835.789 [Default:CheckIn:Read_Iridium] Stopped
2023-02-21T18:07:15.789Z,1677002835.789 [Default:CheckIn:C.Wait] Running Loop=1
2023-02-21T18:07:15.789Z,1677002835.789 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-02-21T18:07:25.453Z,1677002845.453 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-02-21T18:07:25.454Z,1677002845.454 [NAL9602] Data Fault, FailCount= 1
2023-02-21T18:07:25.454Z,1677002845.454 [NAL9602](ERROR): Data Fault
2023-02-21T18:07:25.588Z,1677002845.588 [CBIT](ERROR): Data Fault in component: NAL9602
2023-02-21T18:07:25.862Z,1677002845.862 [NAL9602](INFO): Powering down
2023-02-21T18:07:26.723Z,1677002846.723 [CBIT](INFO): Clearing failed state for component NAL9602
2023-02-21T18:07:26.723Z,1677002846.723 [NAL9602] No Fault, FailCount= 1
2023-02-21T18:07:52.133Z,1677002872.133 [CBIT](INFO): Clearing failed state for component BPC1
2023-02-21T18:07:52.133Z,1677002872.133 [BPC1] No Fault, FailCount= 1
2023-02-21T18:07:56.158Z,1677002876.158 [NAL9602](INFO): Powering up NAL9602
2023-02-21T18:08:07.066Z,1677002887.066 [NAL9602](INFO): NAL9602 initialized
2023-02-21T18:08:46.294Z,1677002926.294 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-02-21T18:08:46.294Z,1677002926.294 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:08:46.305Z,1677002926.305 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:08:46.672Z,1677002926.672 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:08:46.673Z,1677002926.673 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-02-21T18:08:53.536Z,1677002933.536 [BPC1](INFO): BPC1A: initialized.
2023-02-21T18:08:53.548Z,1677002933.548 [BPC1](INFO): BPC1B: initialized.
2023-02-21T18:08:55.141Z,1677002935.141 [BPC1](INFO): BPC1A: sending IBPS break.
2023-02-21T18:08:55.142Z,1677002935.142 [BPC1](INFO): BPC1B: sending IBPS break.
2023-02-21T18:08:59.180Z,1677002939.180 [BPC1](INFO): BPC1B: validating data format.
2023-02-21T18:08:59.210Z,1677002939.210 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2023-02-21T18:08:59.210Z,1677002939.210 [BPC1](INFO): BPC1B: got valid message (1824 bytes).
2023-02-21T18:08:59.584Z,1677002939.584 [BPC1](INFO): BPC1A: validating data format.
2023-02-21T18:08:59.600Z,1677002939.600 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2023-02-21T18:08:59.600Z,1677002939.600 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2023-02-21T18:08:59.601Z,1677002939.601 [BPC1](INFO): Looking for stick 04CCto match 0BE5
2023-02-21T18:08:59.602Z,1677002939.602 [BPC1](INFO): Looking for stick 04CCto match 0124
2023-02-21T18:08:59.602Z,1677002939.602 [BPC1](INFO): Looking for stick 04CCto match 0162
2023-02-21T18:08:59.602Z,1677002939.602 [BPC1](INFO): Looking for stick 04CCto match 017A
2023-02-21T18:08:59.603Z,1677002939.603 [BPC1](INFO): Looking for stick 04CCto match 0495
2023-02-21T18:08:59.603Z,1677002939.603 [BPC1](INFO): Looking for stick 04CCto match 0458
2023-02-21T18:08:59.603Z,1677002939.603 [BPC1](INFO): Looking for stick 04CCto match 0139
2023-02-21T18:08:59.604Z,1677002939.604 [BPC1](INFO): Looking for stick 04CCto match 00F0
2023-02-21T18:08:59.604Z,1677002939.604 [BPC1](INFO): Looking for stick 04CCto match 0451
2023-02-21T18:08:59.604Z,1677002939.604 [BPC1](INFO): Looking for stick 04CCto match 049E
2023-02-21T18:08:59.605Z,1677002939.605 [BPC1](INFO): Looking for stick 04CCto match 04A2
2023-02-21T18:08:59.605Z,1677002939.605 [BPC1](INFO): Looking for stick 04CCto match 044F
2023-02-21T18:08:59.605Z,1677002939.605 [BPC1](INFO): Looking for stick 04CCto match 047F
2023-02-21T18:08:59.606Z,1677002939.606 [BPC1](INFO): Looking for stick 04CCto match 0496
2023-02-21T18:08:59.606Z,1677002939.606 [BPC1](INFO): Looking for stick 04CCto match 04CE
2023-02-21T18:08:59.606Z,1677002939.606 [BPC1](INFO): Looking for stick 04CCto match 04A5
2023-02-21T18:08:59.607Z,1677002939.607 [BPC1](INFO): Looking for stick 04CCto match 04D7
2023-02-21T18:08:59.607Z,1677002939.607 [BPC1](INFO): Looking for stick 04CCto match 04CA
2023-02-21T18:08:59.607Z,1677002939.607 [BPC1](INFO): Looking for stick 04CCto match 04A1
2023-02-21T18:08:59.628Z,1677002939.628 [BPC1](INFO): Looking for stick 04CCto match 049B
2023-02-21T18:08:59.628Z,1677002939.628 [BPC1](INFO): Looking for stick 04CCto match 04BD
2023-02-21T18:08:59.629Z,1677002939.629 [BPC1](INFO): Looking for stick 04CCto match 0494
2023-02-21T18:08:59.629Z,1677002939.629 [BPC1](INFO): Looking for stick 04CCto match 0466
2023-02-21T18:08:59.629Z,1677002939.629 [BPC1](INFO): Looking for stick 04CCto match 0447
2023-02-21T18:08:59.630Z,1677002939.630 [BPC1](INFO): Looking for stick 04CCto match 0480
2023-02-21T18:08:59.630Z,1677002939.630 [BPC1](INFO): Looking for stick 04CCto match 04A3
2023-02-21T18:08:59.630Z,1677002939.630 [BPC1](INFO): Looking for stick 04CCto match 04C5
2023-02-21T18:08:59.631Z,1677002939.631 [BPC1](INFO): Looking for stick 04CCto match 046D
2023-02-21T18:08:59.631Z,1677002939.631 [BPC1](INFO): Looking for stick 04CCto match 0409
2023-02-21T18:08:59.631Z,1677002939.631 [BPC1](INFO): Looking for stick 04CCto match 04D3
2023-02-21T18:08:59.637Z,1677002939.637 [BPC1](INFO): Looking for stick 04CCto match 0493
2023-02-21T18:08:59.637Z,1677002939.637 [BPC1](ERROR): BPC1B: No match for serial number 04CC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-21T18:08:59.989Z,1677002939.989 [BPC1](INFO): Looking for stick 018Dto match 0C1E
2023-02-21T18:08:59.989Z,1677002939.989 [BPC1](INFO): Looking for stick 018Dto match 0481
2023-02-21T18:08:59.990Z,1677002939.990 [BPC1](INFO): Looking for stick 018Dto match 047B
2023-02-21T18:08:59.990Z,1677002939.990 [BPC1](INFO): Looking for stick 018Dto match 0464
2023-02-21T18:08:59.990Z,1677002939.990 [BPC1](INFO): Looking for stick 018Dto match 045C
2023-02-21T18:08:59.991Z,1677002939.991 [BPC1](INFO): Looking for stick 018Dto match 046A
2023-02-21T18:08:59.991Z,1677002939.991 [BPC1](INFO): Looking for stick 018Dto match 045A
2023-02-21T18:08:59.991Z,1677002939.991 [BPC1](INFO): Looking for stick 018Dto match 0487
2023-02-21T18:08:59.992Z,1677002939.992 [BPC1](INFO): Looking for stick 018Dto match 03FE
2023-02-21T18:08:59.992Z,1677002939.992 [BPC1](INFO): Looking for stick 018Dto match 0465
2023-02-21T18:08:59.992Z,1677002939.992 [BPC1](INFO): Looking for stick 018Dto match 046B
2023-02-21T18:08:59.993Z,1677002939.993 [BPC1](INFO): Looking for stick 018Dto match 0445
2023-02-21T18:08:59.993Z,1677002939.993 [BPC1](INFO): Looking for stick 018Dto match 040D
2023-02-21T18:08:59.993Z,1677002939.993 [BPC1](INFO): Looking for stick 018Dto match 04AA
2023-02-21T18:08:59.994Z,1677002939.994 [BPC1](INFO): Looking for stick 018Dto match 049A
2023-02-21T18:08:59.994Z,1677002939.994 [BPC1](INFO): Looking for stick 018Dto match 04C6
2023-02-21T18:08:59.994Z,1677002939.994 [BPC1](INFO): Looking for stick 018Dto match 0486
2023-02-21T18:08:59.995Z,1677002939.995 [BPC1](INFO): Looking for stick 018Dto match 0442
2023-02-21T18:08:59.995Z,1677002939.995 [BPC1](INFO): Looking for stick 018Dto match 0457
2023-02-21T18:08:59.995Z,1677002939.995 [BPC1](INFO): Looking for stick 018Dto match 0455
2023-02-21T18:08:59.996Z,1677002939.996 [BPC1](INFO): Looking for stick 018Dto match 04C0
2023-02-21T18:08:59.996Z,1677002939.996 [BPC1](INFO): Looking for stick 018Dto match 0459
2023-02-21T18:08:59.996Z,1677002939.996 [BPC1](INFO): Looking for stick 018Dto match 045F
2023-02-21T18:08:59.997Z,1677002939.997 [BPC1](INFO): Looking for stick 018Dto match 0449
2023-02-21T18:08:59.997Z,1677002939.997 [BPC1](INFO): Looking for stick 018Dto match 0441
2023-02-21T18:08:59.997Z,1677002939.997 [BPC1](INFO): Looking for stick 018Dto match 0460
2023-02-21T18:08:59.998Z,1677002939.998 [BPC1](INFO): Looking for stick 018Dto match 04A8
2023-02-21T18:08:59.998Z,1677002939.998 [BPC1](INFO): Looking for stick 018Dto match 04BF
2023-02-21T18:08:59.998Z,1677002939.998 [BPC1](INFO): Looking for stick 018Dto match 045D
2023-02-21T18:08:59.999Z,1677002939.999 [BPC1](INFO): Looking for stick 018Dto match 04A4
2023-02-21T18:08:59.999Z,1677002939.999 [BPC1](INFO): Looking for stick 018Dto match 04D9
2023-02-21T18:08:59.000Z,1677002940.000 [BPC1](ERROR): BPC1A: No match for serial number 018D in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2023-02-21T18:09:00.012Z,1677002940.012 [BPC1](FAULT): Failed to parse data from all battery packs.
2023-02-21T18:09:00.012Z,1677002940.012 [BPC1] Data Fault, FailCount= 2
2023-02-21T18:09:00.012Z,1677002940.012 [BPC1](ERROR): Data Fault
2023-02-21T18:09:00.044Z,1677002940.044 [CBIT](ERROR): Data Fault in component: BPC1
2023-02-21T18:11:47.254Z,1677003107.254 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-02-21T18:11:47.254Z,1677003107.254 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:11:47.264Z,1677003107.264 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:11:47.676Z,1677003107.676 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:11:47.676Z,1677003107.676 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-02-21T18:12:16.357Z,1677003136.357 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-02-21T18:12:16.357Z,1677003136.357 [Default:CheckIn:C.Wait] Stopped
2023-02-21T18:12:16.357Z,1677003136.357 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-02-21T18:12:16.357Z,1677003136.357 [Default:CheckIn:D] Running Loop=1
2023-02-21T18:12:16.758Z,1677003136.758 [Default:CheckIn:D] Stopped
2023-02-21T18:12:16.758Z,1677003136.758 [Default:CheckIn:E] Running Loop=1
2023-02-21T18:12:17.168Z,1677003137.168 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.871532 min 
2023-02-21T18:12:17.168Z,1677003137.168 [Default:CheckIn:E] Stopped
2023-02-21T18:12:17.169Z,1677003137.169 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-02-21T18:12:17.169Z,1677003137.169 [Default:CheckIn] Stopped
2023-02-21T18:12:17.169Z,1677003137.169 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-02-21T18:12:17.169Z,1677003137.169 [Default:CheckIn](INFO): Running loop #2
2023-02-21T18:12:17.169Z,1677003137.169 [Default:CheckIn] Running Loop=2
2023-02-21T18:12:17.169Z,1677003137.169 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-02-21T18:12:17.169Z,1677003137.169 [Default:CheckIn:Read_GPS] Running Loop=1
2023-02-21T18:14:48.276Z,1677003288.276 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-02-21T18:14:48.276Z,1677003288.276 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:14:48.287Z,1677003288.287 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:14:48.688Z,1677003288.688 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:14:48.688Z,1677003288.688 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-02-21T18:17:17.362Z,1677003437.362 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-21T18:12:17.2Z
2023-02-21T18:17:17.362Z,1677003437.362 [Default:CheckIn:Read_GPS] Stopped
2023-02-21T18:17:17.362Z,1677003437.362 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-02-21T18:17:29.211Z,1677003449.211 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230221T175633/Courier0007.lzma
2023-02-21T18:17:30.213Z,1677003450.213 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175633/Courier0007.lzma.bak
2023-02-21T18:17:30.213Z,1677003450.213 [DataOverHttps](INFO): SBD MOMSN=17484163
2023-02-21T18:17:49.259Z,1677003469.259 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-02-21T18:17:49.259Z,1677003469.259 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:17:49.269Z,1677003469.269 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:17:49.681Z,1677003469.681 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:17:49.681Z,1677003469.681 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-02-21T18:17:56.195Z,1677003476.195 [DataOverHttps](INFO): Sending 220 bytes from file Logs/20230221T175633/Express0008.lzma
2023-02-21T18:17:57.197Z,1677003477.197 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175633/Express0008.lzma.bak
2023-02-21T18:17:57.198Z,1677003477.198 [DataOverHttps](INFO): SBD MOMSN=17484177
2023-02-21T18:18:06.245Z,1677003486.245 [Default:CheckIn:Read_Iridium] Stopped
2023-02-21T18:18:06.245Z,1677003486.245 [Default:CheckIn:C.Wait] Running Loop=1
2023-02-21T18:18:06.245Z,1677003486.245 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-02-21T18:18:08.233Z,1677003488.233 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-02-21T18:18:08.233Z,1677003488.233 [NAL9602] Data Fault, FailCount= 2
2023-02-21T18:18:08.233Z,1677003488.233 [NAL9602](ERROR): Data Fault
2023-02-21T18:18:08.392Z,1677003488.392 [CBIT](ERROR): Data Fault in component: NAL9602
2023-02-21T18:18:08.657Z,1677003488.657 [NAL9602](INFO): Powering down
2023-02-21T18:18:09.477Z,1677003489.477 [CBIT](INFO): Clearing failed state for component NAL9602
2023-02-21T18:18:09.477Z,1677003489.477 [NAL9602] No Fault, FailCount= 2
2023-02-21T18:18:38.934Z,1677003518.934 [NAL9602](INFO): Powering up NAL9602
2023-02-21T18:18:49.842Z,1677003529.842 [NAL9602](INFO): NAL9602 initialized
2023-02-21T18:19:01.188Z,1677003541.188 [CBIT](INFO): Clearing failed state for component BPC1
2023-02-21T18:19:01.188Z,1677003541.188 [BPC1] No Fault, FailCount= 2
2023-02-21T18:20:02.572Z,1677003602.572 [BPC1](INFO): BPC1A: initialized.
2023-02-21T18:20:02.592Z,1677003602.592 [BPC1](INFO): BPC1B: initialized.
2023-02-21T18:20:04.181Z,1677003604.181 [BPC1](INFO): BPC1A: sending IBPS break.
2023-02-21T18:20:04.182Z,1677003604.182 [BPC1](INFO): BPC1B: sending IBPS break.
2023-02-21T18:20:08.216Z,1677003608.216 [BPC1](INFO): BPC1A: validating data format.
2023-02-21T18:20:08.232Z,1677003608.232 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2023-02-21T18:20:08.232Z,1677003608.232 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2023-02-21T18:20:08.233Z,1677003608.233 [BPC1](INFO): BPC1B: validating data format.
2023-02-21T18:20:08.249Z,1677003608.249 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2023-02-21T18:20:08.249Z,1677003608.249 [BPC1](INFO): BPC1B: got valid message (1824 bytes).
2023-02-21T18:20:08.616Z,1677003608.616 [BPC1](INFO): Looking for stick 018Dto match 0C1E
2023-02-21T18:20:08.616Z,1677003608.616 [BPC1](INFO): Looking for stick 018Dto match 0481
2023-02-21T18:20:08.617Z,1677003608.617 [BPC1](INFO): Looking for stick 018Dto match 047B
2023-02-21T18:20:08.617Z,1677003608.617 [BPC1](INFO): Looking for stick 018Dto match 0464
2023-02-21T18:20:08.617Z,1677003608.617 [BPC1](INFO): Looking for stick 018Dto match 045C
2023-02-21T18:20:08.618Z,1677003608.618 [BPC1](INFO): Looking for stick 018Dto match 046A
2023-02-21T18:20:08.618Z,1677003608.618 [BPC1](INFO): Looking for stick 018Dto match 045A
2023-02-21T18:20:08.618Z,1677003608.618 [BPC1](INFO): Looking for stick 018Dto match 0487
2023-02-21T18:20:08.619Z,1677003608.619 [BPC1](INFO): Looking for stick 018Dto match 03FE
2023-02-21T18:20:08.619Z,1677003608.619 [BPC1](INFO): Looking for stick 018Dto match 0465
2023-02-21T18:20:08.641Z,1677003608.641 [BPC1](INFO): Looking for stick 018Dto match 046B
2023-02-21T18:20:08.642Z,1677003608.642 [BPC1](INFO): Looking for stick 018Dto match 0445
2023-02-21T18:20:08.642Z,1677003608.642 [BPC1](INFO): Looking for stick 018Dto match 040D
2023-02-21T18:20:08.642Z,1677003608.642 [BPC1](INFO): Looking for stick 018Dto match 04AA
2023-02-21T18:20:08.643Z,1677003608.643 [BPC1](INFO): Looking for stick 018Dto match 049A
2023-02-21T18:20:08.643Z,1677003608.643 [BPC1](INFO): Looking for stick 018Dto match 04C6
2023-02-21T18:20:08.643Z,1677003608.643 [BPC1](INFO): Looking for stick 018Dto match 0486
2023-02-21T18:20:08.644Z,1677003608.644 [BPC1](INFO): Looking for stick 018Dto match 0442
2023-02-21T18:20:08.644Z,1677003608.644 [BPC1](INFO): Looking for stick 018Dto match 0457
2023-02-21T18:20:08.644Z,1677003608.644 [BPC1](INFO): Looking for stick 018Dto match 0455
2023-02-21T18:20:08.645Z,1677003608.645 [BPC1](INFO): Looking for stick 018Dto match 04C0
2023-02-21T18:20:08.645Z,1677003608.645 [BPC1](INFO): Looking for stick 018Dto match 0459
2023-02-21T18:20:08.645Z,1677003608.645 [BPC1](INFO): Looking for stick 018Dto match 045F
2023-02-21T18:20:08.646Z,1677003608.646 [BPC1](INFO): Looking for stick 018Dto match 0449
2023-02-21T18:20:08.646Z,1677003608.646 [BPC1](INFO): Looking for stick 018Dto match 0441
2023-02-21T18:20:08.646Z,1677003608.646 [BPC1](INFO): Looking for stick 018Dto match 0460
2023-02-21T18:20:08.647Z,1677003608.647 [BPC1](INFO): Looking for stick 018Dto match 04A8
2023-02-21T18:20:08.647Z,1677003608.647 [BPC1](INFO): Looking for stick 018Dto match 04BF
2023-02-21T18:20:08.672Z,1677003608.672 [BPC1](INFO): Looking for stick 018Dto match 045D
2023-02-21T18:20:08.672Z,1677003608.672 [BPC1](INFO): Looking for stick 018Dto match 04A4
2023-02-21T18:20:08.672Z,1677003608.672 [BPC1](INFO): Looking for stick 018Dto match 04D9
2023-02-21T18:20:08.673Z,1677003608.673 [BPC1](ERROR): BPC1A: No match for serial number 018D in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2023-02-21T18:20:08.674Z,1677003608.674 [BPC1](INFO): Looking for stick 04CCto match 0BE5
2023-02-21T18:20:08.674Z,1677003608.674 [BPC1](INFO): Looking for stick 04CCto match 0124
2023-02-21T18:20:08.675Z,1677003608.675 [BPC1](INFO): Looking for stick 04CCto match 0162
2023-02-21T18:20:08.675Z,1677003608.675 [BPC1](INFO): Looking for stick 04CCto match 017A
2023-02-21T18:20:08.676Z,1677003608.676 [BPC1](INFO): Looking for stick 04CCto match 0495
2023-02-21T18:20:08.676Z,1677003608.676 [BPC1](INFO): Looking for stick 04CCto match 0458
2023-02-21T18:20:08.676Z,1677003608.676 [BPC1](INFO): Looking for stick 04CCto match 0139
2023-02-21T18:20:08.677Z,1677003608.677 [BPC1](INFO): Looking for stick 04CCto match 00F0
2023-02-21T18:20:08.677Z,1677003608.677 [BPC1](INFO): Looking for stick 04CCto match 0451
2023-02-21T18:20:08.677Z,1677003608.677 [BPC1](INFO): Looking for stick 04CCto match 049E
2023-02-21T18:20:08.677Z,1677003608.677 [BPC1](INFO): Looking for stick 04CCto match 04A2
2023-02-21T18:20:08.678Z,1677003608.678 [BPC1](INFO): Looking for stick 04CCto match 044F
2023-02-21T18:20:08.678Z,1677003608.678 [BPC1](INFO): Looking for stick 04CCto match 047F
2023-02-21T18:20:08.678Z,1677003608.678 [BPC1](INFO): Looking for stick 04CCto match 0496
2023-02-21T18:20:08.679Z,1677003608.679 [BPC1](INFO): Looking for stick 04CCto match 04CE
2023-02-21T18:20:08.679Z,1677003608.679 [BPC1](INFO): Looking for stick 04CCto match 04A5
2023-02-21T18:20:08.687Z,1677003608.687 [BPC1](INFO): Looking for stick 04CCto match 04D7
2023-02-21T18:20:08.687Z,1677003608.687 [BPC1](INFO): Looking for stick 04CCto match 04CA
2023-02-21T18:20:08.688Z,1677003608.688 [BPC1](INFO): Looking for stick 04CCto match 04A1
2023-02-21T18:20:08.688Z,1677003608.688 [BPC1](INFO): Looking for stick 04CCto match 049B
2023-02-21T18:20:08.688Z,1677003608.688 [BPC1](INFO): Looking for stick 04CCto match 04BD
2023-02-21T18:20:08.689Z,1677003608.689 [BPC1](INFO): Looking for stick 04CCto match 0494
2023-02-21T18:20:08.689Z,1677003608.689 [BPC1](INFO): Looking for stick 04CCto match 0466
2023-02-21T18:20:08.689Z,1677003608.689 [BPC1](INFO): Looking for stick 04CCto match 0447
2023-02-21T18:20:08.690Z,1677003608.690 [BPC1](INFO): Looking for stick 04CCto match 0480
2023-02-21T18:20:08.690Z,1677003608.690 [BPC1](INFO): Looking for stick 04CCto match 04A3
2023-02-21T18:20:08.690Z,1677003608.690 [BPC1](INFO): Looking for stick 04CCto match 04C5
2023-02-21T18:20:08.691Z,1677003608.691 [BPC1](INFO): Looking for stick 04CCto match 046D
2023-02-21T18:20:08.691Z,1677003608.691 [BPC1](INFO): Looking for stick 04CCto match 0409
2023-02-21T18:20:08.691Z,1677003608.691 [BPC1](INFO): Looking for stick 04CCto match 04D3
2023-02-21T18:20:08.692Z,1677003608.692 [BPC1](INFO): Looking for stick 04CCto match 0493
2023-02-21T18:20:08.693Z,1677003608.693 [BPC1](ERROR): BPC1B: No match for serial number 04CC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-21T18:20:08.693Z,1677003608.693 [BPC1](FAULT): Failed to parse data from all battery packs.
2023-02-21T18:20:08.693Z,1677003608.693 [BPC1] Data Fault, FailCount= 3
2023-02-21T18:20:08.693Z,1677003608.693 [BPC1](ERROR): Data Fault
2023-02-21T18:20:08.748Z,1677003608.748 [CBIT](ERROR): Data Fault in component: BPC1
2023-02-21T18:20:50.260Z,1677003650.260 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2023-02-21T18:20:50.260Z,1677003650.260 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:20:50.270Z,1677003650.270 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:20:50.667Z,1677003650.667 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:20:50.667Z,1677003650.667 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2023-02-21T18:23:06.909Z,1677003786.909 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-02-21T18:23:06.909Z,1677003786.909 [Default:CheckIn:C.Wait] Stopped
2023-02-21T18:23:06.910Z,1677003786.910 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-02-21T18:23:06.910Z,1677003786.910 [Default:CheckIn:D] Running Loop=1
2023-02-21T18:23:07.321Z,1677003787.321 [Default:CheckIn:D] Stopped
2023-02-21T18:23:07.322Z,1677003787.322 [Default:CheckIn:E] Running Loop=1
2023-02-21T18:23:07.738Z,1677003787.738 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.714258 min 
2023-02-21T18:23:07.738Z,1677003787.738 [Default:CheckIn:E] Stopped
2023-02-21T18:23:07.738Z,1677003787.738 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-02-21T18:23:07.738Z,1677003787.738 [Default:CheckIn] Stopped
2023-02-21T18:23:07.738Z,1677003787.738 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-02-21T18:23:07.738Z,1677003787.738 [Default:CheckIn](INFO): Running loop #3
2023-02-21T18:23:07.738Z,1677003787.738 [Default:CheckIn] Running Loop=3
2023-02-21T18:23:07.738Z,1677003787.738 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-02-21T18:23:07.738Z,1677003787.738 [Default:CheckIn:Read_GPS] Running Loop=1
2023-02-21T18:23:51.316Z,1677003831.316 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2023-02-21T18:23:51.316Z,1677003831.316 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:23:51.350Z,1677003831.350 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:23:51.728Z,1677003831.728 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:23:51.728Z,1677003831.728 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2023-02-21T18:26:52.308Z,1677004012.308 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2023-02-21T18:26:52.308Z,1677004012.308 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:26:52.318Z,1677004012.318 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:26:52.721Z,1677004012.721 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:26:52.721Z,1677004012.721 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2023-02-21T18:28:07.889Z,1677004087.889 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-21T18:23:07.7Z
2023-02-21T18:28:07.889Z,1677004087.889 [Default:CheckIn:Read_GPS] Stopped
2023-02-21T18:28:07.889Z,1677004087.889 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-02-21T18:28:19.119Z,1677004099.119 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230221T175633/Courier0010.lzma
2023-02-21T18:28:20.122Z,1677004100.122 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175633/Courier0010.lzma.bak
2023-02-21T18:28:20.122Z,1677004100.122 [DataOverHttps](INFO): SBD MOMSN=17484191
2023-02-21T18:28:46.283Z,1677004126.283 [DataOverHttps](INFO): Sending 191 bytes from file Logs/20230221T175633/Express0011.lzma
2023-02-21T18:28:47.285Z,1677004127.285 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175633/Express0011.lzma.bak
2023-02-21T18:28:47.286Z,1677004127.286 [DataOverHttps](INFO): SBD MOMSN=17484193
2023-02-21T18:28:53.101Z,1677004133.101 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-02-21T18:28:53.102Z,1677004133.102 [NAL9602] Data Fault, FailCount= 3
2023-02-21T18:28:53.102Z,1677004133.102 [NAL9602](ERROR): Data Fault
2023-02-21T18:28:53.126Z,1677004133.126 [CBIT](ERROR): Data Fault in component: NAL9602
2023-02-21T18:28:53.497Z,1677004133.497 [NAL9602](INFO): Powering down
2023-02-21T18:28:54.356Z,1677004134.356 [CBIT](INFO): Clearing failed state for component NAL9602
2023-02-21T18:28:54.356Z,1677004134.356 [NAL9602] No Fault, FailCount= 3
2023-02-21T18:28:55.960Z,1677004135.960 [Default:CheckIn:Read_Iridium] Stopped
2023-02-21T18:28:55.960Z,1677004135.960 [Default:CheckIn:C.Wait] Running Loop=1
2023-02-21T18:28:55.960Z,1677004135.960 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-02-21T18:29:23.798Z,1677004163.798 [NAL9602](INFO): Powering up NAL9602
2023-02-21T18:29:34.720Z,1677004174.720 [NAL9602](INFO): NAL9602 initialized
2023-02-21T18:29:53.313Z,1677004193.313 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2023-02-21T18:29:53.313Z,1677004193.313 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:29:53.323Z,1677004193.323 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:29:53.733Z,1677004193.733 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:29:53.733Z,1677004193.733 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2023-02-21T18:30:09.487Z,1677004209.487 [CBIT](INFO): Clearing failed state for component BPC1
2023-02-21T18:30:09.487Z,1677004209.487 [BPC1] No Fault, FailCount= 3
2023-02-21T18:31:10.868Z,1677004270.868 [BPC1](INFO): BPC1A: initialized.
2023-02-21T18:31:10.879Z,1677004270.879 [BPC1](INFO): BPC1B: initialized.
2023-02-21T18:31:12.476Z,1677004272.476 [BPC1](INFO): BPC1A: sending IBPS break.
2023-02-21T18:31:12.477Z,1677004272.477 [BPC1](INFO): BPC1B: sending IBPS break.
2023-02-21T18:31:16.517Z,1677004276.517 [BPC1](INFO): BPC1A: validating data format.
2023-02-21T18:31:16.578Z,1677004276.578 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2023-02-21T18:31:16.578Z,1677004276.578 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2023-02-21T18:31:16.578Z,1677004276.578 [BPC1](INFO): BPC1B: validating data format.
2023-02-21T18:31:16.611Z,1677004276.611 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2023-02-21T18:31:16.647Z,1677004276.647 [BPC1](INFO): BPC1B: got valid message (1824 bytes).
2023-02-21T18:31:16.916Z,1677004276.916 [BPC1](INFO): Looking for stick 018Dto match 0C1E
2023-02-21T18:31:16.917Z,1677004276.917 [BPC1](INFO): Looking for stick 018Dto match 0481
2023-02-21T18:31:16.917Z,1677004276.917 [BPC1](INFO): Looking for stick 018Dto match 047B
2023-02-21T18:31:16.917Z,1677004276.917 [BPC1](INFO): Looking for stick 018Dto match 0464
2023-02-21T18:31:16.918Z,1677004276.918 [BPC1](INFO): Looking for stick 018Dto match 045C
2023-02-21T18:31:16.918Z,1677004276.918 [BPC1](INFO): Looking for stick 018Dto match 046A
2023-02-21T18:31:16.918Z,1677004276.918 [BPC1](INFO): Looking for stick 018Dto match 045A
2023-02-21T18:31:16.919Z,1677004276.919 [BPC1](INFO): Looking for stick 018Dto match 0487
2023-02-21T18:31:16.919Z,1677004276.919 [BPC1](INFO): Looking for stick 018Dto match 03FE
2023-02-21T18:31:16.919Z,1677004276.919 [BPC1](INFO): Looking for stick 018Dto match 0465
2023-02-21T18:31:16.920Z,1677004276.920 [BPC1](INFO): Looking for stick 018Dto match 046B
2023-02-21T18:31:16.920Z,1677004276.920 [BPC1](INFO): Looking for stick 018Dto match 0445
2023-02-21T18:31:16.920Z,1677004276.920 [BPC1](INFO): Looking for stick 018Dto match 040D
2023-02-21T18:31:16.921Z,1677004276.921 [BPC1](INFO): Looking for stick 018Dto match 04AA
2023-02-21T18:31:16.921Z,1677004276.921 [BPC1](INFO): Looking for stick 018Dto match 049A
2023-02-21T18:31:16.921Z,1677004276.921 [BPC1](INFO): Looking for stick 018Dto match 04C6
2023-02-21T18:31:16.922Z,1677004276.922 [BPC1](INFO): Looking for stick 018Dto match 0486
2023-02-21T18:31:16.922Z,1677004276.922 [BPC1](INFO): Looking for stick 018Dto match 0442
2023-02-21T18:31:16.922Z,1677004276.922 [BPC1](INFO): Looking for stick 018Dto match 0457
2023-02-21T18:31:16.923Z,1677004276.923 [BPC1](INFO): Looking for stick 018Dto match 0455
2023-02-21T18:31:16.923Z,1677004276.923 [BPC1](INFO): Looking for stick 018Dto match 04C0
2023-02-21T18:31:16.924Z,1677004276.924 [BPC1](INFO): Looking for stick 018Dto match 0459
2023-02-21T18:31:16.924Z,1677004276.924 [BPC1](INFO): Looking for stick 018Dto match 045F
2023-02-21T18:31:16.924Z,1677004276.924 [BPC1](INFO): Looking for stick 018Dto match 0449
2023-02-21T18:31:16.925Z,1677004276.925 [BPC1](INFO): Looking for stick 018Dto match 0441
2023-02-21T18:31:16.925Z,1677004276.925 [BPC1](INFO): Looking for stick 018Dto match 0460
2023-02-21T18:31:16.925Z,1677004276.925 [BPC1](INFO): Looking for stick 018Dto match 04A8
2023-02-21T18:31:16.926Z,1677004276.926 [BPC1](INFO): Looking for stick 018Dto match 04BF
2023-02-21T18:31:16.926Z,1677004276.926 [BPC1](INFO): Looking for stick 018Dto match 045D
2023-02-21T18:31:16.926Z,1677004276.926 [BPC1](INFO): Looking for stick 018Dto match 04A4
2023-02-21T18:31:16.926Z,1677004276.926 [BPC1](INFO): Looking for stick 018Dto match 04D9
2023-02-21T18:31:16.927Z,1677004276.927 [BPC1](ERROR): BPC1A: No match for serial number 018D in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2023-02-21T18:31:16.974Z,1677004276.974 [BPC1](INFO): Looking for stick 04CCto match 0BE5
2023-02-21T18:31:16.974Z,1677004276.974 [BPC1](INFO): Looking for stick 04CCto match 0124
2023-02-21T18:31:16.974Z,1677004276.974 [BPC1](INFO): Looking for stick 04CCto match 0162
2023-02-21T18:31:16.975Z,1677004276.975 [BPC1](INFO): Looking for stick 04CCto match 017A
2023-02-21T18:31:16.975Z,1677004276.975 [BPC1](INFO): Looking for stick 04CCto match 0495
2023-02-21T18:31:16.975Z,1677004276.975 [BPC1](INFO): Looking for stick 04CCto match 0458
2023-02-21T18:31:16.976Z,1677004276.976 [BPC1](INFO): Looking for stick 04CCto match 0139
2023-02-21T18:31:16.976Z,1677004276.976 [BPC1](INFO): Looking for stick 04CCto match 00F0
2023-02-21T18:31:16.976Z,1677004276.976 [BPC1](INFO): Looking for stick 04CCto match 0451
2023-02-21T18:31:16.977Z,1677004276.977 [BPC1](INFO): Looking for stick 04CCto match 049E
2023-02-21T18:31:16.977Z,1677004276.977 [BPC1](INFO): Looking for stick 04CCto match 04A2
2023-02-21T18:31:16.977Z,1677004276.977 [BPC1](INFO): Looking for stick 04CCto match 044F
2023-02-21T18:31:16.978Z,1677004276.978 [BPC1](INFO): Looking for stick 04CCto match 047F
2023-02-21T18:31:16.978Z,1677004276.978 [BPC1](INFO): Looking for stick 04CCto match 0496
2023-02-21T18:31:16.978Z,1677004276.978 [BPC1](INFO): Looking for stick 04CCto match 04CE
2023-02-21T18:31:16.979Z,1677004276.979 [BPC1](INFO): Looking for stick 04CCto match 04A5
2023-02-21T18:31:16.979Z,1677004276.979 [BPC1](INFO): Looking for stick 04CCto match 04D7
2023-02-21T18:31:16.000Z,1677004277.000 [BPC1](INFO): Looking for stick 04CCto match 04CA
2023-02-21T18:31:17.000Z,1677004277.000 [BPC1](INFO): Looking for stick 04CCto match 04A1
2023-02-21T18:31:17.001Z,1677004277.001 [BPC1](INFO): Looking for stick 04CCto match 049B
2023-02-21T18:31:17.001Z,1677004277.001 [BPC1](INFO): Looking for stick 04CCto match 04BD
2023-02-21T18:31:17.001Z,1677004277.001 [BPC1](INFO): Looking for stick 04CCto match 0494
2023-02-21T18:31:17.002Z,1677004277.002 [BPC1](INFO): Looking for stick 04CCto match 0466
2023-02-21T18:31:17.002Z,1677004277.002 [BPC1](INFO): Looking for stick 04CCto match 0447
2023-02-21T18:31:17.002Z,1677004277.002 [BPC1](INFO): Looking for stick 04CCto match 0480
2023-02-21T18:31:17.003Z,1677004277.003 [BPC1](INFO): Looking for stick 04CCto match 04A3
2023-02-21T18:31:17.003Z,1677004277.003 [BPC1](INFO): Looking for stick 04CCto match 04C5
2023-02-21T18:31:17.003Z,1677004277.003 [BPC1](INFO): Looking for stick 04CCto match 046D
2023-02-21T18:31:17.004Z,1677004277.004 [BPC1](INFO): Looking for stick 04CCto match 0409
2023-02-21T18:31:17.004Z,1677004277.004 [BPC1](INFO): Looking for stick 04CCto match 04D3
2023-02-21T18:31:17.004Z,1677004277.004 [BPC1](INFO): Looking for stick 04CCto match 0493
2023-02-21T18:31:17.005Z,1677004277.005 [BPC1](ERROR): BPC1B: No match for serial number 04CC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-21T18:31:17.005Z,1677004277.005 [BPC1](FAULT): Failed to parse data from all battery packs.
2023-02-21T18:31:17.005Z,1677004277.005 [BPC1] Data Fault, FailCount= 4
2023-02-21T18:31:17.005Z,1677004277.005 [BPC1](ERROR): Data Fault
2023-02-21T18:31:17.065Z,1677004277.065 [CBIT](ERROR): Data Fault in component: BPC1
2023-02-21T18:32:54.296Z,1677004374.296 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2023-02-21T18:32:54.296Z,1677004374.296 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:32:54.343Z,1677004374.343 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:32:54.753Z,1677004374.753 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:32:54.753Z,1677004374.753 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2023-02-21T18:33:56.540Z,1677004436.540 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-02-21T18:33:56.540Z,1677004436.540 [Default:CheckIn:C.Wait] Stopped
2023-02-21T18:33:56.540Z,1677004436.540 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-02-21T18:33:56.540Z,1677004436.540 [Default:CheckIn:D] Running Loop=1
2023-02-21T18:33:56.913Z,1677004436.913 [Default:CheckIn:D] Stopped
2023-02-21T18:33:56.913Z,1677004436.913 [Default:CheckIn:E] Running Loop=1
2023-02-21T18:33:57.323Z,1677004437.323 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 33.540786 min 
2023-02-21T18:33:57.323Z,1677004437.323 [Default:CheckIn:E] Stopped
2023-02-21T18:33:57.323Z,1677004437.323 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-02-21T18:33:57.323Z,1677004437.323 [Default:CheckIn] Stopped
2023-02-21T18:33:57.323Z,1677004437.323 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-02-21T18:33:57.324Z,1677004437.324 [Default:CheckIn](INFO): Running loop #4
2023-02-21T18:33:57.324Z,1677004437.324 [Default:CheckIn] Running Loop=4
2023-02-21T18:33:57.324Z,1677004437.324 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-02-21T18:33:57.324Z,1677004437.324 [Default:CheckIn:Read_GPS] Running Loop=1
2023-02-21T18:35:55.312Z,1677004555.312 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2023-02-21T18:35:55.312Z,1677004555.312 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:35:55.322Z,1677004555.322 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:35:55.733Z,1677004555.733 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:35:55.733Z,1677004555.733 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2023-02-21T18:38:56.301Z,1677004736.301 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2023-02-21T18:38:56.301Z,1677004736.301 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:38:56.311Z,1677004736.311 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:38:56.714Z,1677004736.714 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:38:56.714Z,1677004736.714 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2023-02-21T18:38:57.492Z,1677004737.492 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-21T18:33:57.3Z
2023-02-21T18:38:57.492Z,1677004737.492 [Default:CheckIn:Read_GPS] Stopped
2023-02-21T18:38:57.492Z,1677004737.492 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-02-21T18:39:09.231Z,1677004749.231 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20230221T175633/Courier0013.lzma
2023-02-21T18:39:10.233Z,1677004750.233 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175633/Courier0013.lzma.bak
2023-02-21T18:39:10.234Z,1677004750.234 [DataOverHttps](INFO): SBD MOMSN=17484205
2023-02-21T18:39:32.903Z,1677004772.903 [DataOverHttps](INFO): Sending 190 bytes from file Logs/20230221T175633/Express0014.lzma
2023-02-21T18:39:33.905Z,1677004773.905 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175633/Express0014.lzma.bak
2023-02-21T18:39:33.906Z,1677004773.906 [DataOverHttps](INFO): SBD MOMSN=17484207
2023-02-21T18:39:35.871Z,1677004775.871 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-02-21T18:39:35.871Z,1677004775.871 [NAL9602] Data Fault, FailCount= 4
2023-02-21T18:39:35.871Z,1677004775.871 [NAL9602](ERROR): Data Fault
2023-02-21T18:39:35.914Z,1677004775.914 [CBIT](ERROR): Data Fault in component: NAL9602
2023-02-21T18:39:36.265Z,1677004776.265 [NAL9602](INFO): Powering down
2023-02-21T18:39:37.106Z,1677004777.106 [CBIT](INFO): Clearing failed state for component NAL9602
2023-02-21T18:39:37.107Z,1677004777.107 [NAL9602] No Fault, FailCount= 4
2023-02-21T18:39:43.161Z,1677004783.161 [Default:CheckIn:Read_Iridium] Stopped
2023-02-21T18:39:43.161Z,1677004783.161 [Default:CheckIn:C.Wait] Running Loop=1
2023-02-21T18:39:43.161Z,1677004783.161 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-02-21T18:40:06.577Z,1677004806.577 [NAL9602](INFO): Powering up NAL9602
2023-02-21T18:40:17.495Z,1677004817.495 [NAL9602](INFO): NAL9602 initialized
2023-02-21T18:41:18.101Z,1677004878.101 [CBIT](INFO): Clearing failed state for component BPC1
2023-02-21T18:41:18.101Z,1677004878.101 [BPC1] No Fault, FailCount= 4
2023-02-21T18:41:57.304Z,1677004917.304 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2023-02-21T18:41:57.304Z,1677004917.304 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:41:57.315Z,1677004917.315 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:41:57.709Z,1677004917.709 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:41:57.709Z,1677004917.709 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2023-02-21T18:42:19.504Z,1677004939.504 [BPC1](INFO): BPC1A: initialized.
2023-02-21T18:42:19.524Z,1677004939.524 [BPC1](INFO): BPC1B: initialized.
2023-02-21T18:42:21.108Z,1677004941.108 [BPC1](INFO): BPC1A: sending IBPS break.
2023-02-21T18:42:21.108Z,1677004941.108 [BPC1](INFO): BPC1B: sending IBPS break.
2023-02-21T18:42:25.553Z,1677004945.553 [BPC1](INFO): BPC1A: validating data format.
2023-02-21T18:42:25.569Z,1677004945.569 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2023-02-21T18:42:25.570Z,1677004945.570 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2023-02-21T18:42:25.570Z,1677004945.570 [BPC1](INFO): BPC1B: validating data format.
2023-02-21T18:42:25.587Z,1677004945.587 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2023-02-21T18:42:25.587Z,1677004945.587 [BPC1](INFO): BPC1B: got valid message (1824 bytes).
2023-02-21T18:42:25.954Z,1677004945.954 [BPC1](INFO): Looking for stick 018Dto match 0C1E
2023-02-21T18:42:25.954Z,1677004945.954 [BPC1](INFO): Looking for stick 018Dto match 0481
2023-02-21T18:42:25.954Z,1677004945.954 [BPC1](INFO): Looking for stick 018Dto match 047B
2023-02-21T18:42:25.955Z,1677004945.955 [BPC1](INFO): Looking for stick 018Dto match 0464
2023-02-21T18:42:25.955Z,1677004945.955 [BPC1](INFO): Looking for stick 018Dto match 045C
2023-02-21T18:42:25.955Z,1677004945.955 [BPC1](INFO): Looking for stick 018Dto match 046A
2023-02-21T18:42:25.956Z,1677004945.956 [BPC1](INFO): Looking for stick 018Dto match 045A
2023-02-21T18:42:25.956Z,1677004945.956 [BPC1](INFO): Looking for stick 018Dto match 0487
2023-02-21T18:42:25.956Z,1677004945.956 [BPC1](INFO): Looking for stick 018Dto match 03FE
2023-02-21T18:42:25.957Z,1677004945.957 [BPC1](INFO): Looking for stick 018Dto match 0465
2023-02-21T18:42:25.957Z,1677004945.957 [BPC1](INFO): Looking for stick 018Dto match 046B
2023-02-21T18:42:25.957Z,1677004945.957 [BPC1](INFO): Looking for stick 018Dto match 0445
2023-02-21T18:42:25.958Z,1677004945.958 [BPC1](INFO): Looking for stick 018Dto match 040D
2023-02-21T18:42:25.958Z,1677004945.958 [BPC1](INFO): Looking for stick 018Dto match 04AA
2023-02-21T18:42:25.958Z,1677004945.958 [BPC1](INFO): Looking for stick 018Dto match 049A
2023-02-21T18:42:25.959Z,1677004945.959 [BPC1](INFO): Looking for stick 018Dto match 04C6
2023-02-21T18:42:25.959Z,1677004945.959 [BPC1](INFO): Looking for stick 018Dto match 0486
2023-02-21T18:42:25.960Z,1677004945.960 [BPC1](INFO): Looking for stick 018Dto match 0442
2023-02-21T18:42:25.960Z,1677004945.960 [BPC1](INFO): Looking for stick 018Dto match 0457
2023-02-21T18:42:25.960Z,1677004945.960 [BPC1](INFO): Looking for stick 018Dto match 0455
2023-02-21T18:42:25.961Z,1677004945.961 [BPC1](INFO): Looking for stick 018Dto match 04C0
2023-02-21T18:42:25.961Z,1677004945.961 [BPC1](INFO): Looking for stick 018Dto match 0459
2023-02-21T18:42:25.961Z,1677004945.961 [BPC1](INFO): Looking for stick 018Dto match 045F
2023-02-21T18:42:25.962Z,1677004945.962 [BPC1](INFO): Looking for stick 018Dto match 0449
2023-02-21T18:42:25.962Z,1677004945.962 [BPC1](INFO): Looking for stick 018Dto match 0441
2023-02-21T18:42:25.962Z,1677004945.962 [BPC1](INFO): Looking for stick 018Dto match 0460
2023-02-21T18:42:25.963Z,1677004945.963 [BPC1](INFO): Looking for stick 018Dto match 04A8
2023-02-21T18:42:25.963Z,1677004945.963 [BPC1](INFO): Looking for stick 018Dto match 04BF
2023-02-21T18:42:25.963Z,1677004945.963 [BPC1](INFO): Looking for stick 018Dto match 045D
2023-02-21T18:42:25.976Z,1677004945.976 [BPC1](INFO): Looking for stick 018Dto match 04A4
2023-02-21T18:42:25.976Z,1677004945.976 [BPC1](INFO): Looking for stick 018Dto match 04D9
2023-02-21T18:42:25.977Z,1677004945.977 [BPC1](ERROR): BPC1A: No match for serial number 018D in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2023-02-21T18:42:25.978Z,1677004945.978 [BPC1](INFO): Looking for stick 04CCto match 0BE5
2023-02-21T18:42:25.978Z,1677004945.978 [BPC1](INFO): Looking for stick 04CCto match 0124
2023-02-21T18:42:25.979Z,1677004945.979 [BPC1](INFO): Looking for stick 04CCto match 0162
2023-02-21T18:42:25.979Z,1677004945.979 [BPC1](INFO): Looking for stick 04CCto match 017A
2023-02-21T18:42:25.979Z,1677004945.979 [BPC1](INFO): Looking for stick 04CCto match 0495
2023-02-21T18:42:25.988Z,1677004945.988 [BPC1](INFO): Looking for stick 04CCto match 0458
2023-02-21T18:42:25.989Z,1677004945.989 [BPC1](INFO): Looking for stick 04CCto match 0139
2023-02-21T18:42:25.989Z,1677004945.989 [BPC1](INFO): Looking for stick 04CCto match 00F0
2023-02-21T18:42:25.989Z,1677004945.989 [BPC1](INFO): Looking for stick 04CCto match 0451
2023-02-21T18:42:25.990Z,1677004945.990 [BPC1](INFO): Looking for stick 04CCto match 049E
2023-02-21T18:42:25.990Z,1677004945.990 [BPC1](INFO): Looking for stick 04CCto match 04A2
2023-02-21T18:42:25.990Z,1677004945.990 [BPC1](INFO): Looking for stick 04CCto match 044F
2023-02-21T18:42:25.991Z,1677004945.991 [BPC1](INFO): Looking for stick 04CCto match 047F
2023-02-21T18:42:25.991Z,1677004945.991 [BPC1](INFO): Looking for stick 04CCto match 0496
2023-02-21T18:42:25.991Z,1677004945.991 [BPC1](INFO): Looking for stick 04CCto match 04CE
2023-02-21T18:42:25.000Z,1677004946.000 [BPC1](INFO): Looking for stick 04CCto match 04A5
2023-02-21T18:42:26.000Z,1677004946.000 [BPC1](INFO): Looking for stick 04CCto match 04D7
2023-02-21T18:42:26.001Z,1677004946.001 [BPC1](INFO): Looking for stick 04CCto match 04CA
2023-02-21T18:42:26.001Z,1677004946.001 [BPC1](INFO): Looking for stick 04CCto match 04A1
2023-02-21T18:42:26.001Z,1677004946.001 [BPC1](INFO): Looking for stick 04CCto match 049B
2023-02-21T18:42:26.002Z,1677004946.002 [BPC1](INFO): Looking for stick 04CCto match 04BD
2023-02-21T18:42:26.002Z,1677004946.002 [BPC1](INFO): Looking for stick 04CCto match 0494
2023-02-21T18:42:26.002Z,1677004946.002 [BPC1](INFO): Looking for stick 04CCto match 0466
2023-02-21T18:42:26.003Z,1677004946.003 [BPC1](INFO): Looking for stick 04CCto match 0447
2023-02-21T18:42:26.003Z,1677004946.003 [BPC1](INFO): Looking for stick 04CCto match 0480
2023-02-21T18:42:26.003Z,1677004946.003 [BPC1](INFO): Looking for stick 04CCto match 04A3
2023-02-21T18:42:26.012Z,1677004946.012 [BPC1](INFO): Looking for stick 04CCto match 04C5
2023-02-21T18:42:26.012Z,1677004946.012 [BPC1](INFO): Looking for stick 04CCto match 046D
2023-02-21T18:42:26.013Z,1677004946.013 [BPC1](INFO): Looking for stick 04CCto match 0409
2023-02-21T18:42:26.013Z,1677004946.013 [BPC1](INFO): Looking for stick 04CCto match 04D3
2023-02-21T18:42:26.013Z,1677004946.013 [BPC1](INFO): Looking for stick 04CCto match 0493
2023-02-21T18:42:26.014Z,1677004946.014 [BPC1](ERROR): BPC1B: No match for serial number 04CC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-21T18:42:26.014Z,1677004946.014 [BPC1](FAULT): Failed to parse data from all battery packs.
2023-02-21T18:42:26.014Z,1677004946.014 [BPC1] Data Fault, FailCount= 5
2023-02-21T18:42:26.014Z,1677004946.014 [BPC1](ERROR): Data Fault
2023-02-21T18:42:26.081Z,1677004946.081 [CBIT](ERROR): Data Fault in component: BPC1
2023-02-21T18:44:43.750Z,1677005083.750 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-02-21T18:44:43.750Z,1677005083.750 [Default:CheckIn:C.Wait] Stopped
2023-02-21T18:44:43.751Z,1677005083.751 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-02-21T18:44:43.751Z,1677005083.751 [Default:CheckIn:D] Running Loop=1
2023-02-21T18:44:44.197Z,1677005084.197 [Default:CheckIn:D] Stopped
2023-02-21T18:44:44.197Z,1677005084.197 [Default:CheckIn:E] Running Loop=1
2023-02-21T18:44:44.569Z,1677005084.569 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.328845 min 
2023-02-21T18:44:44.569Z,1677005084.569 [Default:CheckIn:E] Stopped
2023-02-21T18:44:44.569Z,1677005084.569 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-02-21T18:44:44.570Z,1677005084.570 [Default:CheckIn] Stopped
2023-02-21T18:44:44.570Z,1677005084.570 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-02-21T18:44:44.570Z,1677005084.570 [Default:CheckIn](INFO): Running loop #5
2023-02-21T18:44:44.570Z,1677005084.570 [Default:CheckIn] Running Loop=5
2023-02-21T18:44:44.570Z,1677005084.570 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-02-21T18:44:44.570Z,1677005084.570 [Default:CheckIn:Read_GPS] Running Loop=1
2023-02-21T18:44:58.275Z,1677005098.275 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2023-02-21T18:44:58.275Z,1677005098.275 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:44:58.286Z,1677005098.286 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:44:58.702Z,1677005098.702 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:44:58.702Z,1677005098.702 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2023-02-21T18:47:59.264Z,1677005279.264 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2023-02-21T18:47:59.264Z,1677005279.264 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:47:59.275Z,1677005279.275 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:47:59.696Z,1677005279.696 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:47:59.696Z,1677005279.696 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2023-02-21T18:49:44.714Z,1677005384.714 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-21T18:44:44.6Z
2023-02-21T18:49:44.714Z,1677005384.714 [Default:CheckIn:Read_GPS] Stopped
2023-02-21T18:49:44.714Z,1677005384.714 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-02-21T18:49:55.491Z,1677005395.491 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230221T175633/Courier0016.lzma
2023-02-21T18:49:56.493Z,1677005396.493 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175633/Courier0016.lzma.bak
2023-02-21T18:49:56.494Z,1677005396.494 [DataOverHttps](INFO): SBD MOMSN=17484219
2023-02-21T18:50:18.645Z,1677005418.645 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-02-21T18:50:18.645Z,1677005418.645 [NAL9602] Data Fault, FailCount= 5
2023-02-21T18:50:18.645Z,1677005418.645 [NAL9602](ERROR): Data Fault
2023-02-21T18:50:18.697Z,1677005418.697 [CBIT](ERROR): Data Fault in component: NAL9602
2023-02-21T18:50:18.697Z,1677005418.697 [CBIT](CRITICAL): Data Fault in component: NAL9602
2023-02-21T18:50:19.045Z,1677005419.045 [NAL9602](INFO): Powering down
2023-02-21T18:50:19.111Z,1677005419.111 [CBIT](INFO): Critical error at 20230221T185018
2023-02-21T18:50:25.023Z,1677005425.023 [DataOverHttps](INFO): Sending 190 bytes from file Logs/20230221T175633/Express0017.lzma
2023-02-21T18:50:26.025Z,1677005426.025 [DataOverHttps](INFO): Moved sent file to Logs/20230221T175633/Express0017.lzma.bak
2023-02-21T18:50:26.026Z,1677005426.026 [DataOverHttps](INFO): SBD MOMSN=17484221
2023-02-21T18:50:34.829Z,1677005434.829 [Default:CheckIn:Read_Iridium] Stopped
2023-02-21T18:50:34.829Z,1677005434.829 [Default:CheckIn:C.Wait] Running Loop=1
2023-02-21T18:50:34.829Z,1677005434.829 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-02-21T18:51:00.269Z,1677005460.269 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2023-02-21T18:51:00.269Z,1677005460.269 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:51:00.322Z,1677005460.322 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:51:00.720Z,1677005460.720 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:51:00.720Z,1677005460.720 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2023-02-21T18:52:18.670Z,1677005538.670 [CBIT](INFO): Clearing failed state for component NAL9602
2023-02-21T18:52:18.670Z,1677005538.670 [NAL9602] No Fault, FailCount= 5
2023-02-21T18:52:19.049Z,1677005539.049 [NAL9602](INFO): Powering up NAL9602
2023-02-21T18:52:27.173Z,1677005547.173 [CBIT](INFO): Clearing failed state for component BPC1
2023-02-21T18:52:27.173Z,1677005547.173 [BPC1] No Fault, FailCount= 5
2023-02-21T18:52:29.945Z,1677005549.945 [NAL9602](INFO): NAL9602 initialized
2023-02-21T18:53:28.556Z,1677005608.556 [BPC1](INFO): BPC1A: initialized.
2023-02-21T18:53:28.568Z,1677005608.568 [BPC1](INFO): BPC1B: initialized.
2023-02-21T18:53:30.160Z,1677005610.160 [BPC1](INFO): BPC1A: sending IBPS break.
2023-02-21T18:53:30.160Z,1677005610.160 [BPC1](INFO): BPC1B: sending IBPS break.
2023-02-21T18:53:34.600Z,1677005614.600 [BPC1](INFO): BPC1A: validating data format.
2023-02-21T18:53:34.616Z,1677005614.616 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2023-02-21T18:53:34.616Z,1677005614.616 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2023-02-21T18:53:34.617Z,1677005614.617 [BPC1](INFO): BPC1B: validating data format.
2023-02-21T18:53:34.666Z,1677005614.666 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2023-02-21T18:53:34.666Z,1677005614.666 [BPC1](INFO): BPC1B: got valid message (1824 bytes).
2023-02-21T18:53:35.002Z,1677005615.002 [BPC1](INFO): Looking for stick 018Dto match 0C1E
2023-02-21T18:53:35.003Z,1677005615.003 [BPC1](INFO): Looking for stick 018Dto match 0481
2023-02-21T18:53:35.003Z,1677005615.003 [BPC1](INFO): Looking for stick 018Dto match 047B
2023-02-21T18:53:35.003Z,1677005615.003 [BPC1](INFO): Looking for stick 018Dto match 0464
2023-02-21T18:53:35.004Z,1677005615.004 [BPC1](INFO): Looking for stick 018Dto match 045C
2023-02-21T18:53:35.004Z,1677005615.004 [BPC1](INFO): Looking for stick 018Dto match 046A
2023-02-21T18:53:35.004Z,1677005615.004 [BPC1](INFO): Looking for stick 018Dto match 045A
2023-02-21T18:53:35.005Z,1677005615.005 [BPC1](INFO): Looking for stick 018Dto match 0487
2023-02-21T18:53:35.005Z,1677005615.005 [BPC1](INFO): Looking for stick 018Dto match 03FE
2023-02-21T18:53:35.005Z,1677005615.005 [BPC1](INFO): Looking for stick 018Dto match 0465
2023-02-21T18:53:35.006Z,1677005615.006 [BPC1](INFO): Looking for stick 018Dto match 046B
2023-02-21T18:53:35.006Z,1677005615.006 [BPC1](INFO): Looking for stick 018Dto match 0445
2023-02-21T18:53:35.006Z,1677005615.006 [BPC1](INFO): Looking for stick 018Dto match 040D
2023-02-21T18:53:35.007Z,1677005615.007 [BPC1](INFO): Looking for stick 018Dto match 04AA
2023-02-21T18:53:35.007Z,1677005615.007 [BPC1](INFO): Looking for stick 018Dto match 049A
2023-02-21T18:53:35.007Z,1677005615.007 [BPC1](INFO): Looking for stick 018Dto match 04C6
2023-02-21T18:53:35.008Z,1677005615.008 [BPC1](INFO): Looking for stick 018Dto match 0486
2023-02-21T18:53:35.008Z,1677005615.008 [BPC1](INFO): Looking for stick 018Dto match 0442
2023-02-21T18:53:35.008Z,1677005615.008 [BPC1](INFO): Looking for stick 018Dto match 0457
2023-02-21T18:53:35.009Z,1677005615.009 [BPC1](INFO): Looking for stick 018Dto match 0455
2023-02-21T18:53:35.009Z,1677005615.009 [BPC1](INFO): Looking for stick 018Dto match 04C0
2023-02-21T18:53:35.009Z,1677005615.009 [BPC1](INFO): Looking for stick 018Dto match 0459
2023-02-21T18:53:35.010Z,1677005615.010 [BPC1](INFO): Looking for stick 018Dto match 045F
2023-02-21T18:53:35.010Z,1677005615.010 [BPC1](INFO): Looking for stick 018Dto match 0449
2023-02-21T18:53:35.010Z,1677005615.010 [BPC1](INFO): Looking for stick 018Dto match 0441
2023-02-21T18:53:35.011Z,1677005615.011 [BPC1](INFO): Looking for stick 018Dto match 0460
2023-02-21T18:53:35.011Z,1677005615.011 [BPC1](INFO): Looking for stick 018Dto match 04A8
2023-02-21T18:53:35.011Z,1677005615.011 [BPC1](INFO): Looking for stick 018Dto match 04BF
2023-02-21T18:53:35.012Z,1677005615.012 [BPC1](INFO): Looking for stick 018Dto match 045D
2023-02-21T18:53:35.012Z,1677005615.012 [BPC1](INFO): Looking for stick 018Dto match 04A4
2023-02-21T18:53:35.012Z,1677005615.012 [BPC1](INFO): Looking for stick 018Dto match 04D9
2023-02-21T18:53:35.013Z,1677005615.013 [BPC1](ERROR): BPC1A: No match for serial number 018D in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2023-02-21T18:53:35.014Z,1677005615.014 [BPC1](INFO): Looking for stick 04CCto match 0BE5
2023-02-21T18:53:35.014Z,1677005615.014 [BPC1](INFO): Looking for stick 04CCto match 0124
2023-02-21T18:53:35.015Z,1677005615.015 [BPC1](INFO): Looking for stick 04CCto match 0162
2023-02-21T18:53:35.015Z,1677005615.015 [BPC1](INFO): Looking for stick 04CCto match 017A
2023-02-21T18:53:35.015Z,1677005615.015 [BPC1](INFO): Looking for stick 04CCto match 0495
2023-02-21T18:53:35.016Z,1677005615.016 [BPC1](INFO): Looking for stick 04CCto match 0458
2023-02-21T18:53:35.016Z,1677005615.016 [BPC1](INFO): Looking for stick 04CCto match 0139
2023-02-21T18:53:35.016Z,1677005615.016 [BPC1](INFO): Looking for stick 04CCto match 00F0
2023-02-21T18:53:35.017Z,1677005615.017 [BPC1](INFO): Looking for stick 04CCto match 0451
2023-02-21T18:53:35.017Z,1677005615.017 [BPC1](INFO): Looking for stick 04CCto match 049E
2023-02-21T18:53:35.017Z,1677005615.017 [BPC1](INFO): Looking for stick 04CCto match 04A2
2023-02-21T18:53:35.018Z,1677005615.018 [BPC1](INFO): Looking for stick 04CCto match 044F
2023-02-21T18:53:35.018Z,1677005615.018 [BPC1](INFO): Looking for stick 04CCto match 047F
2023-02-21T18:53:35.018Z,1677005615.018 [BPC1](INFO): Looking for stick 04CCto match 0496
2023-02-21T18:53:35.019Z,1677005615.019 [BPC1](INFO): Looking for stick 04CCto match 04CE
2023-02-21T18:53:35.019Z,1677005615.019 [BPC1](INFO): Looking for stick 04CCto match 04A5
2023-02-21T18:53:35.019Z,1677005615.019 [BPC1](INFO): Looking for stick 04CCto match 04D7
2023-02-21T18:53:35.020Z,1677005615.020 [BPC1](INFO): Looking for stick 04CCto match 04CA
2023-02-21T18:53:35.020Z,1677005615.020 [BPC1](INFO): Looking for stick 04CCto match 04A1
2023-02-21T18:53:35.020Z,1677005615.020 [BPC1](INFO): Looking for stick 04CCto match 049B
2023-02-21T18:53:35.021Z,1677005615.021 [BPC1](INFO): Looking for stick 04CCto match 04BD
2023-02-21T18:53:35.021Z,1677005615.021 [BPC1](INFO): Looking for stick 04CCto match 0494
2023-02-21T18:53:35.021Z,1677005615.021 [BPC1](INFO): Looking for stick 04CCto match 0466
2023-02-21T18:53:35.022Z,1677005615.022 [BPC1](INFO): Looking for stick 04CCto match 0447
2023-02-21T18:53:35.022Z,1677005615.022 [BPC1](INFO): Looking for stick 04CCto match 0480
2023-02-21T18:53:35.022Z,1677005615.022 [BPC1](INFO): Looking for stick 04CCto match 04A3
2023-02-21T18:53:35.023Z,1677005615.023 [BPC1](INFO): Looking for stick 04CCto match 04C5
2023-02-21T18:53:35.023Z,1677005615.023 [BPC1](INFO): Looking for stick 04CCto match 046D
2023-02-21T18:53:35.023Z,1677005615.023 [BPC1](INFO): Looking for stick 04CCto match 0409
2023-02-21T18:53:35.024Z,1677005615.024 [BPC1](INFO): Looking for stick 04CCto match 04D3
2023-02-21T18:53:35.024Z,1677005615.024 [BPC1](INFO): Looking for stick 04CCto match 0493
2023-02-21T18:53:35.025Z,1677005615.025 [BPC1](ERROR): BPC1B: No match for serial number 04CC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-21T18:53:35.025Z,1677005615.025 [BPC1](FAULT): Failed to parse data from all battery packs.
2023-02-21T18:53:35.025Z,1677005615.025 [BPC1] Data Fault, FailCount= 6
2023-02-21T18:53:35.025Z,1677005615.025 [BPC1](ERROR): Data Fault
2023-02-21T18:53:35.081Z,1677005615.081 [CBIT](ERROR): Data Fault in component: BPC1
2023-02-21T18:54:01.276Z,1677005641.276 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2023-02-21T18:54:01.276Z,1677005641.276 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-21T18:54:01.287Z,1677005641.287 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-21T18:54:01.700Z,1677005641.700 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-21T18:54:01.700Z,1677005641.700 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2023-02-21T18:54:17.353Z,1677005657.353 [CommandExec](IMPORTANT): got command restart application
2023-02-21T18:54:18.360Z,1677005658.360 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-21T18:54:18.360Z,1677005658.360 [CommandExec](INFO): Uninitializing the command executive.
2023-02-21T18:54:18.360Z,1677005658.360 [CommandExec](INFO): Uninitializing the command scheduler.
2023-02-21T18:54:18.360Z,1677005658.360 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:18.365Z,1677005658.365 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-02-21T18:54:18.365Z,1677005658.365 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-02-21T18:54:18.365Z,1677005658.365 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:18.366Z,1677005658.366 [NavChartDb](INFO): Join timeout helper Thread ID is 6897
2023-02-21T18:54:18.768Z,1677005658.768 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-21T18:54:18.768Z,1677005658.768 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:18.772Z,1677005658.772 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2023-02-21T18:54:18.772Z,1677005658.772 [DAT ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:18.772Z,1677005658.772 [DAT](INFO): Join timeout helper Thread ID is 6898
2023-02-21T18:54:18.788Z,1677005658.788 [DAT](INFO): Powering down
2023-02-21T18:54:18.856Z,1677005658.856 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-21T18:54:18.857Z,1677005658.857 [DAT](INFO): Powering down
2023-02-21T18:54:18.857Z,1677005658.857 [DAT ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:18.876Z,1677005658.876 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-02-21T18:54:18.876Z,1677005658.876 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:18.876Z,1677005658.876 [Radio_Surface](INFO): Join timeout helper Thread ID is 6899
2023-02-21T18:54:19.172Z,1677005659.172 [Radio_Surface](INFO): Powering down
2023-02-21T18:54:19.173Z,1677005659.173 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-21T18:54:19.173Z,1677005659.173 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:19.180Z,1677005659.180 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-02-21T18:54:19.180Z,1677005659.180 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:19.180Z,1677005659.180 [Onboard](INFO): Join timeout helper Thread ID is 6900
2023-02-21T18:54:20.172Z,1677005660.172 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2023-02-21T18:54:20.896Z,1677005660.896 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-21T18:54:20.896Z,1677005660.896 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:20.912Z,1677005660.912 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-02-21T18:54:20.912Z,1677005660.912 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:20.912Z,1677005660.912 [DataOverHttps](INFO): Join timeout helper Thread ID is 6901
2023-02-21T18:54:21.176Z,1677005661.176 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-21T18:54:21.176Z,1677005661.176 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.192Z,1677005661.192 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-02-21T18:54:21.193Z,1677005661.193 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.193Z,1677005661.193 [BackseatComponent](INFO): Join timeout helper Thread ID is 6902
2023-02-21T18:54:21.372Z,1677005661.372 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-21T18:54:21.372Z,1677005661.372 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.392Z,1677005661.392 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-02-21T18:54:21.392Z,1677005661.392 [logger ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.393Z,1677005661.393 [logger](INFO): Join timeout helper Thread ID is 6903
2023-02-21T18:54:21.404Z,1677005661.404 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-21T18:54:21.404Z,1677005661.404 [logger ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.412Z,1677005661.412 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-02-21T18:54:21.412Z,1677005661.412 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.413Z,1677005661.413 [CommandLine](INFO): Join timeout helper Thread ID is 6904
2023-02-21T18:54:21.432Z,1677005661.432 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-21T18:54:21.432Z,1677005661.432 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.453Z,1677005661.453 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-02-21T18:54:21.453Z,1677005661.453 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.454Z,1677005661.454 [CommandExec](INFO): Join timeout helper Thread ID is 6905
2023-02-21T18:54:21.465Z,1677005661.465 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-02-21T18:54:21.465Z,1677005661.465 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.465Z,1677005661.465 [controlThread](INFO): Join timeout helper Thread ID is 6906
2023-02-21T18:54:21.487Z,1677005661.487 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-21T18:54:21.488Z,1677005661.488 [controlThread](DEBUG): Uninitializing ControlThread
2023-02-21T18:54:21.488Z,1677005661.488 [AHRS_M2](INFO): Powering down
2023-02-21T18:54:21.560Z,1677005661.560 [MultiRay](INFO): Powering down.
2023-02-21T18:54:21.561Z,1677005661.561 [NAL9602](INFO): Powering down
2023-02-21T18:54:21.563Z,1677005661.563 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-02-21T18:54:21.564Z,1677005661.564 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-02-21T18:54:21.564Z,1677005661.564 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-02-21T18:54:21.565Z,1677005661.565 [MissionManager](INFO): Uninitializing Mission Default
2023-02-21T18:54:21.565Z,1677005661.565 [Default] Stopped
2023-02-21T18:54:21.565Z,1677005661.565 [Default](DEBUG): Aggregate::uninitialize Default
2023-02-21T18:54:21.565Z,1677005661.565 [Default:B.GoToSurface] Stopped
2023-02-21T18:54:21.565Z,1677005661.565 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-02-21T18:54:21.565Z,1677005661.565 [Default:CheckIn] Stopped
2023-02-21T18:54:21.565Z,1677005661.565 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-02-21T18:54:21.565Z,1677005661.565 [Default:CheckIn:C.Wait] Stopped
2023-02-21T18:54:21.565Z,1677005661.565 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-02-21T18:54:21.568Z,1677005661.568 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-02-21T18:54:21.569Z,1677005661.569 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-02-21T18:54:21.569Z,1677005661.569 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-02-21T18:54:21.569Z,1677005661.569 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-02-21T18:54:21.569Z,1677005661.569 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-02-21T18:54:21.570Z,1677005661.570 [BuoyancyServo](INFO): Powering down
2023-02-21T18:54:21.584Z,1677005661.584 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-02-21T18:54:21.584Z,1677005661.584 [ElevatorServo](INFO): Powering down
2023-02-21T18:54:21.585Z,1677005661.585 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-02-21T18:54:21.585Z,1677005661.585 [MassServo](INFO): Powering down
2023-02-21T18:54:21.586Z,1677005661.586 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-02-21T18:54:21.586Z,1677005661.586 [RudderServo](INFO): Powering down
2023-02-21T18:54:21.587Z,1677005661.587 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-02-21T18:54:21.587Z,1677005661.587 [ThrusterHE](INFO): Powering down
2023-02-21T18:54:21.588Z,1677005661.588 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-02-21T18:54:21.588Z,1677005661.588 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-02-21T18:54:21.588Z,1677005661.588 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-02-21T18:54:21.588Z,1677005661.588 [CBIT](DEBUG): Powering off loads.
2023-02-21T18:54:21.599Z,1677005661.599 [CBIT](DEBUG): Disabling WDT.
2023-02-21T18:54:21.611Z,1677005661.611 [CBIT](DEBUG): Opening all GF detection circuits.
2023-02-21T18:54:21.612Z,1677005661.612 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.683Z,1677005661.683 [DAT ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.689Z,1677005661.689 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.691Z,1677005661.691 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.697Z,1677005661.697 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.742Z,1677005661.742 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.800Z,1677005661.800 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-02-21T18:54:21.858Z,1677005661.858 [logger ThreadHandler](INFO): Thread cancelled.