2020-02-26T00:41:19.663Z,1582677679.663 [Supervisor](DEBUG): Initializing supervisor.
2020-02-26T00:41:19.666Z,1582677679.666 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-02-26T00:41:19.667Z,1582677679.667 [SyncHandler](INFO): Protected caller Thread ID is 6608
2020-02-26T00:41:19.667Z,1582677679.667 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-02-26T00:41:19.668Z,1582677679.668 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-02-26T00:41:19.668Z,1582677679.668 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6609
2020-02-26T00:41:19.671Z,1582677679.671 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-02-26T00:41:19.683Z,1582677679.683 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-02-26T00:41:19.684Z,1582677679.684 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-02-26T00:41:19.685Z,1582677679.685 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6610
2020-02-26T00:41:19.685Z,1582677679.685 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-02-26T00:41:19.686Z,1582677679.686 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-02-26T00:41:19.687Z,1582677679.687 [logger ThreadHandler](INFO): Protected caller Thread ID is 6611
2020-02-26T00:41:19.689Z,1582677679.689 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-02-26T00:41:19.689Z,1582677679.689 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-02-26T00:41:19.690Z,1582677679.690 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-02-26T00:41:19.786Z,1582677679.786 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-02-26T00:41:19.787Z,1582677679.787 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-02-26T00:41:20.355Z,1582677680.355 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-02-26T00:41:20.355Z,1582677680.355 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-02-26T00:41:20.453Z,1582677680.453 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-02-26T00:41:20.454Z,1582677680.454 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-02-26T00:41:20.557Z,1582677680.557 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-02-26T00:41:20.557Z,1582677680.557 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-02-26T00:41:20.639Z,1582677680.639 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-02-26T00:41:20.779Z,1582677680.779 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-02-26T00:41:20.779Z,1582677680.779 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-02-26T00:41:21.074Z,1582677681.074 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-02-26T00:41:21.075Z,1582677681.075 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-02-26T00:41:21.739Z,1582677681.739 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-02-26T00:41:21.739Z,1582677681.739 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-02-26T00:41:21.882Z,1582677681.882 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-02-26T00:41:21.883Z,1582677681.883 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-02-26T00:41:22.072Z,1582677682.072 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-02-26T00:41:22.072Z,1582677682.072 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-02-26T00:41:22.528Z,1582677682.528 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-02-26T00:41:22.529Z,1582677682.529 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-02-26T00:41:22.747Z,1582677682.747 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-02-26T00:41:22.747Z,1582677682.747 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-02-26T00:41:22.943Z,1582677682.943 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-02-26T00:41:22.944Z,1582677682.944 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-02-26T00:41:23.342Z,1582677683.342 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-02-26T00:41:23.343Z,1582677683.343 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-02-26T00:41:23.663Z,1582677683.663 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-02-26T00:41:23.665Z,1582677683.665 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2020-02-26T00:41:23.666Z,1582677683.666 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2020-02-26T00:41:23.750Z,1582677683.750 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2020-02-26T00:41:23.911Z,1582677683.911 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2020-02-26T00:41:24.021Z,1582677684.021 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2020-02-26T00:41:24.108Z,1582677684.108 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2020-02-26T00:41:24.204Z,1582677684.204 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2020-02-26T00:41:24.409Z,1582677684.409 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2020-02-26T00:41:24.632Z,1582677684.632 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-02-26T00:41:24.632Z,1582677684.632 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2020-02-26T00:41:24.727Z,1582677684.727 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2020-02-26T00:41:24.826Z,1582677684.826 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2020-02-26T00:41:24.964Z,1582677684.964 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2020-02-26T00:41:25.072Z,1582677685.072 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/
2020-02-26T00:41:25.073Z,1582677685.073 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-02-26T00:41:25.087Z,1582677685.087 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-02-26T00:41:25.133Z,1582677685.133 [VerticalControl](DEBUG): Construct VerticalControl.
2020-02-26T00:41:25.239Z,1582677685.239 [VerticalControl] Loaded
2020-02-26T00:41:25.239Z,1582677685.239 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-02-26T00:41:25.240Z,1582677685.240 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-02-26T00:41:25.315Z,1582677685.315 [HorizontalControl] Loaded
2020-02-26T00:41:25.315Z,1582677685.315 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-02-26T00:41:25.316Z,1582677685.316 [SpeedControl](DEBUG): Construct SpeedControl.
2020-02-26T00:41:25.321Z,1582677685.321 [SpeedControl] Loaded
2020-02-26T00:41:25.321Z,1582677685.321 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-02-26T00:41:25.322Z,1582677685.322 [LoopControl](DEBUG): Construct LoopControl.
2020-02-26T00:41:25.322Z,1582677685.322 [LoopControl] Loaded
2020-02-26T00:41:25.323Z,1582677685.323 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-02-26T00:41:25.323Z,1582677685.323 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-02-26T00:41:25.324Z,1582677685.324 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-02-26T00:41:25.361Z,1582677685.361 [DepthRateCalculator] Loaded
2020-02-26T00:41:25.362Z,1582677685.362 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-02-26T00:41:25.367Z,1582677685.367 [PitchRateCalculator] Loaded
2020-02-26T00:41:25.367Z,1582677685.367 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-02-26T00:41:25.382Z,1582677685.382 [SpeedCalculator] Loaded
2020-02-26T00:41:25.382Z,1582677685.382 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-02-26T00:41:25.401Z,1582677685.401 [TempGradientCalculator] Loaded
2020-02-26T00:41:25.402Z,1582677685.402 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-02-26T00:41:25.406Z,1582677685.406 [YawRateCalculator] Loaded
2020-02-26T00:41:25.407Z,1582677685.407 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-02-26T00:41:25.434Z,1582677685.434 [ElevatorOffsetCalculator] Loaded
2020-02-26T00:41:25.434Z,1582677685.434 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-02-26T00:41:25.434Z,1582677685.434 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-02-26T00:41:25.435Z,1582677685.435 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-02-26T00:41:25.465Z,1582677685.465 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-02-26T00:41:25.466Z,1582677685.466 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-02-26T00:41:25.541Z,1582677685.541 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-02-26T00:41:25.542Z,1582677685.542 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-02-26T00:41:25.876Z,1582677685.876 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-02-26T00:41:25.876Z,1582677685.876 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-02-26T00:41:25.969Z,1582677685.969 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-02-26T00:41:25.969Z,1582677685.969 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-02-26T00:41:26.272Z,1582677686.272 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-02-26T00:41:26.277Z,1582677686.277 [AHRS_M2](INFO): created writer for : platform_orientation
2020-02-26T00:41:26.279Z,1582677686.279 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-02-26T00:41:26.284Z,1582677686.284 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-02-26T00:41:26.284Z,1582677686.284 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-02-26T00:41:26.289Z,1582677686.289 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-02-26T00:41:26.289Z,1582677686.289 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-02-26T00:41:26.294Z,1582677686.294 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-02-26T00:41:26.361Z,1582677686.361 [AHRS_M2] Loaded
2020-02-26T00:41:26.361Z,1582677686.361 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-02-26T00:41:26.438Z,1582677686.438 [DataOverHttps] Loaded
2020-02-26T00:41:26.438Z,1582677686.438 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-02-26T00:41:26.439Z,1582677686.439 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408E74E0
2020-02-26T00:41:26.439Z,1582677686.439 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6690
2020-02-26T00:41:26.452Z,1582677686.452 [Depth_Keller] Loaded
2020-02-26T00:41:26.452Z,1582677686.452 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-02-26T00:41:26.457Z,1582677686.457 [DropWeight] Loaded
2020-02-26T00:41:26.457Z,1582677686.457 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-02-26T00:41:26.548Z,1582677686.548 [NAL9602] Loaded
2020-02-26T00:41:26.548Z,1582677686.548 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-02-26T00:41:26.583Z,1582677686.583 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now
2020-02-26T00:41:26.584Z,1582677686.584 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now
2020-02-26T00:41:26.584Z,1582677686.584 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now
2020-02-26T00:41:26.585Z,1582677686.585 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full
2020-02-26T00:41:26.585Z,1582677686.585 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now
2020-02-26T00:41:26.586Z,1582677686.586 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now
2020-02-26T00:41:26.586Z,1582677686.586 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now
2020-02-26T00:41:26.587Z,1582677686.587 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full
2020-02-26T00:41:26.587Z,1582677686.587 [Onboard] Loaded
2020-02-26T00:41:26.587Z,1582677686.587 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2020-02-26T00:41:26.591Z,1582677686.591 [Radio_Surface] Loaded
2020-02-26T00:41:26.591Z,1582677686.591 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-02-26T00:41:26.592Z,1582677686.592 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409174E0
2020-02-26T00:41:26.592Z,1582677686.592 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6691
2020-02-26T00:41:26.633Z,1582677686.633 [RDI_Pathfinder] Loaded
2020-02-26T00:41:26.633Z,1582677686.633 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2020-02-26T00:41:26.917Z,1582677686.917 [DAT] Loaded
2020-02-26T00:41:26.918Z,1582677686.918 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-02-26T00:41:28.665Z,1582677688.665 [BPC1] Loaded
2020-02-26T00:41:28.665Z,1582677688.665 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-02-26T00:41:28.665Z,1582677688.665 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-02-26T00:41:28.666Z,1582677688.666 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-02-26T00:41:28.774Z,1582677688.774 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-02-26T00:41:28.775Z,1582677688.775 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-02-26T00:41:28.794Z,1582677688.794 [NavChart] Loaded
2020-02-26T00:41:28.794Z,1582677688.794 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-02-26T00:41:28.798Z,1582677688.798 [UniversalFixResidualReporter] Loaded
2020-02-26T00:41:28.799Z,1582677688.799 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-02-26T00:41:28.799Z,1582677688.799 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-02-26T00:41:28.800Z,1582677688.800 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-02-26T00:41:28.925Z,1582677688.925 [SBIT](DEBUG): Construct Startup Built In Test.
2020-02-26T00:41:28.936Z,1582677688.936 [SBIT] Loaded
2020-02-26T00:41:28.936Z,1582677688.936 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-02-26T00:41:28.937Z,1582677688.937 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-02-26T00:41:28.949Z,1582677688.949 [IBIT] Loaded
2020-02-26T00:41:28.949Z,1582677688.949 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-02-26T00:41:28.952Z,1582677688.952 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-02-26T00:41:29.081Z,1582677689.081 [CBIT] Loaded
2020-02-26T00:41:29.082Z,1582677689.082 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-02-26T00:41:29.082Z,1582677689.082 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-02-26T00:41:29.083Z,1582677689.083 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-02-26T00:41:29.181Z,1582677689.181 [BuoyancyServo] Loaded
2020-02-26T00:41:29.181Z,1582677689.181 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-02-26T00:41:29.192Z,1582677689.192 [ElevatorServo] Loaded
2020-02-26T00:41:29.192Z,1582677689.192 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-02-26T00:41:29.202Z,1582677689.202 [MassServo] Loaded
2020-02-26T00:41:29.202Z,1582677689.202 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-02-26T00:41:29.213Z,1582677689.213 [RudderServo] Loaded
2020-02-26T00:41:29.213Z,1582677689.213 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-02-26T00:41:29.223Z,1582677689.223 [ThrusterServo] Loaded
2020-02-26T00:41:29.223Z,1582677689.223 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-02-26T00:41:29.224Z,1582677689.224 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-02-26T00:41:29.224Z,1582677689.224 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-02-26T00:41:29.237Z,1582677689.237 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-02-26T00:41:29.237Z,1582677689.237 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-02-26T00:41:29.437Z,1582677689.437 [BackSeatDriver] Loaded
2020-02-26T00:41:29.437Z,1582677689.437 [ComponentRegistry](DEBUG): Component "BackSeatDriver" handled in its own thread.
2020-02-26T00:41:29.438Z,1582677689.438 [BackSeatDriver ThreadHandler](DEBUG): Created PCaller Thread at 40AAA4E0
2020-02-26T00:41:29.438Z,1582677689.438 [BackSeatDriver ThreadHandler](INFO): Protected caller Thread ID is 6692
2020-02-26T00:41:29.448Z,1582677689.448 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-02-26T00:41:29.453Z,1582677689.453 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-02-26T00:41:29.453Z,1582677689.453 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-02-26T00:41:29.458Z,1582677689.458 [CTD_Seabird](INFO): created writer for : depth
2020-02-26T00:41:29.458Z,1582677689.458 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-02-26T00:41:29.463Z,1582677689.463 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-02-26T00:41:29.464Z,1582677689.464 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-02-26T00:41:29.469Z,1582677689.469 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-02-26T00:41:29.469Z,1582677689.469 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-02-26T00:41:29.474Z,1582677689.474 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-02-26T00:41:29.475Z,1582677689.475 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-02-26T00:41:29.480Z,1582677689.480 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-02-26T00:41:29.480Z,1582677689.480 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-02-26T00:41:29.485Z,1582677689.485 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-02-26T00:41:29.510Z,1582677689.510 [CTD_Seabird] Loaded
2020-02-26T00:41:29.511Z,1582677689.511 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-02-26T00:41:29.511Z,1582677689.511 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ADA4E0
2020-02-26T00:41:29.512Z,1582677689.512 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6693
2020-02-26T00:41:29.541Z,1582677689.541 [ESPComponent] Loaded
2020-02-26T00:41:29.541Z,1582677689.541 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2020-02-26T00:41:29.547Z,1582677689.547 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-02-26T00:41:29.547Z,1582677689.547 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-02-26T00:41:29.551Z,1582677689.551 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-02-26T00:41:29.551Z,1582677689.551 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-02-26T00:41:29.555Z,1582677689.555 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-02-26T00:41:29.556Z,1582677689.556 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-02-26T00:41:29.560Z,1582677689.560 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-02-26T00:41:29.560Z,1582677689.560 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-02-26T00:41:29.564Z,1582677689.564 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-02-26T00:41:29.564Z,1582677689.564 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-02-26T00:41:29.568Z,1582677689.568 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-02-26T00:41:29.568Z,1582677689.568 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-02-26T00:41:29.572Z,1582677689.572 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-02-26T00:41:29.572Z,1582677689.572 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-02-26T00:41:29.576Z,1582677689.576 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-02-26T00:41:29.580Z,1582677689.580 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-02-26T00:41:29.581Z,1582677689.581 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-02-26T00:41:29.581Z,1582677689.581 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-02-26T00:41:29.585Z,1582677689.585 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-02-26T00:41:29.585Z,1582677689.585 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-02-26T00:41:29.589Z,1582677689.589 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-02-26T00:41:29.589Z,1582677689.589 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-02-26T00:41:29.593Z,1582677689.593 [WetLabsBB2FL] Loaded
2020-02-26T00:41:29.593Z,1582677689.593 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-02-26T00:41:29.594Z,1582677689.594 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B0A4E0
2020-02-26T00:41:29.595Z,1582677689.595 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6694
2020-02-26T00:41:29.609Z,1582677689.609 [WetLabsUBAT..SerialDriver](INFO): Created logger
2020-02-26T00:41:29.609Z,1582677689.609 [WetLabsUBAT..SerialDriver](INFO): publishing on LCM channel WetLabsUBAT
2020-02-26T00:41:29.610Z,1582677689.610 [WetLabsUBAT..StreamSerialDriver](INFO): Created logger
2020-02-26T00:41:29.615Z,1582677689.615 [WetLabsUBAT](INFO): readConfig(): serialNo_: UBAT0051, uartName_: /dev/ttyC1, optionalArgs_: -ldir /mnt/mmc/LRAUV/Logs/latest
2020-02-26T00:41:29.615Z,1582677689.615 [WetLabsUBAT](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsUBAT.biolum_potential
2020-02-26T00:41:29.615Z,1582677689.615 [WetLabsUBAT](DEBUG): LcmSlateWriter::add(): dataName: biolum_potential
2020-02-26T00:41:29.619Z,1582677689.619 [WetLabsUBAT](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsUBAT.flow_rate
2020-02-26T00:41:29.619Z,1582677689.619 [WetLabsUBAT](DEBUG): LcmSlateWriter::add(): dataName: flow_rate
2020-02-26T00:41:29.624Z,1582677689.624 [WetLabsUBAT] Loaded
2020-02-26T00:41:29.624Z,1582677689.624 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread.
2020-02-26T00:41:29.625Z,1582677689.625 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40B3A4E0
2020-02-26T00:41:29.625Z,1582677689.625 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 6695
2020-02-26T00:41:29.626Z,1582677689.626 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-02-26T00:41:29.629Z,1582677689.629 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-02-26T00:41:29.630Z,1582677689.630 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-02-26T00:41:29.637Z,1582677689.637 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-02-26T00:41:29.638Z,1582677689.638 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B6A4E0
2020-02-26T00:41:29.638Z,1582677689.638 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6696
2020-02-26T00:41:29.642Z,1582677689.642 [Supervisor](INFO): Main Thread ID is 6036
2020-02-26T00:41:29.643Z,1582677689.643 [Supervisor](DEBUG): Running supervisor.
2020-02-26T00:41:29.643Z,1582677689.643 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6697
2020-02-26T00:41:29.646Z,1582677689.646 [controlThread ThreadHandler](INFO): Handler Thread ID is 6698
2020-02-26T00:41:29.647Z,1582677689.647 [controlThread](DEBUG): Initializing ControlThread
2020-02-26T00:41:29.647Z,1582677689.647 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-02-26T00:41:29.649Z,1582677689.649 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-02-26T00:41:29.650Z,1582677689.650 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-02-26T00:41:29.650Z,1582677689.650 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-02-26T00:41:29.650Z,1582677689.650 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-02-26T00:41:29.651Z,1582677689.651 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-02-26T00:41:29.651Z,1582677689.651 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-02-26T00:41:29.651Z,1582677689.651 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-02-26T00:41:29.652Z,1582677689.652 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-02-26T00:41:29.652Z,1582677689.652 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-02-26T00:41:29.658Z,1582677689.658 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-02-26T00:41:29.658Z,1582677689.658 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-02-26T00:41:29.659Z,1582677689.659 [SBIT](INFO): Initialize SBIT Component.
2020-02-26T00:41:29.659Z,1582677689.659 [SBIT](IMPORTANT): git: 2019-12-03-78-gb92fbb9
2020-02-26T00:41:29.659Z,1582677689.659 [SBIT](INFO): git hash: b92fbb99b4c8d1793352820b784fbd968d0634e4
2020-02-26T00:41:29.660Z,1582677689.660 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-02-26T00:41:29.660Z,1582677689.660 [SBIT](IMPORTANT): Kernel Version:#1 PREEMPT Thu Feb 21 11:17:40 PST 2019
2020-02-26T00:41:29.661Z,1582677689.661 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2020-02-26T00:41:29.661Z,1582677689.661 [IBIT](INFO): Initialize IBIT Component.
2020-02-26T00:41:29.662Z,1582677689.662 [CBIT](DEBUG): Initialize CBIT Component.
2020-02-26T00:41:29.663Z,1582677689.663 [logger ThreadHandler](INFO): Handler Thread ID is 6699
2020-02-26T00:41:29.674Z,1582677689.674 [CBIT](DEBUG): Initialized mux pins.
2020-02-26T00:41:29.675Z,1582677689.675 [CBIT](DEBUG): Initializing the watchdog timer.
2020-02-26T00:41:29.683Z,1582677689.683 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6700
2020-02-26T00:41:29.684Z,1582677689.684 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-02-26T00:41:29.695Z,1582677689.695 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6701
2020-02-26T00:41:29.698Z,1582677689.698 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-02-26T00:41:29.699Z,1582677689.699 [CBIT](DEBUG): Initializing heartbeat.
2020-02-26T00:41:29.707Z,1582677689.707 [BackSeatDriver ThreadHandler](INFO): Handler Thread ID is 6702
2020-02-26T00:41:29.727Z,1582677689.727 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6703
2020-02-26T00:41:29.727Z,1582677689.727 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-02-26T00:41:29.732Z,1582677689.732 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6705
2020-02-26T00:41:29.733Z,1582677689.733 [WetLabsBB2FL](INFO): Powering down
2020-02-26T00:41:29.763Z,1582677689.763 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 6706
2020-02-26T00:41:29.770Z,1582677689.770 [CBIT](DEBUG): Deactivating GF circuits.
2020-02-26T00:41:29.771Z,1582677689.771 [CBIT](DEBUG): Deactivating emergency mode.
2020-02-26T00:41:29.775Z,1582677689.775 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6707
2020-02-26T00:41:29.778Z,1582677689.778 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-02-26T00:41:29.778Z,1582677689.778 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-02-26T00:41:29.779Z,1582677689.779 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-02-26T00:41:29.779Z,1582677689.779 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-02-26T00:41:29.779Z,1582677689.779 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-02-26T00:41:29.779Z,1582677689.779 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-02-26T00:41:29.779Z,1582677689.779 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-02-26T00:41:29.779Z,1582677689.779 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-02-26T00:41:29.780Z,1582677689.780 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-02-26T00:41:29.780Z,1582677689.780 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-02-26T00:41:29.780Z,1582677689.780 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-02-26T00:41:29.780Z,1582677689.780 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-02-26T00:41:29.780Z,1582677689.780 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-02-26T00:41:29.781Z,1582677689.781 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-02-26T00:41:29.781Z,1582677689.781 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-02-26T00:41:29.781Z,1582677689.781 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-02-26T00:41:29.806Z,1582677689.806 [CBIT](DEBUG): Backplane powered.
2020-02-26T00:41:29.808Z,1582677689.808 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-02-26T00:41:29.818Z,1582677689.818 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-02-26T00:41:29.829Z,1582677689.829 [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-02-26T00:41:29.830Z,1582677689.830 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-02-26T00:41:29.913Z,1582677689.913 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-02-26T00:41:29.914Z,1582677689.914 [Default:A.Wait](DEBUG): Construct Wait.
2020-02-26T00:41:29.932Z,1582677689.932 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-02-26T00:41:29.966Z,1582677689.966 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-02-26T00:41:29.968Z,1582677689.968 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-02-26T00:41:29.982Z,1582677689.982 [Default:E.Execute](DEBUG): Construct Execute.
2020-02-26T00:41:30.016Z,1582677690.016 [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-02-26T00:41:30.020Z,1582677690.020 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,Onboard,RDI_Pathfinder,DAT,BPC1,ESPComponent,Depth_Keller,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-02-26T00:41:30.042Z,1582677690.042 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-02-26T00:41:30.099Z,1582677690.099 [Radio_Surface](INFO): Powering up
2020-02-26T00:41:30.222Z,1582677690.222 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-02-26T00:41:30.222Z,1582677690.222 [DAT](INFO): Powering up
2020-02-26T00:41:30.235Z,1582677690.235 [DAT](DEBUG): Initializing DAT.
2020-02-26T00:41:30.243Z,1582677690.243 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-02-26T00:41:30.365Z,1582677690.365 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-02-26T00:41:30.375Z,1582677690.375 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-02-26T00:41:30.376Z,1582677690.376 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-02-26T00:41:30.387Z,1582677690.387 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-02-26T00:41:30.388Z,1582677690.388 [MassServo](DEBUG): Initializing EZServoServo.
2020-02-26T00:41:30.399Z,1582677690.399 [MassServo](DEBUG): Initializing MassServo.
2020-02-26T00:41:30.400Z,1582677690.400 [RudderServo](DEBUG): Initializing EZServoServo.
2020-02-26T00:41:30.416Z,1582677690.416 [RudderServo](DEBUG): Initializing RudderServo.
2020-02-26T00:41:30.417Z,1582677690.417 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-02-26T00:41:30.495Z,1582677690.495 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-02-26T00:41:30.621Z,1582677690.621 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2020-02-26T00:41:30.622Z,1582677690.622 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2020-02-26T00:41:30.622Z,1582677690.622 [DropWeight] Hardware Fault, FailCount= 1
2020-02-26T00:41:30.622Z,1582677690.622 [DropWeight](ERROR): Hardware Fault
2020-02-26T00:41:30.694Z,1582677690.694 [CommandLine](FAULT): Scheduling is paused
2020-02-26T00:41:30.694Z,1582677690.694 [CBIT](INFO): Critical error at 20200226T004130
2020-02-26T00:41:30.695Z,1582677690.695 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-02-26T00:41:30.697Z,1582677690.697 [CBIT](ERROR): Hardware Fault in component: DropWeight
2020-02-26T00:41:30.698Z,1582677690.698 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2020-02-26T00:41:31.243Z,1582677691.243 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-02-26T00:41:31.243Z,1582677691.243 [RudderServo](FAULT): Rudder failed to initialize
2020-02-26T00:41:31.243Z,1582677691.243 [RudderServo] Communications Fault, FailCount= 1
2020-02-26T00:41:31.243Z,1582677691.243 [RudderServo](ERROR): Communications Fault
2020-02-26T00:41:31.364Z,1582677691.364 [CBIT](INFO): Critical error at 20200226T004130
2020-02-26T00:41:31.366Z,1582677691.366 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-02-26T00:41:31.527Z,1582677691.527 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-02-26T00:41:31.528Z,1582677691.528 [RudderServo](INFO): Powering down
2020-02-26T00:41:32.210Z,1582677692.210 [RudderServo](DEBUG): Initializing EZServoServo.
2020-02-26T00:41:32.327Z,1582677692.327 [RudderServo](DEBUG): Initializing RudderServo.
2020-02-26T00:41:32.332Z,1582677692.332 [CBIT](INFO): Clearing failed state for component RudderServo
2020-02-26T00:41:32.332Z,1582677692.332 [RudderServo] No Fault, FailCount= 1
2020-02-26T00:41:40.735Z,1582677700.735 [DAT](DEBUG): 
2020-02-26T00:41:40.736Z,1582677700.736 [DAT](DEBUG): Teledyne Benthos DAT-900 Series
2020-02-26T00:41:41.911Z,1582677701.911 [DAT](DEBUG): MF Frequency Band
2020-02-26T00:41:41.912Z,1582677701.912 [DAT](DEBUG): Directional Acoustic Transponder version 8.12.21
2020-02-26T00:41:41.913Z,1582677701.913 [DAT](DEBUG): Feb 26 2020 00:30:10 
2020-02-26T00:41:42.728Z,1582677702.728 [RDI_Pathfinder](INFO): SA. Got:

2020-02-26T00:41:42.731Z,1582677702.731 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:Pathfinder 600
2020-02-26T00:41:42.737Z,1582677702.737 [RDI_Pathfinder](INFO): Next line. Got:
Teledyne RD Instruments (c) 2019
2020-02-26T00:41:42.749Z,1582677702.749 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got:All rights reserved.
2020-02-26T00:41:42.749Z,1582677702.749 [RDI_Pathfinder](ERROR): Failed to parse:All rights reserved.
2020-02-26T00:41:42.759Z,1582677702.759 [DAT](DEBUG): Features enabled [Bearing]
2020-02-26T00:41:42.760Z,1582677702.760 [DAT](DEBUG): CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2020-02-26T00:41:42.760Z,1582677702.760 [DAT](INFO): commRate: 800
2020-02-26T00:41:43.119Z,1582677703.119 [DAT](INFO): entering command mode
2020-02-26T00:41:43.523Z,1582677703.523 [DAT](DEBUG): checking for command mode acknowledgment
2020-02-26T00:41:43.928Z,1582677703.928 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:41:43.928Z,1582677703.928 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:41:43.930Z,1582677703.930 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516303741,35.0, +21.2,   0.0,1524.7,  0
2020-02-26T00:41:43.931Z,1582677703.931 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:43.932Z,1582677703.932 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:43.932Z,1582677703.932 [DAT](DEBUG): checking for command mode acknowledgment
2020-02-26T00:41:43.933Z,1582677703.933 [DAT](INFO): command mode acknowledged
2020-02-26T00:41:43.933Z,1582677703.933 [DAT](INFO): setting verbose to 3
2020-02-26T00:41:44.331Z,1582677704.331 [DAT](DEBUG): checking for verbose setting acknowledgment
2020-02-26T00:41:44.332Z,1582677704.332 [DAT](INFO): set verbose to 3
2020-02-26T00:41:44.740Z,1582677704.740 [DAT](INFO): setting transmit power to 8
2020-02-26T00:41:45.140Z,1582677705.140 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:41:45.140Z,1582677705.140 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:41:45.142Z,1582677705.142 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516303841,35.0, +21.2,   0.0,1524.7,  0
2020-02-26T00:41:45.143Z,1582677705.143 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:45.144Z,1582677705.144 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:45.144Z,1582677705.144 [DAT](DEBUG): checking for transmit power setting acknowledgment
2020-02-26T00:41:45.542Z,1582677705.542 [DAT](DEBUG): checking for transmit power setting acknowledgment
2020-02-26T00:41:45.543Z,1582677705.543 [DAT](INFO): set transmit power to 8
2020-02-26T00:41:45.939Z,1582677705.939 [DAT](INFO): setting local address to 9
2020-02-26T00:41:46.351Z,1582677706.351 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:41:46.352Z,1582677706.352 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:41:46.353Z,1582677706.353 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516303941,35.0, +21.2,   0.0,1524.7,  0
2020-02-26T00:41:46.355Z,1582677706.355 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:46.355Z,1582677706.355 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:46.356Z,1582677706.356 [DAT](DEBUG): checking for local address setting acknowledgment
2020-02-26T00:41:46.756Z,1582677706.756 [DAT](DEBUG): checking for local address setting acknowledgment
2020-02-26T00:41:46.757Z,1582677706.757 [DAT](INFO): set local address to 9
2020-02-26T00:41:47.571Z,1582677707.571 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:41:47.572Z,1582677707.572 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:41:47.573Z,1582677707.573 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516304041,35.0, +21.2,   0.0,1524.7,  0
2020-02-26T00:41:47.579Z,1582677707.579 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:47.579Z,1582677707.579 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:47.971Z,1582677707.971 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:41:47.972Z,1582677707.972 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:41:47.973Z,1582677707.973 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516304141,35.0, +21.2,   0.0,1524.7,  0
2020-02-26T00:41:47.983Z,1582677707.983 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:47.983Z,1582677707.983 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:48.777Z,1582677708.777 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:41:48.777Z,1582677708.777 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:41:48.779Z,1582677708.779 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516304241,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:41:48.781Z,1582677708.781 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:48.781Z,1582677708.781 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:49.993Z,1582677709.993 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:41:49.993Z,1582677709.993 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:41:49.995Z,1582677709.995 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516304341,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:41:49.996Z,1582677709.996 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:49.997Z,1582677709.997 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:50.788Z,1582677710.788 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:41:50.788Z,1582677710.788 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:41:50.790Z,1582677710.790 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516304441,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:41:50.792Z,1582677710.792 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:50.792Z,1582677710.792 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:52.001Z,1582677712.001 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:41:52.001Z,1582677712.001 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:41:52.003Z,1582677712.003 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516304541,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:41:52.005Z,1582677712.005 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:52.005Z,1582677712.005 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:41:52.410Z,1582677712.410 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2020-02-26T00:41:52.410Z,1582677712.410 [RDI_Pathfinder] Communications Fault, FailCount= 1
2020-02-26T00:41:52.411Z,1582677712.411 [RDI_Pathfinder](ERROR): Communications Fault
2020-02-26T00:41:52.503Z,1582677712.503 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2020-02-26T00:41:52.903Z,1582677712.903 [RDI_Pathfinder](INFO): Powering down
2020-02-26T00:41:53.719Z,1582677713.719 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2020-02-26T00:41:53.719Z,1582677713.719 [RDI_Pathfinder] No Fault, FailCount= 1
2020-02-26T00:41:56.836Z,1582677716.836 [NAL9602](INFO): Powering up NAL9602
2020-02-26T00:42:06.540Z,1582677726.540 [RDI_Pathfinder](INFO): SA. Got:

2020-02-26T00:42:06.542Z,1582677726.542 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:Pathfinder 600
2020-02-26T00:42:06.575Z,1582677726.575 [RDI_Pathfinder](INFO): Next line. Got:
Teledyne RD Instruments (c) 2019
2020-02-26T00:42:06.583Z,1582677726.583 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got:All rights reserved.
2020-02-26T00:42:06.583Z,1582677726.583 [RDI_Pathfinder](ERROR): Failed to parse:All rights reserved.
2020-02-26T00:42:07.736Z,1582677727.736 [NAL9602](INFO): NAL9602 initialized
2020-02-26T00:42:07.766Z,1582677727.766 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:07.767Z,1582677727.767 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:07.768Z,1582677727.768 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516310108,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:42:07.770Z,1582677727.770 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:07.770Z,1582677727.770 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:08.604Z,1582677728.604 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:08.604Z,1582677728.604 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:08.606Z,1582677728.606 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516310208,35.0, +21.2,   0.0,1524.7,  0
2020-02-26T00:42:08.627Z,1582677728.627 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:08.628Z,1582677728.628 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:09.068Z,1582677729.068 [SBIT](IMPORTANT): Beginning Startup BIT
2020-02-26T00:42:09.084Z,1582677729.084 [CBIT](IMPORTANT): Beginning ground fault scan
2020-02-26T00:42:10.183Z,1582677730.183 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:10.183Z,1582677730.183 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:10.185Z,1582677730.185 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516310308,35.0, +21.2,   0.0,1524.7,  0
2020-02-26T00:42:10.186Z,1582677730.186 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:10.187Z,1582677730.187 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:11.024Z,1582677731.024 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:11.024Z,1582677731.024 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:11.026Z,1582677731.026 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516310408,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:42:11.028Z,1582677731.028 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:11.028Z,1582677731.028 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:11.432Z,1582677731.432 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:11.433Z,1582677731.433 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:11.460Z,1582677731.460 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516310508,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:42:11.461Z,1582677731.461 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:11.461Z,1582677731.461 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:12.481Z,1582677732.481 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:12.481Z,1582677732.481 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:12.483Z,1582677732.483 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516310608,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:42:12.485Z,1582677732.485 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:12.485Z,1582677732.485 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:13.688Z,1582677733.688 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:13.688Z,1582677733.688 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:13.690Z,1582677733.690 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516310708,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:42:13.691Z,1582677733.691 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:13.692Z,1582677733.692 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:14.520Z,1582677734.520 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:14.521Z,1582677734.521 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:14.522Z,1582677734.522 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516310808,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:42:14.524Z,1582677734.524 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:14.524Z,1582677734.524 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:15.759Z,1582677735.759 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:15.759Z,1582677735.759 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:15.761Z,1582677735.761 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516310908,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:42:15.763Z,1582677735.763 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:15.763Z,1582677735.763 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:16.531Z,1582677736.531 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2020-02-26T00:42:16.531Z,1582677736.531 [RDI_Pathfinder] Communications Fault, FailCount= 2
2020-02-26T00:42:16.531Z,1582677736.531 [RDI_Pathfinder](ERROR): Communications Fault
2020-02-26T00:42:16.659Z,1582677736.659 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2020-02-26T00:42:17.003Z,1582677737.003 [RDI_Pathfinder](INFO): Powering down
2020-02-26T00:42:17.855Z,1582677737.855 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2020-02-26T00:42:17.855Z,1582677737.855 [RDI_Pathfinder] No Fault, FailCount= 2
2020-02-26T00:42:20.274Z,1582677740.274 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.001278
CHAN A1 (24V): -0.000523
CHAN A2 (12V): -0.007583
CHAN A3 (5V): -0.002427
CHAN B0 (3.3V): 0.000234
CHAN B1 (3.15aV): -0.000082
CHAN B2 (3.15bV): -0.000164
CHAN B3 (GND): 0.002556
OPEN: 0.005217
Full Scale Calc: 4.765 mA, -1.589 mA
2020-02-26T00:42:30.737Z,1582677750.737 [RDI_Pathfinder](INFO): SA. Got:

2020-02-26T00:42:30.739Z,1582677750.739 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:Pathfinder 600
2020-02-26T00:42:30.745Z,1582677750.745 [RDI_Pathfinder](INFO): Next line. Got:
Teledyne RD Instruments (c) 2019
2020-02-26T00:42:30.748Z,1582677750.748 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got:All rights reserved.
2020-02-26T00:42:30.749Z,1582677750.749 [RDI_Pathfinder](ERROR): Failed to parse:All rights reserved.
2020-02-26T00:42:31.575Z,1582677751.575 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:31.575Z,1582677751.575 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:31.577Z,1582677751.577 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516312518,35.0, +21.2,   0.0,1524.7,  0
2020-02-26T00:42:31.582Z,1582677751.582 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:31.583Z,1582677751.583 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:32.786Z,1582677752.786 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:32.786Z,1582677752.786 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:32.788Z,1582677752.788 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516312618,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:42:32.789Z,1582677752.789 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:32.789Z,1582677752.789 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:34.376Z,1582677754.376 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:34.376Z,1582677754.376 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:34.378Z,1582677754.378 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516312718,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:42:34.380Z,1582677754.380 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:34.380Z,1582677754.380 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:35.184Z,1582677755.184 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:35.184Z,1582677755.184 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:35.186Z,1582677755.186 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516312818,35.0, +21.2,   0.0,1524.7,  0
2020-02-26T00:42:35.208Z,1582677755.208 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:35.208Z,1582677755.208 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:35.584Z,1582677755.584 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:35.584Z,1582677755.584 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:35.586Z,1582677755.586 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516312918,35.0, +21.2,   0.0,1524.7,  0
2020-02-26T00:42:35.588Z,1582677755.588 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:35.588Z,1582677755.588 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:36.817Z,1582677756.817 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:36.817Z,1582677756.817 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:36.819Z,1582677756.819 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516313018,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:42:36.820Z,1582677756.820 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:36.820Z,1582677756.820 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:37.626Z,1582677757.626 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:37.626Z,1582677757.626 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:37.628Z,1582677757.628 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516313118,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:42:37.629Z,1582677757.629 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:37.630Z,1582677757.630 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:38.820Z,1582677758.820 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:38.821Z,1582677758.821 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:38.823Z,1582677758.823 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516313218,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:42:38.824Z,1582677758.824 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:38.825Z,1582677758.825 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:39.632Z,1582677759.632 [RDI_Pathfinder](INFO): SA. Got::SA,   +0.00,   +0.00,  0.00
2020-02-26T00:42:39.632Z,1582677759.632 [RDI_Pathfinder](INFO): Expected to see TS and didn't. Got:

2020-02-26T00:42:39.634Z,1582677759.634 [RDI_Pathfinder](INFO): Next line. Got::TS,20022516313318,35.0, +21.2,   0.0,1524.9,  0
2020-02-26T00:42:39.635Z,1582677759.635 [RDI_Pathfinder](INFO): Next line with CR/LF flush. Got::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:39.635Z,1582677759.635 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-26T00:42:40.431Z,1582677760.431 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2020-02-26T00:42:40.431Z,1582677760.431 [RDI_Pathfinder] Communications Fault, FailCount= 3
2020-02-26T00:42:40.431Z,1582677760.431 [RDI_Pathfinder](ERROR): Communications Fault
2020-02-26T00:42:40.575Z,1582677760.575 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2020-02-26T00:42:40.575Z,1582677760.575 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2020-02-26T00:42:40.911Z,1582677760.911 [RDI_Pathfinder](INFO): Powering down
2020-02-26T00:42:41.125Z,1582677761.125 [CBIT](INFO): Critical error at 20200226T004240
2020-02-26T00:43:02.828Z,1582677782.828 [SBIT](IMPORTANT): SBIT PASSED
2020-02-26T00:43:02.828Z,1582677782.828 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-02-26T00:43:02.829Z,1582677782.829 [SBIT](IMPORTANT): BR_Ping1D.loadAtStartup=0 bool;

2020-02-26T00:43:02.829Z,1582677782.829 [SBIT](IMPORTANT): CBIT.gf24Offset=143 microampere;

2020-02-26T00:43:02.829Z,1582677782.829 [SBIT](IMPORTANT): DAT.sbdAddress=-1 enum;

2020-02-26T00:43:02.829Z,1582677782.829 [SBIT](IMPORTANT): DAT.transponderAddress=4 enum;

2020-02-26T00:43:02.829Z,1582677782.829 [SBIT](IMPORTANT): DAT.verbosity=3 count;

2020-02-26T00:43:02.829Z,1582677782.829 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2020-02-26T00:43:02.830Z,1582677782.830 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=5 minute;

2020-02-26T00:43:02.830Z,1582677782.830 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;

2020-02-26T00:43:02.830Z,1582677782.830 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_median_sea_water_temperature 0.025000 kelvin;

2020-02-26T00:43:02.830Z,1582677782.830 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 50.000000 liter_per_second;

2020-02-26T00:43:02.830Z,1582677782.830 [SBIT](IMPORTANT): Express linearApproximation acoustic_contact_range 15.000000 meter;

2020-02-26T00:43:02.830Z,1582677782.830 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;

2020-02-26T00:43:02.830Z,1582677782.830 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=5 ampere_hour;

2020-02-26T00:43:02.830Z,1582677782.830 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=13 volt;

2020-02-26T00:43:02.831Z,1582677782.831 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=225 cubic_centimeter;

2020-02-26T00:43:02.831Z,1582677782.831 [SBIT](IMPORTANT): VerticalControl.massDefault=5 millimeter;

2020-02-26T00:43:02.831Z,1582677782.831 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=1 bool;

2020-02-26T00:43:03.173Z,1582677783.173 [MissionManager](IMPORTANT): Started mission Startup
2020-02-26T00:43:03.174Z,1582677783.174 [Startup] Running Loop=1
2020-02-26T00:43:03.174Z,1582677783.174 [Startup](DEBUG): Aggregate::initialize Startup
2020-02-26T00:43:03.174Z,1582677783.174 [Startup:A.GoToSurface] Running Loop=1
2020-02-26T00:43:03.174Z,1582677783.174 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-02-26T00:43:03.175Z,1582677783.175 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-02-26T00:43:03.175Z,1582677783.175 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-02-26T00:43:03.176Z,1582677783.176 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-02-26T00:43:03.176Z,1582677783.176 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-02-26T00:43:03.176Z,1582677783.176 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-02-26T00:43:03.178Z,1582677783.178 [Startup:StartupSatComms] Running Loop=1
2020-02-26T00:43:03.178Z,1582677783.178 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-02-26T00:43:03.178Z,1582677783.178 [Startup:StartupSatComms:A] Running Loop=1
2020-02-26T00:43:03.572Z,1582677783.572 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-02-26T00:43:59.432Z,1582677839.432 [CommandLine](IMPORTANT): got command restart application
2020-02-26T00:44:00.439Z,1582677840.439 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-26T00:44:00.439Z,1582677840.439 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:00.542Z,1582677840.542 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-02-26T00:44:00.543Z,1582677840.543 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:00.543Z,1582677840.543 [CommandLine](INFO): Join timeout helper Thread ID is 6735
2020-02-26T00:44:00.551Z,1582677840.551 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-02-26T00:44:00.551Z,1582677840.551 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:00.551Z,1582677840.551 [NavChartDb](INFO): Join timeout helper Thread ID is 6736
2020-02-26T00:44:00.607Z,1582677840.607 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-26T00:44:00.607Z,1582677840.607 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:00.623Z,1582677840.623 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler
2020-02-26T00:44:00.623Z,1582677840.623 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:00.623Z,1582677840.623 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 6737
2020-02-26T00:44:00.960Z,1582677840.960 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004838
2020-02-26T00:44:00.971Z,1582677840.971 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-26T00:44:00.971Z,1582677840.971 [WetLabsUBAT](INFO): Powering down
2020-02-26T00:44:01.002Z,1582677841.002 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:01.007Z,1582677841.007 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-02-26T00:44:01.007Z,1582677841.007 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:01.008Z,1582677841.008 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6738
2020-02-26T00:44:01.463Z,1582677841.463 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-26T00:44:01.463Z,1582677841.463 [WetLabsBB2FL](INFO): Powering down
2020-02-26T00:44:01.464Z,1582677841.464 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:01.478Z,1582677841.478 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-02-26T00:44:01.479Z,1582677841.479 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:01.479Z,1582677841.479 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6739
2020-02-26T00:44:02.359Z,1582677842.359 [CTD_Seabird](INFO): Powering down
2020-02-26T00:44:02.371Z,1582677842.371 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-26T00:44:02.372Z,1582677842.372 [CTD_Seabird](INFO): Powering down
2020-02-26T00:44:02.386Z,1582677842.386 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:02.388Z,1582677842.388 [ComponentRegistry](INFO): Shutting down BackSeatDriver ThreadHandler
2020-02-26T00:44:02.388Z,1582677842.388 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:02.388Z,1582677842.388 [BackSeatDriver](INFO): Join timeout helper Thread ID is 6740
2020-02-26T00:44:02.463Z,1582677842.463 [BackSeatDriver ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-26T00:44:02.463Z,1582677842.463 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:02.467Z,1582677842.467 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-02-26T00:44:02.467Z,1582677842.467 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:02.468Z,1582677842.468 [Radio_Surface](INFO): Join timeout helper Thread ID is 6741
2020-02-26T00:44:02.847Z,1582677842.847 [Radio_Surface](INFO): Powering down
2020-02-26T00:44:02.847Z,1582677842.847 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-26T00:44:02.848Z,1582677842.848 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:02.867Z,1582677842.867 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-02-26T00:44:02.867Z,1582677842.867 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:02.868Z,1582677842.868 [DataOverHttps](INFO): Join timeout helper Thread ID is 6742
2020-02-26T00:44:02.963Z,1582677842.963 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-26T00:44:02.963Z,1582677842.963 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:02.967Z,1582677842.967 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-02-26T00:44:02.967Z,1582677842.967 [logger ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:02.968Z,1582677842.968 [logger](INFO): Join timeout helper Thread ID is 6743
2020-02-26T00:44:02.983Z,1582677842.983 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-26T00:44:02.983Z,1582677842.983 [logger ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:02.987Z,1582677842.987 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-02-26T00:44:02.988Z,1582677842.988 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:02.988Z,1582677842.988 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-02-26T00:44:02.988Z,1582677842.988 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:02.988Z,1582677842.988 [controlThread](INFO): Join timeout helper Thread ID is 6744
2020-02-26T00:44:03.020Z,1582677843.020 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-26T00:44:03.020Z,1582677843.020 [controlThread](DEBUG): Uninitializing ControlThread
2020-02-26T00:44:03.020Z,1582677843.020 [AHRS_M2](INFO): Powering down
2020-02-26T00:44:03.091Z,1582677843.091 [NAL9602](INFO): Powering down
2020-02-26T00:44:03.092Z,1582677843.092 [RDI_Pathfinder](INFO): Powering down
2020-02-26T00:44:03.093Z,1582677843.093 [DAT](INFO): Powering down
2020-02-26T00:44:03.212Z,1582677843.212 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-02-26T00:44:03.213Z,1582677843.213 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-02-26T00:44:03.213Z,1582677843.213 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-02-26T00:44:03.214Z,1582677843.214 [MissionManager](INFO): Uninitializing Mission Default
2020-02-26T00:44:03.216Z,1582677843.216 [MissionManager](INFO): Uninitializing Mission Startup
2020-02-26T00:44:03.216Z,1582677843.216 [Startup] Stopped
2020-02-26T00:44:03.216Z,1582677843.216 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-02-26T00:44:03.216Z,1582677843.216 [Startup:A.GoToSurface] Stopped
2020-02-26T00:44:03.216Z,1582677843.216 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-02-26T00:44:03.216Z,1582677843.216 [Startup:StartupSatComms] Stopped
2020-02-26T00:44:03.216Z,1582677843.216 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-02-26T00:44:03.216Z,1582677843.216 [Startup:StartupSatComms:A] Stopped
2020-02-26T00:44:03.217Z,1582677843.217 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-02-26T00:44:03.218Z,1582677843.218 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-02-26T00:44:03.218Z,1582677843.218 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-02-26T00:44:03.218Z,1582677843.218 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-02-26T00:44:03.219Z,1582677843.219 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-02-26T00:44:03.219Z,1582677843.219 [BuoyancyServo](INFO): Powering down
2020-02-26T00:44:03.231Z,1582677843.231 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-02-26T00:44:03.231Z,1582677843.231 [ElevatorServo](INFO): Powering down
2020-02-26T00:44:03.231Z,1582677843.231 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-02-26T00:44:03.232Z,1582677843.232 [MassServo](INFO): Powering down
2020-02-26T00:44:03.232Z,1582677843.232 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-02-26T00:44:03.232Z,1582677843.232 [RudderServo](INFO): Powering down
2020-02-26T00:44:03.233Z,1582677843.233 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-02-26T00:44:03.233Z,1582677843.233 [ThrusterServo](INFO): Powering down
2020-02-26T00:44:03.234Z,1582677843.234 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-02-26T00:44:03.234Z,1582677843.234 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-02-26T00:44:03.235Z,1582677843.235 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-02-26T00:44:03.235Z,1582677843.235 [CBIT](DEBUG): Powering off loads.
2020-02-26T00:44:03.246Z,1582677843.246 [CBIT](DEBUG): Disabling WDT.
2020-02-26T00:44:03.258Z,1582677843.258 [CBIT](DEBUG): Opening all GF detection circuits.
2020-02-26T00:44:03.259Z,1582677843.259 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:03.346Z,1582677843.346 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:03.352Z,1582677843.352 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:03.532Z,1582677843.532 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:03.533Z,1582677843.533 [WetLabsUBAT](INFO): WetLabs destructor: _dataLog is not open
2020-02-26T00:44:03.534Z,1582677843.534 [WetLabsUBAT](INFO): WetLabs destructor: done
2020-02-26T00:44:03.537Z,1582677843.537 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:03.540Z,1582677843.540 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:03.543Z,1582677843.543 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:03.552Z,1582677843.552 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-02-26T00:44:03.612Z,1582677843.612 [logger ThreadHandler](INFO): Thread cancelled.