2020-10-08T03:08:49.403Z,1602126529.403 [Supervisor](DEBUG): Initializing supervisor.
2020-10-08T03:08:49.409Z,1602126529.409 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-10-08T03:08:49.409Z,1602126529.409 [SyncHandler](INFO): Protected caller Thread ID is 5914
2020-10-08T03:08:49.409Z,1602126529.409 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-10-08T03:08:49.410Z,1602126529.410 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-10-08T03:08:49.411Z,1602126529.411 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5915
2020-10-08T03:08:49.415Z,1602126529.415 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-10-08T03:08:49.434Z,1602126529.434 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-10-08T03:08:49.435Z,1602126529.435 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-10-08T03:08:49.435Z,1602126529.435 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5916
2020-10-08T03:08:49.438Z,1602126529.438 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-10-08T03:08:49.438Z,1602126529.438 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-10-08T03:08:49.439Z,1602126529.439 [logger ThreadHandler](INFO): Protected caller Thread ID is 5917
2020-10-08T03:08:49.442Z,1602126529.442 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-10-08T03:08:49.443Z,1602126529.443 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-10-08T03:08:49.445Z,1602126529.445 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-10-08T03:08:49.611Z,1602126529.611 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-10-08T03:08:49.612Z,1602126529.612 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-10-08T03:08:50.233Z,1602126530.233 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-10-08T03:08:50.234Z,1602126530.234 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-10-08T03:08:50.443Z,1602126530.443 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-10-08T03:08:50.443Z,1602126530.443 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-10-08T03:08:50.527Z,1602126530.527 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-10-08T03:08:50.638Z,1602126530.638 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-10-08T03:08:50.639Z,1602126530.639 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-10-08T03:08:50.723Z,1602126530.723 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-10-08T03:08:50.829Z,1602126530.829 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-10-08T03:08:50.830Z,1602126530.830 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-10-08T03:08:51.144Z,1602126531.144 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-10-08T03:08:51.145Z,1602126531.145 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-10-08T03:08:51.682Z,1602126531.682 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-10-08T03:08:51.682Z,1602126531.682 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-10-08T03:08:51.837Z,1602126531.837 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-10-08T03:08:51.838Z,1602126531.838 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-10-08T03:08:52.043Z,1602126532.043 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-10-08T03:08:52.044Z,1602126532.044 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-10-08T03:08:52.470Z,1602126532.470 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-10-08T03:08:52.470Z,1602126532.470 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-10-08T03:08:52.703Z,1602126532.703 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-10-08T03:08:52.703Z,1602126532.703 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-10-08T03:08:52.916Z,1602126532.916 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-10-08T03:08:52.917Z,1602126532.917 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-10-08T03:08:53.275Z,1602126533.275 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-10-08T03:08:53.276Z,1602126533.276 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-10-08T03:08:53.644Z,1602126533.644 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-10-08T03:08:53.646Z,1602126533.646 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2020-10-08T03:08:53.647Z,1602126533.647 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2020-10-08T03:08:53.891Z,1602126533.891 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2020-10-08T03:08:54.310Z,1602126534.310 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2020-10-08T03:08:54.428Z,1602126534.428 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2020-10-08T03:08:54.574Z,1602126534.574 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2020-10-08T03:08:54.674Z,1602126534.674 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2020-10-08T03:08:54.877Z,1602126534.877 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2020-10-08T03:08:55.136Z,1602126535.136 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-10-08T03:08:55.137Z,1602126535.137 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2020-10-08T03:08:55.235Z,1602126535.235 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2020-10-08T03:08:55.339Z,1602126535.339 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2020-10-08T03:08:55.472Z,1602126535.472 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2020-10-08T03:08:55.578Z,1602126535.578 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/
2020-10-08T03:08:55.579Z,1602126535.579 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-10-08T03:08:55.596Z,1602126535.596 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2020-10-08T03:08:55.673Z,1602126535.673 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2020-10-08T03:08:55.673Z,1602126535.673 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-10-08T03:08:55.724Z,1602126535.724 [VerticalControl](DEBUG): Construct VerticalControl.
2020-10-08T03:08:55.783Z,1602126535.783 [VerticalControl] Loaded
2020-10-08T03:08:55.783Z,1602126535.783 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-10-08T03:08:55.786Z,1602126535.786 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-10-08T03:08:55.823Z,1602126535.823 [HorizontalControl] Loaded
2020-10-08T03:08:55.823Z,1602126535.823 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-10-08T03:08:55.826Z,1602126535.826 [SpeedControl](DEBUG): Construct SpeedControl.
2020-10-08T03:08:55.829Z,1602126535.829 [SpeedControl] Loaded
2020-10-08T03:08:55.829Z,1602126535.829 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-10-08T03:08:55.831Z,1602126535.831 [LoopControl](DEBUG): Construct LoopControl.
2020-10-08T03:08:55.832Z,1602126535.832 [LoopControl] Loaded
2020-10-08T03:08:55.832Z,1602126535.832 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-10-08T03:08:55.833Z,1602126535.833 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-10-08T03:08:55.833Z,1602126535.833 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-10-08T03:08:55.872Z,1602126535.872 [DepthRateCalculator] Loaded
2020-10-08T03:08:55.872Z,1602126535.872 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-10-08T03:08:55.877Z,1602126535.877 [PitchRateCalculator] Loaded
2020-10-08T03:08:55.877Z,1602126535.877 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-10-08T03:08:55.887Z,1602126535.887 [SpeedCalculator] Loaded
2020-10-08T03:08:55.887Z,1602126535.887 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-10-08T03:08:55.901Z,1602126535.901 [TempGradientCalculator] Loaded
2020-10-08T03:08:55.901Z,1602126535.901 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-10-08T03:08:55.906Z,1602126535.906 [YawRateCalculator] Loaded
2020-10-08T03:08:55.906Z,1602126535.906 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-10-08T03:08:55.922Z,1602126535.922 [ElevatorOffsetCalculator] Loaded
2020-10-08T03:08:55.922Z,1602126535.922 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-10-08T03:08:55.923Z,1602126535.923 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-10-08T03:08:55.923Z,1602126535.923 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-10-08T03:08:55.950Z,1602126535.950 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-10-08T03:08:55.950Z,1602126535.950 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-10-08T03:08:56.004Z,1602126536.004 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-10-08T03:08:56.005Z,1602126536.005 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-10-08T03:08:56.304Z,1602126536.304 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-10-08T03:08:56.304Z,1602126536.304 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-10-08T03:08:56.401Z,1602126536.401 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-10-08T03:08:56.402Z,1602126536.402 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-10-08T03:08:56.744Z,1602126536.744 [AHRS_M2] Loaded
2020-10-08T03:08:56.744Z,1602126536.744 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-10-08T03:08:56.775Z,1602126536.775 [BackseatComponent] Loaded
2020-10-08T03:08:56.776Z,1602126536.776 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2020-10-08T03:08:56.777Z,1602126536.777 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408F94E0
2020-10-08T03:08:56.777Z,1602126536.777 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 5999
2020-10-08T03:08:57.513Z,1602126537.513 [BPC1] Loaded
2020-10-08T03:08:57.513Z,1602126537.513 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-10-08T03:08:57.586Z,1602126537.586 [DataOverHttps] Loaded
2020-10-08T03:08:57.586Z,1602126537.586 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-10-08T03:08:57.587Z,1602126537.587 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409294E0
2020-10-08T03:08:57.588Z,1602126537.588 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6000
2020-10-08T03:08:57.606Z,1602126537.606 [Depth_Keller] Loaded
2020-10-08T03:08:57.606Z,1602126537.606 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-10-08T03:08:57.664Z,1602126537.664 [NAL9602] Loaded
2020-10-08T03:08:57.664Z,1602126537.664 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-10-08T03:08:57.692Z,1602126537.692 [Onboard] Loaded
2020-10-08T03:08:57.693Z,1602126537.693 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2020-10-08T03:08:57.694Z,1602126537.694 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409594E0
2020-10-08T03:08:57.694Z,1602126537.694 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6001
2020-10-08T03:08:57.706Z,1602126537.706 [Radio_Surface] Loaded
2020-10-08T03:08:57.707Z,1602126537.707 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-10-08T03:08:57.708Z,1602126537.708 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409894E0
2020-10-08T03:08:57.708Z,1602126537.708 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6002
2020-10-08T03:08:57.738Z,1602126537.738 [RDI_Pathfinder] Loaded
2020-10-08T03:08:57.738Z,1602126537.738 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2020-10-08T03:08:57.812Z,1602126537.812 [DAT] Loaded
2020-10-08T03:08:57.813Z,1602126537.813 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-10-08T03:08:57.813Z,1602126537.813 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-10-08T03:08:57.814Z,1602126537.814 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-10-08T03:08:57.890Z,1602126537.890 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-10-08T03:08:57.891Z,1602126537.891 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-10-08T03:08:57.904Z,1602126537.904 [NavChart] Loaded
2020-10-08T03:08:57.904Z,1602126537.904 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-10-08T03:08:57.910Z,1602126537.910 [UniversalFixResidualReporter] Loaded
2020-10-08T03:08:57.910Z,1602126537.910 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-10-08T03:08:57.911Z,1602126537.911 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-10-08T03:08:57.911Z,1602126537.911 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-10-08T03:08:58.048Z,1602126538.048 [SBIT](DEBUG): Construct Startup Built In Test.
2020-10-08T03:08:58.057Z,1602126538.057 [SBIT] Loaded
2020-10-08T03:08:58.057Z,1602126538.057 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-10-08T03:08:58.059Z,1602126538.059 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-10-08T03:08:58.072Z,1602126538.072 [IBIT] Loaded
2020-10-08T03:08:58.072Z,1602126538.072 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-10-08T03:08:58.078Z,1602126538.078 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-10-08T03:08:58.174Z,1602126538.174 [CBIT] Loaded
2020-10-08T03:08:58.175Z,1602126538.175 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-10-08T03:08:58.175Z,1602126538.175 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-10-08T03:08:58.176Z,1602126538.176 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-10-08T03:08:58.287Z,1602126538.287 [BuoyancyServo] Loaded
2020-10-08T03:08:58.287Z,1602126538.287 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-10-08T03:08:58.306Z,1602126538.306 [ElevatorServo] Loaded
2020-10-08T03:08:58.306Z,1602126538.306 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-10-08T03:08:58.325Z,1602126538.325 [MassServo] Loaded
2020-10-08T03:08:58.326Z,1602126538.326 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-10-08T03:08:58.343Z,1602126538.343 [RudderServo] Loaded
2020-10-08T03:08:58.343Z,1602126538.343 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-10-08T03:08:58.361Z,1602126538.361 [ThrusterServo] Loaded
2020-10-08T03:08:58.361Z,1602126538.361 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-10-08T03:08:58.362Z,1602126538.362 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-10-08T03:08:58.362Z,1602126538.362 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-10-08T03:08:58.373Z,1602126538.373 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-10-08T03:08:58.374Z,1602126538.374 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-10-08T03:08:58.541Z,1602126538.541 [CTD_Seabird] Loaded
2020-10-08T03:08:58.542Z,1602126538.542 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-10-08T03:08:58.543Z,1602126538.543 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40AB94E0
2020-10-08T03:08:58.543Z,1602126538.543 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6003
2020-10-08T03:08:58.575Z,1602126538.575 [ESPComponent] Loaded
2020-10-08T03:08:58.575Z,1602126538.575 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2020-10-08T03:08:58.594Z,1602126538.594 [PAR_Licor] Loaded
2020-10-08T03:08:58.594Z,1602126538.594 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-10-08T03:08:58.626Z,1602126538.626 [WetLabsBB2FL] Loaded
2020-10-08T03:08:58.626Z,1602126538.626 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-10-08T03:08:58.627Z,1602126538.627 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AE94E0
2020-10-08T03:08:58.627Z,1602126538.627 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6004
2020-10-08T03:08:58.646Z,1602126538.646 [WetLabsUBAT] Loaded
2020-10-08T03:08:58.646Z,1602126538.646 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread.
2020-10-08T03:08:58.647Z,1602126538.647 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40B194E0
2020-10-08T03:08:58.647Z,1602126538.647 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 6005
2020-10-08T03:08:58.648Z,1602126538.648 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-10-08T03:08:58.671Z,1602126538.671 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-10-08T03:08:58.674Z,1602126538.674 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-10-08T03:08:58.727Z,1602126538.727 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-10-08T03:08:58.730Z,1602126538.730 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B494E0
2020-10-08T03:08:58.730Z,1602126538.730 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6006
2020-10-08T03:08:58.768Z,1602126538.768 [Supervisor](INFO): Main Thread ID is 5734
2020-10-08T03:08:58.768Z,1602126538.768 [Supervisor](DEBUG): Running supervisor.
2020-10-08T03:08:58.769Z,1602126538.769 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6007
2020-10-08T03:08:58.798Z,1602126538.798 [controlThread ThreadHandler](INFO): Handler Thread ID is 6008
2020-10-08T03:08:58.798Z,1602126538.798 [controlThread](DEBUG): Initializing ControlThread
2020-10-08T03:08:58.799Z,1602126538.799 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-10-08T03:08:58.801Z,1602126538.801 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-10-08T03:08:58.802Z,1602126538.802 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-10-08T03:08:58.802Z,1602126538.802 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-10-08T03:08:58.803Z,1602126538.803 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-10-08T03:08:58.803Z,1602126538.803 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-10-08T03:08:58.803Z,1602126538.803 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-10-08T03:08:58.804Z,1602126538.804 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-10-08T03:08:58.804Z,1602126538.804 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-10-08T03:08:58.805Z,1602126538.805 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-10-08T03:08:58.810Z,1602126538.810 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-10-08T03:08:58.810Z,1602126538.810 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-10-08T03:08:58.810Z,1602126538.810 [SBIT](INFO): Initialize SBIT Component.
2020-10-08T03:08:58.811Z,1602126538.811 [SBIT](IMPORTANT): git: 2020-09-23a-38-g0705018
2020-10-08T03:08:58.811Z,1602126538.811 [SBIT](INFO): git hash: 07050183e37285877b4e85b27f87f7f45e39aa2e
2020-10-08T03:08:58.811Z,1602126538.811 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-10-08T03:08:58.813Z,1602126538.813 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020
2020-10-08T03:08:58.814Z,1602126538.814 [SBIT](INFO): Beginning SBIT in 99.000000 seconds.
2020-10-08T03:08:58.814Z,1602126538.814 [IBIT](INFO): Initialize IBIT Component.
2020-10-08T03:08:58.815Z,1602126538.815 [CBIT](DEBUG): Initialize CBIT Component.
2020-10-08T03:08:58.816Z,1602126538.816 [logger ThreadHandler](INFO): Handler Thread ID is 6009
2020-10-08T03:08:58.828Z,1602126538.828 [CBIT](DEBUG): Initialized mux pins.
2020-10-08T03:08:58.828Z,1602126538.828 [CBIT](DEBUG): Initializing the watchdog timer.
2020-10-08T03:08:58.856Z,1602126538.856 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-10-08T03:08:58.856Z,1602126538.856 [CBIT](DEBUG): Initializing heartbeat.
2020-10-08T03:08:58.857Z,1602126538.857 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 6010
2020-10-08T03:08:58.859Z,1602126538.859 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6011
2020-10-08T03:08:58.860Z,1602126538.860 [Onboard ThreadHandler](INFO): Handler Thread ID is 6012
2020-10-08T03:08:58.861Z,1602126538.861 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6013
2020-10-08T03:08:58.877Z,1602126538.877 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-10-08T03:08:58.897Z,1602126538.897 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6014
2020-10-08T03:08:58.897Z,1602126538.897 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-10-08T03:08:58.900Z,1602126538.900 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6016
2020-10-08T03:08:58.903Z,1602126538.903 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 6017
2020-10-08T03:08:58.905Z,1602126538.905 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6018
2020-10-08T03:08:58.909Z,1602126538.909 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-10-08T03:08:58.909Z,1602126538.909 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-10-08T03:08:58.909Z,1602126538.909 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-10-08T03:08:58.909Z,1602126538.909 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-10-08T03:08:58.909Z,1602126538.909 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-10-08T03:08:58.910Z,1602126538.910 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-10-08T03:08:58.910Z,1602126538.910 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-10-08T03:08:58.910Z,1602126538.910 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-10-08T03:08:58.910Z,1602126538.910 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-10-08T03:08:58.910Z,1602126538.910 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-10-08T03:08:58.910Z,1602126538.910 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-10-08T03:08:58.911Z,1602126538.911 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-10-08T03:08:58.911Z,1602126538.911 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-10-08T03:08:58.911Z,1602126538.911 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-10-08T03:08:58.911Z,1602126538.911 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-10-08T03:08:58.911Z,1602126538.911 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-10-08T03:08:58.928Z,1602126538.928 [CBIT](DEBUG): Deactivating GF circuits.
2020-10-08T03:08:58.928Z,1602126538.928 [CBIT](DEBUG): Deactivating emergency mode.
2020-10-08T03:08:58.953Z,1602126538.953 [WetLabsBB2FL](INFO): Powering up
2020-10-08T03:08:58.964Z,1602126538.964 [CBIT](DEBUG): Backplane powered.
2020-10-08T03:08:58.973Z,1602126538.973 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-10-08T03:08:59.018Z,1602126539.018 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-10-08T03:08:59.029Z,1602126539.029 [WetLabsUBAT](INFO): Powering up
2020-10-08T03:08:59.078Z,1602126539.078 [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>


2020-10-08T03:08:59.079Z,1602126539.079 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-10-08T03:08:59.135Z,1602126539.135 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-10-08T03:08:59.152Z,1602126539.152 [Default:A.Wait](DEBUG): Construct Wait.
2020-10-08T03:08:59.155Z,1602126539.155 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-10-08T03:08:59.182Z,1602126539.182 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-10-08T03:08:59.205Z,1602126539.205 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-10-08T03:08:59.210Z,1602126539.210 [Default:E.Execute](DEBUG): Construct Execute.
2020-10-08T03:08:59.230Z,1602126539.230 [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>


2020-10-08T03:08:59.234Z,1602126539.234 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,RDI_Pathfinder,DAT,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-10-08T03:08:59.244Z,1602126539.244 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-10-08T03:08:59.264Z,1602126539.264 [Radio_Surface](INFO): Powering up
2020-10-08T03:08:59.321Z,1602126539.321 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2020-10-08T03:08:59.335Z,1602126539.335 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-10-08T03:08:59.336Z,1602126539.336 [DAT](INFO): Powering up
2020-10-08T03:08:59.336Z,1602126539.336 [DAT](DEBUG): Initializing DAT.
2020-10-08T03:08:59.369Z,1602126539.369 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-10-08T03:08:59.455Z,1602126539.455 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-10-08T03:08:59.520Z,1602126539.520 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-10-08T03:08:59.529Z,1602126539.529 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-10-08T03:08:59.530Z,1602126539.530 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-10-08T03:08:59.537Z,1602126539.537 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-10-08T03:08:59.538Z,1602126539.538 [MassServo](DEBUG): Initializing EZServoServo.
2020-10-08T03:08:59.545Z,1602126539.545 [MassServo](DEBUG): Initializing MassServo.
2020-10-08T03:08:59.546Z,1602126539.546 [RudderServo](DEBUG): Initializing EZServoServo.
2020-10-08T03:08:59.561Z,1602126539.561 [RudderServo](DEBUG): Initializing RudderServo.
2020-10-08T03:08:59.562Z,1602126539.562 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-10-08T03:08:59.569Z,1602126539.569 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-10-08T03:08:59.665Z,1602126539.665 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-10-08T03:09:00.376Z,1602126540.376 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-10-08T03:09:00.376Z,1602126540.376 [RudderServo](FAULT): Rudder failed to initialize
2020-10-08T03:09:00.377Z,1602126540.377 [RudderServo] Communications Fault, FailCount= 1
2020-10-08T03:09:00.377Z,1602126540.377 [RudderServo](ERROR): Communications Fault
2020-10-08T03:09:00.512Z,1602126540.512 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-10-08T03:09:00.681Z,1602126540.681 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-10-08T03:09:00.682Z,1602126540.682 [RudderServo](INFO): Powering down
2020-10-08T03:09:01.349Z,1602126541.349 [RudderServo](DEBUG): Initializing EZServoServo.
2020-10-08T03:09:01.469Z,1602126541.469 [RudderServo](DEBUG): Initializing RudderServo.
2020-10-08T03:09:01.473Z,1602126541.473 [CBIT](INFO): Clearing failed state for component RudderServo
2020-10-08T03:09:01.473Z,1602126541.473 [RudderServo] No Fault, FailCount= 1
2020-10-08T03:09:01.513Z,1602126541.513 [WetLabsBB2FL](INFO): Powering down
2020-10-08T03:09:06.933Z,1602126546.933 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2020-10-08T03:09:08.277Z,1602126548.277 [WetLabsUBAT](INFO): Powering down
2020-10-08T03:09:13.452Z,1602126553.452 [DAT](INFO): commRate: 800
2020-10-08T03:09:15.482Z,1602126555.482 [DAT](INFO): entering command mode
2020-10-08T03:09:15.875Z,1602126555.875 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:16.278Z,1602126556.278 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:16.693Z,1602126556.693 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:17.137Z,1602126557.137 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:17.490Z,1602126557.490 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:17.906Z,1602126557.906 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:18.302Z,1602126558.302 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:18.702Z,1602126558.702 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:19.117Z,1602126559.117 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:19.522Z,1602126559.522 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:19.929Z,1602126559.929 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:20.318Z,1602126560.318 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:20.722Z,1602126560.722 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:21.145Z,1602126561.145 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:21.530Z,1602126561.530 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:21.945Z,1602126561.945 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:22.338Z,1602126562.338 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:22.750Z,1602126562.750 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:23.184Z,1602126563.184 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:23.550Z,1602126563.550 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:23.954Z,1602126563.954 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:24.377Z,1602126564.377 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:24.762Z,1602126564.762 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:25.166Z,1602126565.166 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:25.589Z,1602126565.589 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:25.994Z,1602126565.994 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:26.378Z,1602126566.378 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:26.794Z,1602126566.794 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:27.197Z,1602126567.197 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:27.596Z,1602126567.596 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:28.012Z,1602126568.012 [NAL9602](INFO): Powering up NAL9602
2020-10-08T03:09:28.029Z,1602126568.029 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:28.398Z,1602126568.398 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:28.851Z,1602126568.851 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:29.210Z,1602126569.210 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:29.610Z,1602126569.610 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:30.025Z,1602126570.025 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:30.418Z,1602126570.418 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:30.823Z,1602126570.823 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-08T03:09:30.823Z,1602126570.823 [DAT](FAULT): failed to enter command mode
2020-10-08T03:09:31.245Z,1602126571.245 [DAT](INFO): entering command mode
2020-10-08T03:09:31.631Z,1602126571.631 [DAT](INFO): setting verbose to 3
2020-10-08T03:09:32.047Z,1602126572.047 [DAT](INFO): set verbose to 3
2020-10-08T03:09:32.047Z,1602126572.047 [DAT](INFO): setting DatVerbose to 27440
2020-10-08T03:09:32.439Z,1602126572.439 [DAT](INFO): set DatVerbose to 27440
2020-10-08T03:09:32.440Z,1602126572.440 [DAT](INFO): setting transmit power to 8
2020-10-08T03:09:32.843Z,1602126572.843 [DAT](INFO): set transmit power to 8
2020-10-08T03:09:32.844Z,1602126572.844 [DAT](INFO): setting local address to 9
2020-10-08T03:09:33.247Z,1602126573.247 [DAT](INFO): set local address to 9
2020-10-08T03:09:38.939Z,1602126578.939 [NAL9602](INFO): NAL9602 initialized
2020-10-08T03:10:19.404Z,1602126619.404 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:10:30.665Z,1602126630.665 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:10:38.313Z,1602126638.313 [SBIT](IMPORTANT): Beginning Startup BIT
2020-10-08T03:10:38.317Z,1602126638.317 [CBIT](IMPORTANT): Beginning ground fault scan
2020-10-08T03:10:45.622Z,1602126645.622 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:10:49.273Z,1602126649.273 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.009847
CHAN A1 (24V): -0.001576
CHAN A2 (12V): -0.007136
CHAN A3 (5V): -0.002204
CHAN B0 (3.3V): 0.000113
CHAN B1 (3.15aV): -0.000446
CHAN B2 (3.15bV): -0.000116
CHAN B3 (GND): 0.001842
OPEN: 0.005111
Full Scale Calc: 4.765 mA, -1.589 mA
2020-10-08T03:11:20.329Z,1602126680.329 [RDI_Pathfinder](ERROR): only read 0 of 4 data items
2020-10-08T03:11:26.025Z,1602126686.025 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:11:27.107Z,1602126687.107 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005042
2020-10-08T03:11:32.073Z,1602126692.073 [SBIT](IMPORTANT): SBIT PASSED
2020-10-08T03:11:32.073Z,1602126692.073 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-10-08T03:11:32.074Z,1602126692.074 [SBIT](IMPORTANT): AMEcho.loadAtStartup=0 bool;

2020-10-08T03:11:32.074Z,1602126692.074 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count;

2020-10-08T03:11:32.074Z,1602126692.074 [SBIT](IMPORTANT): BuoyancyServo.loadAtStartup=1 bool;

2020-10-08T03:11:32.074Z,1602126692.074 [SBIT](IMPORTANT): CBIT.gf24Offset=145 microampere;

2020-10-08T03:11:32.075Z,1602126692.075 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool;

2020-10-08T03:11:32.075Z,1602126692.075 [SBIT](IMPORTANT): DAT.sbdAddress=-1 enum;

2020-10-08T03:11:32.075Z,1602126692.075 [SBIT](IMPORTANT): DAT.surfaceThreshold=100 meter;

2020-10-08T03:11:32.075Z,1602126692.075 [SBIT](IMPORTANT): DAT.verbosity=0 count;

2020-10-08T03:11:32.075Z,1602126692.075 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2020-10-08T03:11:32.075Z,1602126692.075 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2020-10-08T03:11:32.075Z,1602126692.075 [SBIT](IMPORTANT): Express linearApproximation AMEcho.altitude 1.000000 meter;

2020-10-08T03:11:32.075Z,1602126692.075 [SBIT](IMPORTANT): Express none ThrusterServo.component_avgCurrent;

2020-10-08T03:11:32.075Z,1602126692.075 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 1.000000 liter_per_second;

2020-10-08T03:11:32.076Z,1602126692.076 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;

2020-10-08T03:11:32.076Z,1602126692.076 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=13 volt;

2020-10-08T03:11:32.076Z,1602126692.076 [SBIT](IMPORTANT): PAR_Licor.loadAtStartup=1 bool;

2020-10-08T03:11:32.076Z,1602126692.076 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=1 bool;

2020-10-08T03:11:32.080Z,1602126692.080 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=170 cubic_centimeter;

2020-10-08T03:11:32.080Z,1602126692.080 [SBIT](IMPORTANT): VerticalControl.massDefault=20 millimeter;

2020-10-08T03:11:32.081Z,1602126692.081 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=1 bool;

2020-10-08T03:11:32.455Z,1602126692.455 [MissionManager](IMPORTANT): Started mission Startup
2020-10-08T03:11:32.455Z,1602126692.455 [Startup] Running Loop=1
2020-10-08T03:11:32.455Z,1602126692.455 [Startup](DEBUG): Aggregate::initialize Startup
2020-10-08T03:11:32.455Z,1602126692.455 [Startup:A.GoToSurface] Running Loop=1
2020-10-08T03:11:32.455Z,1602126692.455 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-10-08T03:11:32.456Z,1602126692.456 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-10-08T03:11:32.456Z,1602126692.456 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-10-08T03:11:32.457Z,1602126692.457 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-10-08T03:11:32.457Z,1602126692.457 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-10-08T03:11:32.458Z,1602126692.458 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-10-08T03:11:32.459Z,1602126692.459 [Startup:StartupSatComms] Running Loop=1
2020-10-08T03:11:32.459Z,1602126692.459 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-10-08T03:11:32.459Z,1602126692.459 [Startup:StartupSatComms:A] Running Loop=1
2020-10-08T03:11:32.943Z,1602126692.943 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-10-08T03:11:59.158Z,1602126719.158 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-10-08T03:11:59.158Z,1602126719.158 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-08T03:11:59.201Z,1602126719.201 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-08T03:11:59.543Z,1602126719.543 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-08T03:11:59.543Z,1602126719.543 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-10-08T03:12:32.636Z,1602126752.636 [Startup:StartupSatComms:A](INFO): Timed out from 2020-10-08T03:11:32.5Z
2020-10-08T03:12:32.636Z,1602126752.636 [Startup:StartupSatComms:A] Stopped
2020-10-08T03:12:32.636Z,1602126752.636 [Startup:StartupSatComms:B] Running Loop=1
2020-10-08T03:12:33.058Z,1602126753.058 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-10-08T03:12:37.575Z,1602126757.575 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201008T024334/Courier0010.lzma
2020-10-08T03:12:37.734Z,1602126757.734 [DataOverHttps](INFO): Moved sent file to Logs/20201008T024334/Courier0010.lzma.bak
2020-10-08T03:12:37.734Z,1602126757.734 [DataOverHttps](INFO): SBD MOMSN=12816639
2020-10-08T03:12:54.676Z,1602126774.676 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20201008T030849/Courier0000.lzma
2020-10-08T03:12:55.678Z,1602126775.678 [DataOverHttps](INFO): Moved sent file to Logs/20201008T030849/Courier0000.lzma.bak
2020-10-08T03:12:55.678Z,1602126775.678 [DataOverHttps](INFO): SBD MOMSN=12816641
2020-10-08T03:13:13.424Z,1602126793.424 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20201008T024334/Express0011.lzma
2020-10-08T03:13:14.426Z,1602126794.426 [DataOverHttps](INFO): Moved sent file to Logs/20201008T024334/Express0011.lzma.bak
2020-10-08T03:13:14.426Z,1602126794.426 [DataOverHttps](INFO): SBD MOMSN=12816644
2020-10-08T03:13:32.258Z,1602126812.258 [DataOverHttps](INFO): Sending 1125 bytes from file Logs/20201008T030849/Express0001.lzma
2020-10-08T03:13:32.983Z,1602126812.983 [Startup:StartupSatComms:B](INFO): Timed out from 2020-10-08T03:12:32.6Z
2020-10-08T03:13:32.983Z,1602126812.983 [Startup:StartupSatComms:B] Stopped
2020-10-08T03:13:32.984Z,1602126812.984 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-10-08T03:13:32.984Z,1602126812.984 [Startup:StartupSatComms] Stopped
2020-10-08T03:13:32.984Z,1602126812.984 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-10-08T03:13:32.985Z,1602126812.985 [Startup](INFO): Completed Startup
2020-10-08T03:13:32.985Z,1602126812.985 [MissionManager](INFO): Startup is completed.
2020-10-08T03:13:32.985Z,1602126812.985 [MissionManager](INFO): Uninitializing Mission Startup
2020-10-08T03:13:32.985Z,1602126812.985 [Startup] Stopped
2020-10-08T03:13:32.985Z,1602126812.985 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-10-08T03:13:32.985Z,1602126812.985 [Startup:A.GoToSurface] Stopped
2020-10-08T03:13:32.985Z,1602126812.985 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-10-08T03:13:33.258Z,1602126813.258 [DataOverHttps](INFO): Moved sent file to Logs/20201008T030849/Express0001.lzma.bak
2020-10-08T03:13:33.258Z,1602126813.258 [DataOverHttps](INFO): SBD MOMSN=12816648
2020-10-08T03:13:33.374Z,1602126813.374 [MissionManager](IMPORTANT): Started mission Default
2020-10-08T03:13:33.374Z,1602126813.374 [Default] Running Loop=1
2020-10-08T03:13:33.374Z,1602126813.374 [Default](DEBUG): Aggregate::initialize Default
2020-10-08T03:13:33.374Z,1602126813.374 [Default:B.GoToSurface] Running Loop=1
2020-10-08T03:13:33.374Z,1602126813.374 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-10-08T03:13:33.375Z,1602126813.375 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-10-08T03:13:33.375Z,1602126813.375 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-10-08T03:13:33.375Z,1602126813.375 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-10-08T03:13:33.375Z,1602126813.375 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-10-08T03:13:33.376Z,1602126813.376 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-10-08T03:13:33.376Z,1602126813.376 [Default:A.Wait] Running Loop=1
2020-10-08T03:13:33.376Z,1602126813.376 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-10-08T03:13:44.454Z,1602126824.454 [CommandLine](IMPORTANT): got command run ./Missions/test.xml
2020-10-08T03:13:44.455Z,1602126824.455 [MissionManager](INFO): Loading Mission: ./Missions/test.xml
2020-10-08T03:13:44.466Z,1602126824.466 [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="test">

    <ReadData Strategy="MinError">
        <Science:WetLabsUBAT.biolum_potential/>
    </ReadData>

    <ReadData Strategy="MinError">
        <Science:WetLabsUBAT.enableBroadcast/>
    </ReadData>

</Mission>


2020-10-08T03:13:44.468Z,1602126824.468 [CommandLine](IMPORTANT): Running ./Missions/test.xml
2020-10-08T03:13:44.677Z,1602126824.677 [Default] Stopped
2020-10-08T03:13:44.677Z,1602126824.677 [Default](DEBUG): Aggregate::uninitialize Default
2020-10-08T03:13:44.677Z,1602126824.677 [Default:A.Wait] Stopped
2020-10-08T03:13:44.677Z,1602126824.677 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-10-08T03:13:44.678Z,1602126824.678 [Default:B.GoToSurface] Stopped
2020-10-08T03:13:44.678Z,1602126824.678 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-10-08T03:13:44.678Z,1602126824.678 [MissionManager](IMPORTANT): Started mission test
2020-10-08T03:13:44.678Z,1602126824.678 [test] Running Loop=1
2020-10-08T03:13:44.678Z,1602126824.678 [test](DEBUG): Aggregate::initialize test
2020-10-08T03:13:44.678Z,1602126824.678 [test:A] Running Loop=1
2020-10-08T03:13:44.678Z,1602126824.678 [test:B] Running Loop=1
2020-10-08T03:13:44.678Z,1602126824.678 [test:B] Running Loop=1
2020-10-08T03:13:44.679Z,1602126824.679 [test:B](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.enableBroadcast
2020-10-08T03:13:44.679Z,1602126824.679 [test:A] Running Loop=1
2020-10-08T03:13:44.680Z,1602126824.680 [test:A](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.biolum_potential
2020-10-08T03:13:44.925Z,1602126824.925 [WetLabsUBAT](INFO): Activating messaging.
2020-10-08T03:13:45.333Z,1602126825.333 [WetLabsUBAT](INFO): Powering up
2020-10-08T03:14:00.252Z,1602126840.252 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:14:10.606Z,1602126850.606 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:14:22.012Z,1602126862.012 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:14:22.329Z,1602126862.329 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:14:25.006Z,1602126865.006 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout.
2020-10-08T03:14:25.006Z,1602126865.006 [WetLabsUBAT] Communications Fault, FailCount= 1
2020-10-08T03:14:25.006Z,1602126865.006 [WetLabsUBAT](ERROR): Communications Fault
2020-10-08T03:14:25.134Z,1602126865.134 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT
2020-10-08T03:14:25.509Z,1602126865.509 [WetLabsUBAT](INFO): Powering down
2020-10-08T03:14:26.718Z,1602126866.718 [CBIT](INFO): Clearing failed state for component WetLabsUBAT
2020-10-08T03:14:26.718Z,1602126866.718 [WetLabsUBAT] No Fault, FailCount= 1
2020-10-08T03:14:26.722Z,1602126866.722 [WetLabsUBAT](INFO): Powering up
2020-10-08T03:14:32.420Z,1602126872.420 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:14:35.241Z,1602126875.241 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:14:42.054Z,1602126882.054 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-10-08T03:14:43.330Z,1602126883.330 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:14:46.166Z,1602126886.166 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:14:54.390Z,1602126894.390 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:14:57.065Z,1602126897.065 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:15:00.257Z,1602126900.257 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-10-08T03:15:00.257Z,1602126900.257 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-08T03:15:00.266Z,1602126900.266 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-08T03:15:00.677Z,1602126900.677 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-08T03:15:00.678Z,1602126900.678 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-10-08T03:15:05.210Z,1602126905.210 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:15:06.386Z,1602126906.386 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout.
2020-10-08T03:15:06.386Z,1602126906.386 [WetLabsUBAT] Communications Fault, FailCount= 1
2020-10-08T03:15:06.386Z,1602126906.386 [WetLabsUBAT](ERROR): Communications Fault
2020-10-08T03:15:06.433Z,1602126906.433 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT
2020-10-08T03:15:06.885Z,1602126906.885 [WetLabsUBAT](INFO): Powering down
2020-10-08T03:15:07.567Z,1602126907.567 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:15:07.995Z,1602126907.995 [CBIT](INFO): Clearing failed state for component WetLabsUBAT
2020-10-08T03:15:07.995Z,1602126907.995 [WetLabsUBAT] No Fault, FailCount= 1
2020-10-08T03:15:08.098Z,1602126908.098 [WetLabsUBAT](INFO): Powering up
2020-10-08T03:15:16.052Z,1602126916.052 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:15:18.481Z,1602126918.481 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:15:27.014Z,1602126927.014 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:15:29.385Z,1602126929.385 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:15:37.979Z,1602126937.979 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:15:40.299Z,1602126940.299 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:15:47.771Z,1602126947.771 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout.
2020-10-08T03:15:47.771Z,1602126947.771 [WetLabsUBAT] Communications Fault, FailCount= 1
2020-10-08T03:15:47.771Z,1602126947.771 [WetLabsUBAT](ERROR): Communications Fault
2020-10-08T03:15:47.997Z,1602126947.997 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT
2020-10-08T03:15:48.273Z,1602126948.273 [WetLabsUBAT](INFO): Powering down
2020-10-08T03:15:48.774Z,1602126948.774 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:15:49.184Z,1602126949.184 [CBIT](INFO): Clearing failed state for component WetLabsUBAT
2020-10-08T03:15:49.185Z,1602126949.185 [WetLabsUBAT] No Fault, FailCount= 1
2020-10-08T03:15:49.486Z,1602126949.486 [WetLabsUBAT](INFO): Powering up
2020-10-08T03:15:51.198Z,1602126951.198 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:15:59.743Z,1602126959.743 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:16:02.167Z,1602126962.167 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:16:11.021Z,1602126971.021 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:16:13.026Z,1602126973.026 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:16:22.307Z,1602126982.307 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:16:23.926Z,1602126983.926 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:16:29.151Z,1602126989.151 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout.
2020-10-08T03:16:29.151Z,1602126989.151 [WetLabsUBAT] Communications Fault, FailCount= 1
2020-10-08T03:16:29.151Z,1602126989.151 [WetLabsUBAT](ERROR): Communications Fault
2020-10-08T03:16:29.219Z,1602126989.219 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT
2020-10-08T03:16:29.649Z,1602126989.649 [WetLabsUBAT](INFO): Powering down
2020-10-08T03:16:30.743Z,1602126990.743 [CBIT](INFO): Clearing failed state for component WetLabsUBAT
2020-10-08T03:16:30.743Z,1602126990.743 [WetLabsUBAT] No Fault, FailCount= 1
2020-10-08T03:16:30.862Z,1602126990.862 [WetLabsUBAT](INFO): Powering up
2020-10-08T03:16:33.221Z,1602126993.221 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:16:34.832Z,1602126994.832 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:16:43.313Z,1602127003.313 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:16:45.742Z,1602127005.742 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:16:54.227Z,1602127014.227 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:16:54.583Z,1602127014.583 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-10-08T03:16:56.244Z,1602127016.244 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:17:05.551Z,1602127025.551 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:17:07.157Z,1602127027.157 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:17:10.547Z,1602127030.547 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout.
2020-10-08T03:17:10.547Z,1602127030.547 [WetLabsUBAT] Communications Fault, FailCount= 1
2020-10-08T03:17:10.547Z,1602127030.547 [WetLabsUBAT](ERROR): Communications Fault
2020-10-08T03:17:10.800Z,1602127030.800 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT
2020-10-08T03:17:11.048Z,1602127031.048 [WetLabsUBAT](INFO): Powering down
2020-10-08T03:17:11.983Z,1602127031.983 [CBIT](INFO): Clearing failed state for component WetLabsUBAT
2020-10-08T03:17:11.983Z,1602127031.983 [WetLabsUBAT] No Fault, FailCount= 1
2020-10-08T03:17:12.262Z,1602127032.262 [WetLabsUBAT](INFO): Powering up
2020-10-08T03:17:16.874Z,1602127036.874 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:17:27.757Z,1602127047.757 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:17:38.664Z,1602127058.664 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:17:49.633Z,1602127069.633 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:17:51.930Z,1602127071.930 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout.
2020-10-08T03:17:51.930Z,1602127071.930 [WetLabsUBAT] Communications Fault, FailCount= 1
2020-10-08T03:17:51.930Z,1602127071.930 [WetLabsUBAT](ERROR): Communications Fault
2020-10-08T03:17:52.001Z,1602127072.001 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT
2020-10-08T03:17:52.425Z,1602127072.425 [WetLabsUBAT](INFO): Powering down
2020-10-08T03:17:53.586Z,1602127073.586 [CBIT](INFO): Clearing failed state for component WetLabsUBAT
2020-10-08T03:17:53.586Z,1602127073.586 [WetLabsUBAT] No Fault, FailCount= 1
2020-10-08T03:17:53.638Z,1602127073.638 [WetLabsUBAT](INFO): Powering up
2020-10-08T03:18:00.899Z,1602127080.899 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:18:01.246Z,1602127081.246 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-10-08T03:18:01.246Z,1602127081.246 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-08T03:18:01.255Z,1602127081.255 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-08T03:18:01.666Z,1602127081.666 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-08T03:18:01.666Z,1602127081.666 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-10-08T03:18:11.826Z,1602127091.826 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:18:22.751Z,1602127102.751 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:18:33.307Z,1602127113.307 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout.
2020-10-08T03:18:33.307Z,1602127113.307 [WetLabsUBAT] Communications Fault, FailCount= 1
2020-10-08T03:18:33.307Z,1602127113.307 [WetLabsUBAT](ERROR): Communications Fault
2020-10-08T03:18:33.612Z,1602127113.612 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:18:33.668Z,1602127113.668 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT
2020-10-08T03:18:33.809Z,1602127113.809 [WetLabsUBAT](INFO): Powering down
2020-10-08T03:18:34.801Z,1602127114.801 [CBIT](INFO): Clearing failed state for component WetLabsUBAT
2020-10-08T03:18:34.802Z,1602127114.802 [WetLabsUBAT] No Fault, FailCount= 1
2020-10-08T03:18:35.022Z,1602127115.022 [WetLabsUBAT](INFO): Powering up
2020-10-08T03:18:44.516Z,1602127124.516 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:19:14.674Z,1602127154.674 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout.
2020-10-08T03:19:14.674Z,1602127154.674 [WetLabsUBAT] Communications Fault, FailCount= 1
2020-10-08T03:19:14.674Z,1602127154.674 [WetLabsUBAT](ERROR): Communications Fault
2020-10-08T03:19:14.837Z,1602127154.837 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT
2020-10-08T03:19:15.173Z,1602127155.173 [WetLabsUBAT](INFO): Powering down
2020-10-08T03:19:16.046Z,1602127156.046 [CBIT](INFO): Clearing failed state for component WetLabsUBAT
2020-10-08T03:19:16.046Z,1602127156.046 [WetLabsUBAT] No Fault, FailCount= 1
2020-10-08T03:19:16.394Z,1602127156.394 [WetLabsUBAT](INFO): Powering up
2020-10-08T03:19:42.247Z,1602127182.247 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-10-08T03:19:42.247Z,1602127182.247 [NAL9602] Data Fault, FailCount= 1
2020-10-08T03:19:42.247Z,1602127182.247 [NAL9602](ERROR): Data Fault
2020-10-08T03:19:42.269Z,1602127182.269 [CBIT](ERROR): Data Fault in component: NAL9602
2020-10-08T03:19:42.630Z,1602127182.630 [NAL9602](INFO): Powering down
2020-10-08T03:19:43.095Z,1602127183.095 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:19:43.473Z,1602127183.473 [CBIT](INFO): Clearing failed state for component NAL9602
2020-10-08T03:19:43.473Z,1602127183.473 [NAL9602] No Fault, FailCount= 1
2020-10-08T03:19:56.066Z,1602127196.066 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout.
2020-10-08T03:19:56.066Z,1602127196.066 [WetLabsUBAT] Communications Fault, FailCount= 1
2020-10-08T03:19:56.066Z,1602127196.066 [WetLabsUBAT](ERROR): Communications Fault
2020-10-08T03:19:56.442Z,1602127196.442 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT
2020-10-08T03:19:56.565Z,1602127196.565 [WetLabsUBAT](INFO): Powering down
2020-10-08T03:19:57.607Z,1602127197.607 [CBIT](INFO): Clearing failed state for component WetLabsUBAT
2020-10-08T03:19:57.607Z,1602127197.607 [WetLabsUBAT] No Fault, FailCount= 1
2020-10-08T03:19:57.778Z,1602127197.778 [WetLabsUBAT](INFO): Powering up
2020-10-08T03:20:12.954Z,1602127212.954 [NAL9602](INFO): Powering up NAL9602
2020-10-08T03:20:23.862Z,1602127223.862 [NAL9602](INFO): NAL9602 initialized
2020-10-08T03:20:37.430Z,1602127237.430 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout.
2020-10-08T03:20:37.430Z,1602127237.430 [WetLabsUBAT] Communications Fault, FailCount= 1
2020-10-08T03:20:37.430Z,1602127237.430 [WetLabsUBAT](ERROR): Communications Fault
2020-10-08T03:20:37.635Z,1602127237.635 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT
2020-10-08T03:20:37.929Z,1602127237.929 [WetLabsUBAT](INFO): Powering down
2020-10-08T03:20:38.075Z,1602127238.075 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:20:38.843Z,1602127238.843 [CBIT](INFO): Clearing failed state for component WetLabsUBAT
2020-10-08T03:20:38.843Z,1602127238.843 [WetLabsUBAT] No Fault, FailCount= 1
2020-10-08T03:20:39.142Z,1602127239.142 [WetLabsUBAT](INFO): Powering up
2020-10-08T03:20:51.053Z,1602127251.053 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:21:02.274Z,1602127262.274 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2020-10-08T03:21:02.274Z,1602127262.274 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-08T03:21:02.283Z,1602127262.283 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-08T03:21:02.675Z,1602127262.675 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-08T03:21:02.675Z,1602127262.675 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2020-10-08T03:21:05.151Z,1602127265.151 [CommandLine](IMPORTANT): got command stop
2020-10-08T03:21:05.152Z,1602127265.152 [CommandLine](IMPORTANT): Scheduling is paused
2020-10-08T03:21:05.152Z,1602127265.152 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2020-10-08T03:21:05.500Z,1602127265.500 [MissionManager](INFO): MissionManager is completed.
2020-10-08T03:21:05.501Z,1602127265.501 [MissionManager](INFO): Uninitializing Mission test
2020-10-08T03:21:05.501Z,1602127265.501 [test] Stopped
2020-10-08T03:21:05.501Z,1602127265.501 [test](DEBUG): Aggregate::uninitialize test
2020-10-08T03:21:05.501Z,1602127265.501 [test:A] Stopped
2020-10-08T03:21:05.501Z,1602127265.501 [test:B] Stopped
2020-10-08T03:21:05.596Z,1602127265.596 [WetLabsUBAT](INFO): Deactivating messaging.
2020-10-08T03:21:05.689Z,1602127265.689 [WetLabsUBAT](INFO): Powering down
2020-10-08T03:21:05.898Z,1602127265.898 [MissionManager](IMPORTANT): Started mission Default
2020-10-08T03:21:05.899Z,1602127265.899 [Default] Running Loop=1
2020-10-08T03:21:05.899Z,1602127265.899 [Default](DEBUG): Aggregate::initialize Default
2020-10-08T03:21:05.899Z,1602127265.899 [Default:B.GoToSurface] Running Loop=1
2020-10-08T03:21:05.899Z,1602127265.899 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-10-08T03:21:05.899Z,1602127265.899 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-10-08T03:21:05.899Z,1602127265.899 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-10-08T03:21:05.900Z,1602127265.900 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-10-08T03:21:05.928Z,1602127265.928 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-10-08T03:21:05.929Z,1602127265.929 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-10-08T03:21:05.929Z,1602127265.929 [Default:A.Wait] Running Loop=1
2020-10-08T03:21:05.929Z,1602127265.929 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-10-08T03:21:19.247Z,1602127279.247 [Default:A.Wait](INFO): Done Waiting.
2020-10-08T03:21:19.247Z,1602127279.247 [Default:A.Wait] Stopped
2020-10-08T03:21:19.247Z,1602127279.247 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-10-08T03:21:19.659Z,1602127279.659 [Default:CheckIn] Running Loop=1
2020-10-08T03:21:19.659Z,1602127279.659 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-10-08T03:21:19.659Z,1602127279.659 [Default:CheckIn:Read_GPS] Running Loop=1
2020-10-08T03:21:20.062Z,1602127280.062 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-10-08T03:21:59.310Z,1602127319.310 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:22:50.970Z,1602127370.970 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:22:53.803Z,1602127373.803 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:23:34.200Z,1602127414.200 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:23:43.523Z,1602127423.523 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:23:54.404Z,1602127434.404 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:24:03.250Z,1602127443.250 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2020-10-08T03:24:03.250Z,1602127443.250 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-08T03:24:03.261Z,1602127443.261 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-08T03:24:03.672Z,1602127443.672 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-08T03:24:03.672Z,1602127443.672 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2020-10-08T03:24:05.312Z,1602127445.312 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:24:16.626Z,1602127456.626 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:24:25.921Z,1602127465.921 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:24:27.939Z,1602127467.939 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:24:36.422Z,1602127476.422 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:24:38.871Z,1602127478.871 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:24:47.325Z,1602127487.325 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:24:49.780Z,1602127489.780 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:24:58.238Z,1602127498.238 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:25:00.661Z,1602127500.661 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:25:09.555Z,1602127509.555 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:25:11.164Z,1602127511.164 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:25:20.455Z,1602127520.455 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:25:22.074Z,1602127522.074 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:25:31.419Z,1602127531.419 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:25:33.387Z,1602127533.387 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:25:41.963Z,1602127541.963 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:25:44.766Z,1602127544.766 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:25:52.826Z,1602127552.826 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:25:55.665Z,1602127555.665 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:26:03.691Z,1602127563.691 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:26:06.549Z,1602127566.549 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:26:14.594Z,1602127574.594 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:26:17.016Z,1602127577.016 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:26:19.812Z,1602127579.812 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T03:21:19.7Z
2020-10-08T03:26:19.813Z,1602127579.813 [Default:CheckIn:Read_GPS] Stopped
2020-10-08T03:26:19.813Z,1602127579.813 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-10-08T03:26:20.224Z,1602127580.224 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-10-08T03:26:25.558Z,1602127585.558 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:26:27.420Z,1602127587.420 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201008T030849/Courier0004.lzma
2020-10-08T03:26:27.528Z,1602127587.528 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:26:28.422Z,1602127588.422 [DataOverHttps](INFO): Moved sent file to Logs/20201008T030849/Courier0004.lzma.bak
2020-10-08T03:26:28.422Z,1602127588.422 [DataOverHttps](INFO): SBD MOMSN=12816774
2020-10-08T03:26:36.049Z,1602127596.049 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:26:38.435Z,1602127598.435 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:26:46.489Z,1602127606.489 [DataOverHttps](INFO): Sending 509 bytes from file Logs/20201008T030849/Express0005.lzma
2020-10-08T03:26:47.490Z,1602127607.490 [DataOverHttps](INFO): Moved sent file to Logs/20201008T030849/Express0005.lzma.bak
2020-10-08T03:26:47.490Z,1602127607.490 [DataOverHttps](INFO): SBD MOMSN=12816776
2020-10-08T03:26:49.392Z,1602127609.392 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:26:50.519Z,1602127610.519 [Default:CheckIn:Read_Iridium] Stopped
2020-10-08T03:26:50.519Z,1602127610.519 [Default:CheckIn:C.Wait] Running Loop=1
2020-10-08T03:26:50.519Z,1602127610.519 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-10-08T03:27:00.246Z,1602127620.246 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:27:04.246Z,1602127624.246 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2020-10-08T03:27:04.246Z,1602127624.246 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-08T03:27:04.265Z,1602127624.265 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-08T03:27:04.662Z,1602127624.662 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-08T03:27:04.662Z,1602127624.662 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2020-10-08T03:27:11.158Z,1602127631.158 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:27:22.063Z,1602127642.063 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:27:33.374Z,1602127653.374 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:27:43.888Z,1602127663.888 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-10-08T03:27:44.685Z,1602127664.685 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:27:55.594Z,1602127675.594 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:28:06.501Z,1602127686.501 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:28:17.408Z,1602127697.408 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:28:28.317Z,1602127708.317 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:29:36.577Z,1602127776.577 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-10-08T03:30:05.222Z,1602127805.222 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2020-10-08T03:30:05.222Z,1602127805.222 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-08T03:30:05.249Z,1602127805.249 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-08T03:30:05.635Z,1602127805.635 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-08T03:30:05.635Z,1602127805.635 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2020-10-08T03:30:25.014Z,1602127825.014 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-10-08T03:30:25.014Z,1602127825.014 [NAL9602] Data Fault, FailCount= 2
2020-10-08T03:30:25.014Z,1602127825.014 [NAL9602](ERROR): Data Fault
2020-10-08T03:30:25.111Z,1602127825.111 [CBIT](ERROR): Data Fault in component: NAL9602
2020-10-08T03:30:25.413Z,1602127825.413 [NAL9602](INFO): Powering down
2020-10-08T03:30:26.404Z,1602127826.404 [CBIT](INFO): Clearing failed state for component NAL9602
2020-10-08T03:30:26.404Z,1602127826.404 [NAL9602] No Fault, FailCount= 2
2020-10-08T03:30:34.826Z,1602127834.826 [CommandLine](IMPORTANT): got command restart application
2020-10-08T03:30:36.081Z,1602127836.081 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-08T03:30:36.081Z,1602127836.081 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:36.144Z,1602127836.144 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-10-08T03:30:36.144Z,1602127836.144 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:36.145Z,1602127836.145 [CommandLine](INFO): Join timeout helper Thread ID is 6103
2020-10-08T03:30:36.161Z,1602127836.161 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-10-08T03:30:36.161Z,1602127836.161 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:36.161Z,1602127836.161 [NavChartDb](INFO): Join timeout helper Thread ID is 6104
2020-10-08T03:30:36.481Z,1602127836.481 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-08T03:30:36.481Z,1602127836.481 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:36.496Z,1602127836.496 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler
2020-10-08T03:30:36.496Z,1602127836.496 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:36.497Z,1602127836.497 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 6105
2020-10-08T03:30:36.897Z,1602127836.897 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-08T03:30:36.897Z,1602127836.897 [WetLabsUBAT](INFO): Powering down
2020-10-08T03:30:36.898Z,1602127836.898 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:36.912Z,1602127836.912 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-10-08T03:30:36.913Z,1602127836.913 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:36.913Z,1602127836.913 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6106
2020-10-08T03:30:37.165Z,1602127837.165 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-08T03:30:37.165Z,1602127837.165 [WetLabsBB2FL](INFO): Powering down
2020-10-08T03:30:37.166Z,1602127837.166 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:37.180Z,1602127837.180 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-10-08T03:30:37.180Z,1602127837.180 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:37.181Z,1602127837.181 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6107
2020-10-08T03:30:37.205Z,1602127837.205 [CTD_Seabird](INFO): Powering down
2020-10-08T03:30:37.217Z,1602127837.217 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-08T03:30:37.217Z,1602127837.217 [CTD_Seabird](INFO): Powering down
2020-10-08T03:30:37.228Z,1602127837.228 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:37.245Z,1602127837.245 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-10-08T03:30:37.245Z,1602127837.245 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:37.246Z,1602127837.246 [Radio_Surface](INFO): Join timeout helper Thread ID is 6108
2020-10-08T03:30:37.392Z,1602127837.392 [Radio_Surface](INFO): Powering down
2020-10-08T03:30:37.393Z,1602127837.393 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-08T03:30:37.394Z,1602127837.394 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:37.412Z,1602127837.412 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2020-10-08T03:30:37.412Z,1602127837.412 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:37.413Z,1602127837.413 [Onboard](INFO): Join timeout helper Thread ID is 6109
2020-10-08T03:30:39.969Z,1602127839.969 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-08T03:30:39.969Z,1602127839.969 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:39.981Z,1602127839.981 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-10-08T03:30:39.981Z,1602127839.981 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:39.982Z,1602127839.982 [DataOverHttps](INFO): Join timeout helper Thread ID is 6110
2020-10-08T03:30:39.985Z,1602127839.985 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-08T03:30:39.987Z,1602127839.987 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.028Z,1602127840.028 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2020-10-08T03:30:40.028Z,1602127840.028 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.028Z,1602127840.028 [BackseatComponent](INFO): Join timeout helper Thread ID is 6111
2020-10-08T03:30:40.037Z,1602127840.037 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-08T03:30:40.037Z,1602127840.037 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.050Z,1602127840.050 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-10-08T03:30:40.050Z,1602127840.050 [logger ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.050Z,1602127840.050 [logger](INFO): Join timeout helper Thread ID is 6112
2020-10-08T03:30:40.057Z,1602127840.057 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-08T03:30:40.057Z,1602127840.057 [logger ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.069Z,1602127840.069 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-10-08T03:30:40.069Z,1602127840.069 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.069Z,1602127840.069 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-10-08T03:30:40.069Z,1602127840.069 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.070Z,1602127840.070 [controlThread](INFO): Join timeout helper Thread ID is 6113
2020-10-08T03:30:40.166Z,1602127840.166 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-08T03:30:40.166Z,1602127840.166 [controlThread](DEBUG): Uninitializing ControlThread
2020-10-08T03:30:40.167Z,1602127840.167 [AHRS_M2](INFO): Powering down
2020-10-08T03:30:40.238Z,1602127840.238 [NAL9602](INFO): Powering down
2020-10-08T03:30:40.309Z,1602127840.309 [RDI_Pathfinder](INFO): Powering down
2020-10-08T03:30:40.310Z,1602127840.310 [DAT](INFO): Powering down
2020-10-08T03:30:40.430Z,1602127840.430 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-10-08T03:30:40.431Z,1602127840.431 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-10-08T03:30:40.432Z,1602127840.432 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-10-08T03:30:40.433Z,1602127840.433 [MissionManager](INFO): Uninitializing Mission Default
2020-10-08T03:30:40.433Z,1602127840.433 [Default] Stopped
2020-10-08T03:30:40.433Z,1602127840.433 [Default](DEBUG): Aggregate::uninitialize Default
2020-10-08T03:30:40.433Z,1602127840.433 [Default:B.GoToSurface] Stopped
2020-10-08T03:30:40.433Z,1602127840.433 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-10-08T03:30:40.433Z,1602127840.433 [Default:CheckIn] Stopped
2020-10-08T03:30:40.433Z,1602127840.433 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-10-08T03:30:40.433Z,1602127840.433 [Default:CheckIn:C.Wait] Stopped
2020-10-08T03:30:40.433Z,1602127840.433 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-10-08T03:30:40.436Z,1602127840.436 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-10-08T03:30:40.436Z,1602127840.436 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-10-08T03:30:40.437Z,1602127840.437 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-10-08T03:30:40.437Z,1602127840.437 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-10-08T03:30:40.437Z,1602127840.437 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-10-08T03:30:40.437Z,1602127840.437 [BuoyancyServo](INFO): Powering down
2020-10-08T03:30:40.449Z,1602127840.449 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-10-08T03:30:40.449Z,1602127840.449 [ElevatorServo](INFO): Powering down
2020-10-08T03:30:40.449Z,1602127840.449 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-10-08T03:30:40.450Z,1602127840.450 [MassServo](INFO): Powering down
2020-10-08T03:30:40.450Z,1602127840.450 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-10-08T03:30:40.450Z,1602127840.450 [RudderServo](INFO): Powering down
2020-10-08T03:30:40.451Z,1602127840.451 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-10-08T03:30:40.451Z,1602127840.451 [ThrusterServo](INFO): Powering down
2020-10-08T03:30:40.452Z,1602127840.452 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-10-08T03:30:40.453Z,1602127840.453 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-10-08T03:30:40.453Z,1602127840.453 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-10-08T03:30:40.453Z,1602127840.453 [CBIT](DEBUG): Powering off loads.
2020-10-08T03:30:40.464Z,1602127840.464 [CBIT](DEBUG): Disabling WDT.
2020-10-08T03:30:40.476Z,1602127840.476 [CBIT](DEBUG): Opening all GF detection circuits.
2020-10-08T03:30:40.477Z,1602127840.477 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.672Z,1602127840.672 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.696Z,1602127840.696 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.705Z,1602127840.705 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.811Z,1602127840.811 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.897Z,1602127840.897 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.899Z,1602127840.899 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.932Z,1602127840.932 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:40.977Z,1602127840.977 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-10-08T03:30:41.058Z,1602127841.058 [logger ThreadHandler](INFO): Thread cancelled.