2018-09-18T17:51:45.654Z,1537293105.654 [Supervisor](DEBUG): Initializing supervisor.
2018-09-18T17:51:45.657Z,1537293105.657 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-09-18T17:51:45.658Z,1537293105.658 [SyncHandler](INFO): Protected caller Thread ID is 797
2018-09-18T17:51:45.658Z,1537293105.658 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-09-18T17:51:45.659Z,1537293105.659 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-09-18T17:51:45.659Z,1537293105.659 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 798
2018-09-18T17:51:45.662Z,1537293105.662 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-09-18T17:51:45.674Z,1537293105.674 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-09-18T17:51:45.675Z,1537293105.675 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-09-18T17:51:45.675Z,1537293105.675 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 799
2018-09-18T17:51:45.676Z,1537293105.676 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-09-18T17:51:45.677Z,1537293105.677 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-09-18T17:51:45.678Z,1537293105.678 [logger ThreadHandler](INFO): Protected caller Thread ID is 800
2018-09-18T17:51:45.680Z,1537293105.680 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-09-18T17:51:45.680Z,1537293105.680 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-09-18T17:51:45.684Z,1537293105.684 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-09-18T17:51:46.072Z,1537293106.072 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-09-18T17:51:46.073Z,1537293106.073 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-09-18T17:51:46.302Z,1537293106.302 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-09-18T17:51:46.303Z,1537293106.303 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-09-18T17:51:46.642Z,1537293106.642 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-09-18T17:51:46.643Z,1537293106.643 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-09-18T17:51:46.795Z,1537293106.795 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-09-18T17:51:46.797Z,1537293106.797 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-09-18T17:51:46.899Z,1537293106.899 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-09-18T17:51:46.899Z,1537293106.899 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-09-18T17:51:47.431Z,1537293107.431 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-09-18T17:51:47.432Z,1537293107.432 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-09-18T17:51:47.937Z,1537293107.937 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-09-18T17:51:47.938Z,1537293107.938 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-09-18T17:51:48.464Z,1537293108.464 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-09-18T17:51:48.466Z,1537293108.466 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-09-18T17:51:48.577Z,1537293108.577 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-09-18T17:51:48.578Z,1537293108.578 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-09-18T17:51:48.681Z,1537293108.681 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-09-18T17:51:48.682Z,1537293108.682 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-09-18T17:51:48.908Z,1537293108.908 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-09-18T17:51:48.910Z,1537293108.910 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-09-18T17:51:49.132Z,1537293109.132 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-09-18T17:51:49.132Z,1537293109.132 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-09-18T17:51:49.567Z,1537293109.567 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-09-18T17:51:50.045Z,1537293110.045 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-09-18T17:51:50.368Z,1537293110.368 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-09-18T17:51:50.369Z,1537293110.369 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-09-18T17:51:50.454Z,1537293110.454 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2018-09-18T17:51:50.457Z,1537293110.457 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2018-09-18T17:51:50.568Z,1537293110.568 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2018-09-18T17:51:50.697Z,1537293110.697 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2018-09-18T17:51:50.797Z,1537293110.797 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2018-09-18T17:51:50.886Z,1537293110.886 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2018-09-18T17:51:51.060Z,1537293111.060 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2018-09-18T17:51:51.259Z,1537293111.259 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2018-09-18T17:51:51.337Z,1537293111.337 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2018-09-18T17:51:51.583Z,1537293111.583 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-09-18T17:51:51.584Z,1537293111.584 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2018-09-18T17:51:51.670Z,1537293111.670 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2018-09-18T17:51:51.765Z,1537293111.765 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2018-09-18T17:51:51.874Z,1537293111.874 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2018-09-18T17:51:52.012Z,1537293112.012 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2018-09-18T17:51:52.016Z,1537293112.016 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-09-18T17:51:52.317Z,1537293112.317 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-09-18T17:51:52.319Z,1537293112.319 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-09-18T17:51:52.378Z,1537293112.378 [DepthRateCalculator] Loaded
2018-09-18T17:51:52.378Z,1537293112.378 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-09-18T17:51:52.385Z,1537293112.385 [PitchRateCalculator] Loaded
2018-09-18T17:51:52.385Z,1537293112.385 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-09-18T17:51:52.403Z,1537293112.403 [SpeedCalculator] Loaded
2018-09-18T17:51:52.404Z,1537293112.404 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-09-18T17:51:52.428Z,1537293112.428 [TempGradientCalculator] Loaded
2018-09-18T17:51:52.428Z,1537293112.428 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-09-18T17:51:52.462Z,1537293112.462 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2018-09-18T17:51:52.462Z,1537293112.462 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2018-09-18T17:51:52.478Z,1537293112.478 [YawRateCalculator] Loaded
2018-09-18T17:51:52.478Z,1537293112.478 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-09-18T17:51:52.582Z,1537293112.582 [ElevatorOffsetCalculator] Loaded
2018-09-18T17:51:52.583Z,1537293112.583 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-09-18T17:51:52.583Z,1537293112.583 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-09-18T17:51:52.584Z,1537293112.584 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-09-18T17:51:52.693Z,1537293112.693 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-09-18T17:51:52.695Z,1537293112.695 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-09-18T17:51:52.836Z,1537293112.836 [BuoyancyServo] Loaded
2018-09-18T17:51:52.836Z,1537293112.836 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-09-18T17:51:52.852Z,1537293112.852 [ElevatorServo] Loaded
2018-09-18T17:51:52.853Z,1537293112.853 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-09-18T17:51:52.869Z,1537293112.869 [MassServo] Loaded
2018-09-18T17:51:52.869Z,1537293112.869 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-09-18T17:51:52.886Z,1537293112.886 [RudderServo] Loaded
2018-09-18T17:51:52.886Z,1537293112.886 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-09-18T17:51:52.902Z,1537293112.902 [ThrusterServo] Loaded
2018-09-18T17:51:52.902Z,1537293112.902 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-09-18T17:51:52.902Z,1537293112.902 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-09-18T17:51:52.904Z,1537293112.904 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-09-18T17:51:52.929Z,1537293112.929 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-09-18T17:51:52.931Z,1537293112.931 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-09-18T17:51:53.065Z,1537293113.065 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-09-18T17:51:53.066Z,1537293113.066 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-09-18T17:51:53.646Z,1537293113.646 [DataOverHttps] Loaded
2018-09-18T17:51:53.647Z,1537293113.647 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-09-18T17:51:53.661Z,1537293113.661 [Depth_Keller] Loaded
2018-09-18T17:51:53.662Z,1537293113.662 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-09-18T17:51:53.667Z,1537293113.667 [DropWeight] Loaded
2018-09-18T17:51:53.667Z,1537293113.667 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-09-18T17:51:53.775Z,1537293113.775 [NAL9602] Loaded
2018-09-18T17:51:53.775Z,1537293113.775 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-09-18T17:51:53.793Z,1537293113.793 [Onboard] Loaded
2018-09-18T17:51:53.793Z,1537293113.793 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-09-18T17:51:53.805Z,1537293113.805 [Radio_Surface] Loaded
2018-09-18T17:51:53.805Z,1537293113.805 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-09-18T17:51:53.806Z,1537293113.806 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408894E0
2018-09-18T17:51:53.807Z,1537293113.807 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 884
2018-09-18T17:51:53.964Z,1537293113.964 [PNI_TCM] Loaded
2018-09-18T17:51:53.964Z,1537293113.964 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2018-09-18T17:51:54.031Z,1537293114.031 [Rowe_600LCM] Loaded
2018-09-18T17:51:54.032Z,1537293114.032 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2018-09-18T17:51:54.033Z,1537293114.033 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 408B94E0
2018-09-18T17:51:54.033Z,1537293114.033 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 885
2018-09-18T17:51:54.056Z,1537293114.056 [BPC1](CRITICAL): No configuration setting for: BPC1.batteryCommsTimout
2018-09-18T17:51:54.060Z,1537293114.060 [BPC1](INFO): BPC1A: got serial number for stick 1: 0138
2018-09-18T17:51:54.061Z,1537293114.061 [BPC1](INFO): BPC1A: got serial number for stick 2: 0125
2018-09-18T17:51:54.062Z,1537293114.062 [BPC1](INFO): BPC1A: got serial number for stick 3: 00EF
2018-09-18T17:51:54.063Z,1537293114.063 [BPC1](INFO): BPC1A: got serial number for stick 4: 0158
2018-09-18T17:51:54.064Z,1537293114.064 [BPC1](INFO): BPC1A: got serial number for stick 5: 0088
2018-09-18T17:51:54.065Z,1537293114.065 [BPC1](INFO): BPC1A: got serial number for stick 6: 00A3
2018-09-18T17:51:54.066Z,1537293114.066 [BPC1](INFO): BPC1A: got serial number for stick 7: 012D
2018-09-18T17:51:54.067Z,1537293114.067 [BPC1](INFO): BPC1A: got serial number for stick 8: 00E7
2018-09-18T17:51:54.067Z,1537293114.067 [BPC1](INFO): BPC1A: got serial number for stick 9: 0100
2018-09-18T17:51:54.068Z,1537293114.068 [BPC1](INFO): BPC1A: got serial number for stick 10: 00B9
2018-09-18T17:51:54.069Z,1537293114.069 [BPC1](INFO): BPC1A: got serial number for stick 11: 008C
2018-09-18T17:51:54.070Z,1537293114.070 [BPC1](INFO): BPC1A: got serial number for stick 12: 0117
2018-09-18T17:51:54.071Z,1537293114.071 [BPC1](INFO): BPC1A: got serial number for stick 13: 00E4
2018-09-18T17:51:54.071Z,1537293114.071 [BPC1](INFO): BPC1A: got serial number for stick 14: 011D
2018-09-18T17:51:54.072Z,1537293114.072 [BPC1](INFO): BPC1A: got serial number for stick 15: 014E
2018-09-18T17:51:54.073Z,1537293114.073 [BPC1](INFO): BPC1A: got serial number for stick 16: 00EC
2018-09-18T17:51:54.074Z,1537293114.074 [BPC1](INFO): BPC1A: got serial number for stick 17: 008A
2018-09-18T17:51:54.075Z,1537293114.075 [BPC1](INFO): BPC1A: got serial number for stick 18: 0140
2018-09-18T17:51:54.076Z,1537293114.076 [BPC1](INFO): BPC1A: got serial number for stick 19: 00E5
2018-09-18T17:51:54.077Z,1537293114.077 [BPC1](INFO): BPC1A: got serial number for stick 20: 00E0
2018-09-18T17:51:54.077Z,1537293114.077 [BPC1](INFO): BPC1A: got serial number for stick 21: 00CD
2018-09-18T17:51:54.078Z,1537293114.078 [BPC1](INFO): BPC1A: got serial number for stick 22: 009F
2018-09-18T17:51:54.079Z,1537293114.079 [BPC1](INFO): BPC1A: got serial number for stick 23: 009C
2018-09-18T17:51:54.080Z,1537293114.080 [BPC1](INFO): BPC1A: got serial number for stick 24: 00A6
2018-09-18T17:51:54.081Z,1537293114.081 [BPC1](INFO): BPC1A: got serial number for stick 25: 00E8
2018-09-18T17:51:54.081Z,1537293114.081 [BPC1](INFO): BPC1A: got serial number for stick 26: 00D1
2018-09-18T17:51:54.082Z,1537293114.082 [BPC1](INFO): BPC1A: got serial number for stick 27: 00F3
2018-09-18T17:51:54.083Z,1537293114.083 [BPC1](INFO): BPC1A: got serial number for stick 28: 0092
2018-09-18T17:51:54.084Z,1537293114.084 [BPC1](INFO): BPC1A: got serial number for stick 29: 00AD
2018-09-18T17:51:54.085Z,1537293114.085 [BPC1](INFO): BPC1A: got serial number for stick 30: 00E9
2018-09-18T17:51:54.086Z,1537293114.086 [BPC1](INFO): BPC1A: got serial number for stick 31: 0126
2018-09-18T17:51:54.087Z,1537293114.087 [BPC1](INFO): BPC1B: got serial number for stick 32: 0157
2018-09-18T17:51:54.088Z,1537293114.088 [BPC1](INFO): BPC1B: got serial number for stick 33: 00F1
2018-09-18T17:51:54.089Z,1537293114.089 [BPC1](INFO): BPC1B: got serial number for stick 34: 00BF
2018-09-18T17:51:54.090Z,1537293114.090 [BPC1](INFO): BPC1B: got serial number for stick 35: 0089
2018-09-18T17:51:54.091Z,1537293114.091 [BPC1](INFO): BPC1B: got serial number for stick 36: 00C2
2018-09-18T17:51:54.091Z,1537293114.091 [BPC1](INFO): BPC1B: got serial number for stick 37: 00CA
2018-09-18T17:51:54.092Z,1537293114.092 [BPC1](INFO): BPC1B: got serial number for stick 38: 011A
2018-09-18T17:51:54.093Z,1537293114.093 [BPC1](INFO): BPC1B: got serial number for stick 39: 00FD
2018-09-18T17:51:54.094Z,1537293114.094 [BPC1](INFO): BPC1B: got serial number for stick 40: 0095
2018-09-18T17:51:54.095Z,1537293114.095 [BPC1](INFO): BPC1B: got serial number for stick 41: 00BE
2018-09-18T17:51:54.096Z,1537293114.096 [BPC1](INFO): BPC1B: got serial number for stick 42: 0086
2018-09-18T17:51:54.096Z,1537293114.096 [BPC1](INFO): BPC1B: got serial number for stick 43: 00AE
2018-09-18T17:51:54.097Z,1537293114.097 [BPC1](INFO): BPC1B: got serial number for stick 44: 00CB
2018-09-18T17:51:54.098Z,1537293114.098 [BPC1](INFO): BPC1B: got serial number for stick 45: 00F7
2018-09-18T17:51:54.099Z,1537293114.099 [BPC1](INFO): BPC1B: got serial number for stick 46: 00A1
2018-09-18T17:51:54.100Z,1537293114.100 [BPC1](INFO): BPC1B: got serial number for stick 47: 00F0
2018-09-18T17:51:54.101Z,1537293114.101 [BPC1](INFO): BPC1B: got serial number for stick 48: 00C9
2018-09-18T17:51:54.101Z,1537293114.101 [BPC1](INFO): BPC1B: got serial number for stick 49: 0103
2018-09-18T17:51:54.102Z,1537293114.102 [BPC1](INFO): BPC1B: got serial number for stick 50: 0152
2018-09-18T17:51:54.103Z,1537293114.103 [BPC1](INFO): BPC1B: got serial number for stick 51: 014A
2018-09-18T17:51:54.104Z,1537293114.104 [BPC1](INFO): BPC1B: got serial number for stick 52: 0114
2018-09-18T17:51:54.105Z,1537293114.105 [BPC1](INFO): BPC1B: got serial number for stick 53: 015E
2018-09-18T17:51:54.106Z,1537293114.106 [BPC1](INFO): BPC1B: got serial number for stick 54: 008E
2018-09-18T17:51:54.106Z,1537293114.106 [BPC1](INFO): BPC1B: got serial number for stick 55: 00AC
2018-09-18T17:51:54.107Z,1537293114.107 [BPC1](INFO): BPC1B: got serial number for stick 56: 0091
2018-09-18T17:51:54.108Z,1537293114.108 [BPC1](INFO): BPC1B: got serial number for stick 57: 0153
2018-09-18T17:51:54.109Z,1537293114.109 [BPC1](INFO): BPC1B: got serial number for stick 58: 00AF
2018-09-18T17:51:54.110Z,1537293114.110 [BPC1](INFO): BPC1B: got serial number for stick 59: 0151
2018-09-18T17:51:54.110Z,1537293114.110 [BPC1](INFO): BPC1B: got serial number for stick 60: 00DC
2018-09-18T17:51:54.111Z,1537293114.111 [BPC1](INFO): BPC1B: got serial number for stick 61: 00BA
2018-09-18T17:51:54.112Z,1537293114.112 [BPC1](INFO): BPC1B: got serial number for stick 62: 00DA
2018-09-18T17:51:56.620Z,1537293116.620 [BPC1] Loaded
2018-09-18T17:51:56.620Z,1537293116.620 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-09-18T17:51:56.621Z,1537293116.621 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-09-18T17:51:56.621Z,1537293116.621 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-09-18T17:51:56.785Z,1537293116.785 [SBIT](DEBUG): Construct Startup Built In Test.
2018-09-18T17:51:56.810Z,1537293116.810 [SBIT] Loaded
2018-09-18T17:51:56.810Z,1537293116.810 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-09-18T17:51:56.811Z,1537293116.811 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-09-18T17:51:56.823Z,1537293116.823 [IBIT] Loaded
2018-09-18T17:51:56.823Z,1537293116.823 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-09-18T17:51:56.827Z,1537293116.827 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-09-18T17:51:56.990Z,1537293116.990 [CBIT] Loaded
2018-09-18T17:51:56.990Z,1537293116.990 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-09-18T17:51:56.991Z,1537293116.991 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-09-18T17:51:56.993Z,1537293116.993 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-09-18T17:51:57.191Z,1537293117.191 [Aanderaa_O2] Loaded
2018-09-18T17:51:57.192Z,1537293117.192 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-09-18T17:51:57.276Z,1537293117.276 [CTD_NeilBrown] Loaded
2018-09-18T17:51:57.276Z,1537293117.276 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2018-09-18T17:51:57.278Z,1537293117.278 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4097D4E0
2018-09-18T17:51:57.278Z,1537293117.278 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 886
2018-09-18T17:51:57.334Z,1537293117.334 [CTD_Seabird] Loaded
2018-09-18T17:51:57.334Z,1537293117.334 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2018-09-18T17:51:57.335Z,1537293117.335 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409AD4E0
2018-09-18T17:51:57.335Z,1537293117.335 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 887
2018-09-18T17:51:57.351Z,1537293117.351 [PAR_Licor] Loaded
2018-09-18T17:51:57.351Z,1537293117.351 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2018-09-18T17:51:57.406Z,1537293117.406 [WetLabsBB2FL] Loaded
2018-09-18T17:51:57.406Z,1537293117.406 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-09-18T17:51:57.407Z,1537293117.407 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409DD4E0
2018-09-18T17:51:57.407Z,1537293117.407 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 888
2018-09-18T17:51:57.408Z,1537293117.408 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-09-18T17:51:57.409Z,1537293117.409 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-09-18T17:51:57.502Z,1537293117.502 [VerticalControl](DEBUG): Construct VerticalControl.
2018-09-18T17:51:57.594Z,1537293117.594 [VerticalControl] Loaded
2018-09-18T17:51:57.594Z,1537293117.594 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-09-18T17:51:57.595Z,1537293117.595 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-09-18T17:51:57.657Z,1537293117.657 [HorizontalControl] Loaded
2018-09-18T17:51:57.658Z,1537293117.658 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-09-18T17:51:57.658Z,1537293117.658 [SpeedControl](DEBUG): Construct SpeedControl.
2018-09-18T17:51:57.660Z,1537293117.660 [SpeedControl] Loaded
2018-09-18T17:51:57.661Z,1537293117.661 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-09-18T17:51:57.661Z,1537293117.661 [LoopControl](DEBUG): Construct LoopControl.
2018-09-18T17:51:57.662Z,1537293117.662 [LoopControl] Loaded
2018-09-18T17:51:57.662Z,1537293117.662 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-09-18T17:51:57.663Z,1537293117.663 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-09-18T17:51:57.665Z,1537293117.665 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-09-18T17:51:57.703Z,1537293117.703 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-09-18T17:51:57.704Z,1537293117.704 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-09-18T17:51:57.818Z,1537293117.818 [DeadReckonUsingSpeedCalculator] Loaded
2018-09-18T17:51:57.818Z,1537293117.818 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-09-18T17:51:57.836Z,1537293117.836 [NavChart] Loaded
2018-09-18T17:51:57.837Z,1537293117.837 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-09-18T17:51:57.841Z,1537293117.841 [UniversalFixResidualReporter] Loaded
2018-09-18T17:51:57.841Z,1537293117.841 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-09-18T17:51:57.842Z,1537293117.842 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-09-18T17:51:57.846Z,1537293117.846 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-09-18T17:51:57.846Z,1537293117.846 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-09-18T17:51:57.853Z,1537293117.853 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-09-18T17:51:57.854Z,1537293117.854 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A694E0
2018-09-18T17:51:57.855Z,1537293117.855 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 889
2018-09-18T17:51:57.859Z,1537293117.859 [Supervisor](INFO): Main Thread ID is 796
2018-09-18T17:51:57.859Z,1537293117.859 [Supervisor](DEBUG): Running supervisor.
2018-09-18T17:51:57.860Z,1537293117.860 [CommandLine ThreadHandler](INFO): Handler Thread ID is 890
2018-09-18T17:51:57.863Z,1537293117.863 [controlThread ThreadHandler](INFO): Handler Thread ID is 891
2018-09-18T17:51:57.863Z,1537293117.863 [controlThread](DEBUG): Initializing ControlThread
2018-09-18T17:51:57.864Z,1537293117.864 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-09-18T17:51:57.864Z,1537293117.864 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-09-18T17:51:57.865Z,1537293117.865 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-09-18T17:51:57.865Z,1537293117.865 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-09-18T17:51:57.866Z,1537293117.866 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2018-09-18T17:51:57.866Z,1537293117.866 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-09-18T17:51:57.867Z,1537293117.867 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-09-18T17:51:57.875Z,1537293117.875 [SBIT](INFO): Initialize SBIT Component.
2018-09-18T17:51:57.876Z,1537293117.876 [SBIT](IMPORTANT): git: 2018-09-06-6-gbaf5c46
2018-09-18T17:51:57.876Z,1537293117.876 [SBIT](INFO): git hash: baf5c469f70e7902a2cb0333843877cb31121fce
2018-09-18T17:51:57.877Z,1537293117.877 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-09-18T17:51:57.878Z,1537293117.878 [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-18T17:51:57.879Z,1537293117.879 [SBIT](INFO): Beginning SBIT in 23.000000 seconds.
2018-09-18T17:51:57.880Z,1537293117.880 [IBIT](INFO): Initialize IBIT Component.
2018-09-18T17:51:57.881Z,1537293117.881 [CBIT](DEBUG): Initialize CBIT Component.
2018-09-18T17:51:57.881Z,1537293117.881 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2018-09-18T17:51:57.881Z,1537293117.881 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET.
2018-09-18T17:51:57.882Z,1537293117.882 [logger ThreadHandler](INFO): Handler Thread ID is 892
2018-09-18T17:51:57.901Z,1537293117.901 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 893
2018-09-18T17:51:57.907Z,1537293117.907 [Radio_Surface](INFO): Powering up
2018-09-18T17:51:57.913Z,1537293117.913 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 894
2018-09-18T17:51:57.914Z,1537293117.914 [Rowe_600LCM](INFO): Initializing
2018-09-18T17:51:57.914Z,1537293117.914 [Rowe_600LCM](INFO): Checking LCM
2018-09-18T17:51:57.998Z,1537293117.998 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 895
2018-09-18T17:51:57.999Z,1537293117.999 [CTD_NeilBrown](INFO): Powering down
2018-09-18T17:51:58.021Z,1537293118.021 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-09-18T17:51:58.023Z,1537293118.023 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-09-18T17:51:58.024Z,1537293118.024 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-09-18T17:51:58.024Z,1537293118.024 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-09-18T17:51:58.026Z,1537293118.026 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 896
2018-09-18T17:51:58.026Z,1537293118.026 [CTD_Seabird](INFO): Initializing
2018-09-18T17:51:58.027Z,1537293118.027 [CTD_Seabird](INFO): Checking LCM
2018-09-18T17:51:58.024Z,1537293118.024 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-18T17:51:58.028Z,1537293118.028 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-18T17:51:58.028Z,1537293118.028 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-18T17:51:58.029Z,1537293118.029 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-09-18T17:51:58.029Z,1537293118.029 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-09-18T17:51:58.030Z,1537293118.030 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-09-18T17:51:58.145Z,1537293118.145 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 897
2018-09-18T17:51:58.147Z,1537293118.147 [WetLabsBB2FL](INFO): Powering down
2018-09-18T17:51:58.168Z,1537293118.168 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-09-18T17:51:58.255Z,1537293118.255 [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-18T17:51:58.256Z,1537293118.256 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-09-18T17:51:58.257Z,1537293118.257 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 898
2018-09-18T17:51:58.271Z,1537293118.271 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-09-18T17:51:58.271Z,1537293118.271 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-09-18T17:51:58.271Z,1537293118.271 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-09-18T17:51:58.271Z,1537293118.271 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-09-18T17:51:58.272Z,1537293118.272 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-09-18T17:51:58.272Z,1537293118.272 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-09-18T17:51:58.272Z,1537293118.272 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-09-18T17:51:58.272Z,1537293118.272 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-09-18T17:51:58.272Z,1537293118.272 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-09-18T17:51:58.273Z,1537293118.273 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-09-18T17:51:58.273Z,1537293118.273 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-09-18T17:51:58.273Z,1537293118.273 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-09-18T17:51:58.273Z,1537293118.273 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-09-18T17:51:58.273Z,1537293118.273 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-09-18T17:51:58.274Z,1537293118.274 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-09-18T17:51:58.274Z,1537293118.274 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-09-18T17:51:58.365Z,1537293118.365 [CTD_Seabird](INFO): LCM OK
2018-09-18T17:51:58.365Z,1537293118.365 [CTD_Seabird](INFO): Powering up
2018-09-18T17:51:58.373Z,1537293118.373 [Rowe_600LCM](INFO): LCM OK
2018-09-18T17:51:58.373Z,1537293118.373 [Rowe_600LCM](INFO): Powering up
2018-09-18T17:51:58.396Z,1537293118.396 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-09-18T17:51:58.413Z,1537293118.413 [Default:A.Wait](DEBUG): Construct Wait.
2018-09-18T17:51:58.415Z,1537293118.415 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-09-18T17:51:58.438Z,1537293118.438 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-09-18T17:51:58.476Z,1537293118.476 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-09-18T17:51:58.498Z,1537293118.498 [Default:E.Execute](DEBUG): Construct Execute.
2018-09-18T17:51:58.501Z,1537293118.501 [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-18T17:51:58.513Z,1537293118.513 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,Aanderaa_O2,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-09-18T17:51:58.539Z,1537293118.539 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-09-18T17:51:58.589Z,1537293118.589 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2018-09-18T17:51:58.904Z,1537293118.904 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-09-18T17:51:59.017Z,1537293119.017 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-18T17:51:59.241Z,1537293119.241 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-09-18T17:51:59.250Z,1537293119.250 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-09-18T17:51:59.256Z,1537293119.256 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-09-18T17:51:59.285Z,1537293119.285 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-09-18T17:51:59.307Z,1537293119.307 [MassServo](DEBUG): Initializing EZServoServo.
2018-09-18T17:51:59.313Z,1537293119.313 [MassServo](DEBUG): Initializing MassServo.
2018-09-18T17:51:59.327Z,1537293119.327 [RudderServo](DEBUG): Initializing EZServoServo.
2018-09-18T17:51:59.333Z,1537293119.333 [RudderServo](DEBUG): Initializing RudderServo.
2018-09-18T17:51:59.347Z,1537293119.347 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-09-18T17:51:59.353Z,1537293119.353 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-09-18T17:51:59.410Z,1537293119.410 [CommandLine](FAULT): Scheduling is paused
2018-09-18T17:51:59.410Z,1537293119.410 [CBIT](INFO): Critical error at 20180918T175157
2018-09-18T17:51:59.410Z,1537293119.410 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2018-09-18T17:51:59.591Z,1537293119.591 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2018-09-18T17:51:59.591Z,1537293119.591 [DropWeight] Hardware Fault, FailCount= 1
2018-09-18T17:51:59.591Z,1537293119.591 [DropWeight](ERROR): Hardware Fault
2018-09-18T17:51:59.661Z,1537293119.661 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-18T17:51:59.686Z,1537293119.686 [CBIT](INFO): Critical error at 20180918T175159
2018-09-18T17:51:59.689Z,1537293119.689 [CBIT](ERROR): Hardware Fault in component: DropWeight
2018-09-18T17:51:59.690Z,1537293119.690 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2018-09-18T17:51:59.930Z,1537293119.930 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-18T17:52:00.371Z,1537293120.371 [CBIT](INFO): Critical error at 20180918T175159
2018-09-18T17:52:00.439Z,1537293120.439 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-18T17:52:00.828Z,1537293120.828 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-18T17:52:01.252Z,1537293121.252 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-18T17:52:01.629Z,1537293121.629 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-18T17:52:02.071Z,1537293122.071 [Aanderaa_O2](INFO): Powering down
2018-09-18T17:52:02.218Z,1537293122.218 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-18T17:52:02.441Z,1537293122.441 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-09-18T17:52:02.622Z,1537293122.622 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-09-18T17:52:02.760Z,1537293122.760 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-09-18T17:52:02.773Z,1537293122.773 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-09-18T17:52:02.774Z,1537293122.774 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-09-18T17:52:03.620Z,1537293123.620 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-09-18T17:52:03.828Z,1537293123.828 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null &
2018-09-18T17:52:03.830Z,1537293123.830 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd
2018-09-18T17:52:04.649Z,1537293124.649 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-09-18T17:52:04.649Z,1537293124.649 [CTD_Seabird](INFO): Powering down
2018-09-18T17:52:21.292Z,1537293141.292 [SBIT](IMPORTANT): Beginning Startup BIT
2018-09-18T17:52:21.312Z,1537293141.312 [CBIT](IMPORTANT): Beginning ground fault scan
2018-09-18T17:52:24.135Z,1537293144.135 [NAL9602](INFO): Powering up NAL9602
2018-09-18T17:52:32.348Z,1537293152.348 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.002523
CHAN A1 (24V): -0.007113
CHAN A2 (12V): -0.002185
CHAN A3 (5V): -0.001384
CHAN B0 (3.3V): -0.000349
CHAN B1 (3.15aV): -0.000611
CHAN B2 (3.15bV): -0.000048
CHAN B3 (GND): -0.000233
OPEN: -0.000470
Full Scale Calc: 4.765 mA, -1.589 mA
2018-09-18T17:52:35.334Z,1537293155.334 [NAL9602](INFO): NAL9602 initialized
2018-09-18T17:52:59.629Z,1537293179.629 [BPC1](INFO): BPC1A: initialized.
2018-09-18T17:52:59.641Z,1537293179.641 [BPC1](INFO): BPC1B: initialized.
2018-09-18T17:53:01.201Z,1537293181.201 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-18T17:53:01.201Z,1537293181.201 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-18T17:53:05.394Z,1537293185.394 [BPC1](INFO): BPC1A: no match for SMBUS stick msg of size 1901 bytes.
2018-09-18T17:53:05.394Z,1537293185.394 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
Got:

$B11,02,000A,01,02A8,03,0001,08,0B81,09,2DD8,0A,0000,0B,0000%3A
$B11,0C,0001,0D,0000,0E,0000,0F,0000,10,1916,11,FFFF,12,FFFF%4A
$B11,13,FFFF,14,0000,15,0000,16,4AD0,17,000E,18,1A90,19,3840%43
$B11,1A,0031,1B,458C,1C,0138%41
$B12,02,000A,01,02A8,03,0001,08,0B86,09,3934,0A,FFF9,0B,FFFE%45
$B12,0C,0001,0D,002C,0E,002A,0F,0B1A,10,19AB,11,5F28,12,FFFF%34
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000F,18,1A90,19,3840%4D
$B12,1A,0031,1B,458C,1C,0125%4E
$B13,02,000A,01,02A8,03,0001,08,0B8D,09,3925,0A,FFFD,0B,FFFF%48
$B13,0C,0001,0D,002D,0E,002D,0F,0BB9,10,1A5C,11,EA74,12,FFFF%4F
$B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000E,18,1A90,19,3840%4F
$B13,1A,0031,1B,458C,1C,00EF%4A
$B14,02,000A,01,02A8,03,0001,08,0B84,09,3926,0A,FFFC,0B,FFFF%3B
$B14,0C,0001,0D,0032,0E,002C,0F,0B99,10,177F,11,ADF7,12,FFFF%41
$B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000E,18,1A90,19,3840%48
$B14,1A,0031,1B,458F,1C,0158%47
$B15,02,000A,01,02A8,03,0001,08,0B8C,09,3938,0A,0000,0B,0000%47
$B15,0C,0001,0D,0031,0E,002E,0F,0C04,10,18FC,11,FFFF,12,FFFF%4F
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000C,18,1A90,19,3840%4F
$B15,1A,0031,1B,458B,1C,0088%4E
$B16,02,000A,01,02A8,03,0001,08,0B85,09,393F,0A,0000,0B,0000%4C
$B16,0C,0001,0D,0034,0E,002E,0F,0C09,10,175E,11,FFFF,12,FFFF%3E
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000D,18,1A90,19,3840%4B
$B16,1A,0031,1B,458B,1C,00A3%3F
$B17,02,000A,01,02A8,03,0001,08,0B8D,09,3947,0A,0000,0B,0000%4A
$B17,0C,0001,0D,002C,0E,0022,0F,08E2,10,1442,11,FFFF,12,FFFF%4E
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000D,18,1A90,19,3840%4A
$B17,1A,0031,1B,458C,1C,012D%3A
$B18,02,000A,01,02A8,03,0001,08,0B89,09,3E0D,0A,0000,0B,0000%33
$B18,0C,0001,0D,0052,0E,004D,0F,1432,10,18CF,11,FFFF,12,FFFF%33
$B18,13,FFFF,14,0000,15,0000,16,48C0,17,0008,18,1A90,19,3840%49
$B18,1A,0031,1B,458C,1C,00E7%30

 S - Setup Controller
 B - Battery Status
 X - Host HEX
 H - Help

->:
2018-09-18T17:53:05.474Z,1537293185.474 [BPC1](INFO): BPC1B: no match for SMBUS stick msg of size 1901 bytes.
2018-09-18T17:53:05.474Z,1537293185.474 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
Got:

$B11,02,000A,01,02A8,03,0001,08,0B82,09,3680,0A,0000,0B,0000%3E
$B11,0C,0001,0D,0011,0E,0010,0F,041B,10,1841,11,FFFF,12,FFFF%3F
$B11,13,FFFF,14,0000,15,0000,16,48C0,17,000D,18,1A90,19,3840%3C
$B11,1A,0031,1B,458F,1C,0157%4D
$B12,02,000A,01,02A8,03,0001,08,0B85,09,3935,0A,FFFB,0B,FFFF%3F
$B12,0C,0001,0D,002E,0E,002E,0F,0BFF,10,1A3A,11,8FF4,12,FFFF%3A
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0011,18,1A90,19,3840%3B
$B12,1A,0031,1B,458C,1C,00F1%3F
$B13,02,000A,01,02A8,03,0001,08,0B8C,09,392C,0A,FFFB,0B,FFFF%3F
$B13,0C,0001,0D,002A,0E,0028,0F,0A5F,10,1906,11,7C74,12,FFFF%45
$B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3B
$B13,1A,0031,1B,458B,1C,00BF%4C
$B14,02,000A,01,02A8,03,0001,08,0B86,09,392D,0A,FFFC,0B,FFFF%4B
$B14,0C,0001,0D,0030,0E,002E,0F,0C14,10,1979,11,B52C,12,FFFF%42
$B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3C
$B14,1A,0031,1B,458B,1C,0089%4E
$B15,02,000A,01,02A8,03,0001,08,0B85,09,3941,0A,0000,0B,0000%3F
$B15,0C,0001,0D,002A,0E,0028,0F,0A8B,10,192C,11,FFFF,12,FFFF%4A
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3D
$B15,1A,0031,1B,458C,1C,00C2%3E
$B16,02,000A,01,02A8,03,0001,08,0B80,09,3947,0A,0000,0B,0000%3F
$B16,0C,0001,0D,0033,0E,0032,0F,0D08,10,1990,11,FFFF,12,FFFF%3E
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3E
$B16,1A,0031,1B,458C,1C,00CA%4E
$B17,02,000A,01,02A8,03,0001,08,0B8D,09,395A,0A,0000,0B,0000%3D
$B17,0C,0001,0D,0032,0E,002F,0F,0C5D,10,18F7,11,FFFF,12,FFFF%4C
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3F
$B17,1A,0031,1B,458C,1C,011A%3C
$B18,02,000A,01,02A8,03,0001,08,0B87,09,3FA7,0A,0000,0B,0000%3C
$B18,0C,0001,0D,005C,0E,0057,0F,16E8,10,1915,11,FFFF,12,FFFF%4E
$B18,13,FFFF,14,0000,15,0000,16,48C0,17,0008,18,1A90,19,3840%49
$B18,1A,0031,1B,458C,1C,00FD%40

 S - Setup Controller
 B - Battery Status
 X - Host HEX
 H - Help

->:
2018-09-18T17:53:06.153Z,1537293186.153 [BPC1](INFO): BPC1A: initialized.
2018-09-18T17:53:06.165Z,1537293186.165 [BPC1](INFO): BPC1B: initialized.
2018-09-18T17:53:13.339Z,1537293193.339 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-18T17:53:13.736Z,1537293193.736 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-18T17:53:15.433Z,1537293195.433 [SBIT](IMPORTANT): SBIT PASSED
2018-09-18T17:53:15.514Z,1537293195.514 [CommandLine](IMPORTANT): got command configSet list
2018-09-18T17:53:15.515Z,1537293195.515 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-09-18T17:53:15.518Z,1537293195.518 [CommandLine](IMPORTANT): DAT.loadAtStartup=0 bool;

2018-09-18T17:53:15.519Z,1537293195.519 [CommandLine](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2018-09-18T17:53:15.519Z,1537293195.519 [CommandLine](IMPORTANT): ESPComponent.sampleTimeout=10 minute;

2018-09-18T17:53:15.519Z,1537293195.519 [CommandLine](IMPORTANT): ESPComponent.simulateHardware=1 bool;

2018-09-18T17:53:15.519Z,1537293195.519 [CommandLine](IMPORTANT): ElevatorServo.loadAtStartup=0 bool;

2018-09-18T17:53:15.519Z,1537293195.519 [CommandLine](IMPORTANT): Express none CTD_NeilBrown.bin_mean_sea_water_salinity;

2018-09-18T17:53:15.519Z,1537293195.519 [CommandLine](IMPORTANT): Express none CTD_NeilBrown.bin_mean_sea_water_temperature;

2018-09-18T17:53:15.519Z,1537293195.519 [CommandLine](IMPORTANT): Express none CTD_NeilBrown.bin_median_sea_water_temperature;

2018-09-18T17:53:15.519Z,1537293195.519 [CommandLine](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity;

2018-09-18T17:53:15.520Z,1537293195.520 [CommandLine](IMPORTANT): Express none Rowe_600LCM.height_above_sea_floor;

2018-09-18T17:53:15.520Z,1537293195.520 [CommandLine](IMPORTANT): Express none VerticalTemperatureHomogeneityIndexCalculator.vertical_temperature_homogeneity_index;

2018-09-18T17:53:15.520Z,1537293195.520 [CommandLine](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;

2018-09-18T17:53:15.520Z,1537293195.520 [CommandLine](IMPORTANT): MassServo.loadAtStartup=0 bool;

2018-09-18T17:53:15.520Z,1537293195.520 [CommandLine](IMPORTANT): Rowe_600LCM.loadAtStartup=0 bool;

2018-09-18T17:53:15.520Z,1537293195.520 [CommandLine](IMPORTANT): RudderServo.loadAtStartup=0 bool;

2018-09-18T17:53:15.520Z,1537293195.520 [CommandLine](IMPORTANT): StratificationFrontDetector.loadAtStartup=0 bool;

2018-09-18T17:53:15.521Z,1537293195.521 [CommandLine](IMPORTANT): ThrusterServo.loadAtStartup=0 bool;

2018-09-18T17:53:15.521Z,1537293195.521 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=497.852 cubic_centimeter;

2018-09-18T17:53:15.521Z,1537293195.521 [CommandLine](IMPORTANT): VerticalControl.massDefault=-35 millimeter;

2018-09-18T17:53:15.793Z,1537293195.793 [MissionManager](IMPORTANT): Started mission Startup
2018-09-18T17:53:15.793Z,1537293195.793 [Startup] Running Loop=1
2018-09-18T17:53:15.793Z,1537293195.793 [Startup](DEBUG): Aggregate::initialize Startup
2018-09-18T17:53:15.793Z,1537293195.793 [Startup:A.GoToSurface] Running Loop=1
2018-09-18T17:53:15.794Z,1537293195.794 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-09-18T17:53:15.794Z,1537293195.794 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-09-18T17:53:15.795Z,1537293195.795 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-09-18T17:53:15.795Z,1537293195.795 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-09-18T17:53:15.795Z,1537293195.795 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-09-18T17:53:15.796Z,1537293195.796 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-09-18T17:53:15.818Z,1537293195.818 [Startup:StartupSatComms] Running Loop=1
2018-09-18T17:53:15.818Z,1537293195.818 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-09-18T17:53:15.819Z,1537293195.819 [Startup:StartupSatComms:A] Running Loop=1
2018-09-18T17:53:16.163Z,1537293196.163 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-09-18T17:53:18.251Z,1537293198.251 [BPC1](INFO): BPC1B: no match for SMBUS stick msg of size 1901 bytes.
2018-09-18T17:53:18.252Z,1537293198.252 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
Got:

$B11,02,000A,01,02A8,03,0001,08,0B93,09,392E,0A,FFFC,0B,0000%4B
$B11,0C,0001,0D,002B,0E,0029,0F,0ABF,10,1910,11,A131,12,FFFF%30
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%39
$B11,1A,0031,1B,458B,1C,0095%46
$B12,02,000A,01,02A8,03,0001,08,0B83,09,392D,0A,FFFD,0B,0000%4F
$B12,0C,0001,0D,002B,0E,0028,0F,0A9E,10,193D,11,D458,12,FFFF%33
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3A
$B12,1A,0031,1B,458B,1C,00BE%4E
$B13,02,000A,01,02A8,03,0001,08,0B83,09,3932,0A,FFFC,0B,0000%3E
$B13,0C,0001,0D,002B,0E,0028,0F,0A8D,10,1903,11,9E43,12,FFFF%40
$B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3B
$B13,1A,0031,1B,458B,1C,0086%46
$B14,02,000A,01,02A8,03,0001,08,0B84,09,343C,0A,0000,0B,0000%47
$B14,0C,0001,0D,0007,0E,0007,0F,01A8,10,1912,11,FFFF,12,FFFF%33
$B14,13,FFFF,14,0000,15,0000,16,4AC0,17,000C,18,1A90,19,3840%47
$B14,1A,0031,1B,458B,1C,00AE%4B
$B15,02,000A,01,02A8,03,0001,08,0B84,09,2D80,0A,0000,0B,0000%4F
$B15,0C,0001,0D,0000,0E,0000,0F,0000,10,1A0F,11,FFFF,12,FFFF%47
$B15,13,FFFF,14,0000,15,0000,16,4AD0,17,0010,18,1A90,19,3840%33
$B15,1A,0031,1B,458C,1C,00CB%4E
$B16,02,000A,01,02A8,03,0001,08,0B81,09,349D,0A,0000,0B,0000%4D
$B16,0C,0001,0D,0009,0E,0009,0F,023B,10,190C,11,FFFF,12,FFFF%4A
$B16,13,FFFF,14,0000,15,0000,16,4AC0,17,000C,18,1A90,19,3840%45
$B16,1A,0031,1B,458C,1C,00F7%3D
$B17,02,000A,01,02A8,03,0001,08,0B87,09,3D21,0A,0000,0B,0000%44
$B17,0C,0001,0D,004D,0E,004B,0F,13D9,10,19FD,11,FFFF,12,FFFF%30
$B17,13,FFFF,14,0000,15,0000,16,48C0,17,000F,18,1A90,19,3840%38
$B17,1A,0031,1B,458B,1C,00A1%3C
$B18,02,000A,01,02A8,03,0001,08,0B7F,09,3D3C,0A,0000,0B,0000%46
$B18,0C,0001,0D,0055,0E,0051,0F,1569,10,1932,11,FFFF,12,FFFF%4A
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0009,18,1A90,19,3840%38
$B18,1A,0031,1B,458C,1C,00F0%34

 S - Setup Controller
 B - Battery Status
 X - Host HEX
 H - Help

->:
2018-09-18T17:53:18.836Z,1537293198.836 [BPC1](INFO): BPC1A: no match for SMBUS stick msg of size 1901 bytes.
2018-09-18T17:53:18.850Z,1537293198.850 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
Got:

$B11,02,000A,01,02A8,03,0001,08,0B8F,09,3934,0A,FFFD,0B,0000%48
$B11,0C,0001,0D,0030,0E,002D,0F,0BBC,10,18DE,11,EAB0,12,FFFF%3D
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000E,18,1A90,19,3840%4D
$B11,1A,0031,1B,458C,1C,0100%4A
$B12,02,000A,01,02A8,03,0001,08,0B8A,09,3935,0A,FFFC,0B,FFFF%4A
$B12,0C,0001,0D,0032,0E,002D,0F,0BB4,10,17A2,11,AF8C,12,FFFF%3C
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000E,18,1A90,19,3840%4E
$B12,1A,0031,1B,458B,1C,00B9%32
$B13,02,000A,01,02A8,03,0001,08,0B87,09,3933,0A,FFFD,0B,0000%3C
$B13,0C,0001,0D,002B,0E,0029,0F,0AE0,10,1994,11,D980,12,FFFF%48
$B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000E,18,1A90,19,3840%4F
$B13,1A,0031,1B,458B,1C,008C%33
$B14,02,000A,01,02A8,03,0001,08,0B80,09,3927,0A,0000,0B,0000%3B
$B14,0C,0001,0D,0032,0E,002C,0F,0B92,10,178E,11,FFFF,12,FFFF%32
$B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000E,18,1A90,19,3840%48
$B14,1A,0031,1B,458C,1C,0117%49
$B15,02,000A,01,02A8,03,0001,08,0B87,09,3938,0A,0000,0B,0000%33
$B15,0C,0001,0D,0030,0E,002D,0F,0BC7,10,18EB,11,FFFF,12,FFFF%3C
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000D,18,1A90,19,3840%48
$B15,1A,0031,1B,458C,1C,00E4%3E
$B16,02,000A,01,02A8,03,0001,08,0B7F,09,2D78,0A,0000,0B,0000%36
$B16,0C,0001,0D,0000,0E,0000,0F,0000,10,1935,11,FFFF,12,FFFF%4C
$B16,13,FFFF,14,0000,15,0000,16,4AD0,17,000D,18,1A90,19,3840%45
$B16,1A,0031,1B,458C,1C,011D%38
$B17,02,000A,01,02A8,03,0001,08,0B80,09,2D63,0A,0000,0B,0000%44
$B17,0C,0001,0D,0000,0E,0000,0F,0000,10,1987,11,FFFF,12,FFFF%44
$B17,13,FFFF,14,0000,15,0000,16,4AD0,17,000D,18,1A90,19,3840%44
$B17,1A,0031,1B,458C,1C,014E%3D
$B18,02,000A,01,02A8,03,0001,08,0B81,09,3E29,0A,FFFD,0B,FFFF%46
$B18,0C,0001,0D,0058,0E,0056,0F,16CC,10,1A13,11,FFFF,12,FFFF%37
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0009,18,1A90,19,3840%38
$B18,1A,0031,1B,458C,1C,00EC%44

 S - Setup Controller
 B - Battery Status
 X - Host HEX
 H - Help

->:
2018-09-18T17:53:19.405Z,1537293199.405 [BPC1](INFO): BPC1A: initialized.
2018-09-18T17:53:19.417Z,1537293199.417 [BPC1](INFO): BPC1B: initialized.
2018-09-18T17:53:26.999Z,1537293206.999 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-18T17:53:26.000Z,1537293207.000 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-18T17:53:31.480Z,1537293211.480 [BPC1](INFO): BPC1A: no match for SMBUS stick msg of size 1901 bytes.
2018-09-18T17:53:31.481Z,1537293211.481 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
Got:

$B11,02,000A,01,02A8,03,0001,08,0B87,09,3933,0A,FFFB,0B,0000%38
$B11,0C,0001,0D,0033,0E,002D,0F,0BEA,10,17BC,11,8EF8,12,FFFF%41
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000E,18,1A90,19,3840%4D
$B11,1A,0031,1B,458B,1C,008A%33
$B12,02,000A,01,02A8,03,0001,08,0B81,09,344C,0A,0000,0B,0000%43
$B12,0C,0001,0D,0008,0E,0008,0F,01E5,10,1933,11,FFFF,12,FFFF%3F
$B12,13,FFFF,14,0000,15,0000,16,4AC0,17,000B,18,1A90,19,3840%40
$B12,1A,0031,1B,458C,1C,0140%4D
$B13,02,000A,01,02A8,03,0001,08,0B85,09,3924,0A,FFFC,0B,0000%3F
$B13,0C,0001,0D,002C,0E,002C,0F,0B90,10,1A63,11,AD70,12,FFFF%4B
$B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000E,18,1A90,19,3840%4F
$B13,1A,0031,1B,458C,1C,00E5%39
$B14,02,000A,01,02A8,03,0001,08,0B8B,09,392E,0A,FFFC,0B,FFFF%3E
$B14,0C,0001,0D,0032,0E,002D,0F,0BD6,10,17CD,11,B18A,12,FFFF%3C
$B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000E,18,1A90,19,3840%48
$B14,1A,0031,1B,458C,1C,00E0%3B
$B15,02,000A,01,02A8,03,0001,08,0B87,09,37CC,0A,0000,0B,0000%36
$B15,0C,0001,0D,0023,0E,0022,0F,08DF,10,19D0,11,FFFF,12,FFFF%36
$B15,13,FFFF,14,0000,15,0000,16,48C0,17,0009,18,1A90,19,3840%45
$B15,1A,0031,1B,458C,1C,00CD%48
$B16,02,000A,01,02A8,03,0001,08,0B84,09,393C,0A,0000,0B,0000%48
$B16,0C,0001,0D,002E,0E,002D,0F,0BED,10,1A56,11,FFFF,12,FFFF%43
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000D,18,1A90,19,3840%4B
$B16,1A,0031,1B,458B,1C,009F%32
$B17,02,000A,01,02A8,03,0001,08,0B85,09,3947,0A,0000,0B,0000%3B
$B17,0C,0001,0D,0031,0E,002E,0F,0C1A,10,1933,11,FFFF,12,FFFF%3D
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000D,18,1A90,19,3840%4A
$B17,1A,0031,1B,458B,1C,009C%36
$B18,02,000A,01,02A8,03,0001,08,0B85,09,3D59,0A,0000,0B,0000%46
$B18,0C,0001,0D,0057,0E,0054,0F,162C,10,19B4,11,FFFF,12,FFFF%47
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0009,18,1A90,19,3840%38
$B18,1A,0031,1B,458B,1C,00A6%34

 S - Setup Controller
 B - Battery Status
 X - Host HEX
 H - Help

->:
2018-09-18T17:53:31.935Z,1537293211.935 [BPC1](INFO): BPC1B: no match for SMBUS stick msg of size 1901 bytes.
2018-09-18T17:53:31.935Z,1537293211.935 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
Got:

$B11,02,000A,01,02A8,03,0001,08,0B81,09,393B,0A,FFF8,0B,0000%35
$B11,0C,0001,0D,002D,0E,002C,0F,0BAB,10,1A14,11,5783,12,FFFF%4F
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%39
$B11,1A,0031,1B,458C,1C,00C9%31
$B12,02,000A,01,02A8,03,0001,08,0B82,09,3932,0A,FFFA,0B,0000%3C
$B12,0C,0001,0D,002A,0E,0028,0F,0A6C,10,1907,11,6838,12,FFFF%31
$B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3A
$B12,1A,0031,1B,458C,1C,0103%4A
$B13,02,000A,01,02A8,03,0001,08,0B8A,09,3401,0A,0000,0B,0000%44
$B13,0C,0001,0D,0007,0E,0007,0F,01AB,10,19A5,11,FFFF,12,FFFF%39
$B13,13,FFFF,14,0000,15,0000,16,4AC0,17,000C,18,1A90,19,3840%40
$B13,1A,0031,1B,458F,1C,0152%4A
$B14,02,000A,01,02A8,03,0001,08,0B85,09,3459,0A,0000,0B,0000%3A
$B14,0C,0001,0D,0007,0E,0007,0F,01BA,10,18FB,11,FFFF,12,FFFF%4F
$B14,13,FFFF,14,0000,15,0000,16,4AC0,17,000C,18,1A90,19,3840%47
$B14,1A,0031,1B,458C,1C,014A%3A
$B15,02,000A,01,02A8,03,0001,08,0B86,09,3945,0A,0000,0B,0000%38
$B15,0C,0001,0D,002C,0E,002A,0F,0AEB,10,194E,11,FFFF,12,FFFF%4C
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3D
$B15,1A,0031,1B,458C,1C,0114%4B
$B16,02,000A,01,02A8,03,0001,08,0B82,09,2D57,0A,0000,0B,0000%40
$B16,0C,0001,0D,0000,0E,0000,0F,0000,10,194F,11,FFFF,12,FFFF%38
$B16,13,FFFF,14,0000,15,0000,16,4AD0,17,0010,18,1A90,19,3840%30
$B16,1A,0031,1B,458F,1C,015E%38
$B17,02,000A,01,02A8,03,0001,08,0B81,09,3960,0A,0000,0B,0000%3A
$B17,0C,0001,0D,0030,0E,002F,0F,0C6D,10,1A65,11,FFFF,12,FFFF%46
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3F
$B17,1A,0031,1B,458B,1C,008E%31
$B18,02,000A,01,02A8,03,0001,08,0B8C,09,3DE4,0A,0000,0B,0000%4D
$B18,0C,0001,0D,0057,0E,0055,0F,1692,10,19F8,11,FFFF,12,FFFF%34
$B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0009,18,1A90,19,3840%38
$B18,1A,0031,1B,458B,1C,00AC%41

 S - Setup Controller
 B - Battery Status
 X - Host HEX
 H - Help

->:
2018-09-18T17:53:32.205Z,1537293212.205 [BPC1](INFO): BPC1A: initialized.
2018-09-18T17:53:32.617Z,1537293212.617 [BPC1](INFO): BPC1B: initialized.
2018-09-18T17:53:39.804Z,1537293219.804 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-18T17:53:39.804Z,1537293219.804 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-18T17:53:43.859Z,1537293223.859 [BPC1](INFO): BPC1A: no match for SMBUS stick msg of size 1673 bytes.
2018-09-18T17:53:43.859Z,1537293223.859 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
Got:

$B11,02,000A,01,02A8,03,0001,08,0B87,09,3932,0A,FFF8,0B,0000%43
$B11,0C,0001,0D,002E,0E,002D,0F,0BC7,10,1A13,11,5855,12,FFFF%3D
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000D,18,1A90,19,3840%4C
$B11,1A,0031,1B,458C,1C,00E8%36
$B12,02,000A,01,02A8,03,0001,08,0B8A,09,368C,0A,0000,0B,0000%3D
$B12,0C,0001,0D,0013,0E,0011,0F,0479,10,18AC,11,FFFF,12,FFFF%45
$B12,13,FFFF,14,0000,15,0000,16,48C0,17,000B,18,1A90,19,3840%39
$B12,1A,0031,1B,458C,1C,00D1%3D
$B13,02,000A,01,02A8,03,0001,08,0B82,09,3921,0A,FFFC,0B,0000%3D
$B13,0C,0001,0D,0031,0E,002C,0F,0BA8,10,1807,11,AED8,12,FFFF%49
$B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000F,18,1A90,19,3840%4C
$B13,1A,0031,1B,458C,1C,00F3%3C
$B14,02,000A,01,02A8,03,0001,08,0B89,09,378F,0A,0000,0B,0000%47
$B14,0C,0001,0D,001E,0E,001C,0F,0743,10,1905,11,FFFF,12,FFFF%4B
$B14,13,FFFF,14,0000,15,0000,16,48C0,17,000B,18,1A90,19,3840%3F
$B14,1A,0031,1B,458B,1C,0092%44
$B15,02,000A,01,02A8,03,0001,08,0B95,09,3938,0A,0000,0B,0000%30
$B15,0C,0001,0D,0030,0E,002D,0F,0BD9,10,191B,11,FFFF,12,FFFF%40
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000D,18,1A90,19,3840%48
$B15,1A,0031,1B,458B,1C,00AD%4B
$B16,02,000A,01,02A8,03,0001,08,0B85,09,3AB7,0A,0000,0B,0000%34
$B16,0C,0001,0D,0039,0E,0035,0F,0E03,10,18C7,11,FFFF,12,FFFF%45
$B16,13,FFFF,14,0000,15,0000,16,48C0,17,000C,18,1A90,19,3840%3C
$B16,1A,0031,1B,458C,1C,00E9%30
$B17,02,000A,01,02A8,03,0001,08,0B85,09,3950,0A,0000,0B,0000%3D
$B17,0C,0001,0D,0031,0E,002E,0F,0C03,10,18FC,11,FFFF,12,FFFF%4A
$B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,000D,18,1A90,19,3840%4A
$B17,1A,0031,1B,458C,1C,0126%48

 S - Setup Controller
 B - Battery Status
 X - Host HEX
 H - Help

->5@:
2018-09-18T17:53:44.331Z,1537293224.331 [BPC1](INFO): BPC1B: no match for SMBUS stick msg of size 1673 bytes.
2018-09-18T17:53:44.332Z,1537293224.332 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
Got:

$B11,02,000A,01,02A8,03,0001,08,0B82,09,393A,0A,FFF9,0B,FFFC%31
$B11,0C,0001,0D,002D,0E,002C,0F,0BAB,10,1A14,11,6403,12,AF05%45
$B11,13,FFFF,14,0000,15,0000,16,48C0,17,000C,18,1A90,19,3840%3B
$B11,1A,0031,1B,458B,1C,0091%42
$B12,02,000A,01,02A8,03,0001,08,0B85,09,3843,0A,0000,0B,0000%3B
$B12,0C,0001,0D,002A,0E,0024,0F,0970,10,18DD,11,FFFF,12,FFFF%34
$B12,13,FFFF,14,0000,15,0000,16,48C0,17,000C,18,1A90,19,3840%38
$B12,1A,0031,1B,458F,1C,0153%4A
$B13,02,000A,01,02A8,03,0001,08,0B8C,09,3936,0A,0008,0B,0001%46
$B13,0C,0001,0D,0007,0E,002A,0F,0B17,10,19AD,11,5F0E,12,FFFF%4C
$B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0011,18,1A90,19,3840%3A
$B13,1A,0031,1B,458B,1C,00AF%4F
$B14,02,000A,01,02A8,03,0001,08,0B82,09,3937,0A,FFFA,0B,0000%3F
$B14,0C,0001,0D,0007,0E,0029,0F,0AD7,10,1938,11,6C66,12,FFFF%38
$B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3C
$B14,1A,0031,1B,458F,1C,0151%4E
$B15,02,000A,01,02A8,03,0001,08,0B88,09,3943,0A,0000,0B,0001%31
$B15,0C,0001,0D,002C,0E,0028,0F,0A96,10,1906,11,FFFF,12,FFFF%4A
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3D
$B15,1A,0031,1B,458C,1C,00DC%48
$B16,02,000A,01,02A8,03,0001,08,0B83,09,394F,0A,0000,0B,0000%4D
$B16,0C,0001,0D,0000,0E,0030,0F,0CA5,10,197A,11,FFFF,12,FFFF%38
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3E
$B16,1A,0031,1B,458B,1C,00BA%4E
$B17,02,000A,01,02A8,03,0001,08,0B7C,09,2DBE,0A,0000,0B,0000%3A
$B17,0C,0001,0D,0030,0E,0000,0F,0000,10,19F2,11,FFFF,12,FFFF%3C
$B17,13,FFFF,14,0000,15,0000,16,4AD0,17,0010,18,1A90,19,3840%31
$B17,1A,0031,1B,458C,1C,00DA%48

 S - Setup Controller
 B - Battery Status
 X - Host HEX
 H - Help

-> 5@:
2018-09-18T17:53:44.629Z,1537293224.629 [BPC1](INFO): BPC1A: initialized.
2018-09-18T17:53:45.045Z,1537293225.045 [BPC1](INFO): BPC1B: initialized.
2018-09-18T17:53:46.644Z,1537293226.644 [BPC1](INFO): BPC1B: sending IBPS break.
2018-09-18T17:53:50.446Z,1537293230.446 [CommandLine](IMPORTANT): got command quit
2018-09-18T17:53:50.609Z,1537293230.609 [BPC1](INFO): BPC1B: no match for SMBUS stick msg of size 1673 bytes.
2018-09-18T17:53:50.609Z,1537293230.609 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
Got:

$B11,02,000A,01,02A8,03,0001,08,0B8C,09,35E4,0A,0000,0B,0000%35
$B11,0C,0001,0D,000E,0E,000D,0F,0371,10,189E,11,FFFF,12,FFFF%34
$B11,13,FFFF,14,0000,15,0000,16,48C0,17,000C,18,1A90,19,3840%3B
$B11,1A,0031,1B,458B,1C,0091%42
$B12,02,000A,01,02A8,03,0001,08,0B85,09,3843,0A,0000,0B,0000%3B
$B12,0C,0001,0D,0026,0E,0024,0F,0970,10,18DD,11,FFFF,12,FFFF%43
$B12,13,FFFF,14,0000,15,0000,16,48C0,17,000C,18,1A90,19,3840%38
$B12,1A,0031,1B,458F,1C,0153%4A
$B13,02,000A,01,02A8,03,0001,08,0B8D,09,3935,0A,FFF9,0B,FFFD%36
$B13,0C,0001,0D,002C,0E,002A,0F,0B17,10,19AD,11,5F0E,12,DDCC%3A
$B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0011,18,1A90,19,3840%3A
$B13,1A,0031,1B,458B,1C,00AF%4F
$B14,02,000A,01,02A8,03,0001,08,0B83,09,3937,0A,FFFB,0B,FFFE%3E
$B14,0C,0001,0D,002B,0E,0029,0F,0AD7,10,1938,11,8214,12,FFFF%35
$B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3C
$B14,1A,0031,1B,458F,1C,0151%4E
$B15,02,000A,01,02A8,03,0001,08,0B89,09,3943,0A,0000,0B,0000%31
$B15,0C,0001,0D,002B,0E,0028,0F,0A96,10,1906,11,FFFF,12,FFFF%4B
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3D
$B15,1A,0031,1B,458C,1C,00DC%48
$B16,02,000A,01,02A8,03,0001,08,0B84,09,394F,0A,0000,0B,0000%4A
$B16,0C,0001,0D,0032,0E,0030,0F,0CA5,10,197A,11,FFFF,12,FFFF%39
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0010,18,1A90,19,3840%3E
$B16,1A,0031,1B,458B,1C,00BA%4E
$B17,02,000A,01,02A8,03,0001,08,0B7C,09,2DBE,0A,0000,0B,0000%3A
$B17,0C,0001,0D,0000,0E,0000,0F,0000,10,19F2,11,FFFF,12,FFFF%3F
$B17,13,FFFF,14,0000,15,0000,16,4AD0,17,0010,18,1A90,19,3840%31
$B17,1A,0031,1B,458C,1C,00DA%48

 S - Setup Controller
 B - Battery Status
 X - Host HEX
 H - Help

-> 5@:
2018-09-18T17:53:51.006Z,1537293231.006 [BPC1](INFO): BPC1A: sending IBPS break.
2018-09-18T17:53:51.421Z,1537293231.421 [BPC1](INFO): BPC1B: initialized.
2018-09-18T17:53:51.456Z,1537293231.456 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-18T17:53:51.456Z,1537293231.456 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:51.469Z,1537293231.469 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-09-18T17:53:51.469Z,1537293231.469 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:51.470Z,1537293231.470 [CommandLine](INFO): Join timeout helper Thread ID is 919
2018-09-18T17:53:51.485Z,1537293231.485 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-09-18T17:53:51.485Z,1537293231.485 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:51.485Z,1537293231.485 [NavChartDb](INFO): Join timeout helper Thread ID is 920
2018-09-18T17:53:51.669Z,1537293231.669 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-18T17:53:51.670Z,1537293231.670 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:51.677Z,1537293231.677 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2018-09-18T17:53:51.677Z,1537293231.677 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:51.677Z,1537293231.677 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 921
2018-09-18T17:53:52.113Z,1537293232.113 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-18T17:53:52.113Z,1537293232.113 [WetLabsBB2FL](INFO): Powering down
2018-09-18T17:53:52.114Z,1537293232.114 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:52.129Z,1537293232.129 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2018-09-18T17:53:52.129Z,1537293232.129 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:52.129Z,1537293232.129 [CTD_Seabird](INFO): Join timeout helper Thread ID is 922
2018-09-18T17:53:52.325Z,1537293232.325 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-18T17:53:52.423Z,1537293232.423 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-09-18T17:53:52.423Z,1537293232.423 [CTD_Seabird](INFO): Powering down
2018-09-18T17:53:52.424Z,1537293232.424 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:52.429Z,1537293232.429 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2018-09-18T17:53:52.429Z,1537293232.429 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:52.430Z,1537293232.430 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 924
2018-09-18T17:53:52.809Z,1537293232.809 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-18T17:53:52.809Z,1537293232.809 [CTD_NeilBrown](INFO): Powering down
2018-09-18T17:53:52.810Z,1537293232.810 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:52.818Z,1537293232.818 [ComponentRegistry](INFO): Shutting down Rowe_600LCM ThreadHandler
2018-09-18T17:53:52.818Z,1537293232.818 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:52.818Z,1537293232.818 [Rowe_600LCM](INFO): Join timeout helper Thread ID is 925
2018-09-18T17:53:53.229Z,1537293233.229 [Rowe_600LCM ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-18T17:53:53.229Z,1537293233.229 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-09-18T17:53:53.330Z,1537293233.330 [Rowe_600LCM](INFO): Powering down
2018-09-18T17:53:53.331Z,1537293233.331 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:53.350Z,1537293233.350 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-09-18T17:53:53.350Z,1537293233.350 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:53.350Z,1537293233.350 [Radio_Surface](INFO): Join timeout helper Thread ID is 927
2018-09-18T17:53:53.585Z,1537293233.585 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-18T17:53:53.585Z,1537293233.585 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:53.605Z,1537293233.605 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-09-18T17:53:53.606Z,1537293233.606 [logger ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:53.606Z,1537293233.606 [logger](INFO): Join timeout helper Thread ID is 928
2018-09-18T17:53:53.637Z,1537293233.637 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-18T17:53:53.637Z,1537293233.637 [logger ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:53.645Z,1537293233.645 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-09-18T17:53:53.646Z,1537293233.646 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:53.646Z,1537293233.646 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-09-18T17:53:53.646Z,1537293233.646 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:53.646Z,1537293233.646 [controlThread](INFO): Join timeout helper Thread ID is 929
2018-09-18T17:53:53.757Z,1537293233.757 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-18T17:53:53.757Z,1537293233.757 [controlThread](DEBUG): Uninitializing ControlThread
2018-09-18T17:53:53.758Z,1537293233.758 [NAL9602](INFO): Powering down
2018-09-18T17:53:53.760Z,1537293233.760 [PNI_TCM](INFO): Powering down
2018-09-18T17:53:53.850Z,1537293233.850 [Aanderaa_O2](INFO): Powering down
2018-09-18T17:53:53.851Z,1537293233.851 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-09-18T17:53:53.853Z,1537293233.853 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-09-18T17:53:53.854Z,1537293233.854 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-09-18T17:53:53.854Z,1537293233.854 [MissionManager](INFO): Uninitializing Mission Default
2018-09-18T17:53:53.857Z,1537293233.857 [MissionManager](INFO): Uninitializing Mission Startup
2018-09-18T17:53:53.857Z,1537293233.857 [Startup] Stopped
2018-09-18T17:53:53.857Z,1537293233.857 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-09-18T17:53:53.858Z,1537293233.858 [Startup:A.GoToSurface] Stopped
2018-09-18T17:53:53.858Z,1537293233.858 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-09-18T17:53:53.858Z,1537293233.858 [Startup:StartupSatComms] Stopped
2018-09-18T17:53:53.858Z,1537293233.858 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-09-18T17:53:53.858Z,1537293233.858 [Startup:StartupSatComms:A] Stopped
2018-09-18T17:53:53.860Z,1537293233.860 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-09-18T17:53:53.860Z,1537293233.860 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-09-18T17:53:53.861Z,1537293233.861 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-09-18T17:53:53.861Z,1537293233.861 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-09-18T17:53:53.861Z,1537293233.861 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-09-18T17:53:53.862Z,1537293233.862 [BuoyancyServo](INFO): Powering down
2018-09-18T17:53:53.873Z,1537293233.873 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-09-18T17:53:53.873Z,1537293233.873 [ElevatorServo](INFO): Powering down
2018-09-18T17:53:53.874Z,1537293233.874 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-09-18T17:53:53.874Z,1537293233.874 [MassServo](INFO): Powering down
2018-09-18T17:53:53.875Z,1537293233.875 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-09-18T17:53:53.875Z,1537293233.875 [RudderServo](INFO): Powering down
2018-09-18T17:53:53.877Z,1537293233.877 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-09-18T17:53:53.877Z,1537293233.877 [ThrusterServo](INFO): Powering down
2018-09-18T17:53:53.878Z,1537293233.878 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-09-18T17:53:53.878Z,1537293233.878 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-09-18T17:53:53.878Z,1537293233.878 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-09-18T17:53:53.879Z,1537293233.879 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:53.993Z,1537293233.993 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:53.000Z,1537293234.000 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:54.036Z,1537293234.036 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:54.040Z,1537293234.040 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:54.042Z,1537293234.042 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:54.069Z,1537293234.069 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-09-18T17:53:54.128Z,1537293234.128 [logger ThreadHandler](INFO): Thread cancelled.