1970-02-07T21:28:34.732Z,3274114.732 [Supervisor](DEBUG): Initializing supervisor.
1970-02-07T21:28:34.736Z,3274114.736 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
1970-02-07T21:28:34.737Z,3274114.737 [SyncHandler](INFO): Protected caller Thread ID is 804
1970-02-07T21:28:34.738Z,3274114.738 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
1970-02-07T21:28:34.739Z,3274114.739 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
1970-02-07T21:28:34.739Z,3274114.739 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 805
1970-02-07T21:28:34.743Z,3274114.743 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
1970-02-07T21:28:34.762Z,3274114.762 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
1970-02-07T21:28:34.763Z,3274114.763 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
1970-02-07T21:28:34.763Z,3274114.763 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 806
1970-02-07T21:28:34.767Z,3274114.767 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
1970-02-07T21:28:34.768Z,3274114.768 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
1970-02-07T21:28:34.769Z,3274114.769 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 807
1970-02-07T21:28:34.771Z,3274114.771 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
1970-02-07T21:28:34.772Z,3274114.772 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
1970-02-07T21:28:34.772Z,3274114.772 [logger ThreadHandler](INFO): Protected caller Thread ID is 808
1970-02-07T21:28:34.776Z,3274114.776 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
1970-02-07T21:28:34.776Z,3274114.776 [Supervisor](INFO): Looking for Config files in directory: Config/
1970-02-07T21:28:34.780Z,3274114.780 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
1970-02-07T21:28:34.861Z,3274114.861 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
1970-02-07T21:28:34.989Z,3274114.989 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
1970-02-07T21:28:34.990Z,3274114.990 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
1970-02-07T21:28:35.192Z,3274115.192 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
1970-02-07T21:28:35.192Z,3274115.192 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
1970-02-07T21:28:35.516Z,3274115.516 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
1970-02-07T21:28:35.516Z,3274115.516 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
1970-02-07T21:28:35.695Z,3274115.695 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
1970-02-07T21:28:35.697Z,3274115.697 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
1970-02-07T21:28:36.062Z,3274116.062 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
1970-02-07T21:28:36.063Z,3274116.063 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
1970-02-07T21:28:36.171Z,3274116.171 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
1970-02-07T21:28:36.172Z,3274116.172 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
1970-02-07T21:28:36.269Z,3274116.269 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
1970-02-07T21:28:36.271Z,3274116.271 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
1970-02-07T21:28:36.507Z,3274116.507 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
1970-02-07T21:28:36.508Z,3274116.508 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
1970-02-07T21:28:36.704Z,3274116.704 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
1970-02-07T21:28:36.704Z,3274116.704 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
1970-02-07T21:28:36.785Z,3274116.785 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
1970-02-07T21:28:37.100Z,3274117.100 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
1970-02-07T21:28:37.100Z,3274117.100 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
1970-02-07T21:28:37.592Z,3274117.592 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
1970-02-07T21:28:37.593Z,3274117.593 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
1970-02-07T21:28:38.080Z,3274118.080 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
1970-02-07T21:28:38.081Z,3274118.081 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
1970-02-07T21:28:38.819Z,3274118.819 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
1970-02-07T21:28:38.820Z,3274118.820 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
1970-02-07T21:28:39.104Z,3274119.104 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
1970-02-07T21:28:39.106Z,3274119.106 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
1970-02-07T21:28:39.108Z,3274119.108 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
1970-02-07T21:28:39.235Z,3274119.235 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
1970-02-07T21:28:39.327Z,3274119.327 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
1970-02-07T21:28:39.432Z,3274119.432 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
1970-02-07T21:28:39.515Z,3274119.515 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
1970-02-07T21:28:39.611Z,3274119.611 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
1970-02-07T21:28:39.704Z,3274119.704 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
1970-02-07T21:28:39.959Z,3274119.959 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
1970-02-07T21:28:39.960Z,3274119.960 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
1970-02-07T21:28:40.113Z,3274120.113 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
1970-02-07T21:28:40.198Z,3274120.198 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
1970-02-07T21:28:40.346Z,3274120.346 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg
1970-02-07T21:28:40.447Z,3274120.447 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
1970-02-07T21:28:40.451Z,3274120.451 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
1970-02-07T21:28:40.575Z,3274120.575 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
1970-02-07T21:28:40.577Z,3274120.577 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
1970-02-07T21:28:41.362Z,3274121.362 [AHRS_M2] Loaded
1970-02-07T21:28:41.363Z,3274121.363 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
1970-02-07T21:28:42.148Z,3274122.148 [BPC1] Loaded
1970-02-07T21:28:42.149Z,3274122.149 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
1970-02-07T21:28:42.296Z,3274122.296 [DataOverHttps] Loaded
1970-02-07T21:28:42.296Z,3274122.296 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
1970-02-07T21:28:42.298Z,3274122.298 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408204E0
1970-02-07T21:28:42.298Z,3274122.298 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 890
1970-02-07T21:28:42.344Z,3274122.344 [Depth_Keller] Loaded
1970-02-07T21:28:42.344Z,3274122.344 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
1970-02-07T21:28:42.349Z,3274122.349 [DropWeight] Loaded
1970-02-07T21:28:42.349Z,3274122.349 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
1970-02-07T21:28:42.411Z,3274122.411 [NAL9602] Loaded
1970-02-07T21:28:42.411Z,3274122.411 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
1970-02-07T21:28:42.438Z,3274122.438 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now
1970-02-07T21:28:42.439Z,3274122.439 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now
1970-02-07T21:28:42.439Z,3274122.439 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now
1970-02-07T21:28:42.440Z,3274122.440 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full
1970-02-07T21:28:42.440Z,3274122.440 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now
1970-02-07T21:28:42.441Z,3274122.441 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now
1970-02-07T21:28:42.441Z,3274122.441 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now
1970-02-07T21:28:42.442Z,3274122.442 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full
1970-02-07T21:28:42.442Z,3274122.442 [Onboard] Loaded
1970-02-07T21:28:42.442Z,3274122.442 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
1970-02-07T21:28:42.443Z,3274122.443 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408504E0
1970-02-07T21:28:42.443Z,3274122.443 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 891
1970-02-07T21:28:42.456Z,3274122.456 [Power24vConverter] Loaded
1970-02-07T21:28:42.457Z,3274122.457 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
1970-02-07T21:28:42.490Z,3274122.490 [PNI_TCM] Loaded
1970-02-07T21:28:42.490Z,3274122.490 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
1970-02-07T21:28:42.504Z,3274122.504 [Radio_Surface] Loaded
1970-02-07T21:28:42.504Z,3274122.504 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
1970-02-07T21:28:42.505Z,3274122.505 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408804E0
1970-02-07T21:28:42.506Z,3274122.506 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 892
1970-02-07T21:28:42.595Z,3274122.595 [DAT] Loaded
1970-02-07T21:28:42.595Z,3274122.595 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
1970-02-07T21:28:42.596Z,3274122.596 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408B04E0
1970-02-07T21:28:42.596Z,3274122.596 [DAT ThreadHandler](INFO): Protected caller Thread ID is 893
1970-02-07T21:28:42.597Z,3274122.597 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
1970-02-07T21:28:42.598Z,3274122.598 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
1970-02-07T21:28:42.655Z,3274122.655 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
1970-02-07T21:28:42.655Z,3274122.655 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
1970-02-07T21:28:42.676Z,3274122.676 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
1970-02-07T21:28:42.677Z,3274122.677 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
1970-02-07T21:28:42.750Z,3274122.750 [DepthRateCalculator] Loaded
1970-02-07T21:28:42.750Z,3274122.750 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
1970-02-07T21:28:42.755Z,3274122.755 [PitchRateCalculator] Loaded
1970-02-07T21:28:42.756Z,3274122.756 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
1970-02-07T21:28:42.766Z,3274122.766 [SpeedCalculator] Loaded
1970-02-07T21:28:42.767Z,3274122.767 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
1970-02-07T21:28:42.771Z,3274122.771 [YawRateCalculator] Loaded
1970-02-07T21:28:42.772Z,3274122.772 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
1970-02-07T21:28:42.794Z,3274122.794 [ElevatorOffsetCalculator] Loaded
1970-02-07T21:28:42.794Z,3274122.794 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
1970-02-07T21:28:42.795Z,3274122.795 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
1970-02-07T21:28:42.795Z,3274122.795 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
1970-02-07T21:28:42.975Z,3274122.975 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
1970-02-07T21:28:42.976Z,3274122.976 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
1970-02-07T21:28:43.058Z,3274123.058 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
1970-02-07T21:28:43.059Z,3274123.059 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
1970-02-07T21:28:43.196Z,3274123.196 [DeadReckonUsingMultipleVelocitySources] Loaded
1970-02-07T21:28:43.196Z,3274123.196 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
1970-02-07T21:28:43.238Z,3274123.238 [DeadReckonUsingSpeedCalculator] Loaded
1970-02-07T21:28:43.238Z,3274123.238 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
1970-02-07T21:28:43.279Z,3274123.279 [DeadReckonWithRespectToSeafloor] Loaded
1970-02-07T21:28:43.280Z,3274123.280 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
1970-02-07T21:28:43.293Z,3274123.293 [NavChart] Loaded
1970-02-07T21:28:43.294Z,3274123.294 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
1970-02-07T21:28:43.299Z,3274123.299 [UniversalFixResidualReporter] Loaded
1970-02-07T21:28:43.300Z,3274123.300 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
1970-02-07T21:28:43.300Z,3274123.300 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
1970-02-07T21:28:43.301Z,3274123.301 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
1970-02-07T21:28:43.663Z,3274123.663 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
1970-02-07T21:28:43.663Z,3274123.663 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
1970-02-07T21:28:43.833Z,3274123.833 [SBIT](DEBUG): Construct Startup Built In Test.
1970-02-07T21:28:43.847Z,3274123.847 [SBIT] Loaded
1970-02-07T21:28:43.848Z,3274123.848 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
1970-02-07T21:28:43.851Z,3274123.851 [IBIT](DEBUG): Construct Initiated Built In Test.
1970-02-07T21:28:43.864Z,3274123.864 [IBIT] Loaded
1970-02-07T21:28:43.864Z,3274123.864 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
1970-02-07T21:28:43.870Z,3274123.870 [CBIT](DEBUG): Construct Continuous Built In Test.
1970-02-07T21:28:43.973Z,3274123.973 [CBIT] Loaded
1970-02-07T21:28:43.974Z,3274123.974 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
1970-02-07T21:28:43.974Z,3274123.974 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
1970-02-07T21:28:43.975Z,3274123.975 [Module Loader](DEBUG): Loading Module at Modules/Control.so
1970-02-07T21:28:44.042Z,3274124.042 [VerticalControl](DEBUG): Construct VerticalControl.
1970-02-07T21:28:44.097Z,3274124.097 [VerticalControl] Loaded
1970-02-07T21:28:44.097Z,3274124.097 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
1970-02-07T21:28:44.100Z,3274124.100 [HorizontalControl](DEBUG): Construct HorizontalControl.
1970-02-07T21:28:44.139Z,3274124.139 [HorizontalControl] Loaded
1970-02-07T21:28:44.140Z,3274124.140 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
1970-02-07T21:28:44.142Z,3274124.142 [SpeedControl](DEBUG): Construct SpeedControl.
1970-02-07T21:28:44.145Z,3274124.145 [SpeedControl] Loaded
1970-02-07T21:28:44.145Z,3274124.145 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
1970-02-07T21:28:44.148Z,3274124.148 [LoopControl](DEBUG): Construct LoopControl.
1970-02-07T21:28:44.148Z,3274124.148 [LoopControl] Loaded
1970-02-07T21:28:44.149Z,3274124.149 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
1970-02-07T21:28:44.149Z,3274124.149 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
1970-02-07T21:28:44.150Z,3274124.150 [Module Loader](DEBUG): Loading Module at Modules/Science.so
1970-02-07T21:28:44.333Z,3274124.333 [Aanderaa_O2] Loaded
1970-02-07T21:28:44.333Z,3274124.333 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
1970-02-07T21:28:44.394Z,3274124.394 [CTD_Seabird] Loaded
1970-02-07T21:28:44.394Z,3274124.394 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
1970-02-07T21:28:44.395Z,3274124.395 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B104E0
1970-02-07T21:28:44.396Z,3274124.396 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 894
1970-02-07T21:28:44.428Z,3274124.428 [ESPComponent] Loaded
1970-02-07T21:28:44.429Z,3274124.429 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
1970-02-07T21:28:44.449Z,3274124.449 [PAR_Licor] Loaded
1970-02-07T21:28:44.449Z,3274124.449 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
1970-02-07T21:28:44.480Z,3274124.480 [WetLabsBB2FL] Loaded
1970-02-07T21:28:44.480Z,3274124.480 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
1970-02-07T21:28:44.481Z,3274124.481 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B404E0
1970-02-07T21:28:44.482Z,3274124.482 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 895
1970-02-07T21:28:44.483Z,3274124.483 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
1970-02-07T21:28:44.483Z,3274124.483 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
1970-02-07T21:28:44.643Z,3274124.643 [BuoyancyServo] Loaded
1970-02-07T21:28:44.643Z,3274124.643 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
1970-02-07T21:28:44.664Z,3274124.664 [ElevatorServo] Loaded
1970-02-07T21:28:44.664Z,3274124.664 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
1970-02-07T21:28:44.684Z,3274124.684 [MassServo] Loaded
1970-02-07T21:28:44.684Z,3274124.684 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
1970-02-07T21:28:44.703Z,3274124.703 [RudderServo] Loaded
1970-02-07T21:28:44.703Z,3274124.703 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
1970-02-07T21:28:44.720Z,3274124.720 [ThrusterServo] Loaded
1970-02-07T21:28:44.721Z,3274124.721 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
1970-02-07T21:28:44.721Z,3274124.721 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
1970-02-07T21:28:44.728Z,3274124.728 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
1970-02-07T21:28:44.730Z,3274124.730 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
1970-02-07T21:28:44.742Z,3274124.742 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
1970-02-07T21:28:44.743Z,3274124.743 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BA64E0
1970-02-07T21:28:44.743Z,3274124.743 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 896
1970-02-07T21:28:44.748Z,3274124.748 [Supervisor](INFO): Main Thread ID is 796
1970-02-07T21:28:44.748Z,3274124.748 [Supervisor](DEBUG): Running supervisor.
1970-02-07T21:28:44.749Z,3274124.749 [CommandExec ThreadHandler](INFO): Handler Thread ID is 897
1970-02-07T21:28:44.749Z,3274124.749 [CommandExec](INFO): Initializing the command executive.
1970-02-07T21:28:44.751Z,3274124.751 [CommandLine ThreadHandler](INFO): Handler Thread ID is 898
1970-02-07T21:28:44.753Z,3274124.753 [controlThread ThreadHandler](INFO): Handler Thread ID is 899
1970-02-07T21:28:44.753Z,3274124.753 [controlThread](DEBUG): Initializing ControlThread
1970-02-07T21:28:44.760Z,3274124.760 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
1970-02-07T21:28:44.760Z,3274124.760 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
1970-02-07T21:28:44.760Z,3274124.760 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
1970-02-07T21:28:44.760Z,3274124.760 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
1970-02-07T21:28:44.761Z,3274124.761 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
1970-02-07T21:28:44.762Z,3274124.762 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
1970-02-07T21:28:44.763Z,3274124.763 [NavChart](DEBUG): Initialize NavChart Navigation.
1970-02-07T21:28:44.763Z,3274124.763 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
1970-02-07T21:28:44.764Z,3274124.764 [SBIT](INFO): Initialize SBIT Component.
1970-02-07T21:28:44.764Z,3274124.764 [SBIT](IMPORTANT): git: 2023-01-26
1970-02-07T21:28:44.764Z,3274124.764 [SBIT](INFO): git hash: fbcd350f88251f9a867f3fca05699dec8f096e0d
1970-02-07T21:28:44.765Z,3274124.765 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
1970-02-07T21:28:44.766Z,3274124.766 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
1970-02-07T21:28:44.767Z,3274124.767 [SBIT](INFO): Beginning SBIT in 71.000000 seconds.
1970-02-07T21:28:44.768Z,3274124.768 [IBIT](INFO): Initialize IBIT Component.
1970-02-07T21:28:44.768Z,3274124.768 [CBIT](DEBUG): Initialize CBIT Component.
1970-02-07T21:28:44.769Z,3274124.769 [logger ThreadHandler](INFO): Handler Thread ID is 900
1970-02-07T21:28:44.781Z,3274124.781 [CBIT](DEBUG): Initialized mux pins.
1970-02-07T21:28:44.782Z,3274124.782 [CBIT](DEBUG): Initializing the watchdog timer.
1970-02-07T21:28:44.790Z,3274124.790 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 901
1970-02-07T21:28:44.791Z,3274124.791 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
1970-02-07T21:28:44.802Z,3274124.802 [Onboard ThreadHandler](INFO): Handler Thread ID is 902
1970-02-07T21:28:44.806Z,3274124.806 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
1970-02-07T21:28:44.807Z,3274124.807 [CBIT](DEBUG): Initializing heartbeat.
1970-02-07T21:28:44.825Z,3274124.825 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 903
1970-02-07T21:28:44.827Z,3274124.827 [DAT ThreadHandler](INFO): Handler Thread ID is 904
1970-02-07T21:28:44.827Z,3274124.827 [DAT](INFO): Powering up
1970-02-07T21:28:44.828Z,3274124.828 [DAT](DEBUG): Initializing DAT.
1970-02-07T21:28:44.831Z,3274124.831 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 906
1970-02-07T21:28:44.831Z,3274124.831 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
1970-02-07T21:28:44.835Z,3274124.835 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 908
1970-02-07T21:28:44.838Z,3274124.838 [WetLabsBB2FL](INFO): Powering up
1970-02-07T21:28:44.839Z,3274124.839 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 910
1970-02-07T21:28:44.841Z,3274124.841 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000
1970-02-07T21:28:44.843Z,3274124.843 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US2HA05M.000
1970-02-07T21:28:44.843Z,3274124.843 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000
1970-02-07T21:28:44.845Z,3274124.845 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US3HA20M.000
1970-02-07T21:28:44.845Z,3274124.845 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
1970-02-07T21:28:44.847Z,3274124.847 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4HA51M.000
1970-02-07T21:28:44.847Z,3274124.847 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
1970-02-07T21:28:44.847Z,3274124.847 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4HA51M.000
1970-02-07T21:28:44.847Z,3274124.847 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000
1970-02-07T21:28:44.849Z,3274124.849 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5HA53M.000
1970-02-07T21:28:44.849Z,3274124.849 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000
1970-02-07T21:28:44.851Z,3274124.851 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5HA55M.000
1970-02-07T21:28:44.854Z,3274124.854 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5HA55M.000
1970-02-07T21:28:44.877Z,3274124.877 [CBIT](DEBUG): Deactivating GF circuits.
1970-02-07T21:28:44.878Z,3274124.878 [CBIT](DEBUG): Deactivating emergency mode.
1970-02-07T21:28:44.913Z,3274124.913 [CBIT](DEBUG): Backplane powered.
1970-02-07T21:28:44.914Z,3274124.914 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
1970-02-07T21:28:44.916Z,3274124.916 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
1970-02-07T21:28:44.916Z,3274124.916 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
1970-02-07T21:28:44.917Z,3274124.917 [LoopControl](DEBUG): Initialize LoopControlComponent.
1970-02-07T21:28:44.924Z,3274124.924 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
1970-02-07T21:28:44.952Z,3274124.952 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
1970-02-07T21:28:44.989Z,3274124.989 [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>


1970-02-07T21:28:45.008Z,3274125.008 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
1970-02-07T21:28:45.096Z,3274125.096 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
1970-02-07T21:28:45.097Z,3274125.097 [Default:A.Wait](DEBUG): Construct Wait.
1970-02-07T21:28:45.100Z,3274125.100 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
1970-02-07T21:28:45.138Z,3274125.138 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
1970-02-07T21:28:45.141Z,3274125.141 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
1970-02-07T21:28:45.158Z,3274125.158 [Default:E.Execute](DEBUG): Construct Execute.
1970-02-07T21:28:45.161Z,3274125.161 [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="P4H">
                <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>


1970-02-07T21:28:45.194Z,3274125.194 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,PNI_TCM,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
1970-02-07T21:28:45.212Z,3274125.212 [AHRS_M2](DEBUG): Initializing AHRS_M2.
1970-02-07T21:28:45.230Z,3274125.230 [Radio_Surface](INFO): Powering up
1970-02-07T21:28:45.430Z,3274125.430 [Power24vConverter](INFO): Powering up.
1970-02-07T21:28:45.516Z,3274125.516 [BuoyancyServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:45.522Z,3274125.522 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
1970-02-07T21:28:45.523Z,3274125.523 [ElevatorServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:45.530Z,3274125.530 [ElevatorServo](DEBUG): Initializing ElevatorServo.
1970-02-07T21:28:45.531Z,3274125.531 [MassServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:45.538Z,3274125.538 [MassServo](DEBUG): Initializing MassServo.
1970-02-07T21:28:45.539Z,3274125.539 [RudderServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:45.546Z,3274125.546 [RudderServo](DEBUG): Initializing RudderServo.
1970-02-07T21:28:45.547Z,3274125.547 [ThrusterServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:45.554Z,3274125.554 [ThrusterServo](DEBUG): Initializing ThrusterServo.
1970-02-07T21:28:45.557Z,3274125.557 [CBIT](FAULT): Main Battery Failure. Count: 1
1970-02-07T21:28:45.743Z,3274125.743 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

1970-02-07T21:28:45.743Z,3274125.743 [DropWeight] Hardware Fault, FailCount= 1
1970-02-07T21:28:45.743Z,3274125.743 [DropWeight](ERROR): Hardware Fault
1970-02-07T21:28:45.781Z,3274125.781 [CommandExec](FAULT): Scheduling is paused
1970-02-07T21:28:45.810Z,3274125.810 [CBIT](INFO): Critical error at 19700207T212845
1970-02-07T21:28:45.810Z,3274125.810 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
1970-02-07T21:28:45.812Z,3274125.812 [CBIT](ERROR): Hardware Fault in component: DropWeight
1970-02-07T21:28:45.813Z,3274125.813 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
1970-02-07T21:28:46.051Z,3274126.051 [CBIT](INFO): Critical error at 19700207T212845
1970-02-07T21:28:46.942Z,3274126.942 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
1970-02-07T21:28:47.261Z,3274127.261 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
1970-02-07T21:28:47.262Z,3274127.262 [ThrusterServo](FAULT): Thruster failed to initialize
1970-02-07T21:28:47.262Z,3274127.262 [ThrusterServo] Communications Fault, FailCount= 1
1970-02-07T21:28:47.262Z,3274127.262 [ThrusterServo](ERROR): Communications Fault
1970-02-07T21:28:47.266Z,3274127.266 [CBIT](ERROR): Communications Fault in component: ThrusterServo
1970-02-07T21:28:47.301Z,3274127.301 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
1970-02-07T21:28:47.301Z,3274127.301 [ThrusterServo](INFO): Powering down
1970-02-07T21:28:48.014Z,3274128.014 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
1970-02-07T21:28:48.014Z,3274128.014 [MassServo] Communications Fault, FailCount= 1
1970-02-07T21:28:48.014Z,3274128.014 [MassServo](ERROR): Communications Fault
1970-02-07T21:28:48.018Z,3274128.018 [CBIT](ERROR): Communications Fault in component: MassServo
1970-02-07T21:28:48.202Z,3274128.202 [MassServo](DEBUG): Uninitialize Mass Servo.
1970-02-07T21:28:48.202Z,3274128.202 [MassServo](INFO): Powering down
1970-02-07T21:28:48.349Z,3274128.349 [CBIT](INFO): Clearing failed state for component ThrusterServo
1970-02-07T21:28:48.349Z,3274128.349 [ThrusterServo] No Fault, FailCount= 1
1970-02-07T21:28:48.483Z,3274128.483 [AHRS_M2](DEBUG): boresightMatrix m[ decimal 0 0 2 2 f0.0 f0.0 f-1.0 f0.0 f-1.0 f0.0 f-1.0 f0.0 f0.0 ]m set drop

1970-02-07T21:28:48.535Z,3274128.535 [ThrusterServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:48.542Z,3274128.542 [ThrusterServo](DEBUG): Initializing ThrusterServo.
1970-02-07T21:28:48.886Z,3274128.886 [AHRS_M2](DEBUG): chan0Format 2 set drop

1970-02-07T21:28:48.975Z,3274128.975 [MassServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:49.090Z,3274129.090 [MassServo](DEBUG): Initializing MassServo.
1970-02-07T21:28:49.461Z,3274129.461 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
1970-02-07T21:28:49.563Z,3274129.563 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5HA55M.000
1970-02-07T21:28:49.777Z,3274129.777 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
1970-02-07T21:28:49.778Z,3274129.778 [ThrusterServo](FAULT): Thruster failed to initialize
1970-02-07T21:28:49.778Z,3274129.778 [ThrusterServo] Communications Fault, FailCount= 2
1970-02-07T21:28:49.778Z,3274129.778 [ThrusterServo](ERROR): Communications Fault
1970-02-07T21:28:49.781Z,3274129.781 [CBIT](INFO): Clearing failed state for component MassServo
1970-02-07T21:28:49.782Z,3274129.782 [MassServo] No Fault, FailCount= 1
1970-02-07T21:28:49.782Z,3274129.782 [CBIT](ERROR): Communications Fault in component: ThrusterServo
1970-02-07T21:28:49.788Z,3274129.788 [AHRS_M2](DEBUG): chan0Trigger 5 set drop

1970-02-07T21:28:49.874Z,3274129.874 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
1970-02-07T21:28:49.875Z,3274129.875 [ThrusterServo](INFO): Powering down
1970-02-07T21:28:50.133Z,3274130.133 [WetLabsBB2FL] Communications Fault, FailCount= 1
1970-02-07T21:28:50.133Z,3274130.133 [WetLabsBB2FL](ERROR): Communications Fault
1970-02-07T21:28:50.190Z,3274130.190 [AHRS_M2](DEBUG): chan0Enables array[ 0 15 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 ]array set drop

1970-02-07T21:28:50.191Z,3274130.191 [AHRS_M2](DEBUG): chan0EnableBit pitch dvid@ set drop

1970-02-07T21:28:50.259Z,3274130.259 [CBIT](FAULT): Main Battery Failure. Count: 11
1970-02-07T21:28:50.262Z,3274130.262 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
1970-02-07T21:28:50.595Z,3274130.595 [AHRS_M2](DEBUG): chan0EnableBit roll dvid@ set drop

1970-02-07T21:28:50.638Z,3274130.638 [WetLabsBB2FL](INFO): Powering down
1970-02-07T21:28:50.658Z,3274130.658 [RudderServo](FAULT): Overload Error
1970-02-07T21:28:50.658Z,3274130.658 [RudderServo] Hardware Fault, FailCount= 1
1970-02-07T21:28:50.658Z,3274130.658 [RudderServo](ERROR): Hardware Fault
1970-02-07T21:28:50.806Z,3274130.806 [CBIT](ERROR): Hardware Fault in component: RudderServo
1970-02-07T21:28:50.806Z,3274130.806 [CBIT](INFO): Clearing failed state for component ThrusterServo
1970-02-07T21:28:50.806Z,3274130.806 [ThrusterServo] No Fault, FailCount= 2
1970-02-07T21:28:50.999Z,3274130.999 [AHRS_M2](DEBUG): chan0EnableBit yaw dvid@ set drop

1970-02-07T21:28:51.063Z,3274131.063 [RudderServo](DEBUG): Uninitialize Rudder Servo.
1970-02-07T21:28:51.063Z,3274131.063 [RudderServo](INFO): Powering down
1970-02-07T21:28:51.064Z,3274131.064 [ThrusterServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:51.070Z,3274131.070 [ThrusterServo](DEBUG): Initializing ThrusterServo.
1970-02-07T21:28:51.403Z,3274131.403 [AHRS_M2](DEBUG): chan0EnableBit magp dvid@ set drop

1970-02-07T21:28:51.870Z,3274131.870 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
1970-02-07T21:28:51.870Z,3274131.870 [MassServo] Communications Fault, FailCount= 2
1970-02-07T21:28:51.870Z,3274131.870 [MassServo](ERROR): Communications Fault
1970-02-07T21:28:52.190Z,3274132.190 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
1970-02-07T21:28:52.506Z,3274132.506 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
1970-02-07T21:28:52.506Z,3274132.506 [ThrusterServo](FAULT): Thruster failed to initialize
1970-02-07T21:28:52.506Z,3274132.506 [ThrusterServo] Communications Fault, FailCount= 3
1970-02-07T21:28:52.506Z,3274132.506 [ThrusterServo](ERROR): Communications Fault
1970-02-07T21:28:52.510Z,3274132.510 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
1970-02-07T21:28:52.510Z,3274132.510 [WetLabsBB2FL] No Fault, FailCount= 1
1970-02-07T21:28:52.510Z,3274132.510 [CBIT](ERROR): Communications Fault in component: MassServo
1970-02-07T21:28:52.511Z,3274132.511 [CBIT](ERROR): Communications Fault in component: ThrusterServo
1970-02-07T21:28:52.517Z,3274132.517 [AHRS_M2](DEBUG): chan0EnableBit accelp dvid@ set drop

1970-02-07T21:28:52.583Z,3274132.583 [MassServo](DEBUG): Uninitialize Mass Servo.
1970-02-07T21:28:52.583Z,3274132.583 [MassServo](INFO): Powering down
1970-02-07T21:28:52.584Z,3274132.584 [RudderServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:52.666Z,3274132.666 [WetLabsBB2FL](INFO): Powering up
1970-02-07T21:28:52.710Z,3274132.710 [RudderServo](DEBUG): Initializing RudderServo.
1970-02-07T21:28:52.710Z,3274132.710 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
1970-02-07T21:28:52.711Z,3274132.711 [ThrusterServo](INFO): Powering down
1970-02-07T21:28:52.715Z,3274132.715 [CBIT](INFO): Clearing failed state for component RudderServo
1970-02-07T21:28:52.715Z,3274132.715 [RudderServo] No Fault, FailCount= 1
1970-02-07T21:28:52.918Z,3274132.918 [AHRS_M2](DEBUG): chan0EnableBit gyrop dvid@ set drop

1970-02-07T21:28:52.923Z,3274132.923 [PNI_TCM](FAULT): Failed to set parameters during initialization.
1970-02-07T21:28:52.923Z,3274132.923 [PNI_TCM] Data Fault, FailCount= 1
1970-02-07T21:28:52.923Z,3274132.923 [PNI_TCM](ERROR): Data Fault
1970-02-07T21:28:52.980Z,3274132.980 [CBIT](ERROR): Data Fault in component: PNI_TCM
1970-02-07T21:28:53.323Z,3274133.323 [AHRS_M2](DEBUG): chan0EnableBit yawErrEst dvid@ set drop

1970-02-07T21:28:53.327Z,3274133.327 [PNI_TCM](INFO): Powering down
1970-02-07T21:28:53.444Z,3274133.444 [MassServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:53.567Z,3274133.567 [MassServo](DEBUG): Initializing MassServo.
1970-02-07T21:28:53.741Z,3274133.741 [CBIT](INFO): Clearing failed state for component MassServo
1970-02-07T21:28:53.741Z,3274133.741 [MassServo] No Fault, FailCount= 2
1970-02-07T21:28:53.742Z,3274133.742 [CBIT](INFO): Clearing failed state for component ThrusterServo
1970-02-07T21:28:53.742Z,3274133.742 [ThrusterServo] No Fault, FailCount= 3
1970-02-07T21:28:53.748Z,3274133.748 [AHRS_M2](DEBUG): chan0EnableBit temperature dvid@ set drop

1970-02-07T21:28:53.835Z,3274133.835 [ThrusterServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:53.842Z,3274133.842 [ThrusterServo](DEBUG): Initializing ThrusterServo.
1970-02-07T21:28:54.151Z,3274134.151 [AHRS_M2](DEBUG): chan0EnableBit magBufferActiveIndex dvid@ set drop

1970-02-07T21:28:54.555Z,3274134.555 [AHRS_M2](DEBUG): chan0TriggerDivisor 40 set drop

1970-02-07T21:28:54.957Z,3274134.957 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
1970-02-07T21:28:55.274Z,3274135.274 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
1970-02-07T21:28:55.274Z,3274135.274 [ThrusterServo](FAULT): Thruster failed to initialize
1970-02-07T21:28:55.274Z,3274135.274 [ThrusterServo] Communications Fault, FailCount= 4
1970-02-07T21:28:55.274Z,3274135.274 [ThrusterServo](ERROR): Communications Fault
1970-02-07T21:28:55.278Z,3274135.278 [CBIT](CRITICAL): Environmental Failure. Press:14.806857 PSI. Humidity:36%. Temp:24 C. ABORTING MISSION
1970-02-07T21:28:55.278Z,3274135.278 [CBIT](INFO): Clearing failed state for component PNI_TCM
1970-02-07T21:28:55.279Z,3274135.279 [PNI_TCM] No Fault, FailCount= 1
1970-02-07T21:28:55.279Z,3274135.279 [CBIT](ERROR): Communications Fault in component: ThrusterServo
1970-02-07T21:28:55.344Z,3274135.344 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
1970-02-07T21:28:55.344Z,3274135.344 [ThrusterServo](INFO): Powering down
1970-02-07T21:28:55.347Z,3274135.347 [CBIT](INFO): Critical error at 19700207T212855
1970-02-07T21:28:55.347Z,3274135.347 [CBIT](FAULT): Main Battery Failure. Count: 21
1970-02-07T21:28:55.691Z,3274135.691 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
1970-02-07T21:28:55.691Z,3274135.691 [Aanderaa_O2] Communications Fault, FailCount= 1
1970-02-07T21:28:55.692Z,3274135.692 [Aanderaa_O2](ERROR): Communications Fault
1970-02-07T21:28:56.014Z,3274136.014 [CommandExec](IMPORTANT): got command quit
1970-02-07T21:28:56.018Z,3274136.018 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
1970-02-07T21:28:56.018Z,3274136.018 [MassServo] Communications Fault, FailCount= 3
1970-02-07T21:28:56.018Z,3274136.018 [MassServo](ERROR): Communications Fault
1970-02-07T21:28:56.045Z,3274136.045 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
1970-02-07T21:28:56.045Z,3274136.045 [CBIT](ERROR): Communications Fault in component: MassServo
1970-02-07T21:28:56.226Z,3274136.226 [Aanderaa_O2](INFO): Powering down
1970-02-07T21:28:56.241Z,3274136.241 [MassServo](DEBUG): Uninitialize Mass Servo.
1970-02-07T21:28:56.242Z,3274136.242 [MassServo](INFO): Powering down
1970-02-07T21:28:56.365Z,3274136.365 [CBIT](INFO): Clearing failed state for component ThrusterServo
1970-02-07T21:28:56.365Z,3274136.365 [ThrusterServo] No Fault, FailCount= 4
1970-02-07T21:28:56.594Z,3274136.594 [ThrusterServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:56.602Z,3274136.602 [ThrusterServo](DEBUG): Initializing ThrusterServo.
1970-02-07T21:28:56.955Z,3274136.955 [MassServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:57.018Z,3274137.018 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
1970-02-07T21:28:57.018Z,3274137.018 [CommandExec](INFO): Uninitializing the command executive.
1970-02-07T21:28:57.018Z,3274137.018 [CommandExec](INFO): Uninitializing the command scheduler.
1970-02-07T21:28:57.018Z,3274137.018 [CommandExec ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:57.074Z,3274137.074 [MassServo](DEBUG): Initializing MassServo.
1970-02-07T21:28:57.103Z,3274137.103 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
1970-02-07T21:28:57.103Z,3274137.103 [Aanderaa_O2] No Fault, FailCount= 1
1970-02-07T21:28:57.103Z,3274137.103 [CBIT](INFO): Clearing failed state for component MassServo
1970-02-07T21:28:57.103Z,3274137.103 [MassServo] No Fault, FailCount= 3
1970-02-07T21:28:57.134Z,3274137.134 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
1970-02-07T21:28:57.134Z,3274137.134 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
1970-02-07T21:28:57.134Z,3274137.134 [NavChartDb ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:57.135Z,3274137.135 [NavChartDb](INFO): Join timeout helper Thread ID is 929
1970-02-07T21:28:57.284Z,3274137.284 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
1970-02-07T21:28:57.284Z,3274137.284 [NavChartDb ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:57.298Z,3274137.298 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
1970-02-07T21:28:57.298Z,3274137.298 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:57.298Z,3274137.298 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 930
1970-02-07T21:28:57.482Z,3274137.482 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
1970-02-07T21:28:57.578Z,3274137.578 [WetLabsBB2FL](INFO): Powering down
1970-02-07T21:28:57.579Z,3274137.579 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:57.598Z,3274137.598 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
1970-02-07T21:28:57.598Z,3274137.598 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:57.598Z,3274137.598 [CTD_Seabird](INFO): Join timeout helper Thread ID is 932
1970-02-07T21:28:57.701Z,3274137.701 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
1970-02-07T21:28:57.882Z,3274137.882 [CTD_Seabird](INFO): Powering down
1970-02-07T21:28:58.014Z,3274138.014 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
1970-02-07T21:28:58.014Z,3274138.014 [CTD_Seabird](INFO): Powering down
1970-02-07T21:28:58.018Z,3274138.018 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
1970-02-07T21:28:58.018Z,3274138.018 [ThrusterServo](FAULT): Thruster failed to initialize
1970-02-07T21:28:58.018Z,3274138.018 [ThrusterServo] Communications Fault, FailCount= 5
1970-02-07T21:28:58.018Z,3274138.018 [ThrusterServo](ERROR): Communications Fault
1970-02-07T21:28:58.022Z,3274138.022 [CBIT](ERROR): Communications Fault in component: ThrusterServo
1970-02-07T21:28:58.022Z,3274138.022 [CBIT](CRITICAL): Communications Fault in component: ThrusterServo
1970-02-07T21:28:58.025Z,3274138.025 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:58.030Z,3274138.030 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
1970-02-07T21:28:58.030Z,3274138.030 [DAT ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:58.030Z,3274138.030 [DAT](INFO): Join timeout helper Thread ID is 933
1970-02-07T21:28:58.146Z,3274138.146 [RudderServo](FAULT): Overload Error
1970-02-07T21:28:58.146Z,3274138.146 [RudderServo] Hardware Fault, FailCount= 2
1970-02-07T21:28:58.146Z,3274138.146 [RudderServo](ERROR): Hardware Fault
1970-02-07T21:28:58.170Z,3274138.170 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
1970-02-07T21:28:58.170Z,3274138.170 [ThrusterServo](INFO): Powering down
1970-02-07T21:28:58.172Z,3274138.172 [CBIT](INFO): Critical error at 19700207T212858
1970-02-07T21:28:58.175Z,3274138.175 [CBIT](ERROR): Hardware Fault in component: RudderServo
1970-02-07T21:28:58.182Z,3274138.182 [DAT](INFO): Powering down
1970-02-07T21:28:58.254Z,3274138.254 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
1970-02-07T21:28:58.254Z,3274138.254 [DAT](INFO): Powering down
1970-02-07T21:28:58.255Z,3274138.255 [DAT ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:58.273Z,3274138.273 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
1970-02-07T21:28:58.274Z,3274138.274 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:58.274Z,3274138.274 [Radio_Surface](INFO): Join timeout helper Thread ID is 934
1970-02-07T21:28:58.488Z,3274138.488 [RudderServo](DEBUG): Uninitialize Rudder Servo.
1970-02-07T21:28:58.488Z,3274138.488 [RudderServo](INFO): Powering down
1970-02-07T21:28:58.566Z,3274138.566 [Radio_Surface](INFO): Powering down
1970-02-07T21:28:58.567Z,3274138.567 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
1970-02-07T21:28:58.567Z,3274138.567 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:58.575Z,3274138.575 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
1970-02-07T21:28:58.575Z,3274138.575 [Onboard ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:58.575Z,3274138.575 [Onboard](INFO): Join timeout helper Thread ID is 935
1970-02-07T21:28:59.578Z,3274139.578 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
1970-02-07T21:28:59.578Z,3274139.578 [MassServo] Communications Fault, FailCount= 4
1970-02-07T21:28:59.578Z,3274139.578 [MassServo](ERROR): Communications Fault
1970-02-07T21:28:59.578Z,3274139.578 [RudderServo](DEBUG): Initializing EZServoServo.
1970-02-07T21:28:59.706Z,3274139.706 [RudderServo](DEBUG): Initializing RudderServo.
1970-02-07T21:28:59.710Z,3274139.710 [CBIT](ERROR): Communications Fault in component: MassServo
1970-02-07T21:28:59.710Z,3274139.710 [CBIT](INFO): Clearing failed state for component RudderServo
1970-02-07T21:28:59.710Z,3274139.710 [RudderServo] No Fault, FailCount= 2
1970-02-07T21:28:59.792Z,3274139.792 [MassServo](DEBUG): Uninitialize Mass Servo.
1970-02-07T21:28:59.792Z,3274139.792 [MassServo](INFO): Powering down
1970-02-07T21:28:59.803Z,3274139.803 [CBIT](FAULT): Main Battery Failure. Count: 31
1970-02-07T21:28:59.814Z,3274139.814 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
1970-02-07T21:28:59.814Z,3274139.814 [Onboard ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:59.834Z,3274139.834 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
1970-02-07T21:28:59.834Z,3274139.834 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:59.835Z,3274139.835 [DataOverHttps](INFO): Join timeout helper Thread ID is 937
1970-02-07T21:28:59.850Z,3274139.850 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
1970-02-07T21:28:59.850Z,3274139.850 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:59.851Z,3274139.851 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
1970-02-07T21:28:59.851Z,3274139.851 [logger ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:59.852Z,3274139.852 [logger](INFO): Join timeout helper Thread ID is 938
1970-02-07T21:28:59.882Z,3274139.882 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
1970-02-07T21:28:59.882Z,3274139.882 [logger ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:59.886Z,3274139.886 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
1970-02-07T21:28:59.886Z,3274139.886 [CommandLine ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:59.887Z,3274139.887 [CommandLine](INFO): Join timeout helper Thread ID is 939
1970-02-07T21:28:59.982Z,3274139.982 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
1970-02-07T21:28:59.982Z,3274139.982 [CommandLine ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:59.986Z,3274139.986 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
1970-02-07T21:28:59.986Z,3274139.986 [CommandExec ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:59.987Z,3274139.987 [CommandExec](INFO): Join timeout helper Thread ID is 940
1970-02-07T21:28:59.988Z,3274139.988 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
1970-02-07T21:28:59.988Z,3274139.988 [controlThread ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:28:59.988Z,3274139.988 [controlThread](INFO): Join timeout helper Thread ID is 941
1970-02-07T21:29:00.114Z,3274140.114 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
1970-02-07T21:29:00.114Z,3274140.114 [controlThread](DEBUG): Uninitializing ControlThread
1970-02-07T21:29:00.116Z,3274140.116 [NAL9602](INFO): Powering down
1970-02-07T21:29:00.117Z,3274140.117 [PNI_TCM](INFO): Powering down
1970-02-07T21:29:00.330Z,3274140.330 [Aanderaa_O2](INFO): Powering down
1970-02-07T21:29:00.332Z,3274140.332 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
1970-02-07T21:29:00.334Z,3274140.334 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
1970-02-07T21:29:00.334Z,3274140.334 [NavChart](DEBUG): Uninitialize NavChart Navigation.
1970-02-07T21:29:00.335Z,3274140.335 [MissionManager](INFO): Uninitializing Mission Default
1970-02-07T21:29:00.337Z,3274140.337 [MissionManager](INFO): Uninitializing Mission Startup
1970-02-07T21:29:00.339Z,3274140.339 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
1970-02-07T21:29:00.339Z,3274140.339 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
1970-02-07T21:29:00.340Z,3274140.340 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
1970-02-07T21:29:00.340Z,3274140.340 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
1970-02-07T21:29:00.340Z,3274140.340 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
1970-02-07T21:29:00.340Z,3274140.340 [BuoyancyServo](INFO): Powering down
1970-02-07T21:29:00.354Z,3274140.354 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
1970-02-07T21:29:00.354Z,3274140.354 [ElevatorServo](INFO): Powering down
1970-02-07T21:29:00.355Z,3274140.355 [MassServo](DEBUG): Uninitialize Mass Servo.
1970-02-07T21:29:00.355Z,3274140.355 [MassServo](INFO): Powering down
1970-02-07T21:29:00.356Z,3274140.356 [RudderServo](DEBUG): Uninitialize Rudder Servo.
1970-02-07T21:29:00.356Z,3274140.356 [RudderServo](INFO): Powering down
1970-02-07T21:29:00.357Z,3274140.357 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
1970-02-07T21:29:00.357Z,3274140.357 [ThrusterServo](INFO): Powering down
1970-02-07T21:29:00.358Z,3274140.358 [SBIT](DEBUG): Uninitialize SBIT Component.
1970-02-07T21:29:00.358Z,3274140.358 [IBIT](DEBUG): Uninitialize IBIT Component.
1970-02-07T21:29:00.358Z,3274140.358 [CBIT](DEBUG): Uninitialize CBIT Component.
1970-02-07T21:29:00.358Z,3274140.358 [CBIT](DEBUG): Powering off loads.
1970-02-07T21:29:00.369Z,3274140.369 [CBIT](DEBUG): Disabling WDT.
1970-02-07T21:29:00.381Z,3274140.381 [CBIT](DEBUG): Opening all GF detection circuits.
1970-02-07T21:29:00.382Z,3274140.382 [controlThread ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:29:00.392Z,3274140.392 [DAT ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:29:00.397Z,3274140.397 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:29:00.401Z,3274140.401 [Onboard ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:29:00.406Z,3274140.406 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:29:00.538Z,3274140.538 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:29:00.544Z,3274140.544 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:29:00.920Z,3274140.920 [NavChartDb ThreadHandler](INFO): Thread cancelled.
1970-02-07T21:29:00.965Z,3274140.965 [logger ThreadHandler](INFO): Thread cancelled.