2019-03-23T19:36:43.525Z,1553369803.525 [Supervisor](DEBUG): Initializing supervisor.
2019-03-23T19:36:43.527Z,1553369803.527 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-03-23T19:36:43.528Z,1553369803.528 [SyncHandler](INFO): Protected caller Thread ID is 2272
2019-03-23T19:36:43.529Z,1553369803.529 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-03-23T19:36:43.530Z,1553369803.530 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-03-23T19:36:43.530Z,1553369803.530 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2273
2019-03-23T19:36:43.533Z,1553369803.533 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-03-23T19:36:43.545Z,1553369803.545 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-03-23T19:36:43.546Z,1553369803.546 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-03-23T19:36:43.547Z,1553369803.547 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2274
2019-03-23T19:36:43.547Z,1553369803.547 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-03-23T19:36:43.548Z,1553369803.548 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-03-23T19:36:43.549Z,1553369803.549 [logger ThreadHandler](INFO): Protected caller Thread ID is 2275
2019-03-23T19:36:43.551Z,1553369803.551 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-03-23T19:36:43.551Z,1553369803.551 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-03-23T19:36:43.553Z,1553369803.553 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-03-23T19:36:43.989Z,1553369803.989 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-03-23T19:36:43.990Z,1553369803.990 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-03-23T19:36:44.137Z,1553369804.137 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-03-23T19:36:44.138Z,1553369804.138 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-03-23T19:36:44.220Z,1553369804.220 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-03-23T19:36:44.319Z,1553369804.319 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-03-23T19:36:44.320Z,1553369804.320 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-03-23T19:36:44.417Z,1553369804.417 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-03-23T19:36:44.418Z,1553369804.418 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-03-23T19:36:44.800Z,1553369804.800 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-03-23T19:36:44.800Z,1553369804.800 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-03-23T19:36:44.904Z,1553369804.904 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-03-23T19:36:44.905Z,1553369804.905 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-03-23T19:36:45.382Z,1553369805.382 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-03-23T19:36:45.383Z,1553369805.383 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-03-23T19:36:45.592Z,1553369805.592 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-03-23T19:36:45.593Z,1553369805.593 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-03-23T19:36:45.909Z,1553369805.909 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-03-23T19:36:45.910Z,1553369805.910 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-03-23T19:36:46.130Z,1553369806.130 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-03-23T19:36:46.131Z,1553369806.131 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-03-23T19:36:46.277Z,1553369806.277 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-03-23T19:36:46.278Z,1553369806.278 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-03-23T19:36:46.788Z,1553369806.788 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-03-23T19:36:46.789Z,1553369806.789 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-03-23T19:36:47.135Z,1553369807.135 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-03-23T19:36:47.136Z,1553369807.136 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-03-23T19:36:47.348Z,1553369807.348 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-03-23T19:36:47.350Z,1553369807.350 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2019-03-23T19:36:47.351Z,1553369807.351 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2019-03-23T19:36:47.537Z,1553369807.537 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2019-03-23T19:36:47.622Z,1553369807.622 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2019-03-23T19:36:47.739Z,1553369807.739 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2019-03-23T19:36:47.860Z,1553369807.860 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2019-03-23T19:36:48.135Z,1553369808.135 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-03-23T19:36:48.135Z,1553369808.135 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2019-03-23T19:36:48.242Z,1553369808.242 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2019-03-23T19:36:48.528Z,1553369808.528 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2019-03-23T19:36:48.649Z,1553369808.649 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2019-03-23T19:36:48.833Z,1553369808.833 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2019-03-23T19:36:48.936Z,1553369808.936 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2019-03-23T19:36:49.036Z,1553369809.036 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-03-23T19:36:49.046Z,1553369809.046 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-03-23T19:36:49.061Z,1553369809.061 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-03-23T19:36:49.061Z,1553369809.061 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-03-23T19:36:49.134Z,1553369809.134 [VerticalControl](DEBUG): Construct VerticalControl.
2019-03-23T19:36:49.251Z,1553369809.251 [VerticalControl] Loaded
2019-03-23T19:36:49.251Z,1553369809.251 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-03-23T19:36:49.252Z,1553369809.252 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-03-23T19:36:49.323Z,1553369809.323 [HorizontalControl] Loaded
2019-03-23T19:36:49.323Z,1553369809.323 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-03-23T19:36:49.324Z,1553369809.324 [SpeedControl](DEBUG): Construct SpeedControl.
2019-03-23T19:36:49.329Z,1553369809.329 [SpeedControl] Loaded
2019-03-23T19:36:49.330Z,1553369809.330 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-03-23T19:36:49.330Z,1553369809.330 [LoopControl](DEBUG): Construct LoopControl.
2019-03-23T19:36:49.331Z,1553369809.331 [LoopControl] Loaded
2019-03-23T19:36:49.331Z,1553369809.331 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-03-23T19:36:49.332Z,1553369809.332 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-03-23T19:36:49.332Z,1553369809.332 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-03-23T19:36:49.432Z,1553369809.432 [ElevatorServo] Loaded
2019-03-23T19:36:49.432Z,1553369809.432 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-03-23T19:36:49.443Z,1553369809.443 [MassServo] Loaded
2019-03-23T19:36:49.444Z,1553369809.444 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-03-23T19:36:49.455Z,1553369809.455 [ThrusterServo] Loaded
2019-03-23T19:36:49.456Z,1553369809.456 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-03-23T19:36:49.456Z,1553369809.456 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-03-23T19:36:49.457Z,1553369809.457 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-03-23T19:36:49.500Z,1553369809.500 [DepthRateCalculator] Loaded
2019-03-23T19:36:49.501Z,1553369809.501 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-03-23T19:36:49.506Z,1553369809.506 [PitchRateCalculator] Loaded
2019-03-23T19:36:49.506Z,1553369809.506 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-03-23T19:36:49.522Z,1553369809.522 [SpeedCalculator] Loaded
2019-03-23T19:36:49.522Z,1553369809.522 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-03-23T19:36:49.543Z,1553369809.543 [TempGradientCalculator] Loaded
2019-03-23T19:36:49.544Z,1553369809.544 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-03-23T19:36:49.549Z,1553369809.549 [YawRateCalculator] Loaded
2019-03-23T19:36:49.549Z,1553369809.549 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-03-23T19:36:49.579Z,1553369809.579 [ElevatorOffsetCalculator] Loaded
2019-03-23T19:36:49.580Z,1553369809.580 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-03-23T19:36:49.580Z,1553369809.580 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-03-23T19:36:49.581Z,1553369809.581 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-03-23T19:36:49.691Z,1553369809.691 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-03-23T19:36:49.691Z,1553369809.691 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-03-23T19:36:49.753Z,1553369809.753 [DeadReckonUsingSpeedCalculator] Loaded
2019-03-23T19:36:49.753Z,1553369809.753 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-03-23T19:36:49.775Z,1553369809.775 [NavChart] Loaded
2019-03-23T19:36:49.775Z,1553369809.775 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-03-23T19:36:49.779Z,1553369809.779 [UniversalFixResidualReporter] Loaded
2019-03-23T19:36:49.779Z,1553369809.779 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-03-23T19:36:49.779Z,1553369809.779 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-03-23T19:36:49.780Z,1553369809.780 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-03-23T19:36:50.119Z,1553369810.119 [DataOverHttps] Loaded
2019-03-23T19:36:50.119Z,1553369810.119 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-03-23T19:36:50.120Z,1553369810.120 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408004E0
2019-03-23T19:36:50.120Z,1553369810.120 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2355
2019-03-23T19:36:50.134Z,1553369810.134 [Depth_Keller] Loaded
2019-03-23T19:36:50.134Z,1553369810.134 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-03-23T19:36:50.236Z,1553369810.236 [NAL9602] Loaded
2019-03-23T19:36:50.237Z,1553369810.237 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-03-23T19:36:50.253Z,1553369810.253 [Onboard] Loaded
2019-03-23T19:36:50.253Z,1553369810.253 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-03-23T19:36:50.256Z,1553369810.256 [Radio_Surface] Loaded
2019-03-23T19:36:50.257Z,1553369810.257 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-03-23T19:36:50.258Z,1553369810.258 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408304E0
2019-03-23T19:36:50.258Z,1553369810.258 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2356
2019-03-23T19:36:50.284Z,1553369810.284 [BPC1](INFO): BPC1A: got serial number for stick 1: 023F
2019-03-23T19:36:50.285Z,1553369810.285 [BPC1](INFO): BPC1A: got serial number for stick 2: 02A8
2019-03-23T19:36:50.286Z,1553369810.286 [BPC1](INFO): BPC1A: got serial number for stick 3: 01D7
2019-03-23T19:36:50.287Z,1553369810.287 [BPC1](INFO): BPC1A: got serial number for stick 4: 01EF
2019-03-23T19:36:50.288Z,1553369810.288 [BPC1](INFO): BPC1A: got serial number for stick 5: 0299
2019-03-23T19:36:50.289Z,1553369810.289 [BPC1](INFO): BPC1A: got serial number for stick 6: 0292
2019-03-23T19:36:50.290Z,1553369810.290 [BPC1](INFO): BPC1A: got serial number for stick 7: 0296
2019-03-23T19:36:50.290Z,1553369810.290 [BPC1](INFO): BPC1A: got serial number for stick 8: 0291
2019-03-23T19:36:50.291Z,1553369810.291 [BPC1](INFO): BPC1A: marked stick 8 as reserve.
2019-03-23T19:36:50.292Z,1553369810.292 [BPC1](INFO): BPC1A: got serial number for stick 9: 00BB
2019-03-23T19:36:50.293Z,1553369810.293 [BPC1](INFO): BPC1A: got serial number for stick 10: 025B
2019-03-23T19:36:50.294Z,1553369810.294 [BPC1](INFO): BPC1A: got serial number for stick 11: 024E
2019-03-23T19:36:50.294Z,1553369810.294 [BPC1](INFO): BPC1A: got serial number for stick 12: 029C
2019-03-23T19:36:50.295Z,1553369810.295 [BPC1](INFO): BPC1A: got serial number for stick 13: 0242
2019-03-23T19:36:50.296Z,1553369810.296 [BPC1](INFO): BPC1A: got serial number for stick 14: 01FA
2019-03-23T19:36:50.297Z,1553369810.297 [BPC1](INFO): BPC1A: got serial number for stick 15: 0269
2019-03-23T19:36:50.298Z,1553369810.298 [BPC1](INFO): BPC1A: got serial number for stick 16: 02AD
2019-03-23T19:36:50.298Z,1553369810.298 [BPC1](INFO): BPC1A: marked stick 16 as reserve.
2019-03-23T19:36:50.299Z,1553369810.299 [BPC1](INFO): BPC1A: got serial number for stick 17: 0295
2019-03-23T19:36:50.300Z,1553369810.300 [BPC1](INFO): BPC1A: got serial number for stick 18: 0224
2019-03-23T19:36:50.301Z,1553369810.301 [BPC1](INFO): BPC1A: got serial number for stick 19: 00F6
2019-03-23T19:36:50.302Z,1553369810.302 [BPC1](INFO): BPC1A: got serial number for stick 20: 0294
2019-03-23T19:36:50.303Z,1553369810.303 [BPC1](INFO): BPC1A: got serial number for stick 21: 0271
2019-03-23T19:36:50.304Z,1553369810.304 [BPC1](INFO): BPC1A: got serial number for stick 22: 0206
2019-03-23T19:36:50.305Z,1553369810.305 [BPC1](INFO): BPC1A: got serial number for stick 23: 02B0
2019-03-23T19:36:50.305Z,1553369810.305 [BPC1](INFO): BPC1A: got serial number for stick 24: 020C
2019-03-23T19:36:50.306Z,1553369810.306 [BPC1](INFO): BPC1A: marked stick 24 as reserve.
2019-03-23T19:36:50.307Z,1553369810.307 [BPC1](INFO): BPC1A: got serial number for stick 25: 016F
2019-03-23T19:36:50.307Z,1553369810.307 [BPC1](INFO): BPC1A: got serial number for stick 26: 026A
2019-03-23T19:36:50.308Z,1553369810.308 [BPC1](INFO): BPC1A: got serial number for stick 27: 01C6
2019-03-23T19:36:50.309Z,1553369810.309 [BPC1](INFO): BPC1A: got serial number for stick 28: 0246
2019-03-23T19:36:50.310Z,1553369810.310 [BPC1](INFO): BPC1A: got serial number for stick 29: 02D3
2019-03-23T19:36:50.311Z,1553369810.311 [BPC1](INFO): BPC1A: got serial number for stick 30: 01C0
2019-03-23T19:36:50.312Z,1553369810.312 [BPC1](INFO): BPC1A: got serial number for stick 31: 01F3
2019-03-23T19:36:50.313Z,1553369810.313 [BPC1](INFO): BPC1B: got serial number for stick 32: 0163
2019-03-23T19:36:50.314Z,1553369810.314 [BPC1](INFO): BPC1B: got serial number for stick 33: 01AA
2019-03-23T19:36:50.315Z,1553369810.315 [BPC1](INFO): BPC1B: got serial number for stick 34: 0197
2019-03-23T19:36:50.316Z,1553369810.316 [BPC1](INFO): BPC1B: got serial number for stick 35: 0215
2019-03-23T19:36:50.317Z,1553369810.317 [BPC1](INFO): BPC1B: got serial number for stick 36: 020E
2019-03-23T19:36:50.318Z,1553369810.318 [BPC1](INFO): BPC1B: got serial number for stick 37: 0228
2019-03-23T19:36:50.319Z,1553369810.319 [BPC1](INFO): BPC1B: got serial number for stick 38: 02B4
2019-03-23T19:36:50.319Z,1553369810.319 [BPC1](INFO): BPC1B: got serial number for stick 39: 01AC
2019-03-23T19:36:50.320Z,1553369810.320 [BPC1](INFO): BPC1B: marked stick 39 as reserve.
2019-03-23T19:36:50.321Z,1553369810.321 [BPC1](INFO): BPC1B: got serial number for stick 40: 022A
2019-03-23T19:36:50.322Z,1553369810.322 [BPC1](INFO): BPC1B: got serial number for stick 41: 0232
2019-03-23T19:36:50.323Z,1553369810.323 [BPC1](INFO): BPC1B: got serial number for stick 42: 0219
2019-03-23T19:36:50.324Z,1553369810.324 [BPC1](INFO): BPC1B: got serial number for stick 43: 0229
2019-03-23T19:36:50.324Z,1553369810.324 [BPC1](INFO): BPC1B: got serial number for stick 44: 0253
2019-03-23T19:36:50.325Z,1553369810.325 [BPC1](INFO): BPC1B: got serial number for stick 45: 02A1
2019-03-23T19:36:50.326Z,1553369810.326 [BPC1](INFO): BPC1B: got serial number for stick 46: 028A
2019-03-23T19:36:50.327Z,1553369810.327 [BPC1](INFO): BPC1B: got serial number for stick 47: 019A
2019-03-23T19:36:50.327Z,1553369810.327 [BPC1](INFO): BPC1B: marked stick 47 as reserve.
2019-03-23T19:36:50.328Z,1553369810.328 [BPC1](INFO): BPC1B: got serial number for stick 48: 0202
2019-03-23T19:36:50.329Z,1553369810.329 [BPC1](INFO): BPC1B: got serial number for stick 49: 027C
2019-03-23T19:36:50.330Z,1553369810.330 [BPC1](INFO): BPC1B: got serial number for stick 50: 022F
2019-03-23T19:36:50.331Z,1553369810.331 [BPC1](INFO): BPC1B: got serial number for stick 51: 01FF
2019-03-23T19:36:50.332Z,1553369810.332 [BPC1](INFO): BPC1B: got serial number for stick 52: 0203
2019-03-23T19:36:50.333Z,1553369810.333 [BPC1](INFO): BPC1B: got serial number for stick 53: 02A6
2019-03-23T19:36:50.334Z,1553369810.334 [BPC1](INFO): BPC1B: got serial number for stick 54: 01D4
2019-03-23T19:36:50.334Z,1553369810.334 [BPC1](INFO): BPC1B: got serial number for stick 55: 017F
2019-03-23T19:36:50.335Z,1553369810.335 [BPC1](INFO): BPC1B: marked stick 55 as reserve.
2019-03-23T19:36:50.335Z,1553369810.335 [BPC1](INFO): BPC1B: got serial number for stick 56: 021D
2019-03-23T19:36:50.336Z,1553369810.336 [BPC1](INFO): BPC1B: got serial number for stick 57: 01BF
2019-03-23T19:36:50.337Z,1553369810.337 [BPC1](INFO): BPC1B: got serial number for stick 58: 0216
2019-03-23T19:36:50.338Z,1553369810.338 [BPC1](INFO): BPC1B: got serial number for stick 59: 024A
2019-03-23T19:36:50.339Z,1553369810.339 [BPC1](INFO): BPC1B: got serial number for stick 60: 01DA
2019-03-23T19:36:50.340Z,1553369810.340 [BPC1](INFO): BPC1B: got serial number for stick 61: 01DF
2019-03-23T19:36:50.340Z,1553369810.340 [BPC1](INFO): BPC1B: got serial number for stick 62: 0205
2019-03-23T19:36:51.864Z,1553369811.864 [BPC1] Loaded
2019-03-23T19:36:51.865Z,1553369811.865 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-03-23T19:36:51.865Z,1553369811.865 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-03-23T19:36:51.866Z,1553369811.866 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-03-23T19:36:51.937Z,1553369811.937 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-03-23T19:36:51.938Z,1553369811.938 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-03-23T19:36:52.045Z,1553369812.045 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-03-23T19:36:52.046Z,1553369812.046 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-03-23T19:36:52.075Z,1553369812.075 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-03-23T19:36:52.075Z,1553369812.075 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-03-23T19:36:52.346Z,1553369812.346 [CTD_NeilBrown] Loaded
2019-03-23T19:36:52.346Z,1553369812.346 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-03-23T19:36:52.347Z,1553369812.347 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 409BD4E0
2019-03-23T19:36:52.348Z,1553369812.348 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 2357
2019-03-23T19:36:52.398Z,1553369812.398 [WetLabsBB2FL] Loaded
2019-03-23T19:36:52.399Z,1553369812.399 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-03-23T19:36:52.400Z,1553369812.400 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409ED4E0
2019-03-23T19:36:52.400Z,1553369812.400 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2358
2019-03-23T19:36:52.401Z,1553369812.401 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-03-23T19:36:52.401Z,1553369812.401 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-03-23T19:36:52.697Z,1553369812.697 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-03-23T19:36:52.697Z,1553369812.697 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-03-23T19:36:52.844Z,1553369812.844 [SBIT](DEBUG): Construct Startup Built In Test.
2019-03-23T19:36:52.856Z,1553369812.856 [SBIT] Loaded
2019-03-23T19:36:52.856Z,1553369812.856 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-03-23T19:36:52.857Z,1553369812.857 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-03-23T19:36:52.868Z,1553369812.868 [IBIT] Loaded
2019-03-23T19:36:52.868Z,1553369812.868 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-03-23T19:36:52.871Z,1553369812.871 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-03-23T19:36:53.014Z,1553369813.014 [CBIT] Loaded
2019-03-23T19:36:53.014Z,1553369813.014 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-03-23T19:36:53.015Z,1553369813.015 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-03-23T19:36:53.018Z,1553369813.018 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-03-23T19:36:53.019Z,1553369813.019 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-03-23T19:36:53.026Z,1553369813.026 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-03-23T19:36:53.027Z,1553369813.027 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AC54E0
2019-03-23T19:36:53.027Z,1553369813.027 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2359
2019-03-23T19:36:53.032Z,1553369813.032 [Supervisor](INFO): Main Thread ID is 2271
2019-03-23T19:36:53.033Z,1553369813.033 [Supervisor](DEBUG): Running supervisor.
2019-03-23T19:36:53.033Z,1553369813.033 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2360
2019-03-23T19:36:53.036Z,1553369813.036 [controlThread ThreadHandler](INFO): Handler Thread ID is 2361
2019-03-23T19:36:53.036Z,1553369813.036 [controlThread](DEBUG): Initializing ControlThread
2019-03-23T19:36:53.037Z,1553369813.037 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-03-23T19:36:53.039Z,1553369813.039 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-03-23T19:36:53.040Z,1553369813.040 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-03-23T19:36:53.040Z,1553369813.040 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-03-23T19:36:53.041Z,1553369813.041 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-03-23T19:36:53.041Z,1553369813.041 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-03-23T19:36:53.042Z,1553369813.042 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-03-23T19:36:53.042Z,1553369813.042 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-03-23T19:36:53.043Z,1553369813.043 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-03-23T19:36:53.043Z,1553369813.043 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-03-23T19:36:53.044Z,1553369813.044 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-23T19:36:53.045Z,1553369813.045 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-03-23T19:36:53.045Z,1553369813.045 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-03-23T19:36:53.050Z,1553369813.050 [SBIT](INFO): Initialize SBIT Component.
2019-03-23T19:36:53.050Z,1553369813.050 [SBIT](IMPORTANT): git: 2019-03-18-18-g6cf6cc5
2019-03-23T19:36:53.050Z,1553369813.050 [SBIT](INFO): git hash: 6cf6cc5c1826bb1f8f9a0dab23a9d4b1019792a5
2019-03-23T19:36:53.051Z,1553369813.051 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-03-23T19:36:53.052Z,1553369813.052 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
2019-03-23T19:36:53.053Z,1553369813.053 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-03-23T19:36:53.054Z,1553369813.054 [IBIT](INFO): Initialize IBIT Component.
2019-03-23T19:36:53.055Z,1553369813.055 [CBIT](DEBUG): Initialize CBIT Component.
2019-03-23T19:36:53.056Z,1553369813.056 [logger ThreadHandler](INFO): Handler Thread ID is 2362
2019-03-23T19:36:53.069Z,1553369813.069 [CBIT](DEBUG): Initialized mux pins.
2019-03-23T19:36:53.069Z,1553369813.069 [CBIT](DEBUG): Initializing the watchdog timer.
2019-03-23T19:36:53.073Z,1553369813.073 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2363
2019-03-23T19:36:53.074Z,1553369813.074 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-03-23T19:36:53.081Z,1553369813.081 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2364
2019-03-23T19:36:53.089Z,1553369813.089 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 2365
2019-03-23T19:36:53.093Z,1553369813.093 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-03-23T19:36:53.093Z,1553369813.093 [CBIT](DEBUG): Initializing heartbeat.
2019-03-23T19:36:53.101Z,1553369813.101 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2366
2019-03-23T19:36:53.102Z,1553369813.102 [WetLabsBB2FL](INFO): Powering down
2019-03-23T19:36:53.129Z,1553369813.129 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2367
2019-03-23T19:36:53.133Z,1553369813.133 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-03-23T19:36:53.133Z,1553369813.133 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-03-23T19:36:53.133Z,1553369813.133 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-03-23T19:36:53.133Z,1553369813.133 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-03-23T19:36:53.134Z,1553369813.134 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-03-23T19:36:53.134Z,1553369813.134 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-03-23T19:36:53.134Z,1553369813.134 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-03-23T19:36:53.134Z,1553369813.134 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-03-23T19:36:53.135Z,1553369813.135 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-03-23T19:36:53.135Z,1553369813.135 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-03-23T19:36:53.135Z,1553369813.135 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-03-23T19:36:53.135Z,1553369813.135 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-03-23T19:36:53.135Z,1553369813.135 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-03-23T19:36:53.136Z,1553369813.136 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-03-23T19:36:53.136Z,1553369813.136 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-03-23T19:36:53.136Z,1553369813.136 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-03-23T19:36:53.165Z,1553369813.165 [CBIT](DEBUG): Deactivating GF circuits.
2019-03-23T19:36:53.165Z,1553369813.165 [CBIT](DEBUG): Deactivating emergency mode.
2019-03-23T19:36:53.201Z,1553369813.201 [CBIT](DEBUG): Backplane powered.
2019-03-23T19:36:53.202Z,1553369813.202 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-03-23T19:36:53.213Z,1553369813.213 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-23T19:36:53.231Z,1553369813.231 [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>


2019-03-23T19:36:53.232Z,1553369813.232 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-03-23T19:36:53.319Z,1553369813.319 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-03-23T19:36:53.337Z,1553369813.337 [Default:A.Wait](DEBUG): Construct Wait.
2019-03-23T19:36:53.338Z,1553369813.338 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-23T19:36:53.442Z,1553369813.442 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-03-23T19:36:53.462Z,1553369813.462 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-03-23T19:36:53.468Z,1553369813.468 [Default:E.Execute](DEBUG): Construct Execute.
2019-03-23T19:36:53.485Z,1553369813.485 [Radio_Surface](INFO): Powering up
2019-03-23T19:36:53.495Z,1553369813.495 [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="P2H">
                <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>


2019-03-23T19:36:53.500Z,1553369813.500 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,ElevatorServo,MassServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-03-23T19:36:53.642Z,1553369813.642 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-23T19:36:53.805Z,1553369813.805 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-23T19:36:53.806Z,1553369813.806 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-23T19:36:53.842Z,1553369813.842 [MassServo](DEBUG): Initializing MassServo.
2019-03-23T19:36:53.843Z,1553369813.843 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-03-23T19:36:53.877Z,1553369813.877 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-03-23T19:37:04.354Z,1553369824.354 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004508
2019-03-23T19:37:20.574Z,1553369840.574 [NAL9602](INFO): Powering up NAL9602
2019-03-23T19:37:21.814Z,1553369841.814 [SBIT](IMPORTANT): Beginning Startup BIT
2019-03-23T19:37:21.818Z,1553369841.818 [CBIT](IMPORTANT): Beginning ground fault scan
2019-03-23T19:37:31.522Z,1553369851.522 [NAL9602](INFO): NAL9602 initialized
2019-03-23T19:37:32.341Z,1553369852.341 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:37:32.837Z,1553369852.837 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.022140
CHAN A1 (24V): 0.000985
CHAN A2 (12V): -0.068348
CHAN A3 (5V): -0.002678
CHAN B0 (3.3V): -0.000886
CHAN B1 (3.15aV): -0.001402
CHAN B2 (3.15bV): -0.000810
CHAN B3 (GND): -0.000166
OPEN: -0.001224
Full Scale Calc: 4.765 mA, -1.589 mA
2019-03-23T19:37:34.910Z,1553369854.910 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-23T19:37:54.625Z,1553369874.625 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:37:54.637Z,1553369874.637 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:37:55.838Z,1553369875.838 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:37:56.249Z,1553369876.249 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:37:59.466Z,1553369879.466 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:37:59.478Z,1553369879.478 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:37:59.479Z,1553369879.479 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:37:59.864Z,1553369879.864 [BPC1](ERROR): BPC1B expected report for stick number: 3/6, but read number: 5.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39E9,0A,0000,0B,0000%32
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39AF,0A,0000,0B,0000%3B
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A76,0A,FFBC,0B,FFB1%41
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0D4C,12,0B72%44
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A75,0A,FFB3,0B,FFA7%41
$B17,0C,0001,0D,003B,0E,0039,0F,0F19,10,19CB,11,0BC4,12,0A2E%4C
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7C,0A,FFFC,0B,FFFC%3F
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:37:59.865Z,1553369879.865 [BPC1](ERROR): BPC1B expected report for stick number: 4/6, but read number: 6.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39E9,0A,0000,0B,0000%32
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39AF,0A,0000,0B,0000%3B
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A76,0A,FFBC,0B,FFB1%41
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0D4C,12,0B72%44
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A75,0A,FFB3,0B,FFA7%41
$B17,0C,0001,0D,003B,0E,0039,0F,0F19,10,19CB,11,0BC4,12,0A2E%4C
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7C,0A,FFFC,0B,FFFC%3F
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:37:59.866Z,1553369879.866 [BPC1](ERROR): BPC1B expected report for stick number: 5/6, but read number: 7.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39E9,0A,0000,0B,0000%32
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39AF,0A,0000,0B,0000%3B
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A76,0A,FFBC,0B,FFB1%41
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0D4C,12,0B72%44
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A75,0A,FFB3,0B,FFA7%41
$B17,0C,0001,0D,003B,0E,0039,0F,0F19,10,19CB,11,0BC4,12,0A2E%4C
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7C,0A,FFFC,0B,FFFC%3F
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:37:59.867Z,1553369879.867 [BPC1](ERROR): BPC1B expected report for stick number: 6/6, but read number: 8.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39E9,0A,0000,0B,0000%32
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39AF,0A,0000,0B,0000%3B
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A76,0A,FFBC,0B,FFB1%41
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0D4C,12,0B72%44
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A75,0A,FFB3,0B,FFA7%41
$B17,0C,0001,0D,003B,0E,0039,0F,0F19,10,19CB,11,0BC4,12,0A2E%4C
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7C,0A,FFFC,0B,FFFC%3F
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:37:59.867Z,1553369879.867 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:38:00.265Z,1553369880.265 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:38:00.281Z,1553369880.281 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:38:00.282Z,1553369880.282 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:38:00.719Z,1553369880.719 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:38:00.733Z,1553369880.733 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:38:01.501Z,1553369881.501 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:38:01.514Z,1553369881.514 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-23T19:38:01.515Z,1553369881.515 [SBIT](FAULT): Control surface position failure.
2019-03-23T19:38:08.389Z,1553369888.389 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:38:09.196Z,1553369889.196 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:38:11.627Z,1553369891.627 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:38:11.680Z,1553369891.680 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:38:11.680Z,1553369891.680 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:38:12.038Z,1553369892.038 [BPC1](ERROR): BPC1B expected report for stick number: 3/6, but read number: 5.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39E9,0A,0000,0B,0000%32
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39AF,0A,0000,0B,0000%3B
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A73,0A,FFAB,0B,FFAF%32
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0AA3,12,0B2A%32
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A71,0A,FFA2,0B,FFA4%44
$B17,0C,0001,0D,003B,0E,0039,0F,0F19,10,19CB,11,09A3,12,09D9%40
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:12.038Z,1553369892.038 [BPC1](ERROR): BPC1B expected report for stick number: 4/6, but read number: 6.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39E9,0A,0000,0B,0000%32
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39AF,0A,0000,0B,0000%3B
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A73,0A,FFAB,0B,FFAF%32
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0AA3,12,0B2A%32
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A71,0A,FFA2,0B,FFA4%44
$B17,0C,0001,0D,003B,0E,0039,0F,0F19,10,19CB,11,09A3,12,09D9%40
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:12.039Z,1553369892.039 [BPC1](ERROR): BPC1B expected report for stick number: 5/6, but read number: 7.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39E9,0A,0000,0B,0000%32
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39AF,0A,0000,0B,0000%3B
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A73,0A,FFAB,0B,FFAF%32
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0AA3,12,0B2A%32
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A71,0A,FFA2,0B,FFA4%44
$B17,0C,0001,0D,003B,0E,0039,0F,0F19,10,19CB,11,09A3,12,09D9%40
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:12.040Z,1553369892.040 [BPC1](ERROR): BPC1B expected report for stick number: 6/6, but read number: 8.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39E9,0A,0000,0B,0000%32
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39AF,0A,0000,0B,0000%3B
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A73,0A,FFAB,0B,FFAF%32
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0AA3,12,0B2A%32
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A71,0A,FFA2,0B,FFA4%44
$B17,0C,0001,0D,003B,0E,0039,0F,0F19,10,19CB,11,09A3,12,09D9%40
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:12.040Z,1553369892.040 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:38:12.841Z,1553369892.841 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:38:14.041Z,1553369894.041 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:38:14.108Z,1553369894.108 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:38:14.108Z,1553369894.108 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:38:14.452Z,1553369894.452 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:38:15.269Z,1553369895.269 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:38:15.279Z,1553369895.279 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-23T19:38:15.279Z,1553369895.279 [SBIT](FAULT): Control surface position failure.
2019-03-23T19:38:15.674Z,1553369895.674 [SBIT](CRITICAL): SBIT FAILED
2019-03-23T19:38:15.689Z,1553369895.689 [CommandLine](FAULT): Scheduling is paused
2019-03-23T19:38:15.690Z,1553369895.690 [CBIT](INFO): Critical error at 20190323T193815
2019-03-23T19:38:15.690Z,1553369895.690 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-03-23T19:38:15.718Z,1553369895.718 [CommandLine](IMPORTANT): got command configSet list
2019-03-23T19:38:15.718Z,1553369895.718 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-03-23T19:38:15.719Z,1553369895.719 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2019-03-23T19:38:15.719Z,1553369895.719 [CommandLine](IMPORTANT): BPC1.batterySamplingInterval=10 minute;

2019-03-23T19:38:15.720Z,1553369895.720 [CommandLine](IMPORTANT): BuoyancyServo.loadAtStartup=0 bool;

2019-03-23T19:38:15.720Z,1553369895.720 [CommandLine](IMPORTANT): CBIT.vehicleOpen=1 bool;

2019-03-23T19:38:15.720Z,1553369895.720 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2019-03-23T19:38:15.720Z,1553369895.720 [CommandLine](IMPORTANT): Depth_Keller.offset=-0.13 decibar;

2019-03-23T19:38:15.720Z,1553369895.720 [CommandLine](IMPORTANT): Depth_Keller.scale=45.92 micropascal;

2019-03-23T19:38:15.720Z,1553369895.720 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-03-23T19:38:15.720Z,1553369895.720 [CommandLine](IMPORTANT): RudderServo.loadAtStartup=0 bool;

2019-03-23T19:38:16.082Z,1553369896.082 [MissionManager](IMPORTANT): Started mission Startup
2019-03-23T19:38:16.082Z,1553369896.082 [Startup] Running Loop=1
2019-03-23T19:38:16.082Z,1553369896.082 [Startup](DEBUG): Aggregate::initialize Startup
2019-03-23T19:38:16.082Z,1553369896.082 [Startup:A.GoToSurface] Running Loop=1
2019-03-23T19:38:16.082Z,1553369896.082 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-23T19:38:16.083Z,1553369896.083 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-23T19:38:16.083Z,1553369896.083 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-23T19:38:16.084Z,1553369896.084 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-23T19:38:16.084Z,1553369896.084 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-23T19:38:16.085Z,1553369896.085 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-23T19:38:16.086Z,1553369896.086 [Startup:StartupSatComms] Running Loop=1
2019-03-23T19:38:16.086Z,1553369896.086 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-03-23T19:38:16.086Z,1553369896.086 [Startup:StartupSatComms:A] Running Loop=1
2019-03-23T19:38:16.482Z,1553369896.482 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-03-23T19:38:20.913Z,1553369900.913 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:38:22.539Z,1553369902.539 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:38:24.145Z,1553369904.145 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:38:24.199Z,1553369904.199 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:38:24.199Z,1553369904.199 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:38:24.551Z,1553369904.551 [BPC1](ERROR): BPC1B expected report for stick number: 3/6, but read number: 5.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39EA,0A,0000,0B,0000%4A
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A75,0A,FFC1,0B,FFB7%37
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0E5A,12,0C63%47
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A73,0A,FFB6,0B,FFAE%30
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0C3D,12,0B0B%4A
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:24.552Z,1553369904.552 [BPC1](ERROR): BPC1B expected report for stick number: 4/6, but read number: 6.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39EA,0A,0000,0B,0000%4A
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A75,0A,FFC1,0B,FFB7%37
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0E5A,12,0C63%47
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A73,0A,FFB6,0B,FFAE%30
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0C3D,12,0B0B%4A
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:24.553Z,1553369904.553 [BPC1](ERROR): BPC1B expected report for stick number: 5/6, but read number: 7.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39EA,0A,0000,0B,0000%4A
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A75,0A,FFC1,0B,FFB7%37
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0E5A,12,0C63%47
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A73,0A,FFB6,0B,FFAE%30
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0C3D,12,0B0B%4A
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:24.554Z,1553369904.554 [BPC1](ERROR): BPC1B expected report for stick number: 6/6, but read number: 8.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39EA,0A,0000,0B,0000%4A
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A75,0A,FFC1,0B,FFB7%37
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0E5A,12,0C63%47
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A73,0A,FFB6,0B,FFAE%30
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0C3D,12,0B0B%4A
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:24.554Z,1553369904.554 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:38:25.365Z,1553369905.365 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:38:27.387Z,1553369907.387 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:38:27.455Z,1553369907.455 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:38:27.456Z,1553369907.456 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:38:27.798Z,1553369907.798 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:38:28.601Z,1553369908.601 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:38:33.043Z,1553369913.043 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:38:36.265Z,1553369916.265 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:38:36.265Z,1553369916.265 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:38:36.325Z,1553369916.325 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:38:36.325Z,1553369916.325 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:38:36.667Z,1553369916.667 [BPC1](ERROR): BPC1B expected report for stick number: 3/6, but read number: 5.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39EA,0A,0000,0B,0000%4A
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A64,0A,FFFB,0B,FFFB%37
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A74,0A,FFBD,0B,FFBB%37
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0D7F,12,0D1B%32
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A72,0A,FFB7,0B,FFB2%44
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0C68,12,0B9C%3B
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:36.668Z,1553369916.668 [BPC1](ERROR): BPC1B expected report for stick number: 4/6, but read number: 6.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39EA,0A,0000,0B,0000%4A
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A64,0A,FFFB,0B,FFFB%37
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A74,0A,FFBD,0B,FFBB%37
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0D7F,12,0D1B%32
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A72,0A,FFB7,0B,FFB2%44
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0C68,12,0B9C%3B
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:36.670Z,1553369916.670 [BPC1](ERROR): BPC1B expected report for stick number: 5/6, but read number: 7.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39EA,0A,0000,0B,0000%4A
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A64,0A,FFFB,0B,FFFB%37
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A74,0A,FFBD,0B,FFBB%37
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0D7F,12,0D1B%32
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A72,0A,FFB7,0B,FFB2%44
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0C68,12,0B9C%3B
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:36.670Z,1553369916.670 [BPC1](ERROR): BPC1B expected report for stick number: 6/6, but read number: 8.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8E,09,39EA,0A,0000,0B,0000%4A
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A64,0A,FFFB,0B,FFFB%37
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A74,0A,FFBD,0B,FFBB%37
$B16,0C,0001,0D,003B,0E,0039,0F,0F12,10,19C7,11,0D7F,12,0D1B%32
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A72,0A,FFB7,0B,FFB2%44
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0C68,12,0B9C%3B
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:36.671Z,1553369916.671 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:38:37.501Z,1553369917.501 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:38:41.109Z,1553369921.109 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:38:41.220Z,1553369921.220 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:38:41.245Z,1553369921.245 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:38:41.520Z,1553369921.520 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2019-03-23T19:38:42.357Z,1553369922.357 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:38:45.152Z,1553369925.152 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:38:48.799Z,1553369928.799 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:38:48.854Z,1553369928.854 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:38:48.854Z,1553369928.854 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:38:49.190Z,1553369929.190 [BPC1](ERROR): BPC1B expected report for stick number: 3/6, but read number: 5.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8F,09,39EA,0A,0000,0B,0000%49
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A64,0A,FFFB,0B,FFFB%37
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A74,0A,FFBD,0B,FFBC%36
$B16,0C,0001,0D,003B,0E,0039,0F,0F11,10,19C7,11,0D7E,12,0D4B%37
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A72,0A,FFB6,0B,FFB4%43
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0C94,12,0BEB%45
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:49.191Z,1553369929.191 [BPC1](ERROR): BPC1B expected report for stick number: 4/6, but read number: 6.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8F,09,39EA,0A,0000,0B,0000%49
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A64,0A,FFFB,0B,FFFB%37
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A74,0A,FFBD,0B,FFBC%36
$B16,0C,0001,0D,003B,0E,0039,0F,0F11,10,19C7,11,0D7E,12,0D4B%37
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A72,0A,FFB6,0B,FFB4%43
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0C94,12,0BEB%45
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:49.192Z,1553369929.192 [BPC1](ERROR): BPC1B expected report for stick number: 5/6, but read number: 7.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8F,09,39EA,0A,0000,0B,0000%49
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A64,0A,FFFB,0B,FFFB%37
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A74,0A,FFBD,0B,FFBC%36
$B16,0C,0001,0D,003B,0E,0039,0F,0F11,10,19C7,11,0D7E,12,0D4B%37
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A72,0A,FFB6,0B,FFB4%43
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0C94,12,0BEB%45
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:49.193Z,1553369929.193 [BPC1](ERROR): BPC1B expected report for stick number: 6/6, but read number: 8.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8F,09,39EA,0A,0000,0B,0000%49
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A64,0A,FFFB,0B,FFFB%37
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A74,0A,FFBD,0B,FFBC%36
$B16,0C,0001,0D,003B,0E,0039,0F,0F11,10,19C7,11,0D7E,12,0D4B%37
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A72,0A,FFB6,0B,FFB4%43
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0C94,12,0BEB%45
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7B,0A,FFFC,0B,FFFC%3E
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:38:49.193Z,1553369929.193 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:38:49.593Z,1553369929.593 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:38:50.009Z,1553369930.009 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:38:53.252Z,1553369933.252 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-23T19:38:53.252Z,1553369933.252 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-03-23T19:38:53.252Z,1553369933.252 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-23T19:38:53.281Z,1553369933.281 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-23T19:38:53.281Z,1553369933.281 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-03-23T19:38:53.281Z,1553369933.281 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-23T19:38:53.291Z,1553369933.291 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-23T19:38:53.291Z,1553369933.291 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-23T19:38:53.661Z,1553369933.661 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-23T19:38:53.661Z,1553369933.661 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-03-23T19:38:53.661Z,1553369933.661 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-23T19:38:53.662Z,1553369933.662 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-03-23T19:38:54.056Z,1553369934.056 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-23T19:38:54.445Z,1553369934.445 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:38:54.515Z,1553369934.515 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:38:54.516Z,1553369934.516 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:38:54.851Z,1553369934.851 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:38:55.669Z,1553369935.669 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:38:57.273Z,1553369937.273 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:39:00.909Z,1553369940.909 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:39:00.951Z,1553369940.951 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:39:00.952Z,1553369940.952 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:39:01.310Z,1553369941.310 [BPC1](ERROR): BPC1B expected report for stick number: 3/6, but read number: 5.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8F,09,39EA,0A,0000,0B,0000%49
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1717,19,3840%4A
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A73,0A,FFC0,0B,FFBD%43
$B16,0C,0001,0D,003B,0E,0039,0F,0F11,10,19C7,11,0DE8,12,0D7E%3C
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A72,0A,FFBB,0B,FFB5%36
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0D20,12,0C13%49
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8F,09,3B7C,0A,FFFC,0B,FFFC%3C
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:39:01.311Z,1553369941.311 [BPC1](ERROR): BPC1B expected report for stick number: 4/6, but read number: 6.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8F,09,39EA,0A,0000,0B,0000%49
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1717,19,3840%4A
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A73,0A,FFC0,0B,FFBD%43
$B16,0C,0001,0D,003B,0E,0039,0F,0F11,10,19C7,11,0DE8,12,0D7E%3C
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A72,0A,FFBB,0B,FFB5%36
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0D20,12,0C13%49
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8F,09,3B7C,0A,FFFC,0B,FFFC%3C
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:39:01.312Z,1553369941.312 [BPC1](ERROR): BPC1B expected report for stick number: 5/6, but read number: 7.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8F,09,39EA,0A,0000,0B,0000%49
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1717,19,3840%4A
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A73,0A,FFC0,0B,FFBD%43
$B16,0C,0001,0D,003B,0E,0039,0F,0F11,10,19C7,11,0DE8,12,0D7E%3C
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A72,0A,FFBB,0B,FFB5%36
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0D20,12,0C13%49
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8F,09,3B7C,0A,FFFC,0B,FFFC%3C
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:39:01.313Z,1553369941.313 [BPC1](ERROR): BPC1B expected report for stick number: 6/6, but read number: 8.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8F,09,39EA,0A,0000,0B,0000%49
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1717,19,3840%4A
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39B0,0A,0000,0B,0000%4E
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A73,0A,FFC0,0B,FFBD%43
$B16,0C,0001,0D,003B,0E,0039,0F,0F11,10,19C7,11,0DE8,12,0D7E%3C
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A72,0A,FFBB,0B,FFB5%36
$B17,0C,0001,0D,003B,0E,0039,0F,0F18,10,19CB,11,0D20,12,0C13%49
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8F,09,3B7C,0A,FFFC,0B,FFFC%3C
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,E1A5,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:39:01.313Z,1553369941.313 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:39:02.129Z,1553369942.129 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:39:03.746Z,1553369943.746 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:39:08.595Z,1553369948.595 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:39:08.663Z,1553369948.663 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:39:08.663Z,1553369948.663 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:39:09.005Z,1553369949.005 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:39:09.821Z,1553369949.821 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:39:09.821Z,1553369949.821 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:39:13.029Z,1553369953.029 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:39:13.071Z,1553369953.071 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:39:13.071Z,1553369953.071 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:39:13.431Z,1553369953.431 [BPC1](ERROR): BPC1B expected report for stick number: 3/6, but read number: 5.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8F,09,39EA,0A,0000,0B,0000%49
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39AF,0A,0000,0B,0000%3B
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A73,0A,FFBC,0B,FFBD%31
$B16,0C,0001,0D,003B,0E,0039,0F,0F11,10,19C7,11,0D4B,12,0D7E%37
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A71,0A,FFB5,0B,FFB6%41
$B17,0C,0001,0D,003B,0E,0039,0F,0F17,10,19CB,11,0C12,12,0C3C%32
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7C,0A,FFFD,0B,FFFC%38
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,FFFF,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:39:13.431Z,1553369953.431 [BPC1](ERROR): BPC1B expected report for stick number: 4/6, but read number: 6.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8F,09,39EA,0A,0000,0B,0000%49
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39AF,0A,0000,0B,0000%3B
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A73,0A,FFBC,0B,FFBD%31
$B16,0C,0001,0D,003B,0E,0039,0F,0F11,10,19C7,11,0D4B,12,0D7E%37
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A71,0A,FFB5,0B,FFB6%41
$B17,0C,0001,0D,003B,0E,0039,0F,0F17,10,19CB,11,0C12,12,0C3C%32
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7C,0A,FFFD,0B,FFFC%38
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,FFFF,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:39:13.432Z,1553369953.432 [BPC1](ERROR): BPC1B expected report for stick number: 5/6, but read number: 7.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8F,09,39EA,0A,0000,0B,0000%49
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39AF,0A,0000,0B,0000%3B
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A73,0A,FFBC,0B,FFBD%31
$B16,0C,0001,0D,003B,0E,0039,0F,0F11,10,19C7,11,0D4B,12,0D7E%37
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A71,0A,FFB5,0B,FFB6%41
$B17,0C,0001,0D,003B,0E,0039,0F,0F17,10,19CB,11,0C12,12,0C3C%32
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7C,0A,FFFD,0B,FFFC%38
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,FFFF,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:39:13.433Z,1553369953.433 [BPC1](ERROR): BPC1B expected report for stick number: 6/6, but read number: 8.
 uart read:
$B11,02,000A,01,02A8,03,0001,08,0B8F,09,39EA,0A,0000,0B,0000%49
$B11,0C,0001,0D,0035,0E,0032,0F,0D16,10,18BB,11,FFFF,12,FFFF%38
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%30
$B11,1A,0031,1B,458F,1C,0163%4A
$B12,02,000A,01,02A8,03,0001,08,0B8E,09,3A63,0A,FFFB,0B,FFFB%30
$B12,0C,0001,0D,0037,0E,0033,0F,0D72,10,1892,11,A158,12,A158%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%33
$B12,1A,0031,1B,458F,1C,01AA%4C
$B15,02,000A,01,02A8,03,0001,08,0B92,09,39AF,0A,0000,0B,0000%3B
$B15,0C,0001,0D,0035,0E,0032,0F,0D39,10,1930,11,FFFF,12,FFFF%33
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%39
$B15,1A,0031,1B,4B19,1C,020E%3C
$B16,02,000A,01,02A8,03,0001,08,0B8F,09,3A73,0A,FFBC,0B,FFBD%31
$B16,0C,0001,0D,003B,0E,0039,0F,0F11,10,19C7,11,0D4B,12,0D7E%37
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3A
$B16,1A,0031,1B,4B19,1C,0228%40
$B17,02,000A,01,02A8,03,0001,08,0B90,09,3A71,0A,FFB5,0B,FFB6%41
$B17,0C,0001,0D,003B,0E,0039,0F,0F17,10,19CB,11,0C12,12,0C3C%32
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0005,18,1A90,19,3840%3B
$B17,1A,0031,1B,4B19,1C,02B4%3D
$B18,02,C0E0,01,02A8,03,0001,08,0B8E,09,3B7C,0A,FFFD,0B,FFFC%38
$B18,0C,0001,0D,003E,0E,0039,0F,0F0B,10,1874,11,FFFF,12,E1A5%3E
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0008,18,1A90,19,3840%39
$B18,1A,0031,1B,458F,1C,01AC%44

2019-03-23T19:39:13.433Z,1553369953.433 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:39:14.261Z,1553369954.261 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:39:16.274Z,1553369956.274 [Startup:StartupSatComms:A](INFO): Timed out from 2019-03-23T19:38:16.1Z
2019-03-23T19:39:16.274Z,1553369956.274 [Startup:StartupSatComms:A] Stopped
2019-03-23T19:39:16.274Z,1553369956.274 [Startup:StartupSatComms:B] Running Loop=1
2019-03-23T19:39:16.670Z,1553369956.670 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-03-23T19:39:17.512Z,1553369957.512 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:39:18.221Z,1553369958.221 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190323T053022/Courier0007.lzma
2019-03-23T19:39:18.930Z,1553369958.930 [DataOverHttps](INFO): Moved sent file to Logs/20190323T053022/Courier0007.lzma.bak
2019-03-23T19:39:18.931Z,1553369958.931 [DataOverHttps](INFO): SBD MOMSN=10223898
2019-03-23T19:39:22.369Z,1553369962.369 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:39:22.475Z,1553369962.475 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:39:22.475Z,1553369962.475 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:39:22.777Z,1553369962.777 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:39:23.181Z,1553369963.181 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:39:23.585Z,1553369963.585 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:39:26.805Z,1553369966.805 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:39:26.892Z,1553369966.892 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:39:26.893Z,1553369966.893 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:39:27.213Z,1553369967.213 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:39:28.029Z,1553369968.029 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:39:29.352Z,1553369969.352 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20190323T193643/Courier0000.lzma
2019-03-23T19:39:30.169Z,1553369970.169 [DataOverHttps](INFO): Moved sent file to Logs/20190323T193643/Courier0000.lzma.bak
2019-03-23T19:39:30.169Z,1553369970.169 [DataOverHttps](INFO): SBD MOMSN=10223903
2019-03-23T19:39:31.252Z,1553369971.252 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:39:36.103Z,1553369976.103 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:39:36.162Z,1553369976.162 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:39:36.162Z,1553369976.162 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:39:36.507Z,1553369976.507 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:39:37.321Z,1553369977.321 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:39:38.520Z,1553369978.520 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:39:40.300Z,1553369980.300 [DataOverHttps](INFO): Sending 188 bytes from file Logs/20190323T053022/Express0008.lzma
2019-03-23T19:39:41.106Z,1553369981.106 [DataOverHttps](INFO): Moved sent file to Logs/20190323T053022/Express0008.lzma.bak
2019-03-23T19:39:41.106Z,1553369981.106 [DataOverHttps](INFO): SBD MOMSN=10223907
2019-03-23T19:39:42.161Z,1553369982.161 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:39:42.203Z,1553369982.203 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:39:42.204Z,1553369982.204 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:39:42.569Z,1553369982.569 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:39:43.381Z,1553369983.381 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:39:44.996Z,1553369984.996 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:39:49.432Z,1553369989.432 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:39:49.554Z,1553369989.554 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:39:49.555Z,1553369989.555 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:39:49.842Z,1553369989.842 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:39:50.665Z,1553369990.665 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:39:51.406Z,1553369991.406 [DataOverHttps](INFO): Sending 911 bytes from file Logs/20190323T193643/Express0001.lzma
2019-03-23T19:39:52.210Z,1553369992.210 [DataOverHttps](INFO): Moved sent file to Logs/20190323T193643/Express0001.lzma.bak
2019-03-23T19:39:52.210Z,1553369992.210 [DataOverHttps](INFO): SBD MOMSN=10223915
2019-03-23T19:39:53.082Z,1553369993.082 [Startup:StartupSatComms:B] Stopped
2019-03-23T19:39:53.082Z,1553369993.082 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-03-23T19:39:53.082Z,1553369993.082 [Startup:StartupSatComms] Stopped
2019-03-23T19:39:53.082Z,1553369993.082 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-03-23T19:39:53.083Z,1553369993.083 [Startup](INFO): Completed Startup
2019-03-23T19:39:53.083Z,1553369993.083 [MissionManager](INFO): Startup is completed.
2019-03-23T19:39:53.083Z,1553369993.083 [MissionManager](INFO): Uninitializing Mission Startup
2019-03-23T19:39:53.083Z,1553369993.083 [Startup] Stopped
2019-03-23T19:39:53.083Z,1553369993.083 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-03-23T19:39:53.083Z,1553369993.083 [Startup:A.GoToSurface] Stopped
2019-03-23T19:39:53.083Z,1553369993.083 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-23T19:39:53.485Z,1553369993.485 [MissionManager](IMPORTANT): Started mission Default
2019-03-23T19:39:53.485Z,1553369993.485 [Default] Running Loop=1
2019-03-23T19:39:53.486Z,1553369993.486 [Default](DEBUG): Aggregate::initialize Default
2019-03-23T19:39:53.486Z,1553369993.486 [Default:B.GoToSurface] Running Loop=1
2019-03-23T19:39:53.486Z,1553369993.486 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-23T19:39:53.486Z,1553369993.486 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-23T19:39:53.486Z,1553369993.486 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-23T19:39:53.487Z,1553369993.487 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-23T19:39:53.487Z,1553369993.487 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-23T19:39:53.487Z,1553369993.487 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-23T19:39:53.488Z,1553369993.488 [Default:A.Wait] Running Loop=1
2019-03-23T19:39:53.488Z,1553369993.488 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-03-23T19:39:53.872Z,1553369993.872 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:39:57.513Z,1553369997.513 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:39:57.566Z,1553369997.566 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:39:57.567Z,1553369997.567 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:39:57.922Z,1553369997.922 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:39:58.316Z,1553369998.316 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:39:58.737Z,1553369998.737 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:40:03.173Z,1553370003.173 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:40:03.231Z,1553370003.231 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:40:03.231Z,1553370003.231 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:40:03.584Z,1553370003.584 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:40:04.389Z,1553370004.389 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:40:06.824Z,1553370006.824 [Default:A.Wait](INFO): Done Waiting.
2019-03-23T19:40:06.824Z,1553370006.824 [Default:A.Wait] Stopped
2019-03-23T19:40:06.824Z,1553370006.824 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-03-23T19:40:07.234Z,1553370007.234 [Default:CheckIn] Running Loop=1
2019-03-23T19:40:07.234Z,1553370007.234 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-23T19:40:07.234Z,1553370007.234 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-23T19:40:07.615Z,1553370007.615 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-03-23T19:40:09.630Z,1553370009.630 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:40:11.663Z,1553370011.663 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:40:12.865Z,1553370012.865 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:40:12.906Z,1553370012.906 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:40:12.906Z,1553370012.906 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:40:13.274Z,1553370013.274 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:40:14.089Z,1553370014.089 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:40:16.511Z,1553370016.511 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:40:16.568Z,1553370016.568 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:40:16.568Z,1553370016.568 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:40:16.917Z,1553370016.917 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:40:17.737Z,1553370017.737 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:40:24.580Z,1553370024.580 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:40:24.981Z,1553370024.981 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:40:28.228Z,1553370028.228 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:40:28.284Z,1553370028.284 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:40:28.285Z,1553370028.285 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:40:28.621Z,1553370028.621 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:40:29.441Z,1553370029.441 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:40:29.829Z,1553370029.829 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:40:29.887Z,1553370029.887 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:40:29.887Z,1553370029.887 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:40:30.243Z,1553370030.243 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:40:31.057Z,1553370031.057 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:40:38.731Z,1553370038.731 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:40:40.337Z,1553370040.337 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:40:43.175Z,1553370043.175 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:40:43.244Z,1553370043.244 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:40:43.245Z,1553370043.245 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:40:43.586Z,1553370043.586 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:40:43.993Z,1553370043.993 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:40:44.035Z,1553370044.035 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:40:44.035Z,1553370044.035 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:40:44.393Z,1553370044.393 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:40:44.398Z,1553370044.398 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:40:45.197Z,1553370045.197 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:40:51.648Z,1553370051.648 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:40:54.088Z,1553370054.088 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-23T19:40:54.088Z,1553370054.088 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-03-23T19:40:54.088Z,1553370054.088 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-23T19:40:54.089Z,1553370054.089 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-23T19:40:54.089Z,1553370054.089 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-03-23T19:40:54.090Z,1553370054.090 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-23T19:40:54.099Z,1553370054.099 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-23T19:40:54.099Z,1553370054.099 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-23T19:40:54.504Z,1553370054.504 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-23T19:40:54.505Z,1553370054.505 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-03-23T19:40:54.505Z,1553370054.505 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-23T19:40:54.505Z,1553370054.505 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-03-23T19:40:54.896Z,1553370054.896 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-23T19:40:56.093Z,1553370056.093 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:40:56.163Z,1553370056.163 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:40:56.163Z,1553370056.163 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:40:56.163Z,1553370056.163 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:40:56.503Z,1553370056.503 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:40:57.317Z,1553370057.317 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:40:59.335Z,1553370059.335 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:40:59.387Z,1553370059.387 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:40:59.387Z,1553370059.387 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:40:59.740Z,1553370059.740 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:41:00.549Z,1553370060.549 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:41:04.994Z,1553370064.994 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:41:09.835Z,1553370069.835 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:41:09.945Z,1553370069.945 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:41:09.945Z,1553370069.945 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:41:10.246Z,1553370070.246 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:41:10.645Z,1553370070.645 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:41:11.049Z,1553370071.049 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:41:14.283Z,1553370074.283 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:41:14.325Z,1553370074.325 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:41:14.326Z,1553370074.326 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:41:14.688Z,1553370074.688 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:41:15.509Z,1553370075.509 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:41:18.313Z,1553370078.313 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:41:23.160Z,1553370083.160 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:41:23.230Z,1553370083.230 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:41:23.230Z,1553370083.230 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:41:23.571Z,1553370083.571 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:41:24.385Z,1553370084.385 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:41:26.003Z,1553370086.003 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:41:29.625Z,1553370089.625 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:41:29.679Z,1553370089.679 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:41:29.680Z,1553370089.680 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:41:30.040Z,1553370090.040 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:41:30.865Z,1553370090.865 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:41:31.644Z,1553370091.644 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:41:36.506Z,1553370096.506 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:41:36.564Z,1553370096.564 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:41:36.564Z,1553370096.564 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:41:36.900Z,1553370096.900 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:41:37.717Z,1553370097.717 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:41:41.755Z,1553370101.755 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:41:44.973Z,1553370104.973 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:41:44.973Z,1553370104.973 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:41:45.068Z,1553370105.068 [BPC1](INFO): BPC1B: got 6 stick msg (1368 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:41:45.068Z,1553370105.068 [BPC1](INFO): BPC1B: got valid message (1368 bytes).
2019-03-23T19:41:45.381Z,1553370105.381 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:41:46.209Z,1553370106.209 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:41:49.828Z,1553370109.828 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:41:49.886Z,1553370109.886 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:41:49.886Z,1553370109.886 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:41:50.235Z,1553370110.235 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:41:51.061Z,1553370111.061 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:41:53.865Z,1553370113.865 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:41:58.308Z,1553370118.308 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:41:58.713Z,1553370118.713 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:41:58.764Z,1553370118.764 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:41:58.764Z,1553370118.764 [BPC1](INFO): BPC1B: got valid message (1824 bytes).
2019-03-23T19:41:59.124Z,1553370119.124 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:41:59.941Z,1553370119.941 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:42:03.159Z,1553370123.159 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:42:03.217Z,1553370123.217 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:42:03.218Z,1553370123.218 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:42:03.580Z,1553370123.580 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:42:04.381Z,1553370124.381 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:42:07.211Z,1553370127.211 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:42:12.055Z,1553370132.055 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:42:12.055Z,1553370132.055 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:42:12.132Z,1553370132.132 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:42:12.132Z,1553370132.132 [BPC1](INFO): BPC1B: got valid message (1824 bytes).
2019-03-23T19:42:12.463Z,1553370132.463 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:42:13.285Z,1553370133.285 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:42:16.896Z,1553370136.896 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:42:16.954Z,1553370136.954 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:42:16.954Z,1553370136.954 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:42:17.317Z,1553370137.317 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:42:18.129Z,1553370138.129 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:42:20.128Z,1553370140.128 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:42:24.972Z,1553370144.972 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:42:25.040Z,1553370145.040 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:42:25.041Z,1553370145.041 [BPC1](INFO): BPC1B: got valid message (1824 bytes).
2019-03-23T19:42:25.377Z,1553370145.377 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:42:25.384Z,1553370145.384 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:42:26.193Z,1553370146.193 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:42:30.225Z,1553370150.225 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:42:30.282Z,1553370150.282 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:42:30.283Z,1553370150.283 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:42:30.637Z,1553370150.637 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:42:31.449Z,1553370151.449 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:42:33.467Z,1553370153.467 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:42:35.058Z,1553370155.058 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-03-23T19:42:35.877Z,1553370155.877 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:42:38.323Z,1553370158.323 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:42:38.324Z,1553370158.324 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:42:38.382Z,1553370158.382 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:42:38.382Z,1553370158.382 [BPC1](INFO): BPC1B: got valid message (1824 bytes).
2019-03-23T19:42:38.722Z,1553370158.722 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:42:39.529Z,1553370159.529 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:42:39.913Z,1553370159.913 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:42:43.145Z,1553370163.145 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:42:43.159Z,1553370163.159 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:42:43.230Z,1553370163.230 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:42:43.231Z,1553370163.231 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:42:43.573Z,1553370163.573 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:42:44.377Z,1553370164.377 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:42:45.977Z,1553370165.977 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:42:47.189Z,1553370167.189 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:42:49.209Z,1553370169.209 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:42:51.639Z,1553370171.639 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:42:51.696Z,1553370171.696 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:42:51.697Z,1553370171.697 [BPC1](INFO): BPC1B: got valid message (1824 bytes).
2019-03-23T19:42:52.037Z,1553370172.037 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:42:52.058Z,1553370172.058 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:42:52.065Z,1553370172.065 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:42:52.873Z,1553370172.873 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:42:54.861Z,1553370174.861 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:42:55.292Z,1553370175.292 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-23T19:42:55.292Z,1553370175.292 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-03-23T19:42:55.292Z,1553370175.292 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-23T19:42:55.294Z,1553370175.294 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-23T19:42:55.294Z,1553370175.294 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-03-23T19:42:55.294Z,1553370175.294 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-23T19:42:55.304Z,1553370175.304 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-23T19:42:55.304Z,1553370175.304 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-23T19:42:55.716Z,1553370175.716 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-23T19:42:55.717Z,1553370175.717 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-03-23T19:42:55.717Z,1553370175.717 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-23T19:42:55.717Z,1553370175.717 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-03-23T19:42:56.084Z,1553370176.084 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-23T19:42:56.481Z,1553370176.481 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:42:56.593Z,1553370176.593 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:42:56.593Z,1553370176.593 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:42:56.881Z,1553370176.881 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:42:56.903Z,1553370176.903 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:42:57.717Z,1553370177.717 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:42:58.901Z,1553370178.901 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:43:00.131Z,1553370180.131 [BPC1](INFO): BPC1B: sending IBPS break.
2019-03-23T19:43:00.921Z,1553370180.921 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:43:04.157Z,1553370184.157 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:43:04.977Z,1553370184.977 [BPC1](INFO): BPC1B: validating data format.
2019-03-23T19:43:05.035Z,1553370185.035 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:43:05.035Z,1553370185.035 [BPC1](INFO): BPC1B: got valid message (1824 bytes).
2019-03-23T19:43:05.372Z,1553370185.372 [BPC1](INFO): BPC1A: sending IBPS break.
2019-03-23T19:43:05.396Z,1553370185.396 [BPC1](INFO): BPC1B: data parsed.
2019-03-23T19:43:06.189Z,1553370186.189 [BPC1](INFO): BPC1B: initialized.
2019-03-23T19:43:06.985Z,1553370186.985 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:43:10.217Z,1553370190.217 [NAL9602](DEBUG): Fix Requested
2019-03-23T19:43:10.231Z,1553370190.231 [BPC1](INFO): BPC1A: validating data format.
2019-03-23T19:43:10.305Z,1553370190.305 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2019-03-23T19:43:10.306Z,1553370190.306 [BPC1](INFO): BPC1A: got valid message (1824 bytes).
2019-03-23T19:43:10.622Z,1553370190.622 [CommandLine](IMPORTANT): got command restart application
2019-03-23T19:43:10.649Z,1553370190.649 [BPC1](INFO): BPC1A: data parsed.
2019-03-23T19:43:11.445Z,1553370191.445 [BPC1](INFO): BPC1A: initialized.
2019-03-23T19:43:11.625Z,1553370191.625 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-23T19:43:11.625Z,1553370191.625 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:11.769Z,1553370191.769 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-03-23T19:43:11.769Z,1553370191.769 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:11.770Z,1553370191.770 [CommandLine](INFO): Join timeout helper Thread ID is 2387
2019-03-23T19:43:11.770Z,1553370191.770 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-03-23T19:43:11.771Z,1553370191.771 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:11.771Z,1553370191.771 [NavChartDb](INFO): Join timeout helper Thread ID is 2388
2019-03-23T19:43:11.937Z,1553370191.937 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-23T19:43:11.937Z,1553370191.937 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:11.957Z,1553370191.957 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-03-23T19:43:11.957Z,1553370191.957 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:11.957Z,1553370191.957 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2389
2019-03-23T19:43:12.138Z,1553370192.138 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-23T19:43:12.138Z,1553370192.138 [WetLabsBB2FL](INFO): Powering down
2019-03-23T19:43:12.138Z,1553370192.138 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:12.157Z,1553370192.157 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-03-23T19:43:12.157Z,1553370192.157 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:12.157Z,1553370192.157 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 2390
2019-03-23T19:43:12.177Z,1553370192.177 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-23T19:43:12.177Z,1553370192.177 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:12.197Z,1553370192.197 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-03-23T19:43:12.197Z,1553370192.197 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:12.197Z,1553370192.197 [Radio_Surface](INFO): Join timeout helper Thread ID is 2391
2019-03-23T19:43:12.437Z,1553370192.437 [Radio_Surface](INFO): Powering down
2019-03-23T19:43:12.438Z,1553370192.438 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-23T19:43:12.438Z,1553370192.438 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:12.458Z,1553370192.458 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-03-23T19:43:12.458Z,1553370192.458 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:12.458Z,1553370192.458 [DataOverHttps](INFO): Join timeout helper Thread ID is 2392
2019-03-23T19:43:12.601Z,1553370192.601 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-23T19:43:12.601Z,1553370192.601 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:12.618Z,1553370192.618 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-03-23T19:43:12.618Z,1553370192.618 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:12.618Z,1553370192.618 [logger](INFO): Join timeout helper Thread ID is 2393
2019-03-23T19:43:12.657Z,1553370192.657 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-23T19:43:12.657Z,1553370192.657 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:12.665Z,1553370192.665 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-03-23T19:43:12.666Z,1553370192.666 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:12.666Z,1553370192.666 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-03-23T19:43:12.666Z,1553370192.666 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:12.666Z,1553370192.666 [controlThread](INFO): Join timeout helper Thread ID is 2394
2019-03-23T19:43:13.021Z,1553370193.021 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-23T19:43:13.021Z,1553370193.021 [controlThread](DEBUG): Uninitializing ControlThread
2019-03-23T19:43:13.022Z,1553370193.022 [NAL9602](INFO): Powering down
2019-03-23T19:43:13.024Z,1553370193.024 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-03-23T19:43:13.025Z,1553370193.025 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-03-23T19:43:13.025Z,1553370193.025 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-03-23T19:43:13.026Z,1553370193.026 [MissionManager](INFO): Uninitializing Mission Default
2019-03-23T19:43:13.026Z,1553370193.026 [Default] Stopped
2019-03-23T19:43:13.026Z,1553370193.026 [Default](DEBUG): Aggregate::uninitialize Default
2019-03-23T19:43:13.026Z,1553370193.026 [Default:B.GoToSurface] Stopped
2019-03-23T19:43:13.026Z,1553370193.026 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-23T19:43:13.026Z,1553370193.026 [Default:CheckIn] Stopped
2019-03-23T19:43:13.026Z,1553370193.026 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-23T19:43:13.026Z,1553370193.026 [Default:CheckIn:Read_GPS] Stopped
2019-03-23T19:43:13.029Z,1553370193.029 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-03-23T19:43:13.029Z,1553370193.029 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-03-23T19:43:13.029Z,1553370193.029 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-03-23T19:43:13.030Z,1553370193.030 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-03-23T19:43:13.030Z,1553370193.030 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-23T19:43:13.030Z,1553370193.030 [ElevatorServo](INFO): Powering down
2019-03-23T19:43:13.031Z,1553370193.031 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-23T19:43:13.031Z,1553370193.031 [MassServo](INFO): Powering down
2019-03-23T19:43:13.032Z,1553370193.032 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-03-23T19:43:13.032Z,1553370193.032 [ThrusterServo](INFO): Powering down
2019-03-23T19:43:13.033Z,1553370193.033 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-03-23T19:43:13.033Z,1553370193.033 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-03-23T19:43:13.033Z,1553370193.033 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-03-23T19:43:13.034Z,1553370193.034 [CBIT](DEBUG): Powering off loads.
2019-03-23T19:43:13.045Z,1553370193.045 [CBIT](DEBUG): Disabling WDT.
2019-03-23T19:43:13.057Z,1553370193.057 [CBIT](DEBUG): Opening all GF detection circuits.
2019-03-23T19:43:13.057Z,1553370193.057 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:13.136Z,1553370193.136 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:13.142Z,1553370193.142 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:13.177Z,1553370193.177 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:13.179Z,1553370193.179 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:13.211Z,1553370193.211 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-23T19:43:13.268Z,1553370193.268 [logger ThreadHandler](INFO): Thread cancelled.