2018-09-19T22:01:00.593Z,1537394460.593 [Supervisor](DEBUG): Initializing supervisor.
2018-09-19T22:01:00.597Z,1537394460.597 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-09-19T22:01:00.598Z,1537394460.598 [SyncHandler](INFO): Protected caller Thread ID is 1069
2018-09-19T22:01:00.598Z,1537394460.598 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-09-19T22:01:00.599Z,1537394460.599 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-09-19T22:01:00.599Z,1537394460.599 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1070
2018-09-19T22:01:00.603Z,1537394460.603 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-09-19T22:01:00.615Z,1537394460.615 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-09-19T22:01:00.616Z,1537394460.616 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-09-19T22:01:00.617Z,1537394460.617 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1071
2018-09-19T22:01:00.618Z,1537394460.618 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-09-19T22:01:00.618Z,1537394460.618 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-09-19T22:01:00.619Z,1537394460.619 [logger ThreadHandler](INFO): Protected caller Thread ID is 1072
2018-09-19T22:01:00.621Z,1537394460.621 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-09-19T22:01:00.621Z,1537394460.621 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-09-19T22:01:00.623Z,1537394460.623 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-09-19T22:01:00.811Z,1537394460.811 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-09-19T22:01:00.812Z,1537394460.812 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-09-19T22:01:00.955Z,1537394460.955 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-09-19T22:01:00.955Z,1537394460.955 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-09-19T22:01:01.301Z,1537394461.301 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-09-19T22:01:01.301Z,1537394461.301 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-09-19T22:01:01.440Z,1537394461.440 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-09-19T22:01:01.441Z,1537394461.441 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-09-19T22:01:01.521Z,1537394461.521 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-09-19T22:01:01.723Z,1537394461.723 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-09-19T22:01:01.723Z,1537394461.723 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-09-19T22:01:01.822Z,1537394461.822 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-09-19T22:01:01.823Z,1537394461.823 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-09-19T22:01:02.163Z,1537394462.163 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-09-19T22:01:02.163Z,1537394462.163 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-09-19T22:01:02.618Z,1537394462.618 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-09-19T22:01:02.619Z,1537394462.619 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-09-19T22:01:02.931Z,1537394462.931 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-09-19T22:01:02.932Z,1537394462.932 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-09-19T22:01:03.432Z,1537394463.432 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-09-19T22:01:03.432Z,1537394463.432 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-09-19T22:01:03.640Z,1537394463.640 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-09-19T22:01:03.640Z,1537394463.640 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-09-19T22:01:03.739Z,1537394463.739 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-09-19T22:01:03.740Z,1537394463.740 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-09-19T22:01:04.389Z,1537394464.389 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-09-19T22:01:04.389Z,1537394464.389 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-09-19T22:01:04.538Z,1537394464.538 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-09-19T22:01:04.540Z,1537394464.540 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2018-09-19T22:01:04.541Z,1537394464.541 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2018-09-19T22:01:04.860Z,1537394464.860 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-09-19T22:01:04.860Z,1537394464.860 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2018-09-19T22:01:04.959Z,1537394464.959 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2018-09-19T22:01:05.053Z,1537394465.053 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2018-09-19T22:01:05.155Z,1537394465.155 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2018-09-19T22:01:05.241Z,1537394465.241 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2018-09-19T22:01:05.376Z,1537394465.376 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2018-09-19T22:01:05.545Z,1537394465.545 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2018-09-19T22:01:05.655Z,1537394465.655 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2018-09-19T22:01:05.741Z,1537394465.741 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2018-09-19T22:01:05.824Z,1537394465.824 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2018-09-19T22:01:06.155Z,1537394466.155 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/
2018-09-19T22:01:06.155Z,1537394466.155 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-09-19T22:01:06.160Z,1537394466.160 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-09-19T22:01:06.360Z,1537394466.360 [SBIT](DEBUG): Construct Startup Built In Test.
2018-09-19T22:01:06.390Z,1537394466.390 [SBIT] Loaded
2018-09-19T22:01:06.390Z,1537394466.390 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-09-19T22:01:06.391Z,1537394466.391 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-09-19T22:01:06.418Z,1537394466.418 [IBIT] Loaded
2018-09-19T22:01:06.418Z,1537394466.418 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-09-19T22:01:06.422Z,1537394466.422 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-09-19T22:01:06.576Z,1537394466.576 [CBIT] Loaded
2018-09-19T22:01:06.577Z,1537394466.577 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-09-19T22:01:06.577Z,1537394466.577 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-09-19T22:01:06.578Z,1537394466.578 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-09-19T22:01:06.646Z,1537394466.646 [VerticalControl](DEBUG): Construct VerticalControl.
2018-09-19T22:01:06.746Z,1537394466.746 [VerticalControl] Loaded
2018-09-19T22:01:06.747Z,1537394466.747 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-09-19T22:01:06.747Z,1537394466.747 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-09-19T22:01:06.808Z,1537394466.808 [HorizontalControl] Loaded
2018-09-19T22:01:06.808Z,1537394466.808 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-09-19T22:01:06.809Z,1537394466.809 [SpeedControl](DEBUG): Construct SpeedControl.
2018-09-19T22:01:06.814Z,1537394466.814 [SpeedControl] Loaded
2018-09-19T22:01:06.815Z,1537394466.815 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-09-19T22:01:06.815Z,1537394466.815 [LoopControl](DEBUG): Construct LoopControl.
2018-09-19T22:01:06.816Z,1537394466.816 [LoopControl] Loaded
2018-09-19T22:01:06.816Z,1537394466.816 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-09-19T22:01:06.817Z,1537394466.817 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-09-19T22:01:06.817Z,1537394466.817 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-09-19T22:01:06.858Z,1537394466.858 [DepthRateCalculator] Loaded
2018-09-19T22:01:06.858Z,1537394466.858 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-09-19T22:01:06.863Z,1537394466.863 [PitchRateCalculator] Loaded
2018-09-19T22:01:06.864Z,1537394466.864 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-09-19T22:01:06.879Z,1537394466.879 [SpeedCalculator] Loaded
2018-09-19T22:01:06.880Z,1537394466.880 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-09-19T22:01:06.901Z,1537394466.901 [TempGradientCalculator] Loaded
2018-09-19T22:01:06.901Z,1537394466.901 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-09-19T22:01:06.916Z,1537394466.916 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2018-09-19T22:01:06.917Z,1537394466.917 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2018-09-19T22:01:06.922Z,1537394466.922 [YawRateCalculator] Loaded
2018-09-19T22:01:06.922Z,1537394466.922 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-09-19T22:01:06.951Z,1537394466.951 [ElevatorOffsetCalculator] Loaded
2018-09-19T22:01:06.952Z,1537394466.952 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-09-19T22:01:06.952Z,1537394466.952 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-09-19T22:01:06.953Z,1537394466.953 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-09-19T22:01:07.016Z,1537394467.016 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-09-19T22:01:07.016Z,1537394467.016 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-09-19T22:01:07.288Z,1537394467.288 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-09-19T22:01:07.288Z,1537394467.288 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-09-19T22:01:07.383Z,1537394467.383 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-09-19T22:01:07.384Z,1537394467.384 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2018-09-19T22:01:07.438Z,1537394467.438 [DeadReckonUsingSpeedCalculator] Loaded
2018-09-19T22:01:07.438Z,1537394467.438 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-09-19T22:01:07.454Z,1537394467.454 [NavChart] Loaded
2018-09-19T22:01:07.455Z,1537394467.455 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-09-19T22:01:07.459Z,1537394467.459 [UniversalFixResidualReporter] Loaded
2018-09-19T22:01:07.459Z,1537394467.459 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-09-19T22:01:07.460Z,1537394467.460 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-09-19T22:01:07.460Z,1537394467.460 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-09-19T22:01:07.474Z,1537394467.474 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-09-19T22:01:07.474Z,1537394467.474 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-09-19T22:01:07.633Z,1537394467.633 [Aanderaa_O2] Loaded
2018-09-19T22:01:07.633Z,1537394467.633 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-09-19T22:01:07.679Z,1537394467.679 [WetLabsSeaOWL_UV_A] Loaded
2018-09-19T22:01:07.679Z,1537394467.679 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2018-09-19T22:01:07.680Z,1537394467.680 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 406D54E0
2018-09-19T22:01:07.680Z,1537394467.680 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 1151
2018-09-19T22:01:07.681Z,1537394467.681 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-09-19T22:01:07.682Z,1537394467.682 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-09-19T22:01:08.030Z,1537394468.030 [AHRS_M2] Loaded
2018-09-19T22:01:08.031Z,1537394468.031 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2018-09-19T22:01:08.100Z,1537394468.100 [DataOverHttps] Loaded
2018-09-19T22:01:08.101Z,1537394468.101 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-09-19T22:01:08.114Z,1537394468.114 [Depth_Keller] Loaded
2018-09-19T22:01:08.114Z,1537394468.114 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-09-19T22:01:08.119Z,1537394468.119 [DropWeight] Loaded
2018-09-19T22:01:08.120Z,1537394468.120 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-09-19T22:01:08.209Z,1537394468.209 [NAL9602] Loaded
2018-09-19T22:01:08.209Z,1537394468.209 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-09-19T22:01:08.215Z,1537394468.215 [Onboard] Loaded
2018-09-19T22:01:08.215Z,1537394468.215 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-09-19T22:01:08.222Z,1537394468.222 [Radio_Surface] Loaded
2018-09-19T22:01:08.222Z,1537394468.222 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-09-19T22:01:08.223Z,1537394468.223 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409364E0
2018-09-19T22:01:08.223Z,1537394468.223 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1152
2018-09-19T22:01:08.252Z,1537394468.252 [RDI_Pathfinder] Loaded
2018-09-19T22:01:08.252Z,1537394468.252 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2018-09-19T22:01:08.275Z,1537394468.275 [RDI_PathfinderUp] Loaded
2018-09-19T22:01:08.275Z,1537394468.275 [ComponentRegistry](DEBUG): SyncComponent "RDI_PathfinderUp" handled in the control thread.
2018-09-19T22:01:08.281Z,1537394468.281 [SCPI] Loaded
2018-09-19T22:01:08.281Z,1537394468.281 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2018-09-19T22:01:08.305Z,1537394468.305 [BPC1](INFO): BPC1A: got serial number for stick 1: 0140
2018-09-19T22:01:08.306Z,1537394468.306 [BPC1](INFO): BPC1A: got serial number for stick 2: 0163
2018-09-19T22:01:08.307Z,1537394468.307 [BPC1](INFO): BPC1A: got serial number for stick 3: 0157
2018-09-19T22:01:08.308Z,1537394468.308 [BPC1](INFO): BPC1A: got serial number for stick 4: 0159
2018-09-19T22:01:08.309Z,1537394468.309 [BPC1](INFO): BPC1A: got serial number for stick 5: 016E
2018-09-19T22:01:08.309Z,1537394468.309 [BPC1](INFO): BPC1A: got serial number for stick 6: 0160
2018-09-19T22:01:08.310Z,1537394468.310 [BPC1](INFO): BPC1A: got serial number for stick 7: 015C
2018-09-19T22:01:08.311Z,1537394468.311 [BPC1](INFO): BPC1A: got serial number for stick 8: 016D
2018-09-19T22:01:08.312Z,1537394468.312 [BPC1](INFO): BPC1A: got serial number for stick 9: 012D
2018-09-19T22:01:08.313Z,1537394468.313 [BPC1](INFO): BPC1A: got serial number for stick 10: 015E
2018-09-19T22:01:08.313Z,1537394468.313 [BPC1](INFO): BPC1A: got serial number for stick 11: 0164
2018-09-19T22:01:08.314Z,1537394468.314 [BPC1](INFO): BPC1A: got serial number for stick 12: 015B
2018-09-19T22:01:08.315Z,1537394468.315 [BPC1](INFO): BPC1A: got serial number for stick 13: 0172
2018-09-19T22:01:08.315Z,1537394468.315 [BPC1](INFO): BPC1A: got serial number for stick 14: 0166
2018-09-19T22:01:08.316Z,1537394468.316 [BPC1](INFO): BPC1A: got serial number for stick 15: 0170
2018-09-19T22:01:08.317Z,1537394468.317 [BPC1](INFO): BPC1A: got serial number for stick 16: 0148
2018-09-19T22:01:08.318Z,1537394468.318 [BPC1](INFO): BPC1A: got serial number for stick 17: 0130
2018-09-19T22:01:08.318Z,1537394468.318 [BPC1](INFO): BPC1A: got serial number for stick 18: 0169
2018-09-19T22:01:08.319Z,1537394468.319 [BPC1](INFO): BPC1A: got serial number for stick 19: 0158
2018-09-19T22:01:08.320Z,1537394468.320 [BPC1](INFO): BPC1A: got serial number for stick 20: 0162
2018-09-19T22:01:08.321Z,1537394468.321 [BPC1](INFO): BPC1A: got serial number for stick 21: 0150
2018-09-19T22:01:08.321Z,1537394468.321 [BPC1](INFO): BPC1A: got serial number for stick 22: 015F
2018-09-19T22:01:08.322Z,1537394468.322 [BPC1](INFO): BPC1A: got serial number for stick 23: 0171
2018-09-19T22:01:08.323Z,1537394468.323 [BPC1](INFO): BPC1A: got serial number for stick 24: 0143
2018-09-19T22:01:08.324Z,1537394468.324 [BPC1](INFO): BPC1A: got serial number for stick 25: 0144
2018-09-19T22:01:08.324Z,1537394468.324 [BPC1](INFO): BPC1A: got serial number for stick 26: 016A
2018-09-19T22:01:08.325Z,1537394468.325 [BPC1](INFO): BPC1A: got serial number for stick 27: 0155
2018-09-19T22:01:08.326Z,1537394468.326 [BPC1](INFO): BPC1A: got serial number for stick 28: 0151
2018-09-19T22:01:08.327Z,1537394468.327 [BPC1](INFO): BPC1A: got serial number for stick 29: 0154
2018-09-19T22:01:08.327Z,1537394468.327 [BPC1](INFO): BPC1A: got serial number for stick 30: 0161
2018-09-19T22:01:08.328Z,1537394468.328 [BPC1](INFO): BPC1A: got serial number for stick 31: 0138
2018-09-19T22:01:08.330Z,1537394468.330 [BPC1](INFO): BPC1B: got serial number for stick 32: 0165
2018-09-19T22:01:08.330Z,1537394468.330 [BPC1](INFO): BPC1B: got serial number for stick 33: 0135
2018-09-19T22:01:08.331Z,1537394468.331 [BPC1](INFO): BPC1B: got serial number for stick 34: 0149
2018-09-19T22:01:08.332Z,1537394468.332 [BPC1](INFO): BPC1B: got serial number for stick 35: 0146
2018-09-19T22:01:08.333Z,1537394468.333 [BPC1](INFO): BPC1B: got serial number for stick 36: 013D
2018-09-19T22:01:08.333Z,1537394468.333 [BPC1](INFO): BPC1B: got serial number for stick 37: 014D
2018-09-19T22:01:08.334Z,1537394468.334 [BPC1](INFO): BPC1B: got serial number for stick 38: 0156
2018-09-19T22:01:08.335Z,1537394468.335 [BPC1](INFO): BPC1B: got serial number for stick 39: 0133
2018-09-19T22:01:08.336Z,1537394468.336 [BPC1](INFO): BPC1B: got serial number for stick 40: 0131
2018-09-19T22:01:08.336Z,1537394468.336 [BPC1](INFO): BPC1B: got serial number for stick 41: 0145
2018-09-19T22:01:08.337Z,1537394468.337 [BPC1](INFO): BPC1B: got serial number for stick 42: 014A
2018-09-19T22:01:08.338Z,1537394468.338 [BPC1](INFO): BPC1B: got serial number for stick 43: 013C
2018-09-19T22:01:08.339Z,1537394468.339 [BPC1](INFO): BPC1B: got serial number for stick 44: 013B
2018-09-19T22:01:08.339Z,1537394468.339 [BPC1](INFO): BPC1B: got serial number for stick 45: 0132
2018-09-19T22:01:08.340Z,1537394468.340 [BPC1](INFO): BPC1B: got serial number for stick 46: 0134
2018-09-19T22:01:08.341Z,1537394468.341 [BPC1](INFO): BPC1B: got serial number for stick 47: 0153
2018-09-19T22:01:08.342Z,1537394468.342 [BPC1](INFO): BPC1B: got serial number for stick 48: 014B
2018-09-19T22:01:08.342Z,1537394468.342 [BPC1](INFO): BPC1B: got serial number for stick 49: 013A
2018-09-19T22:01:08.343Z,1537394468.343 [BPC1](INFO): BPC1B: got serial number for stick 50: 0136
2018-09-19T22:01:08.344Z,1537394468.344 [BPC1](INFO): BPC1B: got serial number for stick 51: 014F
2018-09-19T22:01:08.345Z,1537394468.345 [BPC1](INFO): BPC1B: got serial number for stick 52: 014E
2018-09-19T22:01:08.345Z,1537394468.345 [BPC1](INFO): BPC1B: got serial number for stick 53: 013F
2018-09-19T22:01:08.346Z,1537394468.346 [BPC1](INFO): BPC1B: got serial number for stick 54: 0152
2018-09-19T22:01:08.347Z,1537394468.347 [BPC1](INFO): BPC1B: got serial number for stick 55: 014C
2018-09-19T22:01:08.347Z,1537394468.347 [BPC1](INFO): BPC1B: got serial number for stick 56: 016B
2018-09-19T22:01:08.348Z,1537394468.348 [BPC1](INFO): BPC1B: got serial number for stick 57: 0141
2018-09-19T22:01:08.349Z,1537394468.349 [BPC1](INFO): BPC1B: got serial number for stick 58: 0139
2018-09-19T22:01:08.350Z,1537394468.350 [BPC1](INFO): BPC1B: got serial number for stick 59: 0137
2018-09-19T22:01:08.350Z,1537394468.350 [BPC1](INFO): BPC1B: got serial number for stick 60: 0142
2018-09-19T22:01:08.351Z,1537394468.351 [BPC1](INFO): BPC1B: got serial number for stick 61: 013E
2018-09-19T22:01:08.352Z,1537394468.352 [BPC1](INFO): BPC1B: got serial number for stick 62: 0147
2018-09-19T22:01:10.185Z,1537394470.185 [BPC1] Loaded
2018-09-19T22:01:10.186Z,1537394470.186 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-09-19T22:01:10.186Z,1537394470.186 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-09-19T22:01:10.187Z,1537394470.187 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-09-19T22:01:10.319Z,1537394470.319 [BuoyancyServo] Loaded
2018-09-19T22:01:10.319Z,1537394470.319 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-09-19T22:01:10.330Z,1537394470.330 [ElevatorServo] Loaded
2018-09-19T22:01:10.331Z,1537394470.331 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-09-19T22:01:10.342Z,1537394470.342 [MassServo] Loaded
2018-09-19T22:01:10.342Z,1537394470.342 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-09-19T22:01:10.353Z,1537394470.353 [RudderServo] Loaded
2018-09-19T22:01:10.354Z,1537394470.354 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-09-19T22:01:10.365Z,1537394470.365 [ThrusterServo] Loaded
2018-09-19T22:01:10.365Z,1537394470.365 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-09-19T22:01:10.365Z,1537394470.365 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-09-19T22:01:10.366Z,1537394470.366 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-09-19T22:01:10.464Z,1537394470.464 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-09-19T22:01:10.465Z,1537394470.465 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-09-19T22:01:10.488Z,1537394470.488 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-09-19T22:01:10.492Z,1537394470.492 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-09-19T22:01:10.493Z,1537394470.493 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-09-19T22:01:10.500Z,1537394470.500 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-09-19T22:01:10.501Z,1537394470.501 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409DF4E0
2018-09-19T22:01:10.501Z,1537394470.501 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1153
2018-09-19T22:01:18.226Z,1537394478.226 [Supervisor](INFO): Main Thread ID is 796
2018-09-19T22:01:18.226Z,1537394478.226 [Supervisor](DEBUG): Running supervisor.
2018-09-19T22:01:18.227Z,1537394478.227 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1154
2018-09-19T22:01:18.229Z,1537394478.229 [controlThread ThreadHandler](INFO): Handler Thread ID is 1155
2018-09-19T22:01:18.230Z,1537394478.230 [controlThread](DEBUG): Initializing ControlThread
2018-09-19T22:01:18.231Z,1537394478.231 [SBIT](INFO): Initialize SBIT Component.
2018-09-19T22:01:18.231Z,1537394478.231 [SBIT](IMPORTANT): git: 2018-09-04-21-gd54d9fc
2018-09-19T22:01:18.231Z,1537394478.231 [SBIT](INFO): git hash: d54d9fc12f891c3a6b7eed365ed7708e78930892
2018-09-19T22:01:18.232Z,1537394478.232 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-09-19T22:01:18.233Z,1537394478.233 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2018-09-19T22:01:18.234Z,1537394478.234 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2018-09-19T22:01:18.235Z,1537394478.235 [IBIT](INFO): Initialize IBIT Component.
2018-09-19T22:01:18.236Z,1537394478.236 [CBIT](DEBUG): Initialize CBIT Component.
2018-09-19T22:01:18.236Z,1537394478.236 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-09-19T22:01:18.247Z,1537394478.247 [logger ThreadHandler](INFO): Handler Thread ID is 1156
2018-09-19T22:01:18.270Z,1537394478.270 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 1157
2018-09-19T22:01:18.271Z,1537394478.271 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-09-19T22:01:18.299Z,1537394478.299 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1158
2018-09-19T22:01:18.305Z,1537394478.305 [Radio_Surface](INFO): Powering up
2018-09-19T22:01:18.318Z,1537394478.318 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1159
2018-09-19T22:01:18.321Z,1537394478.321 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-09-19T22:01:18.322Z,1537394478.322 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-09-19T22:01:18.322Z,1537394478.322 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-09-19T22:01:18.322Z,1537394478.322 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-09-19T22:01:18.322Z,1537394478.322 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-09-19T22:01:18.322Z,1537394478.322 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-09-19T22:01:18.323Z,1537394478.323 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-09-19T22:01:18.323Z,1537394478.323 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-09-19T22:01:18.323Z,1537394478.323 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-09-19T22:01:18.323Z,1537394478.323 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-09-19T22:01:18.323Z,1537394478.323 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-09-19T22:01:18.324Z,1537394478.324 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-09-19T22:01:18.324Z,1537394478.324 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-09-19T22:01:18.324Z,1537394478.324 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-09-19T22:01:18.324Z,1537394478.324 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-09-19T22:01:18.324Z,1537394478.324 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-09-19T22:01:18.342Z,1537394478.342 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-09-19T22:01:18.344Z,1537394478.344 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-09-19T22:01:18.344Z,1537394478.344 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-09-19T22:01:18.345Z,1537394478.345 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-09-19T22:01:18.345Z,1537394478.345 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-09-19T22:01:18.346Z,1537394478.346 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-09-19T22:01:18.346Z,1537394478.346 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-09-19T22:01:18.346Z,1537394478.346 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-09-19T22:01:18.347Z,1537394478.347 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2018-09-19T22:01:18.348Z,1537394478.348 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-09-19T22:01:18.348Z,1537394478.348 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-09-19T22:01:18.349Z,1537394478.349 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-19T22:01:18.350Z,1537394478.350 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-19T22:01:18.350Z,1537394478.350 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-19T22:01:18.350Z,1537394478.350 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-19T22:01:18.351Z,1537394478.351 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-19T22:01:18.351Z,1537394478.351 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-19T22:01:18.352Z,1537394478.352 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-09-19T22:01:18.352Z,1537394478.352 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-09-19T22:01:18.367Z,1537394478.367 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-09-19T22:01:18.403Z,1537394478.403 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-09-19T22:01:18.443Z,1537394478.443 [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>


2018-09-19T22:01:18.444Z,1537394478.444 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-09-19T22:01:18.519Z,1537394478.519 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-09-19T22:01:18.520Z,1537394478.520 [Default:A.Wait](DEBUG): Construct Wait.
2018-09-19T22:01:18.542Z,1537394478.542 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-09-19T22:01:18.569Z,1537394478.569 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-09-19T22:01:18.572Z,1537394478.572 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-09-19T22:01:18.590Z,1537394478.590 [Default:E.Execute](DEBUG): Construct Execute.
2018-09-19T22:01:18.610Z,1537394478.610 [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>


2018-09-19T22:01:18.615Z,1537394478.615 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,AHRS_M2,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,RDI_Pathfinder,RDI_PathfinderUp,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-09-19T22:01:18.678Z,1537394478.678 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-09-19T22:01:18.725Z,1537394478.725 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-09-19T22:01:18.757Z,1537394478.757 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2018-09-19T22:01:18.922Z,1537394478.922 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-09-19T22:01:19.018Z,1537394479.018 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:19.059Z,1537394479.059 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:19.175Z,1537394479.175 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-09-19T22:01:19.182Z,1537394479.182 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-09-19T22:01:19.204Z,1537394479.204 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-09-19T22:01:19.210Z,1537394479.210 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-09-19T22:01:19.224Z,1537394479.224 [MassServo](DEBUG): Initializing EZServoServo.
2018-09-19T22:01:19.230Z,1537394479.230 [MassServo](DEBUG): Initializing MassServo.
2018-09-19T22:01:19.244Z,1537394479.244 [RudderServo](DEBUG): Initializing EZServoServo.
2018-09-19T22:01:19.250Z,1537394479.250 [RudderServo](DEBUG): Initializing RudderServo.
2018-09-19T22:01:19.283Z,1537394479.283 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-09-19T22:01:19.290Z,1537394479.290 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-09-19T22:01:19.473Z,1537394479.473 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2018-09-19T22:01:19.473Z,1537394479.473 [DropWeight] Hardware Fault, FailCount= 1
2018-09-19T22:01:19.473Z,1537394479.473 [DropWeight](ERROR): Hardware Fault
2018-09-19T22:01:19.574Z,1537394479.574 [RDI_PathfinderUp](INFO): Powering down
2018-09-19T22:01:19.596Z,1537394479.596 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-09-19T22:01:19.609Z,1537394479.609 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:19.646Z,1537394479.646 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:19.710Z,1537394479.710 [CommandLine](FAULT): Scheduling is paused
2018-09-19T22:01:19.711Z,1537394479.711 [CBIT](INFO): Critical error at 20180919T220119
2018-09-19T22:01:19.711Z,1537394479.711 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2018-09-19T22:01:19.713Z,1537394479.713 [CBIT](ERROR): Hardware Fault in component: DropWeight
2018-09-19T22:01:19.714Z,1537394479.714 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2018-09-19T22:01:19.962Z,1537394479.962 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:19.964Z,1537394479.964 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:20.248Z,1537394480.248 [CBIT](INFO): Critical error at 20180919T220119
2018-09-19T22:01:20.318Z,1537394480.318 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:20.319Z,1537394480.319 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:20.685Z,1537394480.685 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:20.686Z,1537394480.686 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:21.089Z,1537394481.089 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:21.091Z,1537394481.091 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:21.485Z,1537394481.485 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:21.487Z,1537394481.487 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:21.982Z,1537394481.982 [Aanderaa_O2](INFO): Powering down
2018-09-19T22:01:22.117Z,1537394482.117 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:22.130Z,1537394482.130 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:22.322Z,1537394482.322 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-09-19T22:01:22.367Z,1537394482.367 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:22.368Z,1537394482.368 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:22.701Z,1537394482.701 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:22.703Z,1537394482.703 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-19T22:01:32.350Z,1537394492.350 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2018-09-19T22:01:38.323Z,1537394498.323 [NAL9602](INFO): Powering up NAL9602
2018-09-19T22:01:42.765Z,1537394502.765 [SBIT](IMPORTANT): Beginning Startup BIT
2018-09-19T22:01:42.786Z,1537394502.786 [CBIT](IMPORTANT): Beginning ground fault scan
2018-09-19T22:01:49.255Z,1537394509.255 [NAL9602](INFO): NAL9602 initialized
2018-09-19T22:01:53.771Z,1537394513.771 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.018865
CHAN A1 (24V): -0.021466
CHAN A2 (12V): -0.007282
CHAN A3 (5V): -0.002057
CHAN B0 (3.3V): 0.000410
CHAN B1 (3.15aV): 0.000146
CHAN B2 (3.15bV): 0.000167
CHAN B3 (GND): 0.002407
OPEN: 0.005214
Full Scale Calc: 4.765 mA, -1.589 mA
2018-09-19T22:02:19.938Z,1537394539.938 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:02:20.338Z,1537394540.338 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:02:21.551Z,1537394541.551 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:02:21.551Z,1537394541.551 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:02:25.662Z,1537394545.662 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:02:25.698Z,1537394545.698 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:02:26.079Z,1537394546.079 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:02:26.125Z,1537394546.125 [BPC1](ERROR): BPC1A: No match for stick with serial number:0165 in the onboard configuration file.
2018-09-19T22:02:26.128Z,1537394546.128 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:02:26.153Z,1537394546.153 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:02:26.462Z,1537394546.462 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:02:26.465Z,1537394546.465 [BPC1](ERROR): BPC1B: No match for stick with serial number:0140 in the onboard configuration file.
2018-09-19T22:02:26.482Z,1537394546.482 [BPC1](FAULT): Failed to parse data from all battery packs.
2018-09-19T22:02:26.482Z,1537394546.482 [BPC1] Data Fault, FailCount= 1
2018-09-19T22:02:26.482Z,1537394546.482 [BPC1](ERROR): Data Fault
2018-09-19T22:02:26.595Z,1537394546.595 [CBIT](ERROR): Data Fault in component: BPC1
2018-09-19T22:02:27.855Z,1537394547.855 [CBIT](INFO): Clearing failed state for component BPC1
2018-09-19T22:02:27.855Z,1537394547.855 [BPC1] No Fault, FailCount= 1
2018-09-19T22:02:36.901Z,1537394556.901 [SBIT](IMPORTANT): SBIT PASSED
2018-09-19T22:02:36.944Z,1537394556.944 [CommandLine](IMPORTANT): got command configSet list
2018-09-19T22:02:36.944Z,1537394556.944 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-09-19T22:02:36.945Z,1537394556.945 [CommandLine](IMPORTANT): BPC1.batterySamplingInterval=1 minute;

2018-09-19T22:02:36.945Z,1537394556.945 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=160 cubic_centimeter;

2018-09-19T22:02:36.945Z,1537394556.945 [CommandLine](IMPORTANT): VerticalControl.massDefault=-1 millimeter;

2018-09-19T22:02:37.287Z,1537394557.287 [MissionManager](IMPORTANT): Started mission Startup
2018-09-19T22:02:37.287Z,1537394557.287 [Startup] Running Loop=1
2018-09-19T22:02:37.287Z,1537394557.287 [Startup](DEBUG): Aggregate::initialize Startup
2018-09-19T22:02:37.287Z,1537394557.287 [Startup:A.GoToSurface] Running Loop=1
2018-09-19T22:02:37.287Z,1537394557.287 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-09-19T22:02:37.288Z,1537394557.288 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-09-19T22:02:37.288Z,1537394557.288 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-09-19T22:02:37.289Z,1537394557.289 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-09-19T22:02:37.289Z,1537394557.289 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-09-19T22:02:37.290Z,1537394557.290 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-09-19T22:02:37.296Z,1537394557.296 [Startup:StartupSatComms] Running Loop=1
2018-09-19T22:02:37.296Z,1537394557.296 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-09-19T22:02:37.296Z,1537394557.296 [Startup:StartupSatComms:A] Running Loop=1
2018-09-19T22:02:37.662Z,1537394557.662 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-09-19T22:03:29.283Z,1537394609.283 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:03:29.294Z,1537394609.294 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:03:36.476Z,1537394616.476 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:03:36.476Z,1537394616.476 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:03:37.682Z,1537394617.682 [Startup:StartupSatComms:A](INFO): Timed out from 2018-09-19T22:02:37.3Z
2018-09-19T22:03:37.682Z,1537394617.682 [Startup:StartupSatComms:A] Stopped
2018-09-19T22:03:37.682Z,1537394617.682 [Startup:StartupSatComms:B] Running Loop=1
2018-09-19T22:03:38.095Z,1537394618.095 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-09-19T22:03:41.271Z,1537394621.272 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:03:41.351Z,1537394621.351 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:03:41.351Z,1537394621.351 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:03:41.448Z,1537394621.448 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:03:41.679Z,1537394621.679 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:03:41.693Z,1537394621.693 [BPC1](ERROR): BPC1A: No match for stick with serial number:0165 in the onboard configuration file.
2018-09-19T22:03:41.702Z,1537394621.702 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:03:41.711Z,1537394621.711 [BPC1](ERROR): BPC1B: No match for stick with serial number:0140 in the onboard configuration file.
2018-09-19T22:03:41.711Z,1537394621.711 [BPC1](FAULT): Failed to parse data from all battery packs.
2018-09-19T22:03:41.711Z,1537394621.711 [BPC1] Data Fault, FailCount= 2
2018-09-19T22:03:41.711Z,1537394621.711 [BPC1](ERROR): Data Fault
2018-09-19T22:03:41.751Z,1537394621.751 [CBIT](ERROR): Data Fault in component: BPC1
2018-09-19T22:03:42.892Z,1537394622.892 [CBIT](INFO): Clearing failed state for component BPC1
2018-09-19T22:03:42.892Z,1537394622.892 [BPC1] No Fault, FailCount= 2
2018-09-19T22:04:18.496Z,1537394658.496 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-19T22:04:18.496Z,1537394658.496 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2018-09-19T22:04:18.496Z,1537394658.496 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-19T22:04:18.498Z,1537394658.498 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-19T22:04:18.498Z,1537394658.498 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2018-09-19T22:04:18.498Z,1537394658.498 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-19T22:04:18.512Z,1537394658.512 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-19T22:04:18.512Z,1537394658.512 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-19T22:04:18.897Z,1537394658.897 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-19T22:04:18.897Z,1537394658.897 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2018-09-19T22:04:18.898Z,1537394658.898 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-19T22:04:18.898Z,1537394658.898 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2018-09-19T22:04:19.273Z,1537394659.273 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-19T22:04:19.286Z,1537394659.286 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-19T22:04:19.286Z,1537394659.286 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-19T22:04:19.287Z,1537394659.287 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-19T22:04:19.287Z,1537394659.287 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-19T22:04:19.287Z,1537394659.287 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-19T22:04:24.145Z,1537394664.145 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004390
2018-09-19T22:04:28.260Z,1537394668.260 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180919T215014/Courier0007.lzma
2018-09-19T22:04:29.009Z,1537394669.009 [DataOverHttps](INFO): Moved sent file to Logs/20180919T215014/Courier0007.lzma.bak
2018-09-19T22:04:29.009Z,1537394669.009 [DataOverHttps](INFO): SBD MOMSN=8540772
2018-09-19T22:04:37.964Z,1537394677.964 [Startup:StartupSatComms:B](INFO): Timed out from 2018-09-19T22:03:37.7Z
2018-09-19T22:04:37.964Z,1537394677.964 [Startup:StartupSatComms:B] Stopped
2018-09-19T22:04:37.965Z,1537394677.965 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-09-19T22:04:37.965Z,1537394677.965 [Startup:StartupSatComms] Stopped
2018-09-19T22:04:37.965Z,1537394677.965 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-09-19T22:04:37.966Z,1537394677.966 [Startup](INFO): Completed Startup
2018-09-19T22:04:37.966Z,1537394677.966 [MissionManager](INFO): Startup is completed.
2018-09-19T22:04:37.967Z,1537394677.967 [MissionManager](INFO): Uninitializing Mission Startup
2018-09-19T22:04:37.967Z,1537394677.967 [Startup] Stopped
2018-09-19T22:04:37.967Z,1537394677.967 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-09-19T22:04:37.967Z,1537394677.967 [Startup:A.GoToSurface] Stopped
2018-09-19T22:04:37.967Z,1537394677.967 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-09-19T22:04:38.047Z,1537394678.047 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20180919T220100/Courier0000.lzma
2018-09-19T22:04:38.117Z,1537394678.117 [MissionManager](IMPORTANT): Started mission Default
2018-09-19T22:04:38.118Z,1537394678.118 [Default] Running Loop=1
2018-09-19T22:04:38.118Z,1537394678.118 [Default](DEBUG): Aggregate::initialize Default
2018-09-19T22:04:38.118Z,1537394678.118 [Default:B.GoToSurface] Running Loop=1
2018-09-19T22:04:38.118Z,1537394678.118 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-09-19T22:04:38.118Z,1537394678.118 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-09-19T22:04:38.119Z,1537394678.119 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-09-19T22:04:38.119Z,1537394678.119 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-09-19T22:04:38.119Z,1537394678.119 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-09-19T22:04:38.120Z,1537394678.120 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-09-19T22:04:38.120Z,1537394678.120 [Default:A.Wait] Running Loop=1
2018-09-19T22:04:38.120Z,1537394678.120 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-09-19T22:04:38.792Z,1537394678.792 [DataOverHttps](INFO): Moved sent file to Logs/20180919T220100/Courier0000.lzma.bak
2018-09-19T22:04:38.792Z,1537394678.792 [DataOverHttps](INFO): SBD MOMSN=8540774
2018-09-19T22:04:44.142Z,1537394684.142 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:04:44.158Z,1537394684.158 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:04:51.344Z,1537394691.344 [Default:A.Wait](INFO): Done Waiting.
2018-09-19T22:04:51.344Z,1537394691.344 [Default:A.Wait] Stopped
2018-09-19T22:04:51.345Z,1537394691.345 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-09-19T22:04:51.732Z,1537394691.732 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:04:51.733Z,1537394691.733 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:04:51.752Z,1537394691.752 [Default:CheckIn] Running Loop=1
2018-09-19T22:04:51.752Z,1537394691.752 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-09-19T22:04:51.752Z,1537394691.752 [Default:CheckIn:Read_GPS] Running Loop=1
2018-09-19T22:04:52.155Z,1537394692.155 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-09-19T22:04:56.132Z,1537394696.132 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:04:56.219Z,1537394696.219 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:04:56.514Z,1537394696.514 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:04:56.605Z,1537394696.605 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:04:56.605Z,1537394696.605 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:04:56.640Z,1537394696.640 [BPC1](ERROR): BPC1B: No match for stick with serial number:012D in the onboard configuration file.
2018-09-19T22:04:56.918Z,1537394696.918 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:04:56.933Z,1537394696.933 [BPC1](ERROR): BPC1A: No match for stick with serial number:0131 in the onboard configuration file.
2018-09-19T22:04:56.946Z,1537394696.946 [BPC1](FAULT): Failed to parse data from all battery packs.
2018-09-19T22:04:56.946Z,1537394696.946 [BPC1] Data Fault, FailCount= 3
2018-09-19T22:04:56.946Z,1537394696.946 [BPC1](ERROR): Data Fault
2018-09-19T22:04:56.993Z,1537394696.993 [CBIT](ERROR): Data Fault in component: BPC1
2018-09-19T22:04:58.198Z,1537394698.198 [CBIT](INFO): Clearing failed state for component BPC1
2018-09-19T22:04:58.198Z,1537394698.198 [BPC1] No Fault, FailCount= 3
2018-09-19T22:05:59.454Z,1537394759.454 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:05:59.468Z,1537394759.468 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:06:06.621Z,1537394766.621 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:06:07.033Z,1537394767.033 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:06:11.443Z,1537394771.443 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:06:11.528Z,1537394771.528 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:06:11.813Z,1537394771.813 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:06:11.828Z,1537394771.828 [BPC1](ERROR): BPC1A: No match for stick with serial number:0131 in the onboard configuration file.
2018-09-19T22:06:11.829Z,1537394771.829 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:06:11.928Z,1537394771.928 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:06:12.250Z,1537394772.250 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:06:12.269Z,1537394772.269 [BPC1](ERROR): BPC1B: No match for stick with serial number:012D in the onboard configuration file.
2018-09-19T22:06:12.269Z,1537394772.269 [BPC1](FAULT): Failed to parse data from all battery packs.
2018-09-19T22:06:12.269Z,1537394772.269 [BPC1] Data Fault, FailCount= 4
2018-09-19T22:06:12.269Z,1537394772.269 [BPC1](ERROR): Data Fault
2018-09-19T22:06:12.320Z,1537394772.320 [CBIT](ERROR): Data Fault in component: BPC1
2018-09-19T22:06:13.470Z,1537394773.470 [CBIT](INFO): Clearing failed state for component BPC1
2018-09-19T22:06:13.470Z,1537394773.470 [BPC1] No Fault, FailCount= 4
2018-09-19T22:06:53.123Z,1537394813.123 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-09-19T22:07:14.754Z,1537394834.754 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:07:14.770Z,1537394834.770 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:07:19.571Z,1537394839.571 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-19T22:07:19.571Z,1537394839.571 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2018-09-19T22:07:19.572Z,1537394839.572 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-19T22:07:19.578Z,1537394839.578 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-19T22:07:19.578Z,1537394839.578 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2018-09-19T22:07:19.578Z,1537394839.578 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-19T22:07:19.603Z,1537394839.603 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-19T22:07:19.603Z,1537394839.603 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-19T22:07:19.967Z,1537394839.967 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-19T22:07:19.967Z,1537394839.967 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2018-09-19T22:07:19.967Z,1537394839.967 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-19T22:07:19.968Z,1537394839.968 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2018-09-19T22:07:20.360Z,1537394840.360 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-19T22:07:20.367Z,1537394840.367 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-19T22:07:20.368Z,1537394840.368 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-19T22:07:20.369Z,1537394840.369 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-19T22:07:20.374Z,1537394840.374 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-19T22:07:20.375Z,1537394840.375 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-19T22:07:21.948Z,1537394841.948 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:07:21.948Z,1537394841.948 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:07:26.737Z,1537394846.737 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:07:26.822Z,1537394846.822 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:07:27.175Z,1537394847.175 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:07:27.215Z,1537394847.215 [BPC1](ERROR): BPC1B: No match for stick with serial number:0130 in the onboard configuration file.
2018-09-19T22:07:27.974Z,1537394847.974 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:07:35.151Z,1537394855.151 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:07:39.971Z,1537394859.971 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:07:40.049Z,1537394860.049 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:07:43.238Z,1537394863.238 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:07:43.287Z,1537394863.287 [BPC1](ERROR): BPC1B: No match for stick with serial number:0130 in the onboard configuration file.
2018-09-19T22:07:43.802Z,1537394863.802 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:07:50.995Z,1537394870.995 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:07:55.791Z,1537394875.791 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:07:55.861Z,1537394875.861 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:07:56.203Z,1537394876.203 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:07:56.239Z,1537394876.239 [BPC1](ERROR): BPC1B: No match for stick with serial number:0130 in the onboard configuration file.
2018-09-19T22:07:57.006Z,1537394877.006 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:08:04.195Z,1537394884.195 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:08:08.991Z,1537394888.991 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:08:09.061Z,1537394889.061 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:08:09.407Z,1537394889.407 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:08:09.451Z,1537394889.451 [BPC1](ERROR): BPC1B: No match for stick with serial number:0130 in the onboard configuration file.
2018-09-19T22:08:10.194Z,1537394890.194 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:08:17.784Z,1537394897.784 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:08:22.578Z,1537394902.578 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:08:22.651Z,1537394902.651 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:08:22.992Z,1537394902.992 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:08:23.019Z,1537394903.019 [BPC1](ERROR): BPC1B: No match for stick with serial number:0130 in the onboard configuration file.
2018-09-19T22:08:23.794Z,1537394903.794 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:08:30.987Z,1537394910.987 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:08:35.407Z,1537394915.407 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:08:35.479Z,1537394915.479 [BPC1](INFO): BPC1B: got 7 stick msg (1596 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:08:35.796Z,1537394915.796 [BPC1](INFO): BPC1B valid message: 1596 bytes.
2018-09-19T22:08:35.829Z,1537394915.829 [BPC1](ERROR): BPC1B: No match for stick with serial number:0144 in the onboard configuration file.
2018-09-19T22:08:36.582Z,1537394916.582 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:08:37.784Z,1537394917.784 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:08:43.456Z,1537394923.456 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:08:43.488Z,1537394923.488 [BPC1](INFO): BPC1B: got 7 stick msg (1596 bytes) with LONG_IBPS_MENU.
2018-09-19T22:08:43.608Z,1537394923.608 [BPC1](INFO): BPC1B valid message: 1596 bytes.
2018-09-19T22:08:43.653Z,1537394923.653 [BPC1](ERROR): BPC1B: No match for stick with serial number:0144 in the onboard configuration file.
2018-09-19T22:08:44.414Z,1537394924.414 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:08:51.160Z,1537394931.160 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:08:55.545Z,1537394935.545 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:08:55.617Z,1537394935.617 [BPC1](INFO): BPC1B: got 7 stick msg (1596 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:08:55.956Z,1537394935.956 [BPC1](INFO): BPC1B valid message: 1596 bytes.
2018-09-19T22:08:56.017Z,1537394936.017 [BPC1](ERROR): BPC1B: No match for stick with serial number:0144 in the onboard configuration file.
2018-09-19T22:08:56.782Z,1537394936.782 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:09:03.556Z,1537394943.556 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:09:07.548Z,1537394947.548 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:09:07.623Z,1537394947.623 [BPC1](INFO): BPC1B: got 7 stick msg (1596 bytes) with LONG_IBPS_MENU.
2018-09-19T22:09:07.972Z,1537394947.972 [BPC1](INFO): BPC1B valid message: 1596 bytes.
2018-09-19T22:09:07.991Z,1537394947.991 [BPC1](ERROR): BPC1B: No match for stick with serial number:0144 in the onboard configuration file.
2018-09-19T22:09:08.790Z,1537394948.790 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:09:15.553Z,1537394955.553 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:09:19.973Z,1537394959.973 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:09:20.037Z,1537394960.037 [BPC1](INFO): BPC1B: got 7 stick msg (1596 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:09:20.408Z,1537394960.408 [BPC1](INFO): BPC1B valid message: 1596 bytes.
2018-09-19T22:09:20.458Z,1537394960.458 [BPC1](ERROR): BPC1B: No match for stick with serial number:0144 in the onboard configuration file.
2018-09-19T22:09:21.182Z,1537394961.182 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:09:27.972Z,1537394967.972 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:09:32.374Z,1537394972.374 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:09:32.449Z,1537394972.449 [BPC1](INFO): BPC1B: got 7 stick msg (1596 bytes) with LONG_IBPS_MENU.
2018-09-19T22:09:32.768Z,1537394972.768 [BPC1](INFO): BPC1B valid message: 1596 bytes.
2018-09-19T22:09:32.795Z,1537394972.795 [BPC1](ERROR): BPC1B: No match for stick with serial number:0144 in the onboard configuration file.
2018-09-19T22:09:33.570Z,1537394973.570 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:09:40.357Z,1537394980.357 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:09:44.448Z,1537394984.448 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:09:44.509Z,1537394984.509 [BPC1](INFO): BPC1B: got 7 stick msg (1596 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:09:44.847Z,1537394984.847 [BPC1](INFO): BPC1B valid message: 1596 bytes.
2018-09-19T22:09:44.883Z,1537394984.883 [BPC1](ERROR): BPC1B: No match for stick with serial number:0144 in the onboard configuration file.
2018-09-19T22:09:45.654Z,1537394985.654 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:09:52.067Z,1537394992.067 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-09-19T22:04:51.8Z
2018-09-19T22:09:52.067Z,1537394992.067 [Default:CheckIn:Read_GPS] Stopped
2018-09-19T22:09:52.067Z,1537394992.067 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-09-19T22:09:52.441Z,1537394992.441 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:09:52.468Z,1537394992.468 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-09-19T22:09:56.652Z,1537394996.652 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:09:56.728Z,1537394996.728 [BPC1](INFO): BPC1B: got 7 stick msg (1596 bytes) with LONG_IBPS_MENU.
2018-09-19T22:09:56.769Z,1537394996.769 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180919T220100/Courier0004.lzma
2018-09-19T22:09:56.845Z,1537394996.845 [BPC1](INFO): BPC1B valid message: 1596 bytes.
2018-09-19T22:09:56.893Z,1537394996.893 [BPC1](ERROR): BPC1B: No match for stick with serial number:0144 in the onboard configuration file.
2018-09-19T22:09:57.564Z,1537394997.564 [DataOverHttps](INFO): Moved sent file to Logs/20180919T220100/Courier0004.lzma.bak
2018-09-19T22:09:57.565Z,1537394997.565 [DataOverHttps](INFO): SBD MOMSN=8540820
2018-09-19T22:09:57.626Z,1537394997.626 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:10:06.744Z,1537395006.744 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:10:06.814Z,1537395006.814 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20180919T215014/Express0005.lzma
2018-09-19T22:10:07.600Z,1537395007.600 [DataOverHttps](INFO): Moved sent file to Logs/20180919T215014/Express0005.lzma.bak
2018-09-19T22:10:07.601Z,1537395007.601 [DataOverHttps](INFO): SBD MOMSN=8540822
2018-09-19T22:10:11.636Z,1537395011.636 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:10:11.709Z,1537395011.709 [BPC1](INFO): BPC1B: got 7 stick msg (1596 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:10:11.823Z,1537395011.823 [BPC1](INFO): BPC1B valid message: 1596 bytes.
2018-09-19T22:10:11.859Z,1537395011.859 [BPC1](ERROR): BPC1B: No match for stick with serial number:0144 in the onboard configuration file.
2018-09-19T22:10:12.598Z,1537395012.598 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:10:16.688Z,1537395016.688 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20180919T215014/Express0008.lzma
2018-09-19T22:10:17.464Z,1537395017.464 [DataOverHttps](INFO): Moved sent file to Logs/20180919T215014/Express0008.lzma.bak
2018-09-19T22:10:17.465Z,1537395017.465 [DataOverHttps](INFO): SBD MOMSN=8540826
2018-09-19T22:10:21.532Z,1537395021.532 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:10:21.540Z,1537395021.540 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-19T22:10:21.540Z,1537395021.540 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2018-09-19T22:10:21.540Z,1537395021.540 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-19T22:10:21.542Z,1537395021.542 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-19T22:10:21.542Z,1537395021.542 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2018-09-19T22:10:21.542Z,1537395021.542 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-19T22:10:21.555Z,1537395021.555 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-19T22:10:21.556Z,1537395021.556 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-19T22:10:21.700Z,1537395021.700 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-19T22:10:21.700Z,1537395021.700 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2018-09-19T22:10:21.701Z,1537395021.701 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-19T22:10:21.701Z,1537395021.701 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2018-09-19T22:10:22.050Z,1537395022.050 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-19T22:10:22.051Z,1537395022.051 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-19T22:10:22.051Z,1537395022.051 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-19T22:10:22.051Z,1537395022.051 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-19T22:10:22.052Z,1537395022.052 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-19T22:10:22.052Z,1537395022.052 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-19T22:10:26.400Z,1537395026.400 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:10:26.462Z,1537395026.462 [BPC1](INFO): BPC1B: got 7 stick msg (1596 bytes) with LONG_IBPS_MENU.
2018-09-19T22:10:26.547Z,1537395026.547 [DataOverHttps](INFO): Sending 735 bytes from file Logs/20180919T220100/Express0001.lzma
2018-09-19T22:10:26.595Z,1537395026.595 [BPC1](INFO): BPC1B valid message: 1596 bytes.
2018-09-19T22:10:26.642Z,1537395026.642 [BPC1](ERROR): BPC1B: No match for stick with serial number:0144 in the onboard configuration file.
2018-09-19T22:10:27.328Z,1537395027.328 [DataOverHttps](INFO): Moved sent file to Logs/20180919T220100/Express0001.lzma.bak
2018-09-19T22:10:27.328Z,1537395027.328 [DataOverHttps](INFO): SBD MOMSN=8540829
2018-09-19T22:10:27.430Z,1537395027.430 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:10:36.304Z,1537395036.304 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:10:36.378Z,1537395036.378 [DataOverHttps](INFO): Sending 229 bytes from file Logs/20180919T220100/Express0005.lzma
2018-09-19T22:10:37.173Z,1537395037.173 [DataOverHttps](INFO): Moved sent file to Logs/20180919T220100/Express0005.lzma.bak
2018-09-19T22:10:37.173Z,1537395037.173 [DataOverHttps](INFO): SBD MOMSN=8540846
2018-09-19T22:10:37.735Z,1537395037.735 [Default:CheckIn:Read_Iridium] Stopped
2018-09-19T22:10:37.736Z,1537395037.736 [Default:CheckIn:C.Wait] Running Loop=1
2018-09-19T22:10:37.736Z,1537395037.736 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-09-19T22:10:41.191Z,1537395041.191 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:10:41.263Z,1537395041.263 [BPC1](INFO): BPC1B: got 7 stick msg (1596 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:10:41.413Z,1537395041.413 [BPC1](INFO): BPC1B valid message: 1596 bytes.
2018-09-19T22:10:41.440Z,1537395041.440 [BPC1](ERROR): BPC1B: No match for stick with serial number:0144 in the onboard configuration file.
2018-09-19T22:10:42.186Z,1537395042.186 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:10:49.357Z,1537395049.357 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:10:53.763Z,1537395053.763 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:10:53.836Z,1537395053.836 [BPC1](INFO): BPC1B: got 7 stick msg (1596 bytes) with LONG_IBPS_MENU.
2018-09-19T22:10:54.180Z,1537395054.180 [BPC1](INFO): BPC1B valid message: 1596 bytes.
2018-09-19T22:10:54.197Z,1537395054.197 [BPC1](ERROR): BPC1B: No match for stick with serial number:0144 in the onboard configuration file.
2018-09-19T22:10:54.962Z,1537395054.962 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:10:56.177Z,1537395056.177 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:11:00.574Z,1537395060.574 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:11:00.591Z,1537395060.591 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:11:00.945Z,1537395060.945 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:11:00.976Z,1537395060.976 [BPC1](ERROR): BPC1B: No match for stick with serial number:0140 in the onboard configuration file.
2018-09-19T22:11:01.782Z,1537395061.782 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:11:08.972Z,1537395068.972 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:11:13.764Z,1537395073.764 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:11:13.839Z,1537395073.839 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:11:14.175Z,1537395074.175 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:11:14.198Z,1537395074.198 [BPC1](ERROR): BPC1B: No match for stick with serial number:0140 in the onboard configuration file.
2018-09-19T22:11:14.982Z,1537395074.982 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:11:22.174Z,1537395082.174 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:11:26.948Z,1537395086.948 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:11:27.054Z,1537395087.054 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:11:27.368Z,1537395087.368 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:11:27.403Z,1537395087.403 [BPC1](ERROR): BPC1B: No match for stick with serial number:0140 in the onboard configuration file.
2018-09-19T22:11:28.186Z,1537395088.186 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:11:35.753Z,1537395095.753 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:11:41.386Z,1537395101.386 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:11:41.468Z,1537395101.468 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:11:41.596Z,1537395101.596 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:11:41.611Z,1537395101.611 [BPC1](ERROR): BPC1B: No match for stick with serial number:0140 in the onboard configuration file.
2018-09-19T22:11:42.350Z,1537395102.350 [RDI_Pathfinder](ERROR): Failed to parse:

2018-09-19T22:11:42.362Z,1537395102.362 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:11:49.553Z,1537395109.553 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:11:50.307Z,1537395110.307 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-09-19T22:11:50.307Z,1537395110.307 [NAL9602] Data Fault, FailCount= 1
2018-09-19T22:11:50.307Z,1537395110.307 [NAL9602](ERROR): Data Fault
2018-09-19T22:11:50.416Z,1537395110.416 [CBIT](ERROR): Data Fault in component: NAL9602
2018-09-19T22:11:50.716Z,1537395110.716 [NAL9602](INFO): Powering down
2018-09-19T22:11:51.590Z,1537395111.590 [CBIT](INFO): Clearing failed state for component NAL9602
2018-09-19T22:11:51.590Z,1537395111.590 [NAL9602] No Fault, FailCount= 1
2018-09-19T22:11:54.347Z,1537395114.347 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:11:54.428Z,1537395114.428 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:11:54.733Z,1537395114.733 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:11:54.756Z,1537395114.756 [BPC1](ERROR): BPC1B: No match for stick with serial number:0140 in the onboard configuration file.
2018-09-19T22:11:55.546Z,1537395115.546 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:12:02.380Z,1537395122.380 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:12:07.148Z,1537395127.148 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:12:07.232Z,1537395127.232 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:12:07.525Z,1537395127.525 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:12:07.528Z,1537395127.528 [BPC1](ERROR): BPC1B: No match for stick with serial number:0140 in the onboard configuration file.
2018-09-19T22:12:08.358Z,1537395128.358 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:12:13.942Z,1537395133.942 [BPC1](ERROR): Failed to receive data from all battery packs.
2018-09-19T22:12:13.942Z,1537395133.942 [BPC1] Communications Fault, FailCount= 5
2018-09-19T22:12:13.942Z,1537395133.942 [BPC1](ERROR): Communications Fault
2018-09-19T22:12:13.963Z,1537395133.963 [CBIT](ERROR): Communications Fault in component: BPC1
2018-09-19T22:12:15.173Z,1537395135.173 [CBIT](INFO): Clearing failed state for component BPC1
2018-09-19T22:12:15.173Z,1537395135.173 [BPC1] No Fault, FailCount= 5
2018-09-19T22:12:21.107Z,1537395141.107 [NAL9602](INFO): Powering up NAL9602
2018-09-19T22:12:32.307Z,1537395152.307 [NAL9602](INFO): NAL9602 initialized
2018-09-19T22:13:16.442Z,1537395196.442 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:13:16.458Z,1537395196.458 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:13:17.652Z,1537395197.652 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:13:22.072Z,1537395202.072 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:13:22.088Z,1537395202.088 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:13:22.096Z,1537395202.096 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-19T22:13:22.096Z,1537395202.096 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2018-09-19T22:13:22.096Z,1537395202.096 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-19T22:13:22.098Z,1537395202.098 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-19T22:13:22.099Z,1537395202.099 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2018-09-19T22:13:22.099Z,1537395202.099 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-19T22:13:22.164Z,1537395202.164 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-19T22:13:22.164Z,1537395202.164 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-19T22:13:22.434Z,1537395202.434 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:13:22.438Z,1537395202.438 [BPC1](ERROR): BPC1A: No match for stick with serial number:0165 in the onboard configuration file.
2018-09-19T22:13:22.496Z,1537395202.496 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-19T22:13:22.496Z,1537395202.496 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2018-09-19T22:13:22.497Z,1537395202.497 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-19T22:13:22.497Z,1537395202.497 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2018-09-19T22:13:22.879Z,1537395202.879 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-19T22:13:22.879Z,1537395202.879 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-19T22:13:22.880Z,1537395202.880 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-19T22:13:22.880Z,1537395202.880 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-19T22:13:22.881Z,1537395202.881 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-19T22:13:22.881Z,1537395202.881 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-19T22:13:23.286Z,1537395203.286 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:13:23.656Z,1537395203.656 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:13:28.451Z,1537395208.451 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:13:28.535Z,1537395208.535 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:13:28.844Z,1537395208.844 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:13:28.857Z,1537395208.857 [BPC1](ERROR): BPC1B: No match for stick with serial number:012D in the onboard configuration file.
2018-09-19T22:13:29.662Z,1537395209.662 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:13:30.833Z,1537395210.833 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:13:35.640Z,1537395215.640 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:13:35.716Z,1537395215.716 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:13:36.075Z,1537395216.075 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:13:36.096Z,1537395216.096 [BPC1](ERROR): BPC1A: No match for stick with serial number:0131 in the onboard configuration file.
2018-09-19T22:13:36.846Z,1537395216.846 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:13:36.846Z,1537395216.846 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:13:41.643Z,1537395221.643 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:13:41.724Z,1537395221.724 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:13:41.844Z,1537395221.844 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:13:41.862Z,1537395221.862 [BPC1](ERROR): BPC1B: No match for stick with serial number:012D in the onboard configuration file.
2018-09-19T22:13:42.998Z,1537395222.998 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:13:44.226Z,1537395224.226 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:13:48.981Z,1537395228.981 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:13:49.080Z,1537395229.080 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:13:49.411Z,1537395229.411 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:13:49.440Z,1537395229.440 [BPC1](ERROR): BPC1A: No match for stick with serial number:0131 in the onboard configuration file.
2018-09-19T22:13:50.226Z,1537395230.226 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:13:50.226Z,1537395230.226 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:13:54.985Z,1537395234.985 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:13:55.086Z,1537395235.086 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:13:55.392Z,1537395235.392 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:13:55.428Z,1537395235.428 [BPC1](ERROR): BPC1B: No match for stick with serial number:012D in the onboard configuration file.
2018-09-19T22:13:56.238Z,1537395236.238 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:13:57.799Z,1537395237.799 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:14:02.592Z,1537395242.592 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:14:02.671Z,1537395242.671 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:14:03.021Z,1537395243.021 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:14:03.055Z,1537395243.055 [BPC1](ERROR): BPC1A: No match for stick with serial number:0131 in the onboard configuration file.
2018-09-19T22:14:03.814Z,1537395243.814 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:14:03.814Z,1537395243.814 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:14:08.593Z,1537395248.593 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:14:08.679Z,1537395248.679 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:14:08.982Z,1537395248.982 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:14:09.006Z,1537395249.006 [BPC1](ERROR): BPC1B: No match for stick with serial number:012D in the onboard configuration file.
2018-09-19T22:14:09.814Z,1537395249.814 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:14:10.986Z,1537395250.986 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:14:15.796Z,1537395255.796 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:14:15.871Z,1537395255.871 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:14:16.221Z,1537395256.221 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:14:16.242Z,1537395256.242 [BPC1](ERROR): BPC1A: No match for stick with serial number:0131 in the onboard configuration file.
2018-09-19T22:14:17.006Z,1537395257.006 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:14:17.007Z,1537395257.007 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:14:21.807Z,1537395261.807 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:14:21.878Z,1537395261.878 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:14:22.218Z,1537395262.218 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:14:22.259Z,1537395262.259 [BPC1](ERROR): BPC1B: No match for stick with serial number:012D in the onboard configuration file.
2018-09-19T22:14:23.010Z,1537395263.010 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:14:24.218Z,1537395264.218 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:14:28.997Z,1537395268.997 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:14:29.070Z,1537395269.070 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:14:29.403Z,1537395269.403 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:14:29.425Z,1537395269.425 [BPC1](ERROR): BPC1A: No match for stick with serial number:0131 in the onboard configuration file.
2018-09-19T22:14:30.218Z,1537395270.218 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:14:30.218Z,1537395270.218 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:14:35.010Z,1537395275.010 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:14:35.276Z,1537395275.276 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:14:35.516Z,1537395275.516 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:14:35.581Z,1537395275.581 [BPC1](ERROR): BPC1B: No match for stick with serial number:012D in the onboard configuration file.
2018-09-19T22:14:36.238Z,1537395276.238 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:14:37.427Z,1537395277.427 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:14:42.363Z,1537395282.363 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:14:42.436Z,1537395282.436 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:14:42.748Z,1537395282.748 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:14:42.772Z,1537395282.772 [BPC1](ERROR): BPC1A: No match for stick with serial number:0131 in the onboard configuration file.
2018-09-19T22:14:43.170Z,1537395283.170 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:14:43.534Z,1537395283.534 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:14:47.932Z,1537395287.932 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:14:48.003Z,1537395288.003 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:14:48.350Z,1537395288.350 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:14:48.388Z,1537395288.388 [BPC1](ERROR): BPC1B: No match for stick with serial number:012D in the onboard configuration file.
2018-09-19T22:14:49.142Z,1537395289.142 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:14:51.136Z,1537395291.136 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:14:55.517Z,1537395295.517 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:14:55.600Z,1537395295.600 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:14:55.922Z,1537395295.922 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:14:55.925Z,1537395295.925 [BPC1](ERROR): BPC1A: No match for stick with serial number:0131 in the onboard configuration file.
2018-09-19T22:14:56.742Z,1537395296.742 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:14:56.742Z,1537395296.742 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:15:01.540Z,1537395301.540 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:15:01.632Z,1537395301.632 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:15:01.921Z,1537395301.921 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:15:01.940Z,1537395301.940 [BPC1](ERROR): BPC1B: No match for stick with serial number:012D in the onboard configuration file.
2018-09-19T22:15:02.738Z,1537395302.738 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:15:04.344Z,1537395304.344 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:15:09.136Z,1537395309.136 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:15:09.234Z,1537395309.234 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:15:09.549Z,1537395309.549 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:15:09.577Z,1537395309.577 [BPC1](ERROR): BPC1A: No match for stick with serial number:0131 in the onboard configuration file.
2018-09-19T22:15:10.334Z,1537395310.334 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:15:10.334Z,1537395310.334 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:15:15.149Z,1537395315.149 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:15:15.232Z,1537395315.232 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:15:15.532Z,1537395315.532 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:15:15.536Z,1537395315.536 [BPC1](ERROR): BPC1B: No match for stick with serial number:012D in the onboard configuration file.
2018-09-19T22:15:16.354Z,1537395316.354 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:15:17.517Z,1537395317.517 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:15:22.340Z,1537395322.340 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:15:22.424Z,1537395322.424 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:15:22.713Z,1537395322.713 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:15:22.724Z,1537395322.724 [BPC1](ERROR): BPC1A: No match for stick with serial number:0131 in the onboard configuration file.
2018-09-19T22:15:23.530Z,1537395323.530 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:15:23.530Z,1537395323.530 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:15:28.330Z,1537395328.330 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:15:28.417Z,1537395328.417 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:15:28.724Z,1537395328.724 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:15:28.727Z,1537395328.727 [BPC1](ERROR): BPC1B: No match for stick with serial number:012D in the onboard configuration file.
2018-09-19T22:15:29.550Z,1537395329.550 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:15:30.351Z,1537395330.351 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:15:35.132Z,1537395335.132 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:15:35.225Z,1537395335.225 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:15:35.522Z,1537395335.522 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:15:35.549Z,1537395335.549 [BPC1](ERROR): BPC1A: No match for stick with serial number:0131 in the onboard configuration file.
2018-09-19T22:15:36.362Z,1537395336.362 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:15:37.135Z,1537395337.135 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:15:38.366Z,1537395338.366 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-09-19T22:15:38.367Z,1537395338.367 [Default:CheckIn:C.Wait] Stopped
2018-09-19T22:15:38.367Z,1537395338.367 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-09-19T22:15:38.367Z,1537395338.367 [Default:CheckIn:D] Running Loop=1
2018-09-19T22:15:38.746Z,1537395338.746 [Default:CheckIn:D] Stopped
2018-09-19T22:15:38.746Z,1537395338.746 [Default:CheckIn:E] Running Loop=1
2018-09-19T22:15:41.936Z,1537395341.936 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:15:42.039Z,1537395342.039 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:15:42.051Z,1537395342.051 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.010428 min 
2018-09-19T22:15:42.053Z,1537395342.053 [Default:CheckIn:E] Stopped
2018-09-19T22:15:42.053Z,1537395342.053 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-09-19T22:15:42.053Z,1537395342.053 [Default:CheckIn] Stopped
2018-09-19T22:15:42.053Z,1537395342.053 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-09-19T22:15:42.053Z,1537395342.053 [Default:CheckIn](INFO): Running loop #2
2018-09-19T22:15:42.053Z,1537395342.053 [Default:CheckIn] Running Loop=2
2018-09-19T22:15:42.095Z,1537395342.095 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-09-19T22:15:42.095Z,1537395342.095 [Default:CheckIn:Read_GPS] Running Loop=1
2018-09-19T22:15:42.227Z,1537395342.227 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:15:42.255Z,1537395342.255 [BPC1](ERROR): BPC1B: No match for stick with serial number:012D in the onboard configuration file.
2018-09-19T22:15:42.984Z,1537395342.984 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:15:43.768Z,1537395343.768 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:15:48.568Z,1537395348.568 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:15:48.655Z,1537395348.655 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:15:48.959Z,1537395348.959 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:15:48.998Z,1537395348.998 [BPC1](ERROR): BPC1A: No match for stick with serial number:0131 in the onboard configuration file.
2018-09-19T22:15:49.778Z,1537395349.778 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:15:50.579Z,1537395350.579 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:15:54.973Z,1537395354.973 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:15:55.062Z,1537395355.062 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:15:55.379Z,1537395355.379 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:15:55.398Z,1537395355.398 [BPC1](ERROR): BPC1B: No match for stick with serial number:0130 in the onboard configuration file.
2018-09-19T22:15:56.206Z,1537395356.206 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:15:56.954Z,1537395356.954 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:16:01.799Z,1537395361.799 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:16:01.877Z,1537395361.877 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:16:02.194Z,1537395362.194 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:16:02.240Z,1537395362.240 [BPC1](ERROR): BPC1A: No match for stick with serial number:014B in the onboard configuration file.
2018-09-19T22:16:02.974Z,1537395362.974 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:16:03.769Z,1537395363.769 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:16:08.579Z,1537395368.579 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:16:08.660Z,1537395368.660 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:16:08.961Z,1537395368.961 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:16:08.973Z,1537395368.973 [BPC1](ERROR): BPC1B: No match for stick with serial number:0130 in the onboard configuration file.
2018-09-19T22:16:09.778Z,1537395369.778 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:16:10.188Z,1537395370.188 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:16:14.975Z,1537395374.975 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:16:15.072Z,1537395375.072 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU.
2018-09-19T22:16:15.380Z,1537395375.380 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:16:15.412Z,1537395375.412 [BPC1](ERROR): BPC1A: No match for stick with serial number:014B in the onboard configuration file.
2018-09-19T22:16:16.214Z,1537395376.214 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:16:17.380Z,1537395377.380 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:16:19.814Z,1537395379.814 [CBIT](INFO): Clearing failed state for component DropWeight
2018-09-19T22:16:19.814Z,1537395379.814 [DropWeight] No Fault, FailCount= 1
2018-09-19T22:16:22.198Z,1537395382.198 [BPC1](INFO): BPC1B: validating data format.
2018-09-19T22:16:22.280Z,1537395382.280 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:16:22.579Z,1537395382.579 [BPC1](INFO): BPC1B valid message: 1824 bytes.
2018-09-19T22:16:22.616Z,1537395382.616 [BPC1](ERROR): BPC1B: No match for stick with serial number:0130 in the onboard configuration file.
2018-09-19T22:16:22.984Z,1537395382.984 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-19T22:16:22.984Z,1537395382.984 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2018-09-19T22:16:22.984Z,1537395382.984 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-19T22:16:22.991Z,1537395382.991 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-19T22:16:22.992Z,1537395382.992 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2018-09-19T22:16:22.992Z,1537395382.992 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-19T22:16:23.042Z,1537395383.042 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-19T22:16:23.042Z,1537395383.042 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-19T22:16:23.376Z,1537395383.376 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-19T22:16:23.390Z,1537395383.390 [BPC1](INFO): BPC1B: initialized.
2018-09-19T22:16:23.446Z,1537395383.446 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-19T22:16:23.446Z,1537395383.446 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2018-09-19T22:16:23.447Z,1537395383.447 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-19T22:16:23.447Z,1537395383.447 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2018-09-19T22:16:23.802Z,1537395383.802 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-19T22:16:23.802Z,1537395383.802 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-19T22:16:23.802Z,1537395383.802 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-19T22:16:23.803Z,1537395383.803 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-19T22:16:23.803Z,1537395383.803 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-19T22:16:23.804Z,1537395383.804 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-19T22:16:28.188Z,1537395388.188 [BPC1](INFO): BPC1A: validating data format.
2018-09-19T22:16:28.272Z,1537395388.272 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU.
2018-09-19T22:16:28.591Z,1537395388.591 [BPC1](INFO): BPC1A valid message: 1824 bytes.
2018-09-19T22:16:28.613Z,1537395388.613 [BPC1](ERROR): BPC1A: No match for stick with serial number:014B in the onboard configuration file.
2018-09-19T22:16:29.402Z,1537395389.402 [BPC1](INFO): BPC1A: initialized.
2018-09-19T22:16:30.791Z,1537395390.791 [CommandLine](IMPORTANT): got command restart application
2018-09-19T22:16:30.965Z,1537395390.965 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-19T22:16:31.801Z,1537395391.801 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-19T22:16:31.801Z,1537395391.801 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:31.913Z,1537395391.913 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-09-19T22:16:31.914Z,1537395391.914 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:31.914Z,1537395391.914 [CommandLine](INFO): Join timeout helper Thread ID is 1201
2018-09-19T22:16:31.915Z,1537395391.915 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-09-19T22:16:31.915Z,1537395391.915 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:31.916Z,1537395391.916 [NavChartDb](INFO): Join timeout helper Thread ID is 1202
2018-09-19T22:16:32.106Z,1537395392.106 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-19T22:16:32.106Z,1537395392.106 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:32.114Z,1537395392.114 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-09-19T22:16:32.114Z,1537395392.114 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:32.114Z,1537395392.114 [Radio_Surface](INFO): Join timeout helper Thread ID is 1203
2018-09-19T22:16:32.430Z,1537395392.430 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-19T22:16:32.430Z,1537395392.430 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:32.442Z,1537395392.442 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2018-09-19T22:16:32.442Z,1537395392.442 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:32.442Z,1537395392.442 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 1204
2018-09-19T22:16:32.454Z,1537395392.454 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-19T22:16:32.454Z,1537395392.454 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-09-19T22:16:32.455Z,1537395392.455 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:32.462Z,1537395392.462 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-09-19T22:16:32.462Z,1537395392.462 [logger ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:32.462Z,1537395392.462 [logger](INFO): Join timeout helper Thread ID is 1205
2018-09-19T22:16:32.476Z,1537395392.476 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-19T22:16:32.476Z,1537395392.476 [logger ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:32.491Z,1537395392.491 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-09-19T22:16:32.491Z,1537395392.491 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:32.491Z,1537395392.491 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-09-19T22:16:32.491Z,1537395392.491 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:32.491Z,1537395392.491 [controlThread](INFO): Join timeout helper Thread ID is 1206
2018-09-19T22:16:32.522Z,1537395392.522 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-19T22:16:32.522Z,1537395392.522 [controlThread](DEBUG): Uninitializing ControlThread
2018-09-19T22:16:32.522Z,1537395392.522 [Aanderaa_O2](INFO): Powering down
2018-09-19T22:16:32.523Z,1537395392.523 [AHRS_M2](INFO): Powering down
2018-09-19T22:16:32.595Z,1537395392.595 [NAL9602](INFO): Powering down
2018-09-19T22:16:32.666Z,1537395392.666 [RDI_Pathfinder](INFO): Powering down
2018-09-19T22:16:32.667Z,1537395392.667 [RDI_PathfinderUp](INFO): Powering down
2018-09-19T22:16:32.668Z,1537395392.668 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-09-19T22:16:32.670Z,1537395392.670 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-09-19T22:16:32.670Z,1537395392.670 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-09-19T22:16:32.671Z,1537395392.671 [MissionManager](INFO): Uninitializing Mission Default
2018-09-19T22:16:32.671Z,1537395392.671 [Default] Stopped
2018-09-19T22:16:32.671Z,1537395392.671 [Default](DEBUG): Aggregate::uninitialize Default
2018-09-19T22:16:32.671Z,1537395392.671 [Default:B.GoToSurface] Stopped
2018-09-19T22:16:32.671Z,1537395392.671 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-09-19T22:16:32.671Z,1537395392.671 [Default:CheckIn] Stopped
2018-09-19T22:16:32.672Z,1537395392.672 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-09-19T22:16:32.672Z,1537395392.672 [Default:CheckIn:Read_GPS] Stopped
2018-09-19T22:16:32.675Z,1537395392.675 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-09-19T22:16:32.675Z,1537395392.675 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-09-19T22:16:32.676Z,1537395392.676 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-09-19T22:16:32.676Z,1537395392.676 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-09-19T22:16:32.676Z,1537395392.676 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-09-19T22:16:32.677Z,1537395392.677 [BuoyancyServo](INFO): Powering down
2018-09-19T22:16:32.690Z,1537395392.690 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-09-19T22:16:32.690Z,1537395392.690 [ElevatorServo](INFO): Powering down
2018-09-19T22:16:32.691Z,1537395392.691 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-09-19T22:16:32.691Z,1537395392.691 [MassServo](INFO): Powering down
2018-09-19T22:16:32.692Z,1537395392.692 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-09-19T22:16:32.692Z,1537395392.692 [RudderServo](INFO): Powering down
2018-09-19T22:16:32.693Z,1537395392.693 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-09-19T22:16:32.693Z,1537395392.693 [ThrusterServo](INFO): Powering down
2018-09-19T22:16:32.694Z,1537395392.694 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-09-19T22:16:32.694Z,1537395392.694 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-09-19T22:16:32.695Z,1537395392.695 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-09-19T22:16:32.696Z,1537395392.696 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:32.758Z,1537395392.758 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:32.820Z,1537395392.820 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:32.865Z,1537395392.865 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-09-19T22:16:32.924Z,1537395392.924 [logger ThreadHandler](INFO): Thread cancelled.