2000-02-04T04:16:48.303Z,949637808.303 [Supervisor](DEBUG): Initializing supervisor.
2000-02-04T04:16:48.307Z,949637808.307 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2000-02-04T04:16:48.308Z,949637808.308 [SyncHandler](INFO): Protected caller Thread ID is 827
2000-02-04T04:16:48.308Z,949637808.308 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2000-02-04T04:16:48.309Z,949637808.309 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2000-02-04T04:16:48.309Z,949637808.309 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 828
2000-02-04T04:16:48.313Z,949637808.313 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2000-02-04T04:16:48.331Z,949637808.331 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2000-02-04T04:16:48.332Z,949637808.332 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2000-02-04T04:16:48.333Z,949637808.333 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 829
2000-02-04T04:16:48.337Z,949637808.337 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2000-02-04T04:16:48.338Z,949637808.338 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2000-02-04T04:16:48.338Z,949637808.338 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 830
2000-02-04T04:16:48.340Z,949637808.340 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2000-02-04T04:16:48.341Z,949637808.341 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2000-02-04T04:16:48.342Z,949637808.342 [logger ThreadHandler](INFO): Protected caller Thread ID is 831
2000-02-04T04:16:48.345Z,949637808.345 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2000-02-04T04:16:48.346Z,949637808.346 [Supervisor](INFO): Looking for Config files in directory: Config/
2000-02-04T04:16:48.349Z,949637808.349 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2000-02-04T04:16:48.670Z,949637808.670 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2000-02-04T04:16:48.671Z,949637808.671 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2000-02-04T04:16:49.327Z,949637809.327 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2000-02-04T04:16:49.328Z,949637809.328 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2000-02-04T04:16:49.436Z,949637809.436 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2000-02-04T04:16:49.437Z,949637809.437 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2000-02-04T04:16:49.993Z,949637809.993 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2000-02-04T04:16:49.994Z,949637809.994 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2000-02-04T04:16:50.091Z,949637810.091 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2000-02-04T04:16:50.093Z,949637810.093 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2000-02-04T04:16:50.175Z,949637810.175 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2000-02-04T04:16:50.558Z,949637810.558 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2000-02-04T04:16:50.558Z,949637810.558 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2000-02-04T04:16:50.779Z,949637810.779 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2000-02-04T04:16:50.781Z,949637810.781 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2000-02-04T04:16:50.907Z,949637810.907 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2000-02-04T04:16:50.908Z,949637810.908 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2000-02-04T04:16:51.136Z,949637811.136 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2000-02-04T04:16:51.138Z,949637811.138 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2000-02-04T04:16:51.618Z,949637811.618 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2000-02-04T04:16:51.620Z,949637811.620 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2000-02-04T04:16:52.436Z,949637812.436 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2000-02-04T04:16:52.439Z,949637812.439 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2000-02-04T04:16:52.560Z,949637812.560 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2000-02-04T04:16:52.757Z,949637812.757 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2000-02-04T04:16:52.758Z,949637812.758 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2000-02-04T04:16:52.980Z,949637812.980 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2000-02-04T04:16:52.980Z,949637812.980 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2000-02-04T04:16:53.278Z,949637813.278 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2000-02-04T04:16:53.280Z,949637813.280 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-tanner-dev/
2000-02-04T04:16:53.281Z,949637813.281 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2000-02-04T04:16:53.284Z,949637813.284 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2000-02-04T04:16:53.404Z,949637813.404 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2000-02-04T04:16:53.405Z,949637813.405 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2000-02-04T04:16:53.420Z,949637813.420 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2000-02-04T04:16:53.422Z,949637813.422 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2000-02-04T04:16:53.492Z,949637813.492 [DepthRateCalculator] Loaded
2000-02-04T04:16:53.493Z,949637813.493 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2000-02-04T04:16:53.498Z,949637813.498 [PitchRateCalculator] Loaded
2000-02-04T04:16:53.498Z,949637813.498 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2000-02-04T04:16:53.508Z,949637813.508 [SpeedCalculator] Loaded
2000-02-04T04:16:53.509Z,949637813.509 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2000-02-04T04:16:53.513Z,949637813.513 [YawRateCalculator] Loaded
2000-02-04T04:16:53.514Z,949637813.514 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2000-02-04T04:16:53.535Z,949637813.535 [ElevatorOffsetCalculator] Loaded
2000-02-04T04:16:53.535Z,949637813.535 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2000-02-04T04:16:53.536Z,949637813.536 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2000-02-04T04:16:53.536Z,949637813.536 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2000-02-04T04:16:53.605Z,949637813.605 [VerticalControl](DEBUG): Construct VerticalControl.
2000-02-04T04:16:53.661Z,949637813.661 [VerticalControl] Loaded
2000-02-04T04:16:53.661Z,949637813.661 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2000-02-04T04:16:53.664Z,949637813.664 [HorizontalControl](DEBUG): Construct HorizontalControl.
2000-02-04T04:16:53.702Z,949637813.702 [HorizontalControl] Loaded
2000-02-04T04:16:53.702Z,949637813.702 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2000-02-04T04:16:53.705Z,949637813.705 [SpeedControl](DEBUG): Construct SpeedControl.
2000-02-04T04:16:53.708Z,949637813.708 [SpeedControl] Loaded
2000-02-04T04:16:53.708Z,949637813.708 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2000-02-04T04:16:53.710Z,949637813.710 [LoopControl](DEBUG): Construct LoopControl.
2000-02-04T04:16:53.711Z,949637813.711 [LoopControl] Loaded
2000-02-04T04:16:53.711Z,949637813.711 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2000-02-04T04:16:53.711Z,949637813.711 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2000-02-04T04:16:53.712Z,949637813.712 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2000-02-04T04:16:53.846Z,949637813.846 [DeadReckonUsingMultipleVelocitySources] Loaded
2000-02-04T04:16:53.846Z,949637813.846 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2000-02-04T04:16:53.885Z,949637813.885 [DeadReckonUsingSpeedCalculator] Loaded
2000-02-04T04:16:53.885Z,949637813.885 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2000-02-04T04:16:53.898Z,949637813.898 [NavChart] Loaded
2000-02-04T04:16:53.898Z,949637813.898 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2000-02-04T04:16:53.904Z,949637813.904 [UniversalFixResidualReporter] Loaded
2000-02-04T04:16:53.904Z,949637813.904 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2000-02-04T04:16:53.905Z,949637813.905 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2000-02-04T04:16:53.905Z,949637813.905 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2000-02-04T04:16:54.071Z,949637814.071 [InternalSim] Loaded
2000-02-04T04:16:54.071Z,949637814.071 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2000-02-04T04:16:54.072Z,949637814.072 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2000-02-04T04:16:54.072Z,949637814.072 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2000-02-04T04:16:54.826Z,949637814.826 [AHRS_M2] Loaded
2000-02-04T04:16:54.826Z,949637814.826 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2000-02-04T04:16:54.844Z,949637814.844 [BPC1](CRITICAL): Could not find element Config/Battery.stick1
2000-02-04T04:16:54.845Z,949637814.845 [BPC1](CRITICAL): Could not find element Config/Battery.stick2
2000-02-04T04:16:54.845Z,949637814.845 [BPC1](CRITICAL): Could not find element Config/Battery.stick3
2000-02-04T04:16:54.846Z,949637814.846 [BPC1](CRITICAL): Could not find element Config/Battery.stick4
2000-02-04T04:16:54.846Z,949637814.846 [BPC1](CRITICAL): Could not find element Config/Battery.stick5
2000-02-04T04:16:54.847Z,949637814.847 [BPC1](CRITICAL): Could not find element Config/Battery.stick6
2000-02-04T04:16:54.847Z,949637814.847 [BPC1](CRITICAL): Could not find element Config/Battery.stick7
2000-02-04T04:16:54.848Z,949637814.848 [BPC1](CRITICAL): Could not find element Config/Battery.stick8
2000-02-04T04:16:54.848Z,949637814.848 [BPC1](CRITICAL): Could not find element Config/Battery.stick9
2000-02-04T04:16:54.849Z,949637814.849 [BPC1](CRITICAL): Could not find element Config/Battery.stick10
2000-02-04T04:16:54.849Z,949637814.849 [BPC1](CRITICAL): Could not find element Config/Battery.stick11
2000-02-04T04:16:54.850Z,949637814.850 [BPC1](CRITICAL): Could not find element Config/Battery.stick12
2000-02-04T04:16:54.850Z,949637814.850 [BPC1](CRITICAL): Could not find element Config/Battery.stick13
2000-02-04T04:16:54.850Z,949637814.850 [BPC1](CRITICAL): Could not find element Config/Battery.stick14
2000-02-04T04:16:54.851Z,949637814.851 [BPC1](CRITICAL): Could not find element Config/Battery.stick15
2000-02-04T04:16:54.851Z,949637814.851 [BPC1](CRITICAL): Could not find element Config/Battery.stick16
2000-02-04T04:16:54.852Z,949637814.852 [BPC1](CRITICAL): Could not find element Config/Battery.stick17
2000-02-04T04:16:54.853Z,949637814.853 [BPC1](CRITICAL): Could not find element Config/Battery.stick18
2000-02-04T04:16:54.853Z,949637814.853 [BPC1](CRITICAL): Could not find element Config/Battery.stick19
2000-02-04T04:16:54.853Z,949637814.853 [BPC1](CRITICAL): Could not find element Config/Battery.stick20
2000-02-04T04:16:54.854Z,949637814.854 [BPC1](CRITICAL): Could not find element Config/Battery.stick21
2000-02-04T04:16:54.854Z,949637814.854 [BPC1](CRITICAL): Could not find element Config/Battery.stick22
2000-02-04T04:16:54.855Z,949637814.855 [BPC1](CRITICAL): Could not find element Config/Battery.stick23
2000-02-04T04:16:54.855Z,949637814.855 [BPC1](CRITICAL): Could not find element Config/Battery.stick24
2000-02-04T04:16:54.856Z,949637814.856 [BPC1](CRITICAL): Could not find element Config/Battery.stick25
2000-02-04T04:16:54.856Z,949637814.856 [BPC1](CRITICAL): Could not find element Config/Battery.stick26
2000-02-04T04:16:54.857Z,949637814.857 [BPC1](CRITICAL): Could not find element Config/Battery.stick27
2000-02-04T04:16:54.857Z,949637814.857 [BPC1](CRITICAL): Could not find element Config/Battery.stick28
2000-02-04T04:16:54.858Z,949637814.858 [BPC1](CRITICAL): Could not find element Config/Battery.stick29
2000-02-04T04:16:54.858Z,949637814.858 [BPC1](CRITICAL): Could not find element Config/Battery.stick30
2000-02-04T04:16:54.858Z,949637814.858 [BPC1](CRITICAL): Could not find element Config/Battery.stick31
2000-02-04T04:16:54.860Z,949637814.860 [BPC1](CRITICAL): Could not find element Config/Battery.stick32
2000-02-04T04:16:54.860Z,949637814.860 [BPC1](CRITICAL): Could not find element Config/Battery.stick33
2000-02-04T04:16:54.861Z,949637814.861 [BPC1](CRITICAL): Could not find element Config/Battery.stick34
2000-02-04T04:16:54.861Z,949637814.861 [BPC1](CRITICAL): Could not find element Config/Battery.stick35
2000-02-04T04:16:54.862Z,949637814.862 [BPC1](CRITICAL): Could not find element Config/Battery.stick36
2000-02-04T04:16:54.862Z,949637814.862 [BPC1](CRITICAL): Could not find element Config/Battery.stick37
2000-02-04T04:16:54.863Z,949637814.863 [BPC1](CRITICAL): Could not find element Config/Battery.stick38
2000-02-04T04:16:54.863Z,949637814.863 [BPC1](CRITICAL): Could not find element Config/Battery.stick39
2000-02-04T04:16:54.864Z,949637814.864 [BPC1](CRITICAL): Could not find element Config/Battery.stick40
2000-02-04T04:16:54.864Z,949637814.864 [BPC1](CRITICAL): Could not find element Config/Battery.stick41
2000-02-04T04:16:54.865Z,949637814.865 [BPC1](CRITICAL): Could not find element Config/Battery.stick42
2000-02-04T04:16:54.865Z,949637814.865 [BPC1](CRITICAL): Could not find element Config/Battery.stick43
2000-02-04T04:16:54.866Z,949637814.866 [BPC1](CRITICAL): Could not find element Config/Battery.stick44
2000-02-04T04:16:54.866Z,949637814.866 [BPC1](CRITICAL): Could not find element Config/Battery.stick45
2000-02-04T04:16:54.866Z,949637814.866 [BPC1](CRITICAL): Could not find element Config/Battery.stick46
2000-02-04T04:16:54.867Z,949637814.867 [BPC1](CRITICAL): Could not find element Config/Battery.stick47
2000-02-04T04:16:54.867Z,949637814.867 [BPC1](CRITICAL): Could not find element Config/Battery.stick48
2000-02-04T04:16:54.868Z,949637814.868 [BPC1](CRITICAL): Could not find element Config/Battery.stick49
2000-02-04T04:16:54.869Z,949637814.869 [BPC1](CRITICAL): Could not find element Config/Battery.stick50
2000-02-04T04:16:54.869Z,949637814.869 [BPC1](CRITICAL): Could not find element Config/Battery.stick51
2000-02-04T04:16:54.869Z,949637814.869 [BPC1](CRITICAL): Could not find element Config/Battery.stick52
2000-02-04T04:16:54.870Z,949637814.870 [BPC1](CRITICAL): Could not find element Config/Battery.stick53
2000-02-04T04:16:54.870Z,949637814.870 [BPC1](CRITICAL): Could not find element Config/Battery.stick54
2000-02-04T04:16:54.871Z,949637814.871 [BPC1](CRITICAL): Could not find element Config/Battery.stick55
2000-02-04T04:16:54.871Z,949637814.871 [BPC1](CRITICAL): Could not find element Config/Battery.stick56
2000-02-04T04:16:54.872Z,949637814.872 [BPC1](CRITICAL): Could not find element Config/Battery.stick57
2000-02-04T04:16:54.872Z,949637814.872 [BPC1](CRITICAL): Could not find element Config/Battery.stick58
2000-02-04T04:16:54.873Z,949637814.873 [BPC1](CRITICAL): Could not find element Config/Battery.stick59
2000-02-04T04:16:54.873Z,949637814.873 [BPC1](CRITICAL): Could not find element Config/Battery.stick60
2000-02-04T04:16:54.874Z,949637814.874 [BPC1](CRITICAL): Could not find element Config/Battery.stick61
2000-02-04T04:16:54.874Z,949637814.874 [BPC1](CRITICAL): Could not find element Config/Battery.stick62
2000-02-04T04:16:55.823Z,949637815.823 [BPC1] Loaded
2000-02-04T04:16:55.823Z,949637815.823 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2000-02-04T04:16:55.963Z,949637815.963 [DataOverHttps] Loaded
2000-02-04T04:16:55.963Z,949637815.963 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2000-02-04T04:16:55.965Z,949637815.965 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408DD4E0
2000-02-04T04:16:55.965Z,949637815.965 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 880
2000-02-04T04:16:55.984Z,949637815.984 [Depth_Keller] Loaded
2000-02-04T04:16:55.985Z,949637815.985 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2000-02-04T04:16:55.989Z,949637815.989 [DropWeight] Loaded
2000-02-04T04:16:55.990Z,949637815.990 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2000-02-04T04:16:56.048Z,949637816.048 [NAL9602] Loaded
2000-02-04T04:16:56.048Z,949637816.048 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2000-02-04T04:16:56.076Z,949637816.076 [Onboard] Loaded
2000-02-04T04:16:56.076Z,949637816.076 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2000-02-04T04:16:56.077Z,949637816.077 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4090D4E0
2000-02-04T04:16:56.078Z,949637816.078 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 881
2000-02-04T04:16:56.113Z,949637816.113 [Power24vConverter] Loaded
2000-02-04T04:16:56.113Z,949637816.113 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2000-02-04T04:16:56.126Z,949637816.126 [Radio_Surface] Loaded
2000-02-04T04:16:56.126Z,949637816.126 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2000-02-04T04:16:56.127Z,949637816.127 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4093D4E0
2000-02-04T04:16:56.127Z,949637816.127 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 882
2000-02-04T04:16:56.128Z,949637816.128 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2000-02-04T04:16:56.129Z,949637816.129 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2000-02-04T04:16:56.278Z,949637816.278 [BuoyancyServo] Loaded
2000-02-04T04:16:56.278Z,949637816.278 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2000-02-04T04:16:56.298Z,949637816.298 [ElevatorServo] Loaded
2000-02-04T04:16:56.299Z,949637816.299 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2000-02-04T04:16:56.317Z,949637816.317 [MassServo] Loaded
2000-02-04T04:16:56.317Z,949637816.317 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2000-02-04T04:16:56.335Z,949637816.335 [RudderServo] Loaded
2000-02-04T04:16:56.336Z,949637816.336 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2000-02-04T04:16:56.352Z,949637816.352 [ThrusterServo] Loaded
2000-02-04T04:16:56.352Z,949637816.352 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2000-02-04T04:16:56.353Z,949637816.353 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2000-02-04T04:16:56.354Z,949637816.354 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2000-02-04T04:16:56.435Z,949637816.435 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2000-02-04T04:16:56.436Z,949637816.436 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2000-02-04T04:16:56.479Z,949637816.479 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2000-02-04T04:16:56.479Z,949637816.479 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2000-02-04T04:16:56.835Z,949637816.835 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2000-02-04T04:16:56.835Z,949637816.835 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2000-02-04T04:16:57.273Z,949637817.273 [CTD_Seabird] Loaded
2000-02-04T04:16:57.273Z,949637817.273 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2000-02-04T04:16:57.274Z,949637817.274 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40AD94E0
2000-02-04T04:16:57.275Z,949637817.275 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 883
2000-02-04T04:16:57.294Z,949637817.294 [PAR_Licor] Loaded
2000-02-04T04:16:57.294Z,949637817.294 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2000-02-04T04:16:57.325Z,949637817.325 [WetLabsBB2FL] Loaded
2000-02-04T04:16:57.325Z,949637817.325 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2000-02-04T04:16:57.326Z,949637817.326 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B094E0
2000-02-04T04:16:57.327Z,949637817.327 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 884
2000-02-04T04:16:57.327Z,949637817.327 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2000-02-04T04:16:57.328Z,949637817.328 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2000-02-04T04:16:57.495Z,949637817.495 [SBIT](DEBUG): Construct Startup Built In Test.
2000-02-04T04:16:57.504Z,949637817.504 [SBIT] Loaded
2000-02-04T04:16:57.504Z,949637817.504 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2000-02-04T04:16:57.507Z,949637817.507 [IBIT](DEBUG): Construct Initiated Built In Test.
2000-02-04T04:16:57.519Z,949637817.519 [IBIT] Loaded
2000-02-04T04:16:57.520Z,949637817.520 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2000-02-04T04:16:57.525Z,949637817.525 [CBIT](DEBUG): Construct Continuous Built In Test.
2000-02-04T04:16:57.630Z,949637817.630 [CBIT] Loaded
2000-02-04T04:16:57.630Z,949637817.630 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2000-02-04T04:16:57.631Z,949637817.631 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2000-02-04T04:16:57.637Z,949637817.637 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2000-02-04T04:16:57.639Z,949637817.639 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2000-02-04T04:16:57.650Z,949637817.650 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2000-02-04T04:16:57.651Z,949637817.651 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B774E0
2000-02-04T04:16:57.651Z,949637817.651 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 885
2000-02-04T04:16:57.656Z,949637817.656 [Supervisor](INFO): Main Thread ID is 823
2000-02-04T04:16:57.656Z,949637817.656 [Supervisor](DEBUG): Running supervisor.
2000-02-04T04:16:57.657Z,949637817.657 [CommandExec ThreadHandler](INFO): Handler Thread ID is 886
2000-02-04T04:16:57.657Z,949637817.657 [CommandExec](INFO): Initializing the command executive.
2000-02-04T04:16:57.659Z,949637817.659 [CommandLine ThreadHandler](INFO): Handler Thread ID is 887
2000-02-04T04:16:57.661Z,949637817.661 [controlThread ThreadHandler](INFO): Handler Thread ID is 888
2000-02-04T04:16:57.661Z,949637817.661 [controlThread](DEBUG): Initializing ControlThread
2000-02-04T04:16:57.662Z,949637817.662 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2000-02-04T04:16:57.662Z,949637817.662 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2000-02-04T04:16:57.663Z,949637817.663 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2000-02-04T04:16:57.663Z,949637817.663 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2000-02-04T04:16:57.663Z,949637817.663 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2000-02-04T04:16:57.664Z,949637817.664 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2000-02-04T04:16:57.666Z,949637817.666 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2000-02-04T04:16:57.666Z,949637817.666 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2000-02-04T04:16:57.667Z,949637817.667 [LoopControl](DEBUG): Initialize LoopControlComponent.
2000-02-04T04:16:57.668Z,949637817.668 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2000-02-04T04:16:57.668Z,949637817.668 [NavChart](DEBUG): Initialize NavChart Navigation.
2000-02-04T04:16:57.669Z,949637817.669 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2000-02-04T04:16:57.669Z,949637817.669 [InternalSim](DEBUG):  InternalSim initializing...
2000-02-04T04:16:57.675Z,949637817.675 [InternalSim](DEBUG): oceanModelVarCount=0
2000-02-04T04:16:57.696Z,949637817.696 [logger ThreadHandler](INFO): Handler Thread ID is 889
2000-02-04T04:16:57.778Z,949637817.778 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 890
2000-02-04T04:16:57.779Z,949637817.779 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2000-02-04T04:16:57.804Z,949637817.804 [Onboard ThreadHandler](INFO): Handler Thread ID is 891
2000-02-04T04:16:57.812Z,949637817.812 [SBIT](INFO): Initialize SBIT Component.
2000-02-04T04:16:57.813Z,949637817.813 [SBIT](IMPORTANT): git: 2022-05-16
2000-02-04T04:16:57.813Z,949637817.813 [SBIT](INFO): git hash: 22dd8ec1d68d2d3458ffb0a0481759ba9019d0f5
2000-02-04T04:16:57.814Z,949637817.814 [SBIT](INFO): Kernel Reporting Different Release From Configuration.
Kernel Expected: 2.6.32-45-generic-pae
Kernel Reported: 2.6.27.8
2000-02-04T04:16:57.814Z,949637817.814 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #102-Ubuntu SMP Wed Jan 2 22:10:16 UTC 2013
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2000-02-04T04:16:57.815Z,949637817.815 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2000-02-04T04:16:57.816Z,949637817.816 [IBIT](INFO): Initialize IBIT Component.
2000-02-04T04:16:57.817Z,949637817.817 [CBIT](DEBUG): Initialize CBIT Component.
2000-02-04T04:16:57.828Z,949637817.828 [CBIT](DEBUG): Initialized mux pins.
2000-02-04T04:16:57.828Z,949637817.828 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2000-02-04T04:16:57.828Z,949637817.828 [CBIT](DEBUG): Initializing the watchdog timer.
2000-02-04T04:16:57.829Z,949637817.829 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 892
2000-02-04T04:16:57.840Z,949637817.840 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 893
2000-02-04T04:16:57.841Z,949637817.841 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2000-02-04T04:16:57.852Z,949637817.852 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2000-02-04T04:16:57.853Z,949637817.853 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2000-02-04T04:16:57.865Z,949637817.865 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 894
2000-02-04T04:16:57.888Z,949637817.888 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2000-02-04T04:16:57.892Z,949637817.892 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 895
2000-02-04T04:16:57.899Z,949637817.899 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2000-02-04T04:16:57.899Z,949637817.899 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2000-02-04T04:16:57.899Z,949637817.899 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2000-02-04T04:16:57.899Z,949637817.899 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2000-02-04T04:16:57.899Z,949637817.899 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2000-02-04T04:16:57.900Z,949637817.900 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2000-02-04T04:16:57.900Z,949637817.900 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2000-02-04T04:16:57.900Z,949637817.900 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2000-02-04T04:16:57.948Z,949637817.948 [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>


2000-02-04T04:16:57.949Z,949637817.949 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2000-02-04T04:16:58.023Z,949637818.023 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2000-02-04T04:16:58.036Z,949637818.036 [Default:A.Wait](DEBUG): Construct Wait.
2000-02-04T04:16:58.038Z,949637818.038 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2000-02-04T04:16:58.087Z,949637818.087 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2000-02-04T04:16:58.106Z,949637818.106 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2000-02-04T04:16:58.128Z,949637818.128 [Default:E.Execute](DEBUG): Construct Execute.
2000-02-04T04:16:58.131Z,949637818.131 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2000-02-04T04:16:58.144Z,949637818.144 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2000-02-04T04:16:58.192Z,949637818.192 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2000-02-04T04:16:58.218Z,949637818.218 [Power24vConverter](INFO): Powering up.
2000-02-04T04:16:58.257Z,949637818.257 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2000-02-04T04:16:58.258Z,949637818.258 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2000-02-04T04:16:58.259Z,949637818.259 [MassServo](DEBUG): Initializing MassServo.
2000-02-04T04:16:58.259Z,949637818.259 [RudderServo](DEBUG): Initializing RudderServo.
2000-02-04T04:16:58.268Z,949637818.268 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2000-02-04T04:16:58.270Z,949637818.270 [CommandExec](FAULT): Scheduling is paused
2000-02-04T04:16:58.270Z,949637818.270 [CBIT](INFO): Critical error at 20000204T041654
2000-02-04T04:16:58.270Z,949637818.270 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2000-02-04T04:17:01.389Z,949637821.389 [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

2000-02-04T04:17:01.791Z,949637821.791 [AHRS_M2](DEBUG): chan0Format 2 set drop

2000-02-04T04:17:02.196Z,949637822.196 [AHRS_M2](DEBUG): chan0Trigger 5 set drop

2000-02-04T04:17:02.599Z,949637822.599 [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

2000-02-04T04:17:02.600Z,949637822.600 [AHRS_M2](DEBUG): chan0EnableBit pitch dvid@ set drop

2000-02-04T04:17:03.004Z,949637823.004 [AHRS_M2](DEBUG): chan0EnableBit roll dvid@ set drop

2000-02-04T04:17:03.408Z,949637823.408 [AHRS_M2](DEBUG): chan0EnableBit yaw dvid@ set drop

2000-02-04T04:17:03.812Z,949637823.812 [AHRS_M2](DEBUG): chan0EnableBit magp dvid@ set drop

2000-02-04T04:17:04.216Z,949637824.216 [AHRS_M2](DEBUG): chan0EnableBit accelp dvid@ set drop

2000-02-04T04:17:04.620Z,949637824.620 [AHRS_M2](DEBUG): chan0EnableBit gyrop dvid@ set drop

2000-02-04T04:17:05.023Z,949637825.023 [AHRS_M2](DEBUG): chan0EnableBit yawErrEst dvid@ set drop

2000-02-04T04:17:05.428Z,949637825.428 [AHRS_M2](DEBUG): chan0EnableBit temperature dvid@ set drop

2000-02-04T04:17:05.831Z,949637825.831 [AHRS_M2](DEBUG): chan0EnableBit magBufferActiveIndex dvid@ set drop

2000-02-04T04:17:06.236Z,949637826.236 [AHRS_M2](DEBUG): chan0TriggerDivisor 40 set drop

2000-02-04T04:17:16.335Z,949637836.335 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2000-02-04T04:17:16.335Z,949637836.335 [AHRS_M2] Data Fault, FailCount= 1
2000-02-04T04:17:16.335Z,949637836.335 [AHRS_M2](ERROR): Data Fault
2000-02-04T04:17:16.350Z,949637836.350 [CBIT](ERROR): Data Fault in component: AHRS_M2
2000-02-04T04:17:16.351Z,949637836.351 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2000-02-04T04:17:16.754Z,949637836.754 [CBIT](INFO): Critical error at 20000204T041716
2000-02-04T04:17:18.367Z,949637838.367 [SBIT](IMPORTANT): Beginning Startup BIT
2000-02-04T04:17:32.092Z,949637852.092 [NAL9602](INFO): No messages in MT queue
2000-02-04T04:18:12.510Z,949637892.510 [SBIT](IMPORTANT): SBIT PASSED
2000-02-04T04:18:12.511Z,949637892.511 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2000-02-04T04:18:12.902Z,949637892.902 [MissionManager](IMPORTANT): Started mission Startup
2000-02-04T04:18:12.902Z,949637892.902 [Startup] Running Loop=1
2000-02-04T04:18:12.902Z,949637892.902 [Startup](DEBUG): Aggregate::initialize Startup
2000-02-04T04:18:12.902Z,949637892.902 [Startup:A.GoToSurface] Running Loop=1
2000-02-04T04:18:12.903Z,949637892.903 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2000-02-04T04:18:12.903Z,949637892.903 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2000-02-04T04:18:12.904Z,949637892.904 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2000-02-04T04:18:12.904Z,949637892.904 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2000-02-04T04:18:12.904Z,949637892.904 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2000-02-04T04:18:12.905Z,949637892.905 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2000-02-04T04:18:12.906Z,949637892.906 [Startup:StartupSatComms] Running Loop=1
2000-02-04T04:18:12.906Z,949637892.906 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2000-02-04T04:18:12.906Z,949637892.906 [Startup:StartupSatComms:A] Running Loop=1
2000-02-04T04:18:13.307Z,949637893.307 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2000-02-04T04:18:57.747Z,949637937.747 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2000-02-04T04:18:57.747Z,949637937.747 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2000-02-04T04:18:57.747Z,949637937.747 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2000-02-04T04:18:57.749Z,949637937.749 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2000-02-04T04:18:57.749Z,949637937.749 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2000-02-04T04:18:57.749Z,949637937.749 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2000-02-04T04:18:57.758Z,949637937.758 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2000-02-04T04:18:57.758Z,949637937.758 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2000-02-04T04:18:58.166Z,949637938.166 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2000-02-04T04:18:58.166Z,949637938.166 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2000-02-04T04:18:58.166Z,949637938.166 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2000-02-04T04:18:58.166Z,949637938.166 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2000-02-04T04:18:58.554Z,949637938.554 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2000-02-04T04:19:13.105Z,949637953.105 [Startup:StartupSatComms:A](INFO): Timed out from 2000-02-04T04:18:12.9Z
2000-02-04T04:19:13.105Z,949637953.105 [Startup:StartupSatComms:A] Stopped
2000-02-04T04:19:13.105Z,949637953.105 [Startup:StartupSatComms:B] Running Loop=1
2000-02-04T04:19:13.503Z,949637953.503 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2000-02-04T04:19:46.221Z,949637986.221 [NAL9602](INFO): Sent 18 bytes from file Logs/19241125T023337/Courier0000.lzma
2000-02-04T04:19:46.221Z,949637986.221 [NAL9602](INFO): Packets left to send: 0
2000-02-04T04:20:13.295Z,949638013.295 [Startup:StartupSatComms:B](INFO): Timed out from 2000-02-04T04:19:13.1Z
2000-02-04T04:20:13.295Z,949638013.295 [Startup:StartupSatComms:B] Stopped
2000-02-04T04:20:13.295Z,949638013.295 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2000-02-04T04:20:13.296Z,949638013.296 [Startup:StartupSatComms] Stopped
2000-02-04T04:20:13.296Z,949638013.296 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2000-02-04T04:20:13.296Z,949638013.296 [Startup](INFO): Completed Startup
2000-02-04T04:20:13.297Z,949638013.297 [MissionManager](INFO): Startup is completed.
2000-02-04T04:20:13.297Z,949638013.297 [MissionManager](INFO): Uninitializing Mission Startup
2000-02-04T04:20:13.297Z,949638013.297 [Startup] Stopped
2000-02-04T04:20:13.297Z,949638013.297 [Startup](DEBUG): Aggregate::uninitialize Startup
2000-02-04T04:20:13.297Z,949638013.297 [Startup:A.GoToSurface] Stopped
2000-02-04T04:20:13.297Z,949638013.297 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2000-02-04T04:20:13.698Z,949638013.698 [MissionManager](IMPORTANT): Started mission Default
2000-02-04T04:20:13.698Z,949638013.698 [Default] Running Loop=1
2000-02-04T04:20:13.698Z,949638013.698 [Default](DEBUG): Aggregate::initialize Default
2000-02-04T04:20:13.698Z,949638013.698 [Default:B.GoToSurface] Running Loop=1
2000-02-04T04:20:13.698Z,949638013.698 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2000-02-04T04:20:13.698Z,949638013.698 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2000-02-04T04:20:13.699Z,949638013.699 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2000-02-04T04:20:13.699Z,949638013.699 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2000-02-04T04:20:13.699Z,949638013.699 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2000-02-04T04:20:13.700Z,949638013.700 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2000-02-04T04:20:13.700Z,949638013.700 [Default:A.Wait] Running Loop=1
2000-02-04T04:20:13.700Z,949638013.700 [Default:A.Wait](DEBUG): Initialize Wait Component.
2000-02-04T04:20:17.734Z,949638017.734 [NAL9602](INFO): Sent 18 bytes from file Logs/19241125T023754/Courier0000.lzma
2000-02-04T04:20:17.734Z,949638017.734 [NAL9602](INFO): Packets left to send: 0
2000-02-04T04:20:27.031Z,949638027.031 [Default:A.Wait](INFO): Done Waiting.
2000-02-04T04:20:27.031Z,949638027.031 [Default:A.Wait] Stopped
2000-02-04T04:20:27.031Z,949638027.031 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2000-02-04T04:20:27.434Z,949638027.434 [Default:CheckIn] Running Loop=1
2000-02-04T04:20:27.434Z,949638027.434 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2000-02-04T04:20:27.435Z,949638027.435 [Default:CheckIn:Read_GPS] Running Loop=1
2000-02-04T04:20:27.845Z,949638027.845 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2000-02-04T04:20:58.945Z,949638058.945 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2000-02-04T04:20:58.945Z,949638058.945 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2000-02-04T04:20:58.945Z,949638058.945 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2000-02-04T04:20:58.947Z,949638058.947 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2000-02-04T04:20:58.947Z,949638058.947 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2000-02-04T04:20:58.947Z,949638058.947 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2000-02-04T04:20:58.956Z,949638058.956 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2000-02-04T04:20:58.956Z,949638058.956 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2000-02-04T04:20:59.35