2000-02-07T06:34:44.756Z,949905284.756 [Supervisor](DEBUG): Initializing supervisor.
2000-02-07T06:34:44.760Z,949905284.760 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2000-02-07T06:34:44.761Z,949905284.761 [SyncHandler](INFO): Protected caller Thread ID is 831
2000-02-07T06:34:44.761Z,949905284.761 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2000-02-07T06:34:44.762Z,949905284.762 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2000-02-07T06:34:44.762Z,949905284.762 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 832
2000-02-07T06:34:44.766Z,949905284.766 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2000-02-07T06:34:44.783Z,949905284.783 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2000-02-07T06:34:44.784Z,949905284.784 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2000-02-07T06:34:44.785Z,949905284.785 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 833
2000-02-07T06:34:44.789Z,949905284.789 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2000-02-07T06:34:44.790Z,949905284.790 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2000-02-07T06:34:44.790Z,949905284.790 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 834
2000-02-07T06:34:44.792Z,949905284.792 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2000-02-07T06:34:44.793Z,949905284.793 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2000-02-07T06:34:44.794Z,949905284.794 [logger ThreadHandler](INFO): Protected caller Thread ID is 835
2000-02-07T06:34:44.797Z,949905284.797 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2000-02-07T06:34:44.797Z,949905284.797 [Supervisor](INFO): Looking for Config files in directory: Config/
2000-02-07T06:34:44.801Z,949905284.801 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2000-02-07T06:34:45.186Z,949905285.186 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2000-02-07T06:34:45.187Z,949905285.187 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2000-02-07T06:34:45.973Z,949905285.973 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2000-02-07T06:34:45.974Z,949905285.974 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2000-02-07T06:34:46.094Z,949905286.094 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2000-02-07T06:34:46.095Z,949905286.095 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2000-02-07T06:34:46.684Z,949905286.684 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2000-02-07T06:34:46.685Z,949905286.685 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2000-02-07T06:34:46.793Z,949905286.793 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2000-02-07T06:34:46.794Z,949905286.794 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2000-02-07T06:34:46.888Z,949905286.888 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2000-02-07T06:34:47.347Z,949905287.347 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2000-02-07T06:34:47.347Z,949905287.347 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2000-02-07T06:34:47.590Z,949905287.590 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2000-02-07T06:34:47.591Z,949905287.591 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2000-02-07T06:34:47.743Z,949905287.743 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2000-02-07T06:34:47.744Z,949905287.744 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2000-02-07T06:34:48.021Z,949905288.021 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2000-02-07T06:34:48.022Z,949905288.022 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2000-02-07T06:34:48.832Z,949905288.832 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2000-02-07T06:34:48.832Z,949905288.832 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2000-02-07T06:34:49.237Z,949905289.237 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2000-02-07T06:34:49.238Z,949905289.238 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2000-02-07T06:34:49.330Z,949905289.330 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2000-02-07T06:34:49.544Z,949905289.544 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2000-02-07T06:34:49.544Z,949905289.544 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2000-02-07T06:34:49.793Z,949905289.793 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2000-02-07T06:34:49.794Z,949905289.794 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2000-02-07T06:34:50.111Z,949905290.111 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2000-02-07T06:34:50.113Z,949905290.113 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/
2000-02-07T06:34:50.115Z,949905290.115 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg
2000-02-07T06:34:50.235Z,949905290.235 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg
2000-02-07T06:34:50.400Z,949905290.400 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg
2000-02-07T06:34:50.498Z,949905290.498 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg
2000-02-07T06:34:50.593Z,949905290.593 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg
2000-02-07T06:34:50.729Z,949905290.729 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/workSite.cfg
2000-02-07T06:34:50.825Z,949905290.825 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg
2000-02-07T06:34:50.943Z,949905290.943 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg
2000-02-07T06:34:51.216Z,949905291.216 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2000-02-07T06:34:51.217Z,949905291.217 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg
2000-02-07T06:34:51.364Z,949905291.364 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg
2000-02-07T06:34:51.470Z,949905291.470 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg
2000-02-07T06:34:51.578Z,949905291.578 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg
2000-02-07T06:34:51.686Z,949905291.686 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2000-02-07T06:34:51.709Z,949905291.709 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2000-02-07T06:34:51.850Z,949905291.850 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2000-02-07T06:34:51.850Z,949905291.850 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2000-02-07T06:34:51.866Z,949905291.866 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2000-02-07T06:34:51.867Z,949905291.867 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2000-02-07T06:34:51.937Z,949905291.937 [DepthRateCalculator] Loaded
2000-02-07T06:34:51.937Z,949905291.937 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2000-02-07T06:34:51.942Z,949905291.942 [PitchRateCalculator] Loaded
2000-02-07T06:34:51.943Z,949905291.943 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2000-02-07T06:34:51.953Z,949905291.953 [SpeedCalculator] Loaded
2000-02-07T06:34:51.953Z,949905291.953 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2000-02-07T06:34:51.958Z,949905291.958 [YawRateCalculator] Loaded
2000-02-07T06:34:51.958Z,949905291.958 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2000-02-07T06:34:51.979Z,949905291.979 [ElevatorOffsetCalculator] Loaded
2000-02-07T06:34:51.980Z,949905291.980 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2000-02-07T06:34:51.980Z,949905291.980 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2000-02-07T06:34:51.981Z,949905291.981 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2000-02-07T06:34:52.050Z,949905292.050 [VerticalControl](DEBUG): Construct VerticalControl.
2000-02-07T06:34:52.105Z,949905292.105 [VerticalControl] Loaded
2000-02-07T06:34:52.105Z,949905292.105 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2000-02-07T06:34:52.108Z,949905292.108 [HorizontalControl](DEBUG): Construct HorizontalControl.
2000-02-07T06:34:52.154Z,949905292.154 [HorizontalControl] Loaded
2000-02-07T06:34:52.154Z,949905292.154 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2000-02-07T06:34:52.156Z,949905292.156 [SpeedControl](DEBUG): Construct SpeedControl.
2000-02-07T06:34:52.159Z,949905292.159 [SpeedControl] Loaded
2000-02-07T06:34:52.159Z,949905292.159 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2000-02-07T06:34:52.162Z,949905292.162 [LoopControl](DEBUG): Construct LoopControl.
2000-02-07T06:34:52.162Z,949905292.162 [LoopControl] Loaded
2000-02-07T06:34:52.162Z,949905292.162 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2000-02-07T06:34:52.163Z,949905292.163 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2000-02-07T06:34:52.163Z,949905292.163 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2000-02-07T06:34:52.300Z,949905292.300 [DeadReckonUsingMultipleVelocitySources] Loaded
2000-02-07T06:34:52.301Z,949905292.301 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2000-02-07T06:34:52.314Z,949905292.314 [NavChart] Loaded
2000-02-07T06:34:52.314Z,949905292.314 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2000-02-07T06:34:52.320Z,949905292.320 [UniversalFixResidualReporter] Loaded
2000-02-07T06:34:52.320Z,949905292.320 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2000-02-07T06:34:52.321Z,949905292.321 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2000-02-07T06:34:52.321Z,949905292.321 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2000-02-07T06:34:52.533Z,949905292.533 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2000-02-07T06:34:52.534Z,949905292.534 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2000-02-07T06:34:53.351Z,949905293.351 [AHRS_M2] Loaded
2000-02-07T06:34:53.351Z,949905293.351 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2000-02-07T06:34:53.604Z,949905293.604 [BackseatComponent] Loaded
2000-02-07T06:34:53.605Z,949905293.605 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2000-02-07T06:34:53.606Z,949905293.606 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409384E0
2000-02-07T06:34:53.606Z,949905293.606 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 920
2000-02-07T06:34:53.609Z,949905293.609 [LcmUniversalReporter] Loaded
2000-02-07T06:34:53.609Z,949905293.609 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2000-02-07T06:34:54.639Z,949905294.639 [BPC1] Loaded
2000-02-07T06:34:54.640Z,949905294.640 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2000-02-07T06:34:54.725Z,949905294.725 [DATMMP] Loaded
2000-02-07T06:34:54.725Z,949905294.725 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread.
2000-02-07T06:34:54.726Z,949905294.726 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 409694E0
2000-02-07T06:34:54.727Z,949905294.727 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 921
2000-02-07T06:34:54.865Z,949905294.865 [DataOverHttps] Loaded
2000-02-07T06:34:54.865Z,949905294.865 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2000-02-07T06:34:54.866Z,949905294.866 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409994E0
2000-02-07T06:34:54.867Z,949905294.867 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 922
2000-02-07T06:34:54.889Z,949905294.889 [Depth_Keller] Loaded
2000-02-07T06:34:54.890Z,949905294.890 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2000-02-07T06:34:54.929Z,949905294.929 [DVL_micro] Loaded
2000-02-07T06:34:54.930Z,949905294.930 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2000-02-07T06:34:54.993Z,949905294.993 [NAL9602] Loaded
2000-02-07T06:34:54.993Z,949905294.993 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2000-02-07T06:34:55.022Z,949905295.022 [Onboard] Loaded
2000-02-07T06:34:55.022Z,949905295.022 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2000-02-07T06:34:55.023Z,949905295.023 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409C94E0
2000-02-07T06:34:55.024Z,949905295.024 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 923
2000-02-07T06:34:55.037Z,949905295.037 [Power24vConverter] Loaded
2000-02-07T06:34:55.038Z,949905295.038 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2000-02-07T06:34:55.053Z,949905295.053 [Radio_Surface] Loaded
2000-02-07T06:34:55.053Z,949905295.053 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2000-02-07T06:34:55.054Z,949905295.054 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409F94E0
2000-02-07T06:34:55.054Z,949905295.054 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 924
2000-02-07T06:34:55.069Z,949905295.069 [Sonardyne_Nano] Loaded
2000-02-07T06:34:55.070Z,949905295.070 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2000-02-07T06:34:55.070Z,949905295.070 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2000-02-07T06:34:55.071Z,949905295.071 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2000-02-07T06:34:55.234Z,949905295.234 [BuoyancyServo] Loaded
2000-02-07T06:34:55.234Z,949905295.234 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2000-02-07T06:34:55.257Z,949905295.257 [ElevatorServo] Loaded
2000-02-07T06:34:55.257Z,949905295.257 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2000-02-07T06:34:55.286Z,949905295.286 [DockingStepper] Loaded
2000-02-07T06:34:55.286Z,949905295.286 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread.
2000-02-07T06:34:55.307Z,949905295.307 [MassServo] Loaded
2000-02-07T06:34:55.308Z,949905295.308 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2000-02-07T06:34:55.328Z,949905295.328 [RudderServo] Loaded
2000-02-07T06:34:55.328Z,949905295.328 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2000-02-07T06:34:55.345Z,949905295.345 [ThrusterHE] Loaded
2000-02-07T06:34:55.346Z,949905295.346 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2000-02-07T06:34:55.346Z,949905295.346 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2000-02-07T06:34:55.347Z,949905295.347 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2000-02-07T06:34:55.446Z,949905295.446 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2000-02-07T06:34:55.447Z,949905295.447 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2000-02-07T06:34:55.490Z,949905295.490 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2000-02-07T06:34:55.490Z,949905295.490 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2000-02-07T06:34:55.887Z,949905295.887 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2000-02-07T06:34:55.888Z,949905295.888 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2000-02-07T06:34:56.111Z,949905296.111 [CTD_Seabird] Loaded
2000-02-07T06:34:56.112Z,949905296.112 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2000-02-07T06:34:56.113Z,949905296.113 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BB34E0
2000-02-07T06:34:56.113Z,949905296.113 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 925
2000-02-07T06:34:56.149Z,949905296.149 [ESPComponent] Loaded
2000-02-07T06:34:56.149Z,949905296.149 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2000-02-07T06:34:56.171Z,949905296.171 [PAR_Licor] Loaded
2000-02-07T06:34:56.171Z,949905296.171 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2000-02-07T06:34:56.215Z,949905296.215 [WetLabsBB2FL] Loaded
2000-02-07T06:34:56.216Z,949905296.216 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2000-02-07T06:34:56.217Z,949905296.217 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BE34E0
2000-02-07T06:34:56.217Z,949905296.217 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 926
2000-02-07T06:34:56.218Z,949905296.218 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2000-02-07T06:34:56.218Z,949905296.218 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2000-02-07T06:34:56.387Z,949905296.387 [SBIT](DEBUG): Construct Startup Built In Test.
2000-02-07T06:34:56.396Z,949905296.396 [SBIT] Loaded
2000-02-07T06:34:56.396Z,949905296.396 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2000-02-07T06:34:56.399Z,949905296.399 [IBIT](DEBUG): Construct Initiated Built In Test.
2000-02-07T06:34:56.411Z,949905296.411 [IBIT] Loaded
2000-02-07T06:34:56.412Z,949905296.412 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2000-02-07T06:34:56.418Z,949905296.418 [CBIT](DEBUG): Construct Continuous Built In Test.
2000-02-07T06:34:56.522Z,949905296.522 [CBIT] Loaded
2000-02-07T06:34:56.522Z,949905296.522 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2000-02-07T06:34:56.523Z,949905296.523 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2000-02-07T06:34:56.529Z,949905296.529 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2000-02-07T06:34:56.532Z,949905296.532 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2000-02-07T06:34:56.543Z,949905296.543 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2000-02-07T06:34:56.544Z,949905296.544 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C524E0
2000-02-07T06:34:56.544Z,949905296.544 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 927
2000-02-07T06:34:56.549Z,949905296.549 [Supervisor](INFO): Main Thread ID is 824
2000-02-07T06:34:56.549Z,949905296.549 [Supervisor](DEBUG): Running supervisor.
2000-02-07T06:34:56.549Z,949905296.549 [CommandExec ThreadHandler](INFO): Handler Thread ID is 928
2000-02-07T06:34:56.550Z,949905296.550 [CommandExec](INFO): Initializing the command executive.
2000-02-07T06:34:56.551Z,949905296.551 [CommandLine ThreadHandler](INFO): Handler Thread ID is 929
2000-02-07T06:34:56.553Z,949905296.553 [controlThread ThreadHandler](INFO): Handler Thread ID is 930
2000-02-07T06:34:56.554Z,949905296.554 [controlThread](DEBUG): Initializing ControlThread
2000-02-07T06:34:56.555Z,949905296.555 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2000-02-07T06:34:56.555Z,949905296.555 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2000-02-07T06:34:56.555Z,949905296.555 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2000-02-07T06:34:56.556Z,949905296.556 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2000-02-07T06:34:56.556Z,949905296.556 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2000-02-07T06:34:56.557Z,949905296.557 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2000-02-07T06:34:56.558Z,949905296.558 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2000-02-07T06:34:56.559Z,949905296.559 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2000-02-07T06:34:56.559Z,949905296.559 [LoopControl](DEBUG): Initialize LoopControlComponent.
2000-02-07T06:34:56.560Z,949905296.560 [NavChart](DEBUG): Initialize NavChart Navigation.
2000-02-07T06:34:56.561Z,949905296.561 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2000-02-07T06:34:56.568Z,949905296.568 [SBIT](INFO): Initialize SBIT Component.
2000-02-07T06:34:56.569Z,949905296.569 [SBIT](IMPORTANT): git: 2024-09-17
2000-02-07T06:34:56.569Z,949905296.569 [SBIT](INFO): git hash: 40e9ce87bff78b617219447905233bfcf6062b37
2000-02-07T06:34:56.569Z,949905296.569 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2000-02-07T06:34:56.570Z,949905296.570 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Sep 24 11:12:27 PDT 2019
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2000-02-07T06:34:56.571Z,949905296.571 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2000-02-07T06:34:56.572Z,949905296.572 [IBIT](INFO): Initialize IBIT Component.
2000-02-07T06:34:56.573Z,949905296.573 [CBIT](DEBUG): Initialize CBIT Component.
2000-02-07T06:34:56.574Z,949905296.574 [logger ThreadHandler](INFO): Handler Thread ID is 931
2000-02-07T06:34:56.584Z,949905296.584 [CBIT](DEBUG): Initialized mux pins.
2000-02-07T06:34:56.584Z,949905296.584 [CBIT](DEBUG): Initializing the watchdog timer.
2000-02-07T06:34:56.593Z,949905296.593 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 932
2000-02-07T06:34:56.605Z,949905296.605 [DATMMP ThreadHandler](INFO): Handler Thread ID is 933
2000-02-07T06:34:56.605Z,949905296.605 [DATMMP](INFO): Start
2000-02-07T06:34:56.605Z,949905296.605 [DATMMP](INFO): Powering up
2000-02-07T06:34:56.606Z,949905296.606 [DATMMP](DEBUG): Initializing DATMMP.
2000-02-07T06:34:56.608Z,949905296.608 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2000-02-07T06:34:56.609Z,949905296.609 [CBIT](DEBUG): Initializing heartbeat.
2000-02-07T06:34:56.610Z,949905296.610 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 935
2000-02-07T06:34:56.612Z,949905296.612 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2000-02-07T06:34:56.621Z,949905296.621 [Onboard ThreadHandler](INFO): Handler Thread ID is 936
2000-02-07T06:34:56.638Z,949905296.638 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 937
2000-02-07T06:34:56.653Z,949905296.653 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 938
2000-02-07T06:34:56.654Z,949905296.654 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2000-02-07T06:34:56.657Z,949905296.657 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 940
2000-02-07T06:34:56.661Z,949905296.661 [WetLabsBB2FL](INFO): Powering up
2000-02-07T06:34:56.662Z,949905296.662 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 942
2000-02-07T06:34:56.669Z,949905296.669 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2000-02-07T06:34:56.669Z,949905296.669 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2000-02-07T06:34:56.670Z,949905296.670 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2000-02-07T06:34:56.670Z,949905296.670 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2000-02-07T06:34:56.670Z,949905296.670 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2000-02-07T06:34:56.670Z,949905296.670 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2000-02-07T06:34:56.670Z,949905296.670 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2000-02-07T06:34:56.670Z,949905296.670 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2000-02-07T06:34:56.681Z,949905296.681 [CBIT](DEBUG): Deactivating GF circuits.
2000-02-07T06:34:56.681Z,949905296.681 [CBIT](DEBUG): Deactivating emergency mode.
2000-02-07T06:34:56.720Z,949905296.720 [CBIT](DEBUG): Backplane powered.
2000-02-07T06:34:56.721Z,949905296.721 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2000-02-07T06:34:56.722Z,949905296.722 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2000-02-07T06:34:56.722Z,949905296.722 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2000-02-07T06:34:56.727Z,949905296.727 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2000-02-07T06:34:56.782Z,949905296.782 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2000-02-07T06:34:56.810Z,949905296.810 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2000-02-07T06:34:56.830Z,949905296.830 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Startup {
behavior Guidance:GoToSurface {
run in progression
}
aggregate StartupSatComms {
run in sequence
readDatum {
timeout duration=P1M
Universal:latitude_fix
}
readDatum {
timeout duration=P1M
Universal:platform_communications
}
}
}
2000-02-07T06:34:56.831Z,949905296.831 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2000-02-07T06:34:56.831Z,949905296.831 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2000-02-07T06:34:56.849Z,949905296.849 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2000-02-07T06:34:56.856Z,949905296.856 [DATMMP](INFO): Starting
2000-02-07T06:34:57.044Z,949905297.044 [Radio_Surface](INFO): Powering up
2000-02-07T06:34:57.108Z,949905297.108 [DATMMP](INFO): Starting
2000-02-07T06:34:57.151Z,949905297.151 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
0
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2000-02-07T06:34:57.165Z,949905297.165 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2000-02-07T06:34:57.166Z,949905297.166 [Default:A.Wait](DEBUG): Construct Wait.
2000-02-07T06:34:57.181Z,949905297.181 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2000-02-07T06:34:57.217Z,949905297.217 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2000-02-07T06:34:57.220Z,949905297.220 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2000-02-07T06:34:57.242Z,949905297.242 [Default:E.Execute](DEBUG): Construct Execute.
2000-02-07T06:34:57.253Z,949905297.253 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Default {
arguments {
ElapsedSinceDefaultStarted = 0 minute
}
behavior Guidance:Wait {
"""
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
"""
run in sequence
set duration = 13 second
}
behavior Guidance:GoToSurface {
run in progression
}
aggregate CheckIn {
run in sequence repeat=288
readDatum id="Read_GPS" {
timeout duration=P5M
Universal:time_fix
}
readDatum id="Read_Iridium" {
timeout duration=P4H {
behavior Guidance:Execute {
run in sequence
set command = "Burn on"
}
syslog critical "Dropped weight due to communications timeout."
}
Universal:platform_communications
}
behavior Guidance:Wait {
run in sequence
set duration = 5 minute
}
assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started )
syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute
}
syslog important "Restarting logs and Default mission."
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
}
2000-02-07T06:34:57.257Z,949905297.257 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2000-02-07T06:34:57.268Z,949905297.268 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2000-02-07T06:34:57.360Z,949905297.360 [DATMMP](INFO): Starting
2000-02-07T06:34:57.418Z,949905297.418 [Depth_Keller](ERROR): Pressure or depth reading out of range: 916.499573 decibar, 0.000000 m
2000-02-07T06:34:57.421Z,949905297.421 [Power24vConverter](INFO): Powering up.
2000-02-07T06:34:57.422Z,949905297.422 [Sonardyne_Nano](INFO): Initializing.
2000-02-07T06:34:57.469Z,949905297.469 [DepthRateCalculator](ERROR): Depth measurement is not active
2000-02-07T06:34:57.494Z,949905297.494 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2000-02-07T06:34:57.500Z,949905297.500 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2000-02-07T06:34:57.501Z,949905297.501 [ElevatorServo](DEBUG): Initializing EZServoServo.
2000-02-07T06:34:57.508Z,949905297.508 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2000-02-07T06:34:57.509Z,949905297.509 [DockingStepper](INFO): Start
2000-02-07T06:34:57.509Z,949905297.509 [DockingStepper](DEBUG): Initializing EZServoServo.
2000-02-07T06:34:57.516Z,949905297.516 [DockingStepper](DEBUG): Initializing DockingStepper.
2000-02-07T06:34:57.517Z,949905297.517 [MassServo](DEBUG): Initializing EZServoServo.
2000-02-07T06:34:57.524Z,949905297.524 [MassServo](DEBUG): Initializing MassServo.
2000-02-07T06:34:57.525Z,949905297.525 [RudderServo](DEBUG): Initializing EZServoServo.
2000-02-07T06:34:57.532Z,949905297.532 [RudderServo](DEBUG): Initializing RudderServo.
2000-02-07T06:34:57.533Z,949905297.533 [ThrusterHE](DEBUG): Initializing EZServoServo.
2000-02-07T06:34:57.540Z,949905297.540 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2000-02-07T06:34:57.613Z,949905297.613 [DATMMP](INFO): Starting
2000-02-07T06:34:57.733Z,949905297.733 [DockingStepper](INFO): Starting
2000-02-07T06:34:57.864Z,949905297.864 [DATMMP](INFO): Starting
2000-02-07T06:34:58.092Z,949905298.092 [DockingStepper](INFO): Starting
2000-02-07T06:34:58.116Z,949905298.116 [DATMMP](INFO): Starting
2000-02-07T06:34:58.368Z,949905298.368 [DATMMP](INFO): Starting
2000-02-07T06:34:58.616Z,949905298.616 [DockingStepper](INFO): Starting
2000-02-07T06:34:58.621Z,949905298.621 [DATMMP](INFO): Starting
2000-02-07T06:34:58.872Z,949905298.872 [DATMMP](INFO): Starting
2000-02-07T06:34:58.928Z,949905298.928 [DockingStepper](ERROR): getADC uart error serial timeout
2000-02-07T06:34:58.928Z,949905298.928 [DockingStepper](FAULT): No valid ADC reading. Arm out of allowable range:-1 counts.
2000-02-07T06:34:58.929Z,949905298.929 [DockingStepper] Hardware Fault, FailCount= 1
2000-02-07T06:34:58.929Z,949905298.929 [DockingStepper](ERROR): Hardware Fault
2000-02-07T06:34:58.984Z,949905298.984 [CBIT](ERROR): Hardware Fault in component: DockingStepper
2000-02-07T06:34:59.029Z,949905299.029 [DockingStepper](INFO): Stop
2000-02-07T06:34:59.029Z,949905299.029 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2000-02-07T06:34:59.029Z,949905299.029 [DockingStepper](INFO): Powering down
2000-02-07T06:34:59.124Z,949905299.124 [DATMMP](INFO): Starting
2000-02-07T06:34:59.376Z,949905299.376 [DATMMP](INFO): Starting
2000-02-07T06:34:59.424Z,949905299.424 [DockingStepper](INFO): Stopping
2000-02-07T06:34:59.628Z,949905299.628 [DATMMP](INFO): Starting
2000-02-07T06:34:59.852Z,949905299.852 [DockingStepper](INFO): Stopped
2000-02-07T06:34:59.875Z,949905299.875 [CBIT](INFO): Clearing failed state for component DockingStepper
2000-02-07T06:34:59.875Z,949905299.875 [DockingStepper] No Fault, FailCount= 1
2000-02-07T06:34:59.880Z,949905299.880 [DATMMP](INFO): Starting
2000-02-07T06:35:00.132Z,949905300.132 [DATMMP](INFO): Starting
2000-02-07T06:35:00.300Z,949905300.300 [DockingStepper](INFO): Start
2000-02-07T06:35:00.301Z,949905300.301 [DockingStepper](DEBUG): Initializing EZServoServo.
2000-02-07T06:35:00.384Z,949905300.384 [DATMMP](INFO): Starting
2000-02-07T06:35:00.464Z,949905300.464 [DockingStepper](DEBUG): Initializing DockingStepper.
2000-02-07T06:35:00.638Z,949905300.638 [DATMMP](INFO): Starting
2000-02-07T06:35:00.737Z,949905300.737 [DockingStepper](INFO): Starting
2000-02-07T06:35:00.888Z,949905300.888 [DATMMP](INFO): Starting
2000-02-07T06:35:01.082Z,949905301.082 [DockingStepper](INFO): Starting
2000-02-07T06:35:01.140Z,949905301.140 [DATMMP](INFO): Starting
2000-02-07T06:35:01.392Z,949905301.392 [DATMMP](INFO): Starting
2000-02-07T06:35:01.480Z,949905301.480 [DockingStepper](INFO): Starting
2000-02-07T06:35:01.645Z,949905301.645 [DATMMP](INFO): Starting
2000-02-07T06:35:01.792Z,949905301.792 [DockingStepper](ERROR): getADC uart error serial timeout
2000-02-07T06:35:01.792Z,949905301.792 [DockingStepper](FAULT): No valid ADC reading. Arm out of allowable range:-1 counts.
2000-02-07T06:35:01.792Z,949905301.792 [DockingStepper] Hardware Fault, FailCount= 2
2000-02-07T06:35:01.792Z,949905301.792 [DockingStepper](ERROR): Hardware Fault
2000-02-07T06:35:01.869Z,949905301.869 [CBIT](ERROR): Hardware Fault in component: DockingStepper
2000-02-07T06:35:01.897Z,949905301.897 [DATMMP](INFO): Starting
2000-02-07T06:35:01.953Z,949905301.953 [WetLabsBB2FL] Communications Fault, FailCount= 1
2000-02-07T06:35:01.953Z,949905301.953 [WetLabsBB2FL](ERROR): Communications Fault
2000-02-07T06:35:02.073Z,949905302.073 [DockingStepper](INFO): Stop
2000-02-07T06:35:02.073Z,949905302.073 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2000-02-07T06:35:02.073Z,949905302.073 [DockingStepper](INFO): Powering down
2000-02-07T06:35:02.130Z,949905302.130 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2000-02-07T06:35:02.148Z,949905302.148 [DATMMP](INFO): Starting
2000-02-07T06:35:02.376Z,949905302.376 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:02.400Z,949905302.400 [DATMMP](INFO): Starting
2000-02-07T06:35:02.425Z,949905302.425 [DockingStepper](INFO): Stopping
2000-02-07T06:35:02.453Z,949905302.453 [WetLabsBB2FL](INFO): Powering down
2000-02-07T06:35:02.652Z,949905302.652 [DATMMP](INFO): Starting
2000-02-07T06:35:02.792Z,949905302.792 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:02.829Z,949905302.829 [DockingStepper](INFO): Stopped
2000-02-07T06:35:02.905Z,949905302.905 [DATMMP](INFO): Starting
2000-02-07T06:35:02.933Z,949905302.933 [ThrusterHE](ERROR): Zero Speed Commanded.
2000-02-07T06:35:02.996Z,949905302.996 [CBIT](INFO): Clearing failed state for component DockingStepper
2000-02-07T06:35:02.996Z,949905302.996 [DockingStepper] No Fault, FailCount= 2
2000-02-07T06:35:03.156Z,949905303.156 [DATMMP](INFO): Starting
2000-02-07T06:35:03.184Z,949905303.184 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:03.237Z,949905303.237 [DockingStepper](INFO): Start
2000-02-07T06:35:03.237Z,949905303.237 [DockingStepper](DEBUG): Initializing EZServoServo.
2000-02-07T06:35:03.357Z,949905303.357 [DockingStepper](DEBUG): Initializing DockingStepper.
2000-02-07T06:35:03.408Z,949905303.408 [DATMMP](INFO): Starting
2000-02-07T06:35:03.660Z,949905303.660 [DATMMP](INFO): Starting
2000-02-07T06:35:03.720Z,949905303.720 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2000-02-07T06:35:03.720Z,949905303.720 [WetLabsBB2FL] No Fault, FailCount= 1
2000-02-07T06:35:03.912Z,949905303.912 [DATMMP](INFO): Starting
2000-02-07T06:35:04.040Z,949905304.040 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:04.081Z,949905304.081 [WetLabsBB2FL](INFO): Powering up
2000-02-07T06:35:04.117Z,949905304.117 [DockingStepper](INFO): Starting
2000-02-07T06:35:04.164Z,949905304.164 [DATMMP](INFO): Starting
2000-02-07T06:35:04.416Z,949905304.416 [DATMMP](INFO): Starting
2000-02-07T06:35:04.460Z,949905304.460 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:04.537Z,949905304.537 [DockingStepper](INFO): Starting
2000-02-07T06:35:04.668Z,949905304.668 [DATMMP](INFO): Starting
2000-02-07T06:35:04.840Z,949905304.840 [DockingStepper](ERROR): getADC uart error serial timeout
2000-02-07T06:35:04.840Z,949905304.840 [DockingStepper](FAULT): No valid ADC reading. Arm out of allowable range:-1 counts.
2000-02-07T06:35:04.840Z,949905304.840 [DockingStepper] Hardware Fault, FailCount= 3
2000-02-07T06:35:04.840Z,949905304.840 [DockingStepper](ERROR): Hardware Fault
2000-02-07T06:35:04.845Z,949905304.845 [CBIT](ERROR): Hardware Fault in component: DockingStepper
2000-02-07T06:35:04.920Z,949905304.920 [DATMMP](INFO): Starting
2000-02-07T06:35:05.165Z,949905305.165 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:05.174Z,949905305.174 [DATMMP](INFO): Starting
2000-02-07T06:35:05.254Z,949905305.254 [DockingStepper](INFO): Stop
2000-02-07T06:35:05.254Z,949905305.254 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2000-02-07T06:35:05.254Z,949905305.254 [DockingStepper](INFO): Powering down
2000-02-07T06:35:05.424Z,949905305.424 [DATMMP](INFO): Starting
2000-02-07T06:35:05.592Z,949905305.592 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:05.658Z,949905305.658 [DockingStepper](INFO): Stopping
2000-02-07T06:35:05.676Z,949905305.676 [DATMMP](INFO): Starting
2000-02-07T06:35:05.928Z,949905305.928 [DATMMP](INFO): Starting
2000-02-07T06:35:06.008Z,949905306.008 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:06.089Z,949905306.089 [DockingStepper](INFO): Stopped
2000-02-07T06:35:06.094Z,949905306.094 [CBIT](INFO): Clearing failed state for component DockingStepper
2000-02-07T06:35:06.094Z,949905306.094 [DockingStepper] No Fault, FailCount= 3
2000-02-07T06:35:06.180Z,949905306.180 [DATMMP](INFO): Starting
2000-02-07T06:35:06.432Z,949905306.432 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:06.436Z,949905306.436 [DATMMP](INFO): Starting
2000-02-07T06:35:06.489Z,949905306.489 [DockingStepper](INFO): Start
2000-02-07T06:35:06.490Z,949905306.490 [DockingStepper](DEBUG): Initializing EZServoServo.
2000-02-07T06:35:06.609Z,949905306.609 [DockingStepper](DEBUG): Initializing DockingStepper.
2000-02-07T06:35:06.614Z,949905306.614 [CBIT](CRITICAL): Environmental Failure. Press:14.752082 PSI. Humidity:40%. Temp:26 C. ABORTING MISSION
2000-02-07T06:35:06.614Z,949905306.614 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals
2000-02-07T06:35:06.688Z,949905306.688 [DATMMP](INFO): Starting
2000-02-07T06:35:06.940Z,949905306.940 [DATMMP](INFO): Starting
2000-02-07T06:35:06.941Z,949905306.941 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:07.002Z,949905307.002 [DockingStepper](INFO): Starting
2000-02-07T06:35:07.004Z,949905307.004 [CommandExec](FAULT): Scheduling is paused
2000-02-07T06:35:07.004Z,949905307.004 [CBIT](INFO): Critical error at 20000207T063506
2000-02-07T06:35:07.192Z,949905307.192 [DATMMP](INFO): Starting
2000-02-07T06:35:07.348Z,949905307.348 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:07.417Z,949905307.417 [DockingStepper](INFO): Starting
2000-02-07T06:35:07.444Z,949905307.444 [DATMMP](INFO): Starting
2000-02-07T06:35:07.696Z,949905307.696 [DATMMP](INFO): Starting
2000-02-07T06:35:07.768Z,949905307.768 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:07.825Z,949905307.825 [DockingStepper](INFO): Starting
2000-02-07T06:35:07.948Z,949905307.948 [DATMMP](INFO): Starting
2000-02-07T06:35:08.136Z,949905308.136 [DockingStepper](ERROR): getADC uart error serial timeout
2000-02-07T06:35:08.136Z,949905308.136 [DockingStepper](FAULT): No valid ADC reading. Arm out of allowable range:-1 counts.
2000-02-07T06:35:08.136Z,949905308.136 [DockingStepper] Hardware Fault, FailCount= 4
2000-02-07T06:35:08.136Z,949905308.136 [DockingStepper](ERROR): Hardware Fault
2000-02-07T06:35:08.141Z,949905308.141 [CBIT](ERROR): Hardware Fault in component: DockingStepper
2000-02-07T06:35:08.200Z,949905308.200 [DATMMP](INFO): Starting
2000-02-07T06:35:08.452Z,949905308.452 [DATMMP](INFO): Starting
2000-02-07T06:35:08.472Z,949905308.472 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:08.537Z,949905308.537 [DockingStepper](INFO): Stop
2000-02-07T06:35:08.538Z,949905308.538 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2000-02-07T06:35:08.538Z,949905308.538 [DockingStepper](INFO): Powering down
2000-02-07T06:35:08.704Z,949905308.704 [DATMMP](INFO): Starting
2000-02-07T06:35:08.705Z,949905308.705 [DATMMP](INFO): DAT read:
2000-02-07T06:35:08.706Z,949905308.706 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series
2000-02-07T06:35:08.864Z,949905308.864 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:08.942Z,949905308.942 [DockingStepper](INFO): Stopping
2000-02-07T06:35:08.956Z,949905308.956 [DATMMP](INFO): Starting
2000-02-07T06:35:09.208Z,949905309.208 [DATMMP](INFO): Starting
2000-02-07T06:35:09.292Z,949905309.292 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:09.360Z,949905309.360 [WetLabsBB2FL] Communications Fault, FailCount= 2
2000-02-07T06:35:09.360Z,949905309.360 [WetLabsBB2FL](ERROR): Communications Fault
2000-02-07T06:35:09.381Z,949905309.381 [DockingStepper](INFO): Stopped
2000-02-07T06:35:09.385Z,949905309.385 [CBIT](INFO): Clearing failed state for component DockingStepper
2000-02-07T06:35:09.386Z,949905309.386 [DockingStepper] No Fault, FailCount= 4
2000-02-07T06:35:09.386Z,949905309.386 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2000-02-07T06:35:09.460Z,949905309.460 [DATMMP](INFO): Starting
2000-02-07T06:35:09.704Z,949905309.704 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2000-02-07T06:35:09.704Z,949905309.704 [CTD_Seabird] Communications Fault, FailCount= 1
2000-02-07T06:35:09.704Z,949905309.704 [CTD_Seabird](ERROR): Communications Fault
2000-02-07T06:35:09.712Z,949905309.712 [DATMMP](INFO): Starting
2000-02-07T06:35:09.732Z,949905309.732 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:09.809Z,949905309.809 [DockingStepper](INFO): Start
2000-02-07T06:35:09.810Z,949905309.810 [DockingStepper](DEBUG): Initializing EZServoServo.
2000-02-07T06:35:09.860Z,949905309.860 [WetLabsBB2FL](INFO): Powering down
2000-02-07T06:35:09.929Z,949905309.929 [DockingStepper](DEBUG): Initializing DockingStepper.
2000-02-07T06:35:09.934Z,949905309.934 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2000-02-07T06:35:09.965Z,949905309.965 [DATMMP](INFO): Starting
2000-02-07T06:35:10.109Z,949905310.109 [CTD_Seabird](INFO): Powering down
2000-02-07T06:35:10.216Z,949905310.216 [DATMMP](INFO): Starting
2000-02-07T06:35:10.268Z,949905310.268 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout
2000-02-07T06:35:10.268Z,949905310.268 [AHRS_M2](FAULT): Failed to initialize within timeout.
2000-02-07T06:35:10.268Z,949905310.268 [AHRS_M2] Communications Fault, FailCount= 1
2000-02-07T06:35:10.268Z,949905310.268 [AHRS_M2](ERROR): Communications Fault
2000-02-07T06:35:10.330Z,949905310.330 [DockingStepper](INFO): Starting
2000-02-07T06:35:10.334Z,949905310.334 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2000-02-07T06:35:10.341Z,949905310.341 [AHRS_M2](INFO): Powering down
2000-02-07T06:35:10.468Z,949905310.468 [DATMMP](INFO): Starting
2000-02-07T06:35:10.469Z,949905310.469 [DATMMP](INFO): DAT read: MF Frequency Band
2000-02-07T06:35:10.470Z,949905310.470 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2000-02-07T06:35:10.471Z,949905310.471 [DATMMP](INFO): DAT read: Jan 7 2000 06:35:04
2000-02-07T06:35:10.489Z,949905310.489 [DockingStepper](INFO): Starting
2000-02-07T06:35:10.720Z,949905310.720 [DATMMP](INFO): Starting
2000-02-07T06:35:10.809Z,949905310.809 [DockingStepper](INFO): Starting
2000-02-07T06:35:10.814Z,949905310.814 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2000-02-07T06:35:10.814Z,949905310.814 [WetLabsBB2FL] No Fault, FailCount= 2
2000-02-07T06:35:10.972Z,949905310.972 [DATMMP](INFO): Starting
2000-02-07T06:35:11.074Z,949905311.074 [WetLabsBB2FL](INFO): Powering up
2000-02-07T06:35:11.217Z,949905311.217 [DockingStepper](INFO): Starting
2000-02-07T06:35:11.224Z,949905311.224 [DATMMP](INFO): Starting
2000-02-07T06:35:11.476Z,949905311.476 [DATMMP](INFO): Starting
2000-02-07T06:35:11.528Z,949905311.528 [DockingStepper](ERROR): getADC uart error serial timeout
2000-02-07T06:35:11.528Z,949905311.528 [DockingStepper](FAULT): No valid ADC reading. Arm out of allowable range:-1 counts.
2000-02-07T06:35:11.528Z,949905311.528 [DockingStepper] Hardware Fault, FailCount= 5
2000-02-07T06:35:11.529Z,949905311.529 [DockingStepper](ERROR): Hardware Fault
2000-02-07T06:35:11.533Z,949905311.533 [CBIT](INFO): Clearing failed state for component AHRS_M2
2000-02-07T06:35:11.533Z,949905311.533 [AHRS_M2] No Fault, FailCount= 1
2000-02-07T06:35:11.533Z,949905311.533 [CBIT](ERROR): Hardware Fault in component: DockingStepper
2000-02-07T06:35:11.534Z,949905311.534 [CBIT](CRITICAL): Hardware Fault in component: DockingStepper
2000-02-07T06:35:11.534Z,949905311.534 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2000-02-07T06:35:11.534Z,949905311.534 [CTD_Seabird] No Fault, FailCount= 1
2000-02-07T06:35:11.552Z,949905311.552 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2000-02-07T06:35:11.659Z,949905311.659 [DockingStepper](INFO): Stop
2000-02-07T06:35:11.661Z,949905311.661 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2000-02-07T06:35:11.661Z,949905311.661 [DockingStepper](INFO): Powering down
2000-02-07T06:35:11.664Z,949905311.664 [CBIT](INFO): Critical error at 20000207T063511
2000-02-07T06:35:11.728Z,949905311.728 [DATMMP](INFO): Starting
2000-02-07T06:35:11.729Z,949905311.729 [DATMMP](INFO): DAT read: Features enabled [Bearing]
2000-02-07T06:35:11.730Z,949905311.730 [DATMMP](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP
2000-02-07T06:35:11.731Z,949905311.731 [DATMMP](INFO): commRate: 600
2000-02-07T06:35:11.856Z,949905311.856 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2000-02-07T06:35:11.980Z,949905311.980 [DATMMP](INFO): Starting
2000-02-07T06:35:12.033Z,949905312.033 [DockingStepper](INFO): Stopping
2000-02-07T06:35:12.232Z,949905312.232 [DATMMP](INFO): Starting
2000-02-07T06:35:12.405Z,949905312.405 [DockingStepper](INFO): Stopped
2000-02-07T06:35:12.484Z,949905312.484 [DATMMP](INFO): Starting
2000-02-07T06:35:12.736Z,949905312.736 [DATMMP](INFO): Starting
2000-02-07T06:35:12.988Z,949905312.988 [DATMMP](INFO): Starting
2000-02-07T06:35:13.241Z,949905313.241 [DATMMP](INFO): Starting
2000-02-07T06:35:13.492Z,949905313.492 [DATMMP](INFO): Starting
2000-02-07T06:35:13.744Z,949905313.744 [DATMMP](INFO): Starting
2000-02-07T06:35:13.796Z,949905313.796 [DATMMP](INFO): entering command mode
2000-02-07T06:35:13.996Z,949905313.996 [DATMMP](INFO): Starting
2000-02-07T06:35:13.997Z,949905313.997 [DATMMP](INFO): DAT read:
2000-02-07T06:35:13.997Z,949905313.997 [DATMMP](INFO): DAT read: user:1>
2000-02-07T06:35:13.997Z,949905313.997 [DATMMP](DEBUG): read user prompt 1: user:1>