2000-02-04T03:04:09.028Z,949633449.028 [Supervisor](DEBUG): Initializing supervisor. 2000-02-04T03:04:09.033Z,949633449.033 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2000-02-04T03:04:09.033Z,949633449.033 [SyncHandler](INFO): Protected caller Thread ID is 839 2000-02-04T03:04:09.033Z,949633449.033 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2000-02-04T03:04:09.034Z,949633449.034 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2000-02-04T03:04:09.035Z,949633449.035 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 840 2000-02-04T03:04:09.038Z,949633449.038 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2000-02-04T03:04:09.056Z,949633449.056 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2000-02-04T03:04:09.057Z,949633449.057 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2000-02-04T03:04:09.058Z,949633449.058 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 841 2000-02-04T03:04:09.062Z,949633449.062 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2000-02-04T03:04:09.063Z,949633449.063 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2000-02-04T03:04:09.063Z,949633449.063 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 842 2000-02-04T03:04:09.065Z,949633449.065 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2000-02-04T03:04:09.066Z,949633449.066 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2000-02-04T03:04:09.067Z,949633449.067 [logger ThreadHandler](INFO): Protected caller Thread ID is 843 2000-02-04T03:04:09.070Z,949633449.070 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2000-02-04T03:04:09.071Z,949633449.071 [Supervisor](INFO): Looking for Config files in directory: Config/ 2000-02-04T03:04:09.075Z,949633449.075 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2000-02-04T03:04:09.489Z,949633449.489 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2000-02-04T03:04:09.491Z,949633449.491 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2000-02-04T03:04:10.847Z,949633450.847 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2000-02-04T03:04:10.849Z,949633450.849 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2000-02-04T03:04:10.969Z,949633450.969 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2000-02-04T03:04:10.971Z,949633450.971 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2000-02-04T03:04:11.536Z,949633451.536 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2000-02-04T03:04:11.538Z,949633451.538 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2000-02-04T03:04:11.646Z,949633451.646 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2000-02-04T03:04:11.648Z,949633451.648 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2000-02-04T03:04:11.742Z,949633451.742 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2000-02-04T03:04:12.436Z,949633452.436 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2000-02-04T03:04:12.436Z,949633452.436 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2000-02-04T03:04:12.676Z,949633452.676 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2000-02-04T03:04:12.677Z,949633452.677 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2000-02-04T03:04:12.830Z,949633452.830 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2000-02-04T03:04:12.832Z,949633452.832 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2000-02-04T03:04:13.088Z,949633453.088 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2000-02-04T03:04:13.089Z,949633453.089 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2000-02-04T03:04:13.651Z,949633453.651 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2000-02-04T03:04:13.652Z,949633453.652 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2000-02-04T03:04:14.052Z,949633454.052 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2000-02-04T03:04:14.053Z,949633454.053 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2000-02-04T03:04:14.146Z,949633454.146 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2000-02-04T03:04:14.353Z,949633454.353 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2000-02-04T03:04:14.355Z,949633454.355 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2000-02-04T03:04:14.599Z,949633454.599 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2000-02-04T03:04:14.601Z,949633454.601 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2000-02-04T03:04:14.913Z,949633454.913 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2000-02-04T03:04:14.915Z,949633454.915 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/ 2000-02-04T03:04:14.920Z,949633454.920 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg 2000-02-04T03:04:15.039Z,949633455.039 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg 2000-02-04T03:04:15.203Z,949633455.203 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg 2000-02-04T03:04:15.300Z,949633455.300 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg 2000-02-04T03:04:15.395Z,949633455.395 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg 2000-02-04T03:04:15.515Z,949633455.515 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/workSite.cfg 2000-02-04T03:04:15.611Z,949633455.611 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg 2000-02-04T03:04:15.728Z,949633455.728 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg 2000-02-04T03:04:16.001Z,949633456.001 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2000-02-04T03:04:16.002Z,949633456.002 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg 2000-02-04T03:04:16.150Z,949633456.150 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg 2000-02-04T03:04:16.254Z,949633456.254 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg 2000-02-04T03:04:16.361Z,949633456.361 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg 2000-02-04T03:04:16.477Z,949633456.477 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2000-02-04T03:04:16.482Z,949633456.482 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2000-02-04T03:04:16.624Z,949633456.624 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2000-02-04T03:04:16.625Z,949633456.625 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2000-02-04T03:04:16.640Z,949633456.640 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2000-02-04T03:04:16.641Z,949633456.641 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2000-02-04T03:04:16.710Z,949633456.710 [DepthRateCalculator] Loaded 2000-02-04T03:04:16.710Z,949633456.710 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2000-02-04T03:04:16.716Z,949633456.716 [PitchRateCalculator] Loaded 2000-02-04T03:04:16.716Z,949633456.716 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2000-02-04T03:04:16.726Z,949633456.726 [SpeedCalculator] Loaded 2000-02-04T03:04:16.726Z,949633456.726 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2000-02-04T03:04:16.731Z,949633456.731 [YawRateCalculator] Loaded 2000-02-04T03:04:16.731Z,949633456.731 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2000-02-04T03:04:16.752Z,949633456.752 [ElevatorOffsetCalculator] Loaded 2000-02-04T03:04:16.753Z,949633456.753 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2000-02-04T03:04:16.753Z,949633456.753 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2000-02-04T03:04:16.754Z,949633456.754 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2000-02-04T03:04:16.822Z,949633456.822 [VerticalControl](DEBUG): Construct VerticalControl. 2000-02-04T03:04:16.878Z,949633456.878 [VerticalControl] Loaded 2000-02-04T03:04:16.878Z,949633456.878 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2000-02-04T03:04:16.881Z,949633456.881 [HorizontalControl](DEBUG): Construct HorizontalControl. 2000-02-04T03:04:16.927Z,949633456.927 [HorizontalControl] Loaded 2000-02-04T03:04:16.928Z,949633456.928 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2000-02-04T03:04:16.930Z,949633456.930 [SpeedControl](DEBUG): Construct SpeedControl. 2000-02-04T03:04:16.933Z,949633456.933 [SpeedControl] Loaded 2000-02-04T03:04:16.933Z,949633456.933 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2000-02-04T03:04:16.936Z,949633456.936 [LoopControl](DEBUG): Construct LoopControl. 2000-02-04T03:04:16.936Z,949633456.936 [LoopControl] Loaded 2000-02-04T03:04:16.937Z,949633456.937 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2000-02-04T03:04:16.937Z,949633456.937 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2000-02-04T03:04:16.937Z,949633456.937 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2000-02-04T03:04:17.074Z,949633457.074 [DeadReckonUsingMultipleVelocitySources] Loaded 2000-02-04T03:04:17.074Z,949633457.074 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2000-02-04T03:04:17.088Z,949633457.088 [NavChart] Loaded 2000-02-04T03:04:17.088Z,949633457.088 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2000-02-04T03:04:17.094Z,949633457.094 [UniversalFixResidualReporter] Loaded 2000-02-04T03:04:17.094Z,949633457.094 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2000-02-04T03:04:17.095Z,949633457.095 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2000-02-04T03:04:17.097Z,949633457.097 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2000-02-04T03:04:17.303Z,949633457.303 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2000-02-04T03:04:17.304Z,949633457.304 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2000-02-04T03:04:18.317Z,949633458.317 [AHRS_M2] Loaded 2000-02-04T03:04:18.318Z,949633458.318 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2000-02-04T03:04:18.592Z,949633458.592 [BackseatComponent] Loaded 2000-02-04T03:04:18.592Z,949633458.592 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2000-02-04T03:04:18.593Z,949633458.593 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409214E0 2000-02-04T03:04:18.594Z,949633458.594 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 928 2000-02-04T03:04:18.596Z,949633458.596 [LcmUniversalReporter] Loaded 2000-02-04T03:04:18.597Z,949633458.597 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2000-02-04T03:04:19.421Z,949633459.421 [BPC1] Loaded 2000-02-04T03:04:19.421Z,949633459.421 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2000-02-04T03:04:19.750Z,949633459.750 [DataOverHttps] Loaded 2000-02-04T03:04:19.751Z,949633459.751 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2000-02-04T03:04:19.752Z,949633459.752 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409514E0 2000-02-04T03:04:19.752Z,949633459.752 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 929 2000-02-04T03:04:19.775Z,949633459.775 [Depth_Keller] Loaded 2000-02-04T03:04:19.775Z,949633459.775 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2000-02-04T03:04:19.780Z,949633459.780 [DropWeight] Loaded 2000-02-04T03:04:19.780Z,949633459.780 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2000-02-04T03:04:19.832Z,949633459.832 [DVL_micro] Loaded 2000-02-04T03:04:19.832Z,949633459.832 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2000-02-04T03:04:19.896Z,949633459.896 [NAL9602] Loaded 2000-02-04T03:04:19.896Z,949633459.896 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2000-02-04T03:04:19.925Z,949633459.925 [Onboard] Loaded 2000-02-04T03:04:19.926Z,949633459.926 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2000-02-04T03:04:19.927Z,949633459.927 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409814E0 2000-02-04T03:04:19.927Z,949633459.927 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 930 2000-02-04T03:04:19.941Z,949633459.941 [Power24vConverter] Loaded 2000-02-04T03:04:19.941Z,949633459.941 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2000-02-04T03:04:19.956Z,949633459.956 [Radio_Surface] Loaded 2000-02-04T03:04:19.957Z,949633459.957 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2000-02-04T03:04:19.958Z,949633459.958 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409B14E0 2000-02-04T03:04:19.958Z,949633459.958 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 931 2000-02-04T03:04:19.973Z,949633459.973 [Sonardyne_Nano] Loaded 2000-02-04T03:04:19.974Z,949633459.974 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2000-02-04T03:04:20.070Z,949633460.070 [DAT] Loaded 2000-02-04T03:04:20.070Z,949633460.070 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2000-02-04T03:04:20.071Z,949633460.071 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409E14E0 2000-02-04T03:04:20.072Z,949633460.072 [DAT ThreadHandler](INFO): Protected caller Thread ID is 932 2000-02-04T03:04:20.072Z,949633460.072 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2000-02-04T03:04:20.073Z,949633460.073 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2000-02-04T03:04:20.233Z,949633460.233 [BuoyancyServo] Loaded 2000-02-04T03:04:20.234Z,949633460.234 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2000-02-04T03:04:20.256Z,949633460.256 [ElevatorServo] Loaded 2000-02-04T03:04:20.257Z,949633460.257 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2000-02-04T03:04:20.278Z,949633460.278 [MassServo] Loaded 2000-02-04T03:04:20.279Z,949633460.279 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2000-02-04T03:04:20.299Z,949633460.299 [RudderServo] Loaded 2000-02-04T03:04:20.299Z,949633460.299 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2000-02-04T03:04:20.315Z,949633460.315 [ThrusterHE] Loaded 2000-02-04T03:04:20.316Z,949633460.316 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2000-02-04T03:04:20.316Z,949633460.316 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2000-02-04T03:04:20.317Z,949633460.317 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2000-02-04T03:04:20.399Z,949633460.399 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2000-02-04T03:04:20.399Z,949633460.399 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2000-02-04T03:04:20.442Z,949633460.442 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2000-02-04T03:04:20.443Z,949633460.443 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2000-02-04T03:04:20.836Z,949633460.836 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2000-02-04T03:04:20.837Z,949633460.837 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2000-02-04T03:04:21.062Z,949633461.062 [CTD_Seabird] Loaded 2000-02-04T03:04:21.062Z,949633461.062 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2000-02-04T03:04:21.063Z,949633461.063 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B984E0 2000-02-04T03:04:21.063Z,949633461.063 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 933 2000-02-04T03:04:21.099Z,949633461.099 [ESPComponent] Loaded 2000-02-04T03:04:21.100Z,949633461.100 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2000-02-04T03:04:21.122Z,949633461.122 [PAR_Licor] Loaded 2000-02-04T03:04:21.122Z,949633461.122 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2000-02-04T03:04:21.167Z,949633461.167 [WetLabsBB2FL] Loaded 2000-02-04T03:04:21.167Z,949633461.167 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2000-02-04T03:04:21.168Z,949633461.168 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BC84E0 2000-02-04T03:04:21.168Z,949633461.168 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 934 2000-02-04T03:04:21.169Z,949633461.169 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2000-02-04T03:04:21.170Z,949633461.170 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2000-02-04T03:04:21.338Z,949633461.338 [SBIT](DEBUG): Construct Startup Built In Test. 2000-02-04T03:04:21.347Z,949633461.347 [SBIT] Loaded 2000-02-04T03:04:21.348Z,949633461.348 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2000-02-04T03:04:21.351Z,949633461.351 [IBIT](DEBUG): Construct Initiated Built In Test. 2000-02-04T03:04:21.363Z,949633461.363 [IBIT] Loaded 2000-02-04T03:04:21.364Z,949633461.364 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2000-02-04T03:04:21.370Z,949633461.370 [CBIT](DEBUG): Construct Continuous Built In Test. 2000-02-04T03:04:21.476Z,949633461.476 [CBIT] Loaded 2000-02-04T03:04:21.476Z,949633461.476 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2000-02-04T03:04:21.476Z,949633461.476 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2000-02-04T03:04:21.483Z,949633461.483 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2000-02-04T03:04:21.486Z,949633461.486 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2000-02-04T03:04:21.497Z,949633461.497 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2000-02-04T03:04:21.498Z,949633461.498 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0 2000-02-04T03:04:21.499Z,949633461.499 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 935 2000-02-04T03:04:21.503Z,949633461.503 [Supervisor](INFO): Main Thread ID is 832 2000-02-04T03:04:21.503Z,949633461.503 [Supervisor](DEBUG): Running supervisor. 2000-02-04T03:04:21.504Z,949633461.504 [CommandExec ThreadHandler](INFO): Handler Thread ID is 936 2000-02-04T03:04:21.504Z,949633461.504 [CommandExec](INFO): Initializing the command executive. 2000-02-04T03:04:21.506Z,949633461.506 [CommandLine ThreadHandler](INFO): Handler Thread ID is 937 2000-02-04T03:04:21.508Z,949633461.508 [controlThread ThreadHandler](INFO): Handler Thread ID is 938 2000-02-04T03:04:21.508Z,949633461.508 [controlThread](DEBUG): Initializing ControlThread 2000-02-04T03:04:21.509Z,949633461.509 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2000-02-04T03:04:21.509Z,949633461.509 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2000-02-04T03:04:21.510Z,949633461.510 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2000-02-04T03:04:21.510Z,949633461.510 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2000-02-04T03:04:21.510Z,949633461.510 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2000-02-04T03:04:21.511Z,949633461.511 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2000-02-04T03:04:21.513Z,949633461.513 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2000-02-04T03:04:21.513Z,949633461.513 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2000-02-04T03:04:21.514Z,949633461.514 [LoopControl](DEBUG): Initialize LoopControlComponent. 2000-02-04T03:04:21.515Z,949633461.515 [NavChart](DEBUG): Initialize NavChart Navigation. 2000-02-04T03:04:21.515Z,949633461.515 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2000-02-04T03:04:21.525Z,949633461.525 [SBIT](INFO): Initialize SBIT Component. 2000-02-04T03:04:21.525Z,949633461.525 [SBIT](IMPORTANT): git: 2024-06-04 2000-02-04T03:04:21.526Z,949633461.526 [SBIT](INFO): git hash: 665aaa51948338ae26aa7901209e8336b196d4d1 2000-02-04T03:04:21.526Z,949633461.526 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2000-02-04T03:04:21.527Z,949633461.527 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Sep 24 11:12:27 PDT 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2000-02-04T03:04:21.528Z,949633461.528 [SBIT](INFO): Beginning SBIT in 134.000000 seconds. 2000-02-04T03:04:21.529Z,949633461.529 [IBIT](INFO): Initialize IBIT Component. 2000-02-04T03:04:21.530Z,949633461.530 [CBIT](DEBUG): Initialize CBIT Component. 2000-02-04T03:04:21.530Z,949633461.530 [logger ThreadHandler](INFO): Handler Thread ID is 939 2000-02-04T03:04:21.541Z,949633461.541 [CBIT](DEBUG): Initialized mux pins. 2000-02-04T03:04:21.541Z,949633461.541 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2000-02-04T03:04:21.541Z,949633461.541 [CBIT](DEBUG): Initializing the watchdog timer. 2000-02-04T03:04:21.549Z,949633461.549 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 940 2000-02-04T03:04:21.561Z,949633461.561 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 941 2000-02-04T03:04:21.563Z,949633461.563 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2000-02-04T03:04:21.565Z,949633461.565 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2000-02-04T03:04:21.565Z,949633461.565 [CBIT](DEBUG): Initializing heartbeat. 2000-02-04T03:04:21.573Z,949633461.573 [Onboard ThreadHandler](INFO): Handler Thread ID is 942 2000-02-04T03:04:21.591Z,949633461.591 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 943 2000-02-04T03:04:21.610Z,949633461.610 [DAT ThreadHandler](INFO): Handler Thread ID is 944 2000-02-04T03:04:21.610Z,949633461.610 [DAT](INFO): Powering up 2000-02-04T03:04:21.610Z,949633461.610 [DAT](DEBUG): Initializing DAT. 2000-02-04T03:04:21.614Z,949633461.614 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 946 2000-02-04T03:04:21.615Z,949633461.615 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2000-02-04T03:04:21.618Z,949633461.618 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 948 2000-02-04T03:04:21.621Z,949633461.621 [WetLabsBB2FL](INFO): Powering up 2000-02-04T03:04:21.622Z,949633461.622 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 950 2000-02-04T03:04:21.631Z,949633461.631 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK1NORSO.000 2000-02-04T03:04:21.631Z,949633461.631 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK1NORSO.000 2000-02-04T03:04:21.631Z,949633461.631 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK2NORS.000 2000-02-04T03:04:21.631Z,949633461.631 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK2NORS.000 2000-02-04T03:04:21.631Z,949633461.631 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK3HORRO.000 2000-02-04T03:04:21.631Z,949633461.631 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK3HORRO.000 2000-02-04T03:04:21.637Z,949633461.637 [CBIT](DEBUG): Deactivating GF circuits. 2000-02-04T03:04:21.637Z,949633461.637 [CBIT](DEBUG): Deactivating emergency mode. 2000-02-04T03:04:21.677Z,949633461.677 [CBIT](DEBUG): Backplane powered. 2000-02-04T03:04:21.677Z,949633461.677 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2000-02-04T03:04:21.678Z,949633461.678 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2000-02-04T03:04:21.678Z,949633461.678 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2000-02-04T03:04:21.685Z,949633461.685 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2000-02-04T03:04:21.724Z,949633461.724 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2000-02-04T03:04:21.741Z,949633461.741 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2000-02-04T03:04:21.765Z,949633461.765 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2000-02-04T03:04:21.766Z,949633461.766 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2000-02-04T03:04:21.766Z,949633461.766 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2000-02-04T03:04:21.781Z,949633461.781 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2000-02-04T03:04:21.997Z,949633461.997 [Radio_Surface](INFO): Powering up 2000-02-04T03:04:22.039Z,949633462.039 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2000-02-04T03:04:22.065Z,949633462.065 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2000-02-04T03:04:22.066Z,949633462.066 [Default:A.Wait](DEBUG): Construct Wait. 2000-02-04T03:04:22.068Z,949633462.068 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2000-02-04T03:04:22.108Z,949633462.108 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2000-02-04T03:04:22.122Z,949633462.122 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2000-02-04T03:04:22.128Z,949633462.128 [Default:E.Execute](DEBUG): Construct Execute. 2000-02-04T03:04:22.143Z,949633462.143 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2000-02-04T03:04:22.147Z,949633462.147 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2000-02-04T03:04:22.174Z,949633462.174 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2000-02-04T03:04:22.282Z,949633462.282 [Power24vConverter](INFO): Powering up. 2000-02-04T03:04:22.283Z,949633462.283 [Sonardyne_Nano](INFO): Initializing. 2000-02-04T03:04:22.362Z,949633462.362 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2000-02-04T03:04:22.369Z,949633462.369 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2000-02-04T03:04:22.370Z,949633462.370 [ElevatorServo](DEBUG): Initializing EZServoServo. 2000-02-04T03:04:22.377Z,949633462.377 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2000-02-04T03:04:22.378Z,949633462.378 [MassServo](DEBUG): Initializing EZServoServo. 2000-02-04T03:04:22.385Z,949633462.385 [MassServo](DEBUG): Initializing MassServo. 2000-02-04T03:04:22.386Z,949633462.386 [RudderServo](DEBUG): Initializing EZServoServo. 2000-02-04T03:04:22.393Z,949633462.393 [RudderServo](DEBUG): Initializing RudderServo. 2000-02-04T03:04:22.394Z,949633462.394 [ThrusterHE](DEBUG): Initializing EZServoServo. 2000-02-04T03:04:22.401Z,949633462.401 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2000-02-04T03:04:22.585Z,949633462.585 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2000-02-04T03:04:22.585Z,949633462.585 [DropWeight] Hardware Fault, FailCount= 1 2000-02-04T03:04:22.585Z,949633462.585 [DropWeight](ERROR): Hardware Fault 2000-02-04T03:04:22.622Z,949633462.622 [CommandExec](FAULT): Scheduling is paused 2000-02-04T03:04:22.623Z,949633462.623 [CBIT](INFO): Critical error at 20000204T030422 2000-02-04T03:04:22.623Z,949633462.623 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2000-02-04T03:04:22.633Z,949633462.633 [CBIT](ERROR): Hardware Fault in component: DropWeight 2000-02-04T03:04:22.633Z,949633462.633 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2000-02-04T03:04:23.001Z,949633463.001 [CBIT](INFO): Critical error at 20000204T030422 2000-02-04T03:04:25.709Z,949633465.709 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:26.109Z,949633466.109 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:26.585Z,949633466.585 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:26.909Z,949633466.909 [WetLabsBB2FL] Communications Fault, FailCount= 1 2000-02-04T03:04:26.909Z,949633466.909 [WetLabsBB2FL](ERROR): Communications Fault 2000-02-04T03:04:27.009Z,949633467.009 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:27.227Z,949633467.227 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2000-02-04T03:04:27.409Z,949633467.409 [WetLabsBB2FL](INFO): Powering down 2000-02-04T03:04:27.565Z,949633467.565 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:27.698Z,949633467.698 [RudderServo](FAULT): Overload Error 2000-02-04T03:04:27.698Z,949633467.698 [RudderServo] Hardware Fault, FailCount= 1 2000-02-04T03:04:27.698Z,949633467.698 [RudderServo](ERROR): Hardware Fault 2000-02-04T03:04:27.736Z,949633467.736 [CBIT](ERROR): Hardware Fault in component: RudderServo 2000-02-04T03:04:28.057Z,949633468.057 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:28.122Z,949633468.122 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2000-02-04T03:04:28.122Z,949633468.122 [RudderServo](INFO): Powering down 2000-02-04T03:04:28.123Z,949633468.123 [ThrusterHE](ERROR): Zero Speed Commanded. 2000-02-04T03:04:28.521Z,949633468.521 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:28.713Z,949633468.713 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2000-02-04T03:04:28.713Z,949633468.713 [WetLabsBB2FL] No Fault, FailCount= 1 2000-02-04T03:04:29.026Z,949633469.026 [WetLabsBB2FL](INFO): Powering up 2000-02-04T03:04:29.033Z,949633469.033 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:29.125Z,949633469.125 [RudderServo](DEBUG): Initializing EZServoServo. 2000-02-04T03:04:29.246Z,949633469.246 [RudderServo](DEBUG): Initializing RudderServo. 2000-02-04T03:04:29.250Z,949633469.250 [CBIT](INFO): Clearing failed state for component RudderServo 2000-02-04T03:04:29.250Z,949633469.250 [RudderServo] No Fault, FailCount= 1 2000-02-04T03:04:29.589Z,949633469.589 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:30.057Z,949633470.057 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:30.533Z,949633470.533 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:30.969Z,949633470.969 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:31.445Z,949633471.445 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:31.869Z,949633471.869 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:32.341Z,949633472.341 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:32.773Z,949633472.773 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:33.261Z,949633473.261 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:33.725Z,949633473.725 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:34.169Z,949633474.169 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:34.224Z,949633474.224 [DAT](INFO): DAT read: 2000-02-04T03:04:34.321Z,949633474.321 [WetLabsBB2FL] Communications Fault, FailCount= 2 2000-02-04T03:04:34.321Z,949633474.321 [WetLabsBB2FL](ERROR): Communications Fault 2000-02-04T03:04:34.474Z,949633474.474 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2000-02-04T03:04:34.613Z,949633474.613 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:34.665Z,949633474.665 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2000-02-04T03:04:34.665Z,949633474.665 [CTD_Seabird] Communications Fault, FailCount= 1 2000-02-04T03:04:34.665Z,949633474.665 [CTD_Seabird](ERROR): Communications Fault 2000-02-04T03:04:34.733Z,949633474.733 [RudderServo](FAULT): Overload Error 2000-02-04T03:04:34.733Z,949633474.733 [RudderServo] Hardware Fault, FailCount= 2 2000-02-04T03:04:34.733Z,949633474.733 [RudderServo](ERROR): Hardware Fault 2000-02-04T03:04:34.761Z,949633474.761 [CBIT](ERROR): Hardware Fault in component: RudderServo 2000-02-04T03:04:34.761Z,949633474.761 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2000-02-04T03:04:34.761Z,949633474.761 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2000-02-04T03:04:34.821Z,949633474.821 [WetLabsBB2FL](INFO): Powering down 2000-02-04T03:04:35.070Z,949633475.070 [CTD_Seabird](INFO): Powering down 2000-02-04T03:04:35.093Z,949633475.093 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:35.093Z,949633475.093 [AHRS_M2](FAULT): Failed to initialize within timeout. 2000-02-04T03:04:35.093Z,949633475.093 [AHRS_M2] Communications Fault, FailCount= 1 2000-02-04T03:04:35.093Z,949633475.093 [AHRS_M2](ERROR): Communications Fault 2000-02-04T03:04:35.190Z,949633475.190 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2000-02-04T03:04:35.190Z,949633475.190 [RudderServo](INFO): Powering down 2000-02-04T03:04:35.194Z,949633475.194 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2000-02-04T03:04:35.201Z,949633475.201 [AHRS_M2](INFO): Powering down 2000-02-04T03:04:35.701Z,949633475.701 [RudderServo](DEBUG): Initializing EZServoServo. 2000-02-04T03:04:35.822Z,949633475.822 [RudderServo](DEBUG): Initializing RudderServo. 2000-02-04T03:04:35.826Z,949633475.826 [CBIT](INFO): Clearing failed state for component RudderServo 2000-02-04T03:04:35.826Z,949633475.826 [RudderServo] No Fault, FailCount= 2 2000-02-04T03:04:35.826Z,949633475.826 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2000-02-04T03:04:35.826Z,949633475.826 [WetLabsBB2FL] No Fault, FailCount= 2 2000-02-04T03:04:35.989Z,949633475.989 [DAT](INFO): DAT read: MF Frequency Band 2000-02-04T03:04:35.991Z,949633475.991 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2000-02-04T03:04:35.991Z,949633475.991 [DAT](INFO): DAT read: Jul 17 2024 18:21:16 2000-02-04T03:04:36.074Z,949633476.074 [WetLabsBB2FL](INFO): Powering up 2000-02-04T03:04:36.089Z,949633476.089 [CBIT](INFO): Clearing failed state for component AHRS_M2 2000-02-04T03:04:36.089Z,949633476.089 [AHRS_M2] No Fault, FailCount= 1 2000-02-04T03:04:36.089Z,949633476.089 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2000-02-04T03:04:36.089Z,949633476.089 [CTD_Seabird] No Fault, FailCount= 1 2000-02-04T03:04:36.410Z,949633476.410 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2000-02-04T03:04:36.413Z,949633476.413 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2000-02-04T03:04:37.002Z,949633477.002 [DAT](INFO): DAT read: Features enabled [Bearing] 2000-02-04T03:04:37.250Z,949633477.250 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2000-02-04T03:04:37.251Z,949633477.251 [DAT](INFO): commRate: 800 2000-02-04T03:04:39.317Z,949633479.317 [DAT](INFO): entering command mode 2000-02-04T03:04:39.517Z,949633479.517 [DAT](INFO): DAT read: 2000-02-04T03:04:39.518Z,949633479.518 [DAT](INFO): DAT read: user:1> 2000-02-04T03:04:39.518Z,949633479.518 [DAT](INFO): setting verbose to 3 2000-02-04T03:04:39.769Z,949633479.769 [DAT](INFO): DAT read: user:1> 2000-02-04T03:04:39.770Z,949633479.770 [DAT](INFO): DAT read: Verbose | 3 2000-02-04T03:04:39.771Z,949633479.771 [DAT](INFO): set verbose to 3 2000-02-04T03:04:39.771Z,949633479.771 [DAT](INFO): setting DatVerbose to 27440 2000-02-04T03:04:39.969Z,949633479.969 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:39.978Z,949633479.978 [DVL_micro](FAULT): Failed to initialize within timeout. 2000-02-04T03:04:39.978Z,949633479.978 [DVL_micro] Communications Fault, FailCount= 1 2000-02-04T03:04:39.978Z,949633479.978 [DVL_micro](ERROR): Communications Fault 2000-02-04T03:04:40.021Z,949633480.021 [DAT](INFO): DAT read: user:2> 2000-02-04T03:04:40.022Z,949633480.022 [DAT](INFO): DAT read: DatVerbose | 27440 2000-02-04T03:04:40.023Z,949633480.023 [DAT](INFO): set DatVerbose to 27440 2000-02-04T03:04:40.023Z,949633480.023 [DAT](INFO): setting transmit power to 8 2000-02-04T03:04:40.185Z,949633480.185 [CBIT](ERROR): Communications Fault in component: DVL_micro 2000-02-04T03:04:40.273Z,949633480.273 [DAT](INFO): DAT read: user:3> 2000-02-04T03:04:40.274Z,949633480.274 [DAT](INFO): DAT read: TxPower | 8 (Max) 2000-02-04T03:04:40.275Z,949633480.275 [DAT](INFO): set transmit power to 8 2000-02-04T03:04:40.275Z,949633480.275 [DAT](INFO): setting local address to 11 2000-02-04T03:04:40.517Z,949633480.517 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:40.525Z,949633480.525 [DAT](INFO): DAT read: user:4> 2000-02-04T03:04:40.526Z,949633480.526 [DAT](INFO): DAT read: LocalAddr | 11 2000-02-04T03:04:40.527Z,949633480.527 [DAT](INFO): set local address to 11 2000-02-04T03:04:40.528Z,949633480.528 [DAT](INFO): Setting time to: 3:4:40 And date to:2/4/2000 2000-02-04T03:04:40.613Z,949633480.613 [DVL_micro](INFO): Powering down 2000-02-04T03:04:40.777Z,949633480.777 [DAT](INFO): DAT read: user:5> 2000-02-04T03:04:40.778Z,949633480.778 [DAT](INFO): DAT read: Fri Feb 4, 2000 03:04:40 2000-02-04T03:04:40.779Z,949633480.779 [DAT](INFO): Local DAT time set to Fri Feb 4, 2000 03:04:40 2000-02-04T03:04:41.025Z,949633481.025 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:41.201Z,949633481.201 [RudderServo](FAULT): Overload Error 2000-02-04T03:04:41.201Z,949633481.201 [RudderServo] Hardware Fault, FailCount= 3 2000-02-04T03:04:41.201Z,949633481.201 [RudderServo](ERROR): Hardware Fault 2000-02-04T03:04:41.239Z,949633481.239 [CBIT](ERROR): Hardware Fault in component: RudderServo 2000-02-04T03:04:41.239Z,949633481.239 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2000-02-04T03:04:41.329Z,949633481.329 [WetLabsBB2FL] Communications Fault, FailCount= 3 2000-02-04T03:04:41.329Z,949633481.329 [WetLabsBB2FL](ERROR): Communications Fault 2000-02-04T03:04:41.573Z,949633481.573 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:41.657Z,949633481.657 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2000-02-04T03:04:41.657Z,949633481.657 [RudderServo](INFO): Powering down 2000-02-04T03:04:41.660Z,949633481.660 [CBIT](INFO): Critical error at 20000204T030441 2000-02-04T03:04:41.662Z,949633481.662 [CBIT](INFO): Clearing failed state for component DVL_micro 2000-02-04T03:04:41.662Z,949633481.662 [DVL_micro] No Fault, FailCount= 1 2000-02-04T03:04:41.663Z,949633481.663 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2000-02-04T03:04:41.829Z,949633481.829 [WetLabsBB2FL](INFO): Powering down 2000-02-04T03:04:41.993Z,949633481.993 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:42.393Z,949633482.393 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:42.448Z,949633482.448 [RudderServo](DEBUG): Initializing EZServoServo. 2000-02-04T03:04:42.566Z,949633482.566 [RudderServo](DEBUG): Initializing RudderServo. 2000-02-04T03:04:42.897Z,949633482.897 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:42.964Z,949633482.964 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2000-02-04T03:04:42.964Z,949633482.964 [WetLabsBB2FL] No Fault, FailCount= 3 2000-02-04T03:04:43.042Z,949633483.042 [WetLabsBB2FL](INFO): Powering up 2000-02-04T03:04:43.305Z,949633483.305 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:43.709Z,949633483.709 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:44.109Z,949633484.109 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:44.509Z,949633484.509 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:44.921Z,949633484.921 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:45.325Z,949633485.325 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:45.729Z,949633485.729 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:46.133Z,949633486.133 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:46.529Z,949633486.529 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:46.949Z,949633486.949 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:47.345Z,949633487.345 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:47.733Z,949633487.733 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:48.149Z,949633488.149 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:48.337Z,949633488.337 [WetLabsBB2FL] Communications Fault, FailCount= 4 2000-02-04T03:04:48.337Z,949633488.337 [WetLabsBB2FL](ERROR): Communications Fault 2000-02-04T03:04:48.545Z,949633488.545 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:48.605Z,949633488.605 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2000-02-04T03:04:48.837Z,949633488.837 [WetLabsBB2FL](INFO): Powering down 2000-02-04T03:04:48.957Z,949633488.957 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:49.217Z,949633489.217 [CommandExec](IMPORTANT): got command quit 2000-02-04T03:04:49.357Z,949633489.357 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2000-02-04T03:04:49.357Z,949633489.357 [AHRS_M2](FAULT): Failed to initialize within timeout. 2000-02-04T03:04:49.357Z,949633489.357 [AHRS_M2] Communications Fault, FailCount= 2 2000-02-04T03:04:49.357Z,949633489.357 [AHRS_M2](ERROR): Communications Fault 2000-02-04T03:04:49.425Z,949633489.425 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2000-02-04T03:04:49.438Z,949633489.438 [AHRS_M2](INFO): Powering down 2000-02-04T03:04:49.477Z,949633489.477 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2000-02-04T03:04:49.477Z,949633489.477 [CTD_Seabird] Communications Fault, FailCount= 2 2000-02-04T03:04:49.477Z,949633489.477 [CTD_Seabird](ERROR): Communications Fault 2000-02-04T03:04:49.589Z,949633489.589 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2000-02-04T03:04:49.881Z,949633489.881 [CTD_Seabird](INFO): Powering down 2000-02-04T03:04:49.902Z,949633489.902 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2000-02-04T03:04:49.902Z,949633489.902 [WetLabsBB2FL] No Fault, FailCount= 4 2000-02-04T03:04:50.051Z,949633490.051 [WetLabsBB2FL](INFO): Powering up 2000-02-04T03:04:50.221Z,949633490.221 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-04T03:04:50.221Z,949633490.221 [CommandExec](INFO): Uninitializing the command executive. 2000-02-04T03:04:50.221Z,949633490.221 [CommandExec](INFO): Uninitializing the command scheduler. 2000-02-04T03:04:50.221Z,949633490.221 [CommandExec ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:50.255Z,949633490.255 [NAL9602](INFO): Powering up NAL9602 2000-02-04T03:04:50.336Z,949633490.336 [CBIT](INFO): Clearing failed state for component AHRS_M2 2000-02-04T03:04:50.337Z,949633490.337 [AHRS_M2] No Fault, FailCount= 2 2000-02-04T03:04:50.400Z,949633490.400 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2000-02-04T03:04:50.401Z,949633490.401 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2000-02-04T03:04:50.401Z,949633490.401 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:50.401Z,949633490.401 [NavChartDb](INFO): Join timeout helper Thread ID is 971 2000-02-04T03:04:50.402Z,949633490.402 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-04T03:04:50.402Z,949633490.402 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:50.403Z,949633490.403 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2000-02-04T03:04:50.403Z,949633490.403 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:50.403Z,949633490.403 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 972 2000-02-04T03:04:50.650Z,949633490.650 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2000-02-04T03:04:50.651Z,949633490.651 [WetLabsBB2FL](INFO): Powering down 2000-02-04T03:04:50.652Z,949633490.652 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-04T03:04:50.652Z,949633490.652 [WetLabsBB2FL](INFO): Powering down 2000-02-04T03:04:50.653Z,949633490.653 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:50.665Z,949633490.665 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2000-02-04T03:04:50.665Z,949633490.665 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:50.665Z,949633490.665 [CTD_Seabird](INFO): Join timeout helper Thread ID is 974 2000-02-04T03:04:50.821Z,949633490.821 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-04T03:04:50.821Z,949633490.821 [CTD_Seabird](INFO): Powering down 2000-02-04T03:04:50.833Z,949633490.833 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:50.833Z,949633490.833 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2000-02-04T03:04:50.833Z,949633490.833 [DAT ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:50.833Z,949633490.833 [DAT](INFO): Join timeout helper Thread ID is 975 2000-02-04T03:04:50.861Z,949633490.861 [DAT](INFO): Powering down 2000-02-04T03:04:50.934Z,949633490.934 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-04T03:04:50.934Z,949633490.934 [DAT](INFO): Powering down 2000-02-04T03:04:50.935Z,949633490.935 [DAT ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:50.941Z,949633490.941 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2000-02-04T03:04:50.941Z,949633490.941 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:50.941Z,949633490.941 [Radio_Surface](INFO): Join timeout helper Thread ID is 976 2000-02-04T03:04:51.109Z,949633491.109 [Radio_Surface](INFO): Powering down 2000-02-04T03:04:51.110Z,949633491.110 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-04T03:04:51.110Z,949633491.110 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:51.111Z,949633491.111 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2000-02-04T03:04:51.111Z,949633491.111 [CTD_Seabird] No Fault, FailCount= 2 2000-02-04T03:04:51.129Z,949633491.129 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2000-02-04T03:04:51.130Z,949633491.130 [Onboard ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:51.130Z,949633491.130 [Onboard](INFO): Join timeout helper Thread ID is 977 2000-02-04T03:04:51.597Z,949633491.597 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-04T03:04:51.597Z,949633491.597 [Onboard ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:51.606Z,949633491.606 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2000-02-04T03:04:51.606Z,949633491.606 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:51.611Z,949633491.611 [DataOverHttps](INFO): Join timeout helper Thread ID is 978 2000-02-04T03:04:51.685Z,949633491.685 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-04T03:04:51.685Z,949633491.685 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:51.689Z,949633491.689 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2000-02-04T03:04:51.689Z,949633491.689 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:51.690Z,949633491.690 [BackseatComponent](INFO): Join timeout helper Thread ID is 979 2000-02-04T03:04:51.777Z,949633491.777 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-04T03:04:51.777Z,949633491.777 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:51.793Z,949633491.793 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2000-02-04T03:04:51.794Z,949633491.794 [logger ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:51.794Z,949633491.794 [logger](INFO): Join timeout helper Thread ID is 980 2000-02-04T03:04:51.809Z,949633491.809 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-04T03:04:51.809Z,949633491.809 [logger ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:51.813Z,949633491.813 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2000-02-04T03:04:51.813Z,949633491.813 [CommandLine ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:51.814Z,949633491.814 [CommandLine](INFO): Join timeout helper Thread ID is 981 2000-02-04T03:04:51.869Z,949633491.869 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-04T03:04:51.869Z,949633491.869 [CommandLine ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:51.875Z,949633491.875 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2000-02-04T03:04:51.875Z,949633491.875 [CommandExec ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:51.875Z,949633491.875 [CommandExec](INFO): Join timeout helper Thread ID is 982 2000-02-04T03:04:51.877Z,949633491.877 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2000-02-04T03:04:51.878Z,949633491.878 [controlThread ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:51.878Z,949633491.878 [controlThread](INFO): Join timeout helper Thread ID is 983 2000-02-04T03:04:51.918Z,949633491.918 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-04T03:04:51.918Z,949633491.918 [controlThread](DEBUG): Uninitializing ControlThread 2000-02-04T03:04:51.919Z,949633491.919 [AHRS_M2](INFO): Powering down 2000-02-04T03:04:52.085Z,949633492.085 [DVL_micro](INFO): Powering down 2000-02-04T03:04:52.086Z,949633492.086 [NAL9602](INFO): Powering down 2000-02-04T03:04:52.087Z,949633492.087 [Sonardyne_Nano](INFO): Powering down 2000-02-04T03:04:52.207Z,949633492.207 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2000-02-04T03:04:52.207Z,949633492.207 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2000-02-04T03:04:52.208Z,949633492.208 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2000-02-04T03:04:52.208Z,949633492.208 [MissionManager](INFO): Uninitializing Mission Default 2000-02-04T03:04:52.211Z,949633492.211 [MissionManager](INFO): Uninitializing Mission Startup 2000-02-04T03:04:52.212Z,949633492.212 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2000-02-04T03:04:52.213Z,949633492.213 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2000-02-04T03:04:52.213Z,949633492.213 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2000-02-04T03:04:52.213Z,949633492.213 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2000-02-04T03:04:52.214Z,949633492.214 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2000-02-04T03:04:52.214Z,949633492.214 [BuoyancyServo](INFO): Powering down 2000-02-04T03:04:52.229Z,949633492.229 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2000-02-04T03:04:52.229Z,949633492.229 [ElevatorServo](INFO): Powering down 2000-02-04T03:04:52.230Z,949633492.230 [MassServo](DEBUG): Uninitialize Mass Servo. 2000-02-04T03:04:52.230Z,949633492.230 [MassServo](INFO): Powering down 2000-02-04T03:04:52.231Z,949633492.231 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2000-02-04T03:04:52.231Z,949633492.231 [RudderServo](INFO): Powering down 2000-02-04T03:04:52.231Z,949633492.231 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2000-02-04T03:04:52.232Z,949633492.232 [ThrusterHE](INFO): Powering down 2000-02-04T03:04:52.232Z,949633492.232 [SBIT](DEBUG): Uninitialize SBIT Component. 2000-02-04T03:04:52.233Z,949633492.233 [IBIT](DEBUG): Uninitialize IBIT Component. 2000-02-04T03:04:52.233Z,949633492.233 [CBIT](DEBUG): Uninitialize CBIT Component. 2000-02-04T03:04:52.233Z,949633492.233 [CBIT](DEBUG): Powering off loads. 2000-02-04T03:04:52.244Z,949633492.244 [CBIT](DEBUG): Disabling WDT. 2000-02-04T03:04:52.256Z,949633492.256 [CBIT](DEBUG): Opening all GF detection circuits. 2000-02-04T03:04:52.258Z,949633492.258 [controlThread ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:52.298Z,949633492.298 [DAT ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:52.304Z,949633492.304 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:52.306Z,949633492.306 [Onboard ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:52.314Z,949633492.314 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:52.357Z,949633492.357 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:52.765Z,949633492.765 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:52.771Z,949633492.771 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:52.793Z,949633492.793 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2000-02-04T03:04:52.855Z,949633492.855 [logger ThreadHandler](INFO): Thread cancelled.