2009-11-30T00:03:07.066Z,1259539387.066 [Supervisor](DEBUG): Initializing supervisor.
2009-11-30T00:03:07.070Z,1259539387.070 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2009-11-30T00:03:07.071Z,1259539387.071 [SyncHandler](INFO): Protected caller Thread ID is 831
2009-11-30T00:03:07.071Z,1259539387.071 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2009-11-30T00:03:07.072Z,1259539387.072 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2009-11-30T00:03:07.073Z,1259539387.073 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 832
2009-11-30T00:03:07.077Z,1259539387.077 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2009-11-30T00:03:07.095Z,1259539387.095 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2009-11-30T00:03:07.096Z,1259539387.096 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2009-11-30T00:03:07.097Z,1259539387.097 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 833
2009-11-30T00:03:07.101Z,1259539387.101 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2009-11-30T00:03:07.102Z,1259539387.102 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2009-11-30T00:03:07.102Z,1259539387.102 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 834
2009-11-30T00:03:07.104Z,1259539387.104 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2009-11-30T00:03:07.105Z,1259539387.105 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2009-11-30T00:03:07.106Z,1259539387.106 [logger ThreadHandler](INFO): Protected caller Thread ID is 835
2009-11-30T00:03:07.109Z,1259539387.109 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2009-11-30T00:03:07.110Z,1259539387.110 [Supervisor](INFO): Looking for Config files in directory: Config/
2009-11-30T00:03:07.115Z,1259539387.115 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2009-11-30T00:03:07.263Z,1259539387.263 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2009-11-30T00:03:07.265Z,1259539387.265 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2009-11-30T00:03:07.480Z,1259539387.480 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2009-11-30T00:03:07.481Z,1259539387.481 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2009-11-30T00:03:07.743Z,1259539387.743 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2009-11-30T00:03:07.744Z,1259539387.744 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2009-11-30T00:03:07.852Z,1259539387.852 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2009-11-30T00:03:07.852Z,1259539387.852 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2009-11-30T00:03:08.511Z,1259539388.511 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2009-11-30T00:03:08.512Z,1259539388.512 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2009-11-30T00:03:08.971Z,1259539388.971 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2009-11-30T00:03:08.972Z,1259539388.972 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2009-11-30T00:03:09.562Z,1259539389.562 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2009-11-30T00:03:09.563Z,1259539389.563 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2009-11-30T00:03:09.960Z,1259539389.960 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2009-11-30T00:03:09.962Z,1259539389.962 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2009-11-30T00:03:10.721Z,1259539390.721 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2009-11-30T00:03:10.722Z,1259539390.722 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2009-11-30T00:03:11.093Z,1259539391.093 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2009-11-30T00:03:11.095Z,1259539391.095 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2009-11-30T00:03:11.315Z,1259539391.315 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2009-11-30T00:03:11.315Z,1259539391.315 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2009-11-30T00:03:11.446Z,1259539391.446 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2009-11-30T00:03:11.446Z,1259539391.446 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2009-11-30T00:03:11.530Z,1259539391.530 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2009-11-30T00:03:11.609Z,1259539391.609 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2009-11-30T00:03:11.805Z,1259539391.805 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2009-11-30T00:03:11.806Z,1259539391.806 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2009-11-30T00:03:12.027Z,1259539392.027 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2009-11-30T00:03:12.029Z,1259539392.029 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2009-11-30T00:03:12.031Z,1259539392.031 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2009-11-30T00:03:12.116Z,1259539392.116 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2009-11-30T00:03:12.379Z,1259539392.379 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2009-11-30T00:03:12.380Z,1259539392.380 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2009-11-30T00:03:12.478Z,1259539392.478 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2009-11-30T00:03:12.639Z,1259539392.639 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2009-11-30T00:03:12.827Z,1259539392.827 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2009-11-30T00:03:12.913Z,1259539392.913 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2009-11-30T00:03:13.021Z,1259539393.021 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2009-11-30T00:03:13.124Z,1259539393.124 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2009-11-30T00:03:13.286Z,1259539393.286 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2009-11-30T00:03:13.391Z,1259539393.391 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2009-11-30T00:03:13.492Z,1259539393.492 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2009-11-30T00:03:13.495Z,1259539393.495 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2009-11-30T00:03:13.640Z,1259539393.640 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2009-11-30T00:03:13.640Z,1259539393.640 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2009-11-30T00:03:13.817Z,1259539393.817 [BuoyancyServo] Loaded
2009-11-30T00:03:13.818Z,1259539393.818 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2009-11-30T00:03:13.838Z,1259539393.838 [ElevatorServo] Loaded
2009-11-30T00:03:13.838Z,1259539393.838 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2009-11-30T00:03:13.858Z,1259539393.858 [MassServo] Loaded
2009-11-30T00:03:13.858Z,1259539393.858 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2009-11-30T00:03:13.877Z,1259539393.877 [RudderServo] Loaded
2009-11-30T00:03:13.877Z,1259539393.877 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2009-11-30T00:03:13.893Z,1259539393.893 [ThrusterHE] Loaded
2009-11-30T00:03:13.893Z,1259539393.893 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2009-11-30T00:03:13.894Z,1259539393.894 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2009-11-30T00:03:13.896Z,1259539393.896 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2009-11-30T00:03:14.067Z,1259539394.067 [SBIT](DEBUG): Construct Startup Built In Test.
2009-11-30T00:03:14.082Z,1259539394.082 [SBIT] Loaded
2009-11-30T00:03:14.082Z,1259539394.082 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2009-11-30T00:03:14.085Z,1259539394.085 [IBIT](DEBUG): Construct Initiated Built In Test.
2009-11-30T00:03:14.106Z,1259539394.106 [IBIT] Loaded
2009-11-30T00:03:14.106Z,1259539394.106 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2009-11-30T00:03:14.111Z,1259539394.111 [CBIT](DEBUG): Construct Continuous Built In Test.
2009-11-30T00:03:14.323Z,1259539394.323 [CBIT] Loaded
2009-11-30T00:03:14.323Z,1259539394.323 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2009-11-30T00:03:14.324Z,1259539394.324 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2009-11-30T00:03:14.324Z,1259539394.324 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2009-11-30T00:03:14.529Z,1259539394.529 [CTD_NeilBrown] Loaded
2009-11-30T00:03:14.529Z,1259539394.529 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2009-11-30T00:03:14.530Z,1259539394.530 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 406614E0
2009-11-30T00:03:14.531Z,1259539394.531 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 917
2009-11-30T00:03:14.585Z,1259539394.585 [CTD_Seabird] Loaded
2009-11-30T00:03:14.585Z,1259539394.585 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2009-11-30T00:03:14.586Z,1259539394.586 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406914E0
2009-11-30T00:03:14.587Z,1259539394.587 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 918
2009-11-30T00:03:14.618Z,1259539394.618 [ESPComponent] Loaded
2009-11-30T00:03:14.618Z,1259539394.618 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2009-11-30T00:03:14.637Z,1259539394.637 [PAR_Licor] Loaded
2009-11-30T00:03:14.638Z,1259539394.638 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2009-11-30T00:03:14.669Z,1259539394.669 [WetLabsBB2FL] Loaded
2009-11-30T00:03:14.669Z,1259539394.669 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2009-11-30T00:03:14.670Z,1259539394.670 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406C14E0
2009-11-30T00:03:14.671Z,1259539394.671 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 919
2009-11-30T00:03:14.671Z,1259539394.671 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2009-11-30T00:03:14.673Z,1259539394.673 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2009-11-30T00:03:14.740Z,1259539394.740 [DepthRateCalculator] Loaded
2009-11-30T00:03:14.741Z,1259539394.741 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2009-11-30T00:03:14.746Z,1259539394.746 [PitchRateCalculator] Loaded
2009-11-30T00:03:14.746Z,1259539394.746 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2009-11-30T00:03:14.756Z,1259539394.756 [SpeedCalculator] Loaded
2009-11-30T00:03:14.757Z,1259539394.757 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2009-11-30T00:03:14.761Z,1259539394.761 [YawRateCalculator] Loaded
2009-11-30T00:03:14.762Z,1259539394.762 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2009-11-30T00:03:14.781Z,1259539394.781 [ElevatorOffsetCalculator] Loaded
2009-11-30T00:03:14.781Z,1259539394.781 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2009-11-30T00:03:14.781Z,1259539394.781 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2009-11-30T00:03:14.782Z,1259539394.782 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2009-11-30T00:03:14.902Z,1259539394.902 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2009-11-30T00:03:14.903Z,1259539394.903 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2009-11-30T00:03:14.945Z,1259539394.945 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2009-11-30T00:03:14.946Z,1259539394.946 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2009-11-30T00:03:15.080Z,1259539395.080 [DeadReckonUsingMultipleVelocitySources] Loaded
2009-11-30T00:03:15.081Z,1259539395.081 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2009-11-30T00:03:15.094Z,1259539395.094 [NavChart] Loaded
2009-11-30T00:03:15.094Z,1259539395.094 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2009-11-30T00:03:15.100Z,1259539395.100 [UniversalFixResidualReporter] Loaded
2009-11-30T00:03:15.100Z,1259539395.100 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2009-11-30T00:03:15.101Z,1259539395.101 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2009-11-30T00:03:15.102Z,1259539395.102 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2009-11-30T00:03:16.003Z,1259539396.003 [AHRS_M2] Loaded
2009-11-30T00:03:16.003Z,1259539396.003 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2009-11-30T00:03:17.089Z,1259539397.089 [BPC1] Loaded
2009-11-30T00:03:17.089Z,1259539397.089 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2009-11-30T00:03:17.414Z,1259539397.414 [DataOverHttps] Loaded
2009-11-30T00:03:17.415Z,1259539397.415 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2009-11-30T00:03:17.416Z,1259539397.416 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A3B4E0
2009-11-30T00:03:17.416Z,1259539397.416 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 920
2009-11-30T00:03:17.436Z,1259539397.436 [Depth_Keller] Loaded
2009-11-30T00:03:17.436Z,1259539397.436 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2009-11-30T00:03:17.441Z,1259539397.441 [DropWeight] Loaded
2009-11-30T00:03:17.441Z,1259539397.441 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2009-11-30T00:03:17.477Z,1259539397.477 [DVL_micro] Loaded
2009-11-30T00:03:17.478Z,1259539397.478 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2009-11-30T00:03:17.535Z,1259539397.535 [NAL9602] Loaded
2009-11-30T00:03:17.535Z,1259539397.535 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2009-11-30T00:03:17.561Z,1259539397.561 [Onboard] Loaded
2009-11-30T00:03:17.562Z,1259539397.562 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2009-11-30T00:03:17.563Z,1259539397.563 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A6B4E0
2009-11-30T00:03:17.563Z,1259539397.563 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 921
2009-11-30T00:03:17.575Z,1259539397.575 [Power24vConverter] Loaded
2009-11-30T00:03:17.575Z,1259539397.575 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2009-11-30T00:03:17.588Z,1259539397.588 [Radio_Surface] Loaded
2009-11-30T00:03:17.588Z,1259539397.588 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2009-11-30T00:03:17.589Z,1259539397.589 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A9B4E0
2009-11-30T00:03:17.590Z,1259539397.590 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 922
2009-11-30T00:03:17.675Z,1259539397.675 [DAT] Loaded
2009-11-30T00:03:17.675Z,1259539397.675 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2009-11-30T00:03:17.676Z,1259539397.676 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40ACB4E0
2009-11-30T00:03:17.676Z,1259539397.676 [DAT ThreadHandler](INFO): Protected caller Thread ID is 923
2009-11-30T00:03:17.677Z,1259539397.677 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2009-11-30T00:03:17.678Z,1259539397.678 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2009-11-30T00:03:17.761Z,1259539397.761 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2009-11-30T00:03:17.761Z,1259539397.761 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2009-11-30T00:03:17.832Z,1259539397.832 [VerticalControl](DEBUG): Construct VerticalControl.
2009-11-30T00:03:17.884Z,1259539397.884 [VerticalControl] Loaded
2009-11-30T00:03:17.884Z,1259539397.884 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2009-11-30T00:03:17.887Z,1259539397.887 [HorizontalControl](DEBUG): Construct HorizontalControl.
2009-11-30T00:03:17.923Z,1259539397.923 [HorizontalControl] Loaded
2009-11-30T00:03:17.923Z,1259539397.923 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2009-11-30T00:03:17.926Z,1259539397.926 [SpeedControl](DEBUG): Construct SpeedControl.
2009-11-30T00:03:17.928Z,1259539397.928 [SpeedControl] Loaded
2009-11-30T00:03:17.928Z,1259539397.928 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2009-11-30T00:03:17.931Z,1259539397.931 [LoopControl](DEBUG): Construct LoopControl.
2009-11-30T00:03:17.931Z,1259539397.931 [LoopControl] Loaded
2009-11-30T00:03:17.931Z,1259539397.931 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2009-11-30T00:03:17.932Z,1259539397.932 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2009-11-30T00:03:17.933Z,1259539397.933 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2009-11-30T00:03:17.948Z,1259539397.948 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2009-11-30T00:03:17.949Z,1259539397.949 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2009-11-30T00:03:18.312Z,1259539398.312 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2009-11-30T00:03:18.318Z,1259539398.318 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2009-11-30T00:03:18.321Z,1259539398.321 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2009-11-30T00:03:18.331Z,1259539398.331 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2009-11-30T00:03:18.333Z,1259539398.333 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BD44E0
2009-11-30T00:03:18.333Z,1259539398.333 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 924
2009-11-30T00:03:18.337Z,1259539398.337 [Supervisor](INFO): Main Thread ID is 827
2009-11-30T00:03:18.338Z,1259539398.338 [Supervisor](DEBUG): Running supervisor.
2009-11-30T00:03:18.338Z,1259539398.338 [CommandExec ThreadHandler](INFO): Handler Thread ID is 925
2009-11-30T00:03:18.339Z,1259539398.339 [CommandExec](INFO): Initializing the command executive.
2009-11-30T00:03:18.340Z,1259539398.340 [CommandLine ThreadHandler](INFO): Handler Thread ID is 926
2009-11-30T00:03:18.342Z,1259539398.342 [controlThread ThreadHandler](INFO): Handler Thread ID is 927
2009-11-30T00:03:18.343Z,1259539398.343 [controlThread](DEBUG): Initializing ControlThread
2009-11-30T00:03:18.345Z,1259539398.345 [SBIT](INFO): Initialize SBIT Component.
2009-11-30T00:03:18.345Z,1259539398.345 [SBIT](IMPORTANT): git: 2022-02-18-48-g1549343b4
2009-11-30T00:03:18.345Z,1259539398.345 [SBIT](INFO): git hash: 1549343b4e331ba79affae8faa75cfd33e9b170a
2009-11-30T00:03:18.346Z,1259539398.346 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2009-11-30T00:03:18.347Z,1259539398.347 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2009-11-30T00:03:18.348Z,1259539398.348 [SBIT](INFO): Beginning SBIT in 59.000000 seconds.
2009-11-30T00:03:18.349Z,1259539398.349 [IBIT](INFO): Initialize IBIT Component.
2009-11-30T00:03:18.349Z,1259539398.349 [CBIT](DEBUG): Initialize CBIT Component.
2009-11-30T00:03:18.350Z,1259539398.350 [logger ThreadHandler](INFO): Handler Thread ID is 928
2009-11-30T00:03:18.360Z,1259539398.360 [CBIT](DEBUG): Initialized mux pins.
2009-11-30T00:03:18.360Z,1259539398.360 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2009-11-30T00:03:18.360Z,1259539398.360 [CBIT](DEBUG): Initializing the watchdog timer.
2009-11-30T00:03:18.368Z,1259539398.368 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 929
2009-11-30T00:03:18.369Z,1259539398.369 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2009-11-30T00:03:18.384Z,1259539398.384 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2009-11-30T00:03:18.385Z,1259539398.385 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 930
2009-11-30T00:03:18.386Z,1259539398.386 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2009-11-30T00:03:18.389Z,1259539398.389 [CBIT](FAULT): Found backtrace file:
1646352882.411977 [DAT]: SIGABRT: execution aborted (failed assertion, corrupted heap, or other problem?)
1646352882.411977 [DAT]: Backtrace:
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x1abc90]
/lib/libc.so.6 [0x403566f8]
Modules/Sensor.so(_ZN3DAT8runnableEv+0x244) [0x407c2d10]
./bin/LRAUV(_ZN9Component15executeRunStateEv+0x7c) [0xea3a8]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xc8) [0x1ab6dc]
2009-11-30T00:03:18.392Z,1259539398.392 [CBIT](FAULT): Renaming backtrace file to Data/backtrace2
2009-11-30T00:03:18.393Z,1259539398.393 [CBIT](DEBUG): Initializing heartbeat.
2009-11-30T00:03:18.400Z,1259539398.400 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 932
2009-11-30T00:03:18.405Z,1259539398.405 [WetLabsBB2FL](INFO): Powering up
2009-11-30T00:03:18.406Z,1259539398.406 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 934
2009-11-30T00:03:18.407Z,1259539398.407 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2009-11-30T00:03:18.457Z,1259539398.457 [Onboard ThreadHandler](INFO): Handler Thread ID is 935
2009-11-30T00:03:18.464Z,1259539398.464 [CBIT](DEBUG): Deactivating GF circuits.
2009-11-30T00:03:18.466Z,1259539398.466 [CBIT](DEBUG): Deactivating emergency mode.
2009-11-30T00:03:18.482Z,1259539398.482 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 936
2009-11-30T00:03:18.493Z,1259539398.493 [DAT ThreadHandler](INFO): Handler Thread ID is 937
2009-11-30T00:03:18.493Z,1259539398.493 [DAT](INFO): Powering up
2009-11-30T00:03:18.494Z,1259539398.494 [DAT](DEBUG): Initializing DAT.
2009-11-30T00:03:18.497Z,1259539398.497 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 939
2009-11-30T00:03:18.504Z,1259539398.504 [CBIT](DEBUG): Backplane powered.
2009-11-30T00:03:18.513Z,1259539398.513 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI01M.000
2009-11-30T00:03:18.513Z,1259539398.513 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI01M.000
2009-11-30T00:03:18.513Z,1259539398.513 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI89M.000
2009-11-30T00:03:18.513Z,1259539398.513 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI89M.000
2009-11-30T00:03:18.513Z,1259539398.513 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI11M.000
2009-11-30T00:03:18.514Z,1259539398.514 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI11M.000
2009-11-30T00:03:18.514Z,1259539398.514 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5MI07M.000
2009-11-30T00:03:18.514Z,1259539398.514 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5MI07M.000
2009-11-30T00:03:18.514Z,1259539398.514 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5OH07M.000
2009-11-30T00:03:18.514Z,1259539398.514 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5OH07M.000
2009-11-30T00:03:18.514Z,1259539398.514 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5OH31M.000
2009-11-30T00:03:18.515Z,1259539398.515 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5OH31M.000
2009-11-30T00:03:18.516Z,1259539398.516 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2009-11-30T00:03:18.517Z,1259539398.517 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2009-11-30T00:03:18.517Z,1259539398.517 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2009-11-30T00:03:18.518Z,1259539398.518 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2009-11-30T00:03:18.518Z,1259539398.518 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2009-11-30T00:03:18.519Z,1259539398.519 [NavChart](DEBUG): Initialize NavChart Navigation.
2009-11-30T00:03:18.520Z,1259539398.520 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2009-11-30T00:03:18.530Z,1259539398.530 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2009-11-30T00:03:18.548Z,1259539398.548 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2009-11-30T00:03:18.549Z,1259539398.549 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2009-11-30T00:03:18.549Z,1259539398.549 [LoopControl](DEBUG): Initialize LoopControlComponent.
2009-11-30T00:03:18.550Z,1259539398.550 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2009-11-30T00:03:18.621Z,1259539398.621 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2009-11-30T00:03:18.633Z,1259539398.633 [MissionManager](DEBUG):
2009-11-30T00:03:18.634Z,1259539398.634 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2009-11-30T00:03:18.712Z,1259539398.712 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2009-11-30T00:03:18.713Z,1259539398.713 [Default:A.Wait](DEBUG): Construct Wait.
2009-11-30T00:03:18.716Z,1259539398.716 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2009-11-30T00:03:18.772Z,1259539398.772 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2009-11-30T00:03:18.775Z,1259539398.775 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2009-11-30T00:03:18.782Z,1259539398.782 [Default:E.Execute](DEBUG): Construct Execute.
2009-11-30T00:03:18.801Z,1259539398.801 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2009-11-30T00:03:18.806Z,1259539398.806 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2009-11-30T00:03:18.822Z,1259539398.822 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2009-11-30T00:03:18.888Z,1259539398.888 [Radio_Surface](INFO): Powering up
2009-11-30T00:03:18.965Z,1259539398.965 [Depth_Keller](ERROR): Pressure reading out of range: 1896.040405 decibar
2009-11-30T00:03:18.973Z,1259539398.973 [Power24vConverter](INFO): Powering up.
2009-11-30T00:03:19.012Z,1259539399.012 [DepthRateCalculator](ERROR): Depth measurement is not active
2009-11-30T00:03:19.049Z,1259539399.049 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2009-11-30T00:03:19.056Z,1259539399.056 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2009-11-30T00:03:19.057Z,1259539399.057 [ElevatorServo](DEBUG): Initializing EZServoServo.
2009-11-30T00:03:19.065Z,1259539399.065 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2009-11-30T00:03:19.065Z,1259539399.065 [MassServo](DEBUG): Initializing EZServoServo.
2009-11-30T00:03:19.072Z,1259539399.072 [MassServo](DEBUG): Initializing MassServo.
2009-11-30T00:03:19.073Z,1259539399.073 [RudderServo](DEBUG): Initializing EZServoServo.
2009-11-30T00:03:19.080Z,1259539399.080 [RudderServo](DEBUG): Initializing RudderServo.
2009-11-30T00:03:19.081Z,1259539399.081 [ThrusterHE](DEBUG): Initializing EZServoServo.
2009-11-30T00:03:19.088Z,1259539399.088 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2009-11-30T00:03:19.090Z,1259539399.090 [CBIT](FAULT): Main Battery Failure. Count: 1
2009-11-30T00:03:19.235Z,1259539399.235 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2009-11-30T00:03:19.236Z,1259539399.236 [DropWeight] Hardware Fault, FailCount= 1
2009-11-30T00:03:19.236Z,1259539399.236 [DropWeight](ERROR): Hardware Fault
2009-11-30T00:03:19.257Z,1259539399.257 [CommandExec](FAULT): Scheduling is paused
2009-11-30T00:03:19.257Z,1259539399.257 [CBIT](INFO): Critical error at 20091130T000319
2009-11-30T00:03:19.258Z,1259539399.258 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2009-11-30T00:03:19.260Z,1259539399.260 [CBIT](ERROR): Hardware Fault in component: DropWeight
2009-11-30T00:03:19.261Z,1259539399.261 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2009-11-30T00:03:19.944Z,1259539399.944 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2009-11-30T00:03:19.944Z,1259539399.944 [RudderServo](FAULT): Rudder failed to initialize
2009-11-30T00:03:19.944Z,1259539399.944 [RudderServo] Communications Fault, FailCount= 1
2009-11-30T00:03:19.944Z,1259539399.944 [RudderServo](ERROR): Communications Fault
2009-11-30T00:03:19.946Z,1259539399.946 [CBIT](INFO): Critical error at 20091130T000319
2009-11-30T00:03:19.948Z,1259539399.948 [CBIT](ERROR): Communications Fault in component: RudderServo
2009-11-30T00:03:20.177Z,1259539400.177 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2009-11-30T00:03:20.177Z,1259539400.177 [RudderServo](INFO): Powering down
2009-11-30T00:03:20.852Z,1259539400.852 [RudderServo](DEBUG): Initializing EZServoServo.
2009-11-30T00:03:20.973Z,1259539400.973 [RudderServo](DEBUG): Initializing RudderServo.
2009-11-30T00:03:20.977Z,1259539400.977 [CBIT](INFO): Clearing failed state for component RudderServo
2009-11-30T00:03:20.977Z,1259539400.977 [RudderServo] No Fault, FailCount= 1
2009-11-30T00:03:22.772Z,1259539402.772 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2009-11-30T00:03:23.228Z,1259539403.228 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2009-11-30T00:03:23.298Z,1259539403.298 [CBIT](FAULT): Main Battery Failure. Count: 11
2009-11-30T00:03:23.660Z,1259539403.660 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2009-11-30T00:03:23.692Z,1259539403.692 [WetLabsBB2FL] Communications Fault, FailCount= 1
2009-11-30T00:03:23.692Z,1259539403.692 [WetLabsBB2FL](ERROR): Communications Fault
2009-11-30T00:03:23.727Z,1259539403.727 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2009-11-30T00:03:24.080Z,1259539404.080 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2009-11-30T00:03:24.192Z,1259539404.192 [WetLabsBB2FL](INFO): Powering down
2009-11-30T00:03:24.948Z,1259539404.948 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:25.371Z,1259539405.371 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2009-11-30T00:03:25.371Z,1259539405.371 [WetLabsBB2FL] No Fault, FailCount= 1
2009-11-30T00:03:25.407Z,1259539405.407 [WetLabsBB2FL](INFO): Powering up
2009-11-30T00:03:25.712Z,1259539405.712 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:26.136Z,1259539406.136 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:26.576Z,1259539406.576 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:27.004Z,1259539407.004 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:27.420Z,1259539407.420 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:27.836Z,1259539407.836 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:27.907Z,1259539407.907 [CBIT](FAULT): Main Battery Failure. Count: 21
2009-11-30T00:03:28.264Z,1259539408.264 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:28.684Z,1259539408.684 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:28.750Z,1259539408.750 [CBIT](CRITICAL): Environmental Failure. Press:14.795480 PSI. Humidity:50%. Temp:20 C. ABORTING MISSION
2009-11-30T00:03:29.116Z,1259539409.116 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:29.190Z,1259539409.190 [CBIT](INFO): Critical error at 20091130T000328
2009-11-30T00:03:29.520Z,1259539409.520 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:29.940Z,1259539409.940 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:30.368Z,1259539410.368 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:30.703Z,1259539410.703 [WetLabsBB2FL] Communications Fault, FailCount= 2
2009-11-30T00:03:30.703Z,1259539410.703 [WetLabsBB2FL](ERROR): Communications Fault
2009-11-30T00:03:30.788Z,1259539410.788 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:30.872Z,1259539410.872 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2009-11-30T00:03:31.208Z,1259539411.208 [WetLabsBB2FL](INFO): Powering down
2009-11-30T00:03:31.209Z,1259539411.209 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:31.440Z,1259539411.440 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2009-11-30T00:03:31.440Z,1259539411.440 [CTD_Seabird] Communications Fault, FailCount= 1
2009-11-30T00:03:31.440Z,1259539411.440 [CTD_Seabird](ERROR): Communications Fault
2009-11-30T00:03:31.632Z,1259539411.632 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:31.720Z,1259539411.720 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2009-11-30T00:03:31.845Z,1259539411.845 [CTD_Seabird](INFO): Powering down
2009-11-30T00:03:32.060Z,1259539412.060 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:32.060Z,1259539412.060 [AHRS_M2](FAULT): Failed to initialize within timeout.
2009-11-30T00:03:32.060Z,1259539412.060 [AHRS_M2] Communications Fault, FailCount= 1
2009-11-30T00:03:32.060Z,1259539412.060 [AHRS_M2](ERROR): Communications Fault
2009-11-30T00:03:32.134Z,1259539412.134 [CBIT](FAULT): Main Battery Failure. Count: 31
2009-11-30T00:03:32.136Z,1259539412.136 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2009-11-30T00:03:32.136Z,1259539412.136 [WetLabsBB2FL] No Fault, FailCount= 2
2009-11-30T00:03:32.137Z,1259539412.137 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2009-11-30T00:03:32.165Z,1259539412.165 [AHRS_M2](INFO): Powering down
2009-11-30T00:03:32.428Z,1259539412.428 [WetLabsBB2FL](INFO): Powering up
2009-11-30T00:03:33.032Z,1259539413.032 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2009-11-30T00:03:33.033Z,1259539413.033 [CTD_Seabird] No Fault, FailCount= 1
2009-11-30T00:03:33.033Z,1259539413.033 [CBIT](INFO): Clearing failed state for component AHRS_M2
2009-11-30T00:03:33.033Z,1259539413.033 [AHRS_M2] No Fault, FailCount= 1
2009-11-30T00:03:33.114Z,1259539413.114 [DAT](INFO): commRate: 1200
2009-11-30T00:03:33.188Z,1259539413.188 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2009-11-30T00:03:33.356Z,1259539413.356 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2009-11-30T00:03:35.180Z,1259539415.180 [DAT](INFO): entering command mode
2009-11-30T00:03:35.381Z,1259539415.381 [DAT](INFO): setting verbose to 3
2009-11-30T00:03:35.634Z,1259539415.634 [DAT](INFO): set verbose to 3
2009-11-30T00:03:35.634Z,1259539415.634 [DAT](INFO): setting DatVerbose to 27440
2009-11-30T00:03:35.834Z,1259539415.834 [CBIT](FAULT): Main Battery Failure. Count: 41
2009-11-30T00:03:35.886Z,1259539415.886 [DAT](INFO): set DatVerbose to 27440
2009-11-30T00:03:35.886Z,1259539415.886 [DAT](INFO): setting transmit power to 8
2009-11-30T00:03:36.137Z,1259539416.137 [DAT](INFO): set transmit power to 8
2009-11-30T00:03:36.138Z,1259539416.138 [DAT](INFO): setting local address to 4
2009-11-30T00:03:36.193Z,1259539416.193 [DVL_micro](FAULT): Failed to initialize within timeout.
2009-11-30T00:03:36.193Z,1259539416.193 [DVL_micro] Communications Fault, FailCount= 1
2009-11-30T00:03:36.193Z,1259539416.193 [DVL_micro](ERROR): Communications Fault
2009-11-30T00:03:36.256Z,1259539416.256 [CBIT](ERROR): Communications Fault in component: DVL_micro
2009-11-30T00:03:36.389Z,1259539416.389 [DAT](INFO): set local address to 4
2009-11-30T00:03:36.391Z,1259539416.391 [DAT](INFO): Setting time to: 0:3:36 And date to:11/30/2009
2009-11-30T00:03:36.641Z,1259539416.641 [DAT](INFO): Local DAT time set to Mon Nov 30, 2009 00:03:36
2009-11-30T00:03:36.896Z,1259539416.896 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:36.972Z,1259539416.972 [DVL_micro](INFO): Powering down
2009-11-30T00:03:37.380Z,1259539417.380 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:37.712Z,1259539417.712 [WetLabsBB2FL] Communications Fault, FailCount= 3
2009-11-30T00:03:37.712Z,1259539417.712 [WetLabsBB2FL](ERROR): Communications Fault
2009-11-30T00:03:37.796Z,1259539417.796 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:37.856Z,1259539417.856 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2009-11-30T00:03:37.856Z,1259539417.856 [CBIT](INFO): Clearing failed state for component DVL_micro
2009-11-30T00:03:37.856Z,1259539417.856 [DVL_micro] No Fault, FailCount= 1
2009-11-30T00:03:38.212Z,1259539418.212 [WetLabsBB2FL](INFO): Powering down
2009-11-30T00:03:38.216Z,1259539418.216 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:38.692Z,1259539418.692 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:39.108Z,1259539419.108 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:39.191Z,1259539419.191 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2009-11-30T00:03:39.191Z,1259539419.191 [WetLabsBB2FL] No Fault, FailCount= 3
2009-11-30T00:03:39.425Z,1259539419.425 [WetLabsBB2FL](INFO): Powering up
2009-11-30T00:03:39.516Z,1259539419.516 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:39.936Z,1259539419.936 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:40.340Z,1259539420.340 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:40.397Z,1259539420.397 [CBIT](FAULT): Main Battery Failure. Count: 51
2009-11-30T00:03:40.752Z,1259539420.752 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:41.177Z,1259539421.177 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:41.596Z,1259539421.596 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:42.024Z,1259539422.024 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:42.432Z,1259539422.432 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:42.852Z,1259539422.852 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:43.292Z,1259539423.292 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:43.708Z,1259539423.708 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:44.132Z,1259539424.132 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:44.345Z,1259539424.345 [CommandExec](IMPORTANT): got command quit
2009-11-30T00:03:44.540Z,1259539424.540 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:44.598Z,1259539424.598 [CBIT](FAULT): Main Battery Failure. Count: 61
2009-11-30T00:03:44.720Z,1259539424.720 [WetLabsBB2FL] Communications Fault, FailCount= 4
2009-11-30T00:03:44.720Z,1259539424.720 [WetLabsBB2FL](ERROR): Communications Fault
2009-11-30T00:03:44.944Z,1259539424.944 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:45.012Z,1259539425.012 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2009-11-30T00:03:45.220Z,1259539425.220 [WetLabsBB2FL](INFO): Powering down
2009-11-30T00:03:45.344Z,1259539425.344 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:45.348Z,1259539425.348 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2009-11-30T00:03:45.348Z,1259539425.348 [CommandExec](INFO): Uninitializing the command executive.
2009-11-30T00:03:45.348Z,1259539425.348 [CommandExec](INFO): Uninitializing the command scheduler.
2009-11-30T00:03:45.348Z,1259539425.348 [CommandExec ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:45.428Z,1259539425.428 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2009-11-30T00:03:45.428Z,1259539425.428 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2009-11-30T00:03:45.428Z,1259539425.428 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:45.429Z,1259539425.429 [NavChartDb](INFO): Join timeout helper Thread ID is 958
2009-11-30T00:03:45.600Z,1259539425.600 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2009-11-30T00:03:45.600Z,1259539425.600 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:45.616Z,1259539425.616 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2009-11-30T00:03:45.616Z,1259539425.616 [DAT ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:45.617Z,1259539425.617 [DAT](INFO): Join timeout helper Thread ID is 959
2009-11-30T00:03:45.716Z,1259539425.716 [DAT](INFO): Powering down
2009-11-30T00:03:45.788Z,1259539425.788 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2009-11-30T00:03:45.789Z,1259539425.789 [DAT](INFO): Powering down
2009-11-30T00:03:45.789Z,1259539425.789 [DAT ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:45.804Z,1259539425.804 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2009-11-30T00:03:45.804Z,1259539425.804 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2009-11-30T00:03:45.804Z,1259539425.804 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:45.805Z,1259539425.805 [Radio_Surface](INFO): Join timeout helper Thread ID is 960
2009-11-30T00:03:45.984Z,1259539425.984 [Radio_Surface](INFO): Powering down
2009-11-30T00:03:45.985Z,1259539425.985 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2009-11-30T00:03:45.985Z,1259539425.985 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:45.992Z,1259539425.992 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2009-11-30T00:03:45.992Z,1259539425.992 [Onboard ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:45.992Z,1259539425.992 [Onboard](INFO): Join timeout helper Thread ID is 961
2009-11-30T00:03:46.240Z,1259539426.240 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2009-11-30T00:03:46.240Z,1259539426.240 [CTD_Seabird] Communications Fault, FailCount= 2
2009-11-30T00:03:46.240Z,1259539426.240 [CTD_Seabird](ERROR): Communications Fault
2009-11-30T00:03:46.365Z,1259539426.365 [AHRS_M2](FAULT): Failed to initialize within timeout.
2009-11-30T00:03:46.365Z,1259539426.365 [AHRS_M2] Communications Fault, FailCount= 2
2009-11-30T00:03:46.365Z,1259539426.365 [AHRS_M2](ERROR): Communications Fault
2009-11-30T00:03:46.411Z,1259539426.411 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2009-11-30T00:03:46.411Z,1259539426.411 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2009-11-30T00:03:46.411Z,1259539426.411 [WetLabsBB2FL] No Fault, FailCount= 4
2009-11-30T00:03:46.411Z,1259539426.411 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2009-11-30T00:03:46.433Z,1259539426.433 [WetLabsBB2FL](INFO): Powering up
2009-11-30T00:03:46.645Z,1259539426.645 [CTD_Seabird](INFO): Powering down
2009-11-30T00:03:46.713Z,1259539426.713 [AHRS_M2](INFO): Powering down
2009-11-30T00:03:47.568Z,1259539427.568 [CBIT](INFO): Clearing failed state for component AHRS_M2
2009-11-30T00:03:47.568Z,1259539427.568 [AHRS_M2] No Fault, FailCount= 2
2009-11-30T00:03:47.913Z,1259539427.913 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2009-11-30T00:03:47.923Z,1259539427.923 [NAL9602](INFO): Powering up NAL9602
2009-11-30T00:03:47.968Z,1259539427.968 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2009-11-30T00:03:47.968Z,1259539427.968 [CTD_Seabird] No Fault, FailCount= 2
2009-11-30T00:03:47.988Z,1259539427.988 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2009-11-30T00:03:48.374Z,1259539428.374 [CBIT](FAULT): Main Battery Failure. Count: 71
2009-11-30T00:03:48.480Z,1259539428.480 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2009-11-30T00:03:48.480Z,1259539428.480 [Onboard ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:48.484Z,1259539428.484 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2009-11-30T00:03:48.484Z,1259539428.484 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:48.484Z,1259539428.484 [DataOverHttps](INFO): Join timeout helper Thread ID is 965
2009-11-30T00:03:48.528Z,1259539428.528 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2009-11-30T00:03:48.529Z,1259539428.529 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:48.538Z,1259539428.538 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2009-11-30T00:03:48.538Z,1259539428.538 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:48.539Z,1259539428.539 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 966
2009-11-30T00:03:48.732Z,1259539428.732 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2009-11-30T00:03:48.828Z,1259539428.828 [WetLabsBB2FL](INFO): Powering down
2009-11-30T00:03:48.829Z,1259539428.829 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:48.849Z,1259539428.849 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2009-11-30T00:03:48.849Z,1259539428.849 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:48.849Z,1259539428.849 [CTD_Seabird](INFO): Join timeout helper Thread ID is 967
2009-11-30T00:03:48.992Z,1259539428.992 [CTD_Seabird](INFO): Powering down
2009-11-30T00:03:49.132Z,1259539429.132 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2009-11-30T00:03:49.132Z,1259539429.132 [CTD_Seabird](INFO): Powering down
2009-11-30T00:03:49.144Z,1259539429.144 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:49.163Z,1259539429.163 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2009-11-30T00:03:49.163Z,1259539429.163 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:49.163Z,1259539429.163 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 969
2009-11-30T00:03:49.184Z,1259539429.184 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2009-11-30T00:03:49.184Z,1259539429.184 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:49.197Z,1259539429.197 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2009-11-30T00:03:49.197Z,1259539429.197 [logger ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:49.198Z,1259539429.198 [logger](INFO): Join timeout helper Thread ID is 970
2009-11-30T00:03:49.201Z,1259539429.201 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2009-11-30T00:03:49.201Z,1259539429.201 [logger ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:49.203Z,1259539429.203 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2009-11-30T00:03:49.203Z,1259539429.203 [CommandLine ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:49.203Z,1259539429.203 [CommandLine](INFO): Join timeout helper Thread ID is 971
2009-11-30T00:03:49.264Z,1259539429.264 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2009-11-30T00:03:49.264Z,1259539429.264 [CommandLine ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:49.281Z,1259539429.281 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2009-11-30T00:03:49.281Z,1259539429.281 [CommandExec ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:49.281Z,1259539429.281 [CommandExec](INFO): Join timeout helper Thread ID is 972
2009-11-30T00:03:49.282Z,1259539429.282 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2009-11-30T00:03:49.283Z,1259539429.283 [controlThread ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:49.283Z,1259539429.283 [controlThread](INFO): Join timeout helper Thread ID is 973
2009-11-30T00:03:49.524Z,1259539429.524 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2009-11-30T00:03:49.524Z,1259539429.524 [controlThread](DEBUG): Uninitializing ControlThread
2009-11-30T00:03:49.526Z,1259539429.526 [AHRS_M2](INFO): Powering down
2009-11-30T00:03:49.668Z,1259539429.668 [DVL_micro](INFO): Powering down
2009-11-30T00:03:49.669Z,1259539429.669 [NAL9602](INFO): Powering down
2009-11-30T00:03:49.670Z,1259539429.670 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2009-11-30T00:03:49.671Z,1259539429.671 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2009-11-30T00:03:49.672Z,1259539429.672 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2009-11-30T00:03:49.672Z,1259539429.672 [MissionManager](INFO): Uninitializing Mission Default
2009-11-30T00:03:49.675Z,1259539429.675 [MissionManager](INFO): Uninitializing Mission Startup
2009-11-30T00:03:49.677Z,1259539429.677 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2009-11-30T00:03:49.677Z,1259539429.677 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2009-11-30T00:03:49.677Z,1259539429.677 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2009-11-30T00:03:49.677Z,1259539429.677 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2009-11-30T00:03:49.678Z,1259539429.678 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2009-11-30T00:03:49.678Z,1259539429.678 [BuoyancyServo](INFO): Powering down
2009-11-30T00:03:49.692Z,1259539429.692 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2009-11-30T00:03:49.692Z,1259539429.692 [ElevatorServo](INFO): Powering down
2009-11-30T00:03:49.693Z,1259539429.693 [MassServo](DEBUG): Uninitialize Mass Servo.
2009-11-30T00:03:49.693Z,1259539429.693 [MassServo](INFO): Powering down
2009-11-30T00:03:49.694Z,1259539429.694 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2009-11-30T00:03:49.694Z,1259539429.694 [RudderServo](INFO): Powering down
2009-11-30T00:03:49.695Z,1259539429.695 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2009-11-30T00:03:49.695Z,1259539429.695 [ThrusterHE](INFO): Powering down
2009-11-30T00:03:49.696Z,1259539429.696 [SBIT](DEBUG): Uninitialize SBIT Component.
2009-11-30T00:03:49.696Z,1259539429.696 [IBIT](DEBUG): Uninitialize IBIT Component.
2009-11-30T00:03:49.697Z,1259539429.697 [CBIT](DEBUG): Uninitialize CBIT Component.
2009-11-30T00:03:49.697Z,1259539429.697 [CBIT](DEBUG): Powering off loads.
2009-11-30T00:03:49.708Z,1259539429.708 [CBIT](DEBUG): Disabling WDT.
2009-11-30T00:03:49.720Z,1259539429.720 [CBIT](DEBUG): Opening all GF detection circuits.
2009-11-30T00:03:49.721Z,1259539429.721 [controlThread ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:50.004Z,1259539430.004 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:50.010Z,1259539430.010 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:50.013Z,1259539430.013 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:50.040Z,1259539430.040 [DAT ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:50.044Z,1259539430.044 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:50.046Z,1259539430.046 [Onboard ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:50.054Z,1259539430.054 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:50.140Z,1259539430.140 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2009-11-30T00:03:50.201Z,1259539430.201 [logger ThreadHandler](INFO): Thread cancelled.