2000-02-09T23:33:07.792Z,950139187.792 [Supervisor](DEBUG): Initializing supervisor. 2000-02-09T23:33:07.797Z,950139187.797 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2000-02-09T23:33:07.797Z,950139187.797 [SyncHandler](INFO): Protected caller Thread ID is 4236 2000-02-09T23:33:07.798Z,950139187.798 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2000-02-09T23:33:07.799Z,950139187.799 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2000-02-09T23:33:07.799Z,950139187.799 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4237 2000-02-09T23:33:07.804Z,950139187.804 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2000-02-09T23:33:07.821Z,950139187.821 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2000-02-09T23:33:07.822Z,950139187.822 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2000-02-09T23:33:07.822Z,950139187.822 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4238 2000-02-09T23:33:07.826Z,950139187.826 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2000-02-09T23:33:07.827Z,950139187.827 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2000-02-09T23:33:07.827Z,950139187.827 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4239 2000-02-09T23:33:07.829Z,950139187.829 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2000-02-09T23:33:07.830Z,950139187.830 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2000-02-09T23:33:07.831Z,950139187.831 [logger ThreadHandler](INFO): Protected caller Thread ID is 4240 2000-02-09T23:33:07.834Z,950139187.834 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2000-02-09T23:33:07.835Z,950139187.835 [Supervisor](INFO): Looking for Config files in directory: Config/ 2000-02-09T23:33:07.836Z,950139187.836 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2000-02-09T23:33:08.179Z,950139188.179 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2000-02-09T23:33:08.179Z,950139188.179 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2000-02-09T23:33:08.944Z,950139188.944 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2000-02-09T23:33:08.945Z,950139188.945 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2000-02-09T23:33:09.064Z,950139189.064 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2000-02-09T23:33:09.065Z,950139189.065 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2000-02-09T23:33:09.628Z,950139189.628 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2000-02-09T23:33:09.628Z,950139189.628 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2000-02-09T23:33:09.737Z,950139189.737 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2000-02-09T23:33:09.737Z,950139189.737 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2000-02-09T23:33:09.830Z,950139189.830 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2000-02-09T23:33:10.260Z,950139190.260 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2000-02-09T23:33:10.260Z,950139190.260 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2000-02-09T23:33:10.498Z,950139190.498 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2000-02-09T23:33:10.498Z,950139190.498 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2000-02-09T23:33:10.649Z,950139190.649 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2000-02-09T23:33:10.649Z,950139190.649 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2000-02-09T23:33:10.910Z,950139190.910 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2000-02-09T23:33:10.911Z,950139190.911 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2000-02-09T23:33:11.474Z,950139191.474 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2000-02-09T23:33:11.475Z,950139191.475 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2000-02-09T23:33:11.882Z,950139191.882 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2000-02-09T23:33:11.883Z,950139191.883 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2000-02-09T23:33:11.974Z,950139191.974 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2000-02-09T23:33:12.518Z,950139192.518 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2000-02-09T23:33:12.519Z,950139192.519 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2000-02-09T23:33:13.059Z,950139193.059 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2000-02-09T23:33:13.059Z,950139193.059 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2000-02-09T23:33:13.371Z,950139193.371 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2000-02-09T23:33:13.373Z,950139193.373 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/ 2000-02-09T23:33:13.374Z,950139193.374 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg 2000-02-09T23:33:13.494Z,950139193.494 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg 2000-02-09T23:33:13.657Z,950139193.657 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg 2000-02-09T23:33:13.754Z,950139193.754 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg 2000-02-09T23:33:13.850Z,950139193.850 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg 2000-02-09T23:33:13.970Z,950139193.970 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/workSite.cfg 2000-02-09T23:33:14.067Z,950139194.067 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg 2000-02-09T23:33:14.184Z,950139194.184 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg 2000-02-09T23:33:14.750Z,950139194.750 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2000-02-09T23:33:14.750Z,950139194.750 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg 2000-02-09T23:33:14.896Z,950139194.896 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg 2000-02-09T23:33:15.001Z,950139195.001 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg 2000-02-09T23:33:15.105Z,950139195.105 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg 2000-02-09T23:33:15.222Z,950139195.222 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/root/ 2000-02-09T23:33:15.223Z,950139195.223 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2000-02-09T23:33:15.238Z,950139195.238 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2000-02-09T23:33:15.345Z,950139195.345 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2000-02-09T23:33:15.345Z,950139195.345 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2000-02-09T23:33:15.355Z,950139195.355 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2000-02-09T23:33:15.356Z,950139195.356 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2000-02-09T23:33:15.406Z,950139195.406 [DepthRateCalculator] Loaded 2000-02-09T23:33:15.406Z,950139195.406 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2000-02-09T23:33:15.411Z,950139195.411 [PitchRateCalculator] Loaded 2000-02-09T23:33:15.412Z,950139195.412 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2000-02-09T23:33:15.422Z,950139195.422 [SpeedCalculator] Loaded 2000-02-09T23:33:15.422Z,950139195.422 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2000-02-09T23:33:15.427Z,950139195.427 [YawRateCalculator] Loaded 2000-02-09T23:33:15.427Z,950139195.427 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2000-02-09T23:33:15.448Z,950139195.448 [ElevatorOffsetCalculator] Loaded 2000-02-09T23:33:15.448Z,950139195.448 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2000-02-09T23:33:15.448Z,950139195.448 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2000-02-09T23:33:15.449Z,950139195.449 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2000-02-09T23:33:15.498Z,950139195.498 [VerticalControl](DEBUG): Construct VerticalControl. 2000-02-09T23:33:15.553Z,950139195.553 [VerticalControl] Loaded 2000-02-09T23:33:15.553Z,950139195.553 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2000-02-09T23:33:15.556Z,950139195.556 [HorizontalControl](DEBUG): Construct HorizontalControl. 2000-02-09T23:33:15.601Z,950139195.601 [HorizontalControl] Loaded 2000-02-09T23:33:15.602Z,950139195.602 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2000-02-09T23:33:15.604Z,950139195.604 [SpeedControl](DEBUG): Construct SpeedControl. 2000-02-09T23:33:15.607Z,950139195.607 [SpeedControl] Loaded 2000-02-09T23:33:15.607Z,950139195.607 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2000-02-09T23:33:15.610Z,950139195.610 [LoopControl](DEBUG): Construct LoopControl. 2000-02-09T23:33:15.610Z,950139195.610 [LoopControl] Loaded 2000-02-09T23:33:15.610Z,950139195.610 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2000-02-09T23:33:15.611Z,950139195.611 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2000-02-09T23:33:15.611Z,950139195.611 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2000-02-09T23:33:15.718Z,950139195.718 [DeadReckonUsingMultipleVelocitySources] Loaded 2000-02-09T23:33:15.719Z,950139195.719 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2000-02-09T23:33:15.732Z,950139195.732 [NavChart] Loaded 2000-02-09T23:33:15.733Z,950139195.733 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2000-02-09T23:33:15.738Z,950139195.738 [UniversalFixResidualReporter] Loaded 2000-02-09T23:33:15.738Z,950139195.738 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2000-02-09T23:33:15.739Z,950139195.739 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2000-02-09T23:33:15.739Z,950139195.739 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2000-02-09T23:33:15.906Z,950139195.906 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2000-02-09T23:33:15.906Z,950139195.906 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2000-02-09T23:33:16.350Z,950139196.350 [AHRS_M2] Loaded 2000-02-09T23:33:16.350Z,950139196.350 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2000-02-09T23:33:16.389Z,950139196.389 [BackseatComponent] Loaded 2000-02-09T23:33:16.389Z,950139196.389 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2000-02-09T23:33:16.390Z,950139196.390 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409214E0 2000-02-09T23:33:16.390Z,950139196.390 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 4325 2000-02-09T23:33:16.393Z,950139196.393 [LcmUniversalReporter] Loaded 2000-02-09T23:33:16.394Z,950139196.394 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2000-02-09T23:33:17.214Z,950139197.214 [BPC1] Loaded 2000-02-09T23:33:17.215Z,950139197.215 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2000-02-09T23:33:17.288Z,950139197.288 [DataOverHttps] Loaded 2000-02-09T23:33:17.288Z,950139197.288 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2000-02-09T23:33:17.289Z,950139197.289 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409514E0 2000-02-09T23:33:17.289Z,950139197.289 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4326 2000-02-09T23:33:17.312Z,950139197.312 [Depth_Keller] Loaded 2000-02-09T23:33:17.312Z,950139197.312 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2000-02-09T23:33:17.352Z,950139197.352 [DVL_micro] Loaded 2000-02-09T23:33:17.352Z,950139197.352 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2000-02-09T23:33:17.416Z,950139197.416 [NAL9602] Loaded 2000-02-09T23:33:17.416Z,950139197.416 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2000-02-09T23:33:17.445Z,950139197.445 [Onboard] Loaded 2000-02-09T23:33:17.445Z,950139197.445 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2000-02-09T23:33:17.446Z,950139197.446 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409814E0 2000-02-09T23:33:17.447Z,950139197.447 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4327 2000-02-09T23:33:17.461Z,950139197.461 [Power24vConverter] Loaded 2000-02-09T23:33:17.461Z,950139197.461 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2000-02-09T23:33:17.476Z,950139197.476 [Radio_Surface] Loaded 2000-02-09T23:33:17.476Z,950139197.476 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2000-02-09T23:33:17.477Z,950139197.477 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409B14E0 2000-02-09T23:33:17.478Z,950139197.478 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4328 2000-02-09T23:33:17.493Z,950139197.493 [Sonardyne_Nano] Loaded 2000-02-09T23:33:17.493Z,950139197.493 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2000-02-09T23:33:17.494Z,950139197.494 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2000-02-09T23:33:17.494Z,950139197.494 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2000-02-09T23:33:17.625Z,950139197.625 [BuoyancyServo] Loaded 2000-02-09T23:33:17.625Z,950139197.625 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2000-02-09T23:33:17.647Z,950139197.647 [MassServo] Loaded 2000-02-09T23:33:17.647Z,950139197.647 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2000-02-09T23:33:17.667Z,950139197.667 [RudderServo] Loaded 2000-02-09T23:33:17.667Z,950139197.667 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2000-02-09T23:33:17.683Z,950139197.683 [ThrusterHE] Loaded 2000-02-09T23:33:17.684Z,950139197.684 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2000-02-09T23:33:17.684Z,950139197.684 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2000-02-09T23:33:17.684Z,950139197.684 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2000-02-09T23:33:17.764Z,950139197.764 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2000-02-09T23:33:17.764Z,950139197.764 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2000-02-09T23:33:17.790Z,950139197.790 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2000-02-09T23:33:17.790Z,950139197.790 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2000-02-09T23:33:18.277Z,950139198.277 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2000-02-09T23:33:18.278Z,950139198.278 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2000-02-09T23:33:18.447Z,950139198.447 [CTD_Seabird] Loaded 2000-02-09T23:33:18.447Z,950139198.447 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2000-02-09T23:33:18.448Z,950139198.448 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B684E0 2000-02-09T23:33:18.449Z,950139198.449 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4329 2000-02-09T23:33:18.483Z,950139198.483 [ESPComponent] Loaded 2000-02-09T23:33:18.484Z,950139198.484 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2000-02-09T23:33:18.505Z,950139198.505 [PAR_Licor] Loaded 2000-02-09T23:33:18.506Z,950139198.506 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2000-02-09T23:33:18.507Z,950139198.507 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2000-02-09T23:33:18.507Z,950139198.507 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2000-02-09T23:33:18.642Z,950139198.642 [SBIT](DEBUG): Construct Startup Built In Test. 2000-02-09T23:33:18.651Z,950139198.651 [SBIT] Loaded 2000-02-09T23:33:18.652Z,950139198.652 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2000-02-09T23:33:18.654Z,950139198.654 [IBIT](DEBUG): Construct Initiated Built In Test. 2000-02-09T23:33:18.667Z,950139198.667 [IBIT] Loaded 2000-02-09T23:33:18.667Z,950139198.667 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2000-02-09T23:33:18.673Z,950139198.673 [CBIT](DEBUG): Construct Continuous Built In Test. 2000-02-09T23:33:18.776Z,950139198.776 [CBIT] Loaded 2000-02-09T23:33:18.776Z,950139198.776 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2000-02-09T23:33:18.776Z,950139198.776 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2000-02-09T23:33:18.783Z,950139198.783 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2000-02-09T23:33:18.785Z,950139198.785 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2000-02-09T23:33:18.797Z,950139198.797 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2000-02-09T23:33:18.798Z,950139198.798 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BD74E0 2000-02-09T23:33:18.798Z,950139198.798 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4330 2000-02-09T23:33:18.803Z,950139198.803 [Supervisor](INFO): Main Thread ID is 3972 2000-02-09T23:33:18.803Z,950139198.803 [Supervisor](DEBUG): Running supervisor. 2000-02-09T23:33:18.803Z,950139198.803 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4331 2000-02-09T23:33:18.804Z,950139198.804 [CommandExec](INFO): Initializing the command executive. 2000-02-09T23:33:18.805Z,950139198.805 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4332 2000-02-09T23:33:18.807Z,950139198.807 [controlThread ThreadHandler](INFO): Handler Thread ID is 4333 2000-02-09T23:33:18.808Z,950139198.808 [controlThread](DEBUG): Initializing ControlThread 2000-02-09T23:33:18.809Z,950139198.809 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2000-02-09T23:33:18.809Z,950139198.809 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2000-02-09T23:33:18.809Z,950139198.809 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2000-02-09T23:33:18.810Z,950139198.810 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2000-02-09T23:33:18.810Z,950139198.810 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2000-02-09T23:33:18.811Z,950139198.811 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2000-02-09T23:33:18.812Z,950139198.812 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2000-02-09T23:33:18.813Z,950139198.813 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2000-02-09T23:33:18.813Z,950139198.813 [LoopControl](DEBUG): Initialize LoopControlComponent. 2000-02-09T23:33:18.814Z,950139198.814 [NavChart](DEBUG): Initialize NavChart Navigation. 2000-02-09T23:33:18.815Z,950139198.815 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2000-02-09T23:33:18.824Z,950139198.824 [SBIT](INFO): Initialize SBIT Component. 2000-02-09T23:33:18.825Z,950139198.825 [SBIT](IMPORTANT): git: 2024-08-12-95-g598b95f60 2000-02-09T23:33:18.825Z,950139198.825 [SBIT](INFO): git hash: 598b95f6033d24136933a3d5d1ddac5d4570ac95 2000-02-09T23:33:18.825Z,950139198.825 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2000-02-09T23:33:18.826Z,950139198.826 [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-09T23:33:18.827Z,950139198.827 [SBIT](INFO): Beginning SBIT in 68.000000 seconds. 2000-02-09T23:33:18.828Z,950139198.828 [IBIT](INFO): Initialize IBIT Component. 2000-02-09T23:33:18.829Z,950139198.829 [CBIT](DEBUG): Initialize CBIT Component. 2000-02-09T23:33:18.830Z,950139198.830 [logger ThreadHandler](INFO): Handler Thread ID is 4334 2000-02-09T23:33:18.840Z,950139198.840 [CBIT](DEBUG): Initialized mux pins. 2000-02-09T23:33:18.840Z,950139198.840 [CBIT](DEBUG): Initializing the watchdog timer. 2000-02-09T23:33:18.849Z,950139198.849 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 4335 2000-02-09T23:33:18.860Z,950139198.860 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4336 2000-02-09T23:33:18.862Z,950139198.862 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2000-02-09T23:33:18.864Z,950139198.864 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2000-02-09T23:33:18.865Z,950139198.865 [CBIT](DEBUG): Initializing heartbeat. 2000-02-09T23:33:18.873Z,950139198.873 [Onboard ThreadHandler](INFO): Handler Thread ID is 4337 2000-02-09T23:33:18.890Z,950139198.890 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4338 2000-02-09T23:33:18.913Z,950139198.913 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4339 2000-02-09T23:33:18.913Z,950139198.913 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2000-02-09T23:33:18.918Z,950139198.918 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4341 2000-02-09T23:33:18.920Z,950139198.920 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK1NORSO.000 2000-02-09T23:33:18.920Z,950139198.920 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK1NORSO.000 2000-02-09T23:33:18.920Z,950139198.920 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK2NORS.000 2000-02-09T23:33:18.920Z,950139198.920 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK2NORS.000 2000-02-09T23:33:18.921Z,950139198.921 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK3HORRO.000 2000-02-09T23:33:18.921Z,950139198.921 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK3HORRO.000 2000-02-09T23:33:18.936Z,950139198.936 [CBIT](DEBUG): Deactivating GF circuits. 2000-02-09T23:33:18.936Z,950139198.936 [CBIT](DEBUG): Deactivating emergency mode. 2000-02-09T23:33:18.976Z,950139198.976 [CBIT](DEBUG): Backplane powered. 2000-02-09T23:33:18.977Z,950139198.977 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2000-02-09T23:33:18.978Z,950139198.978 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2000-02-09T23:33:18.978Z,950139198.978 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2000-02-09T23:33:18.979Z,950139198.979 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2000-02-09T23:33:19.011Z,950139199.011 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2000-02-09T23:33:19.032Z,950139199.032 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2000-02-09T23:33:19.068Z,950139199.068 [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-09T23:33:19.080Z,950139199.080 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2000-02-09T23:33:19.080Z,950139199.080 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2000-02-09T23:33:19.082Z,950139199.082 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2000-02-09T23:33:19.296Z,950139199.296 [Radio_Surface](INFO): Powering up 2000-02-09T23:33:19.398Z,950139199.398 [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-09T23:33:19.421Z,950139199.421 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2000-02-09T23:33:19.428Z,950139199.428 [Default:A.Wait](DEBUG): Construct Wait. 2000-02-09T23:33:19.431Z,950139199.431 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2000-02-09T23:33:19.459Z,950139199.459 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2000-02-09T23:33:19.477Z,950139199.477 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2000-02-09T23:33:19.483Z,950139199.483 [Default:E.Execute](DEBUG): Construct Execute. 2000-02-09T23:33:19.502Z,950139199.502 [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-09T23:33:19.507Z,950139199.507 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2000-02-09T23:33:19.529Z,950139199.529 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2000-02-09T23:33:19.601Z,950139199.601 [Power24vConverter](INFO): Powering up. 2000-02-09T23:33:19.602Z,950139199.602 [Sonardyne_Nano](INFO): Initializing. 2000-02-09T23:33:19.675Z,950139199.675 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2000-02-09T23:33:19.680Z,950139199.680 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2000-02-09T23:33:19.681Z,950139199.681 [MassServo](DEBUG): Initializing EZServoServo. 2000-02-09T23:33:19.688Z,950139199.688 [MassServo](DEBUG): Initializing MassServo. 2000-02-09T23:33:19.689Z,950139199.689 [RudderServo](DEBUG): Initializing EZServoServo. 2000-02-09T23:33:19.696Z,950139199.696 [RudderServo](DEBUG): Initializing RudderServo. 2000-02-09T23:33:19.697Z,950139199.697 [ThrusterHE](DEBUG): Initializing EZServoServo. 2000-02-09T23:33:19.705Z,950139199.705 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2000-02-09T23:33:21.555Z,950139201.555 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2000-02-09T23:33:22.820Z,950139202.820 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2207 2000-02-09T23:33:23.181Z,950139203.181 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2000-02-09T23:33:25.437Z,950139205.437 [ThrusterHE](ERROR): Zero Speed Commanded. 2000-02-09T23:33:47.802Z,950139227.802 [NAL9602](INFO): Powering up NAL9602 2000-02-09T23:33:58.719Z,950139238.719 [NAL9602](INFO): NAL9602 initialized 2000-02-09T23:34:24.965Z,950139264.965 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-09T23:34:27.438Z,950139267.438 [SBIT](IMPORTANT): Beginning Startup BIT 2000-02-09T23:34:27.442Z,950139267.442 [CBIT](IMPORTANT): Beginning ground fault scan 2000-02-09T23:34:38.397Z,950139278.397 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.003989 CHAN A1 (24V): -0.003200 CHAN A2 (12V): -0.000043 CHAN A3 (5V): -0.000270 CHAN B0 (3.3V): -0.000905 CHAN B1 (3.15aV): 0.000095 CHAN B2 (3.15bV): 0.000291 CHAN B3 (GND): 0.000364 OPEN: 0.004858 Full Scale: +/- 1 mA 2000-02-09T23:34:39.101Z,950139279.101 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-09T23:34:40.749Z,950139280.749 [SBIT](ERROR): Could not read elevatorAngleReader_. 2000-02-09T23:34:53.241Z,950139293.241 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-09T23:35:07.393Z,950139307.393 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-09T23:35:07.469Z,950139307.469 [SBIT](ERROR): Could not read elevatorAngleReader_. 2000-02-09T23:35:07.469Z,950139307.469 [SBIT](FAULT): Control surface position failure. 2000-02-09T23:35:11.739Z,950139311.739 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005020 2000-02-09T23:35:21.215Z,950139321.215 [SBIT](ERROR): Could not read elevatorAngleReader_. 2000-02-09T23:35:21.215Z,950139321.215 [SBIT](FAULT): Control surface position failure. 2000-02-09T23:35:21.533Z,950139321.533 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-09T23:35:21.577Z,950139321.577 [SBIT](CRITICAL): SBIT FAILED 2000-02-09T23:35:21.577Z,950139321.577 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2000-02-09T23:35:21.578Z,950139321.578 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=20 count; 2000-02-09T23:35:21.578Z,950139321.578 [SBIT](IMPORTANT): CBIT.vehicleOpen=1 bool; 2000-02-09T23:35:21.578Z,950139321.578 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2000-02-09T23:35:21.578Z,950139321.578 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool; 2000-02-09T23:35:21.578Z,950139321.578 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool; 2000-02-09T23:35:21.579Z,950139321.579 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=5 meter; 2000-02-09T23:35:21.579Z,950139321.579 [SBIT](IMPORTANT): Depth_Keller.offset=3.6 decibar; 2000-02-09T23:35:21.579Z,950139321.579 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2000-02-09T23:35:21.579Z,950139321.579 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=3 minute; 2000-02-09T23:35:21.579Z,950139321.579 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2000-02-09T23:35:21.579Z,950139321.579 [SBIT](IMPORTANT): ElevatorServo.currLimit=75 percent; 2000-02-09T23:35:21.579Z,950139321.579 [SBIT](IMPORTANT): ElevatorServo.limitHi=16369 count; 2000-02-09T23:35:21.579Z,950139321.579 [SBIT](IMPORTANT): ElevatorServo.limitLo=0 count; 2000-02-09T23:35:21.579Z,950139321.579 [SBIT](IMPORTANT): ElevatorServo.loadAtStartup=0 bool; 2000-02-09T23:35:21.580Z,950139321.580 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=20 ampere_hour; 2000-02-09T23:35:21.580Z,950139321.580 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt; 2000-02-09T23:35:21.584Z,950139321.584 [SBIT](IMPORTANT): Radio_Surface.loadAtStartup=1 bool; 2000-02-09T23:35:21.584Z,950139321.584 [SBIT](IMPORTANT): VerticalControl.massDefault=12.059213 millimeter; 2000-02-09T23:35:21.584Z,950139321.584 [SBIT](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool; 2000-02-09T23:35:21.586Z,950139321.586 [CommandExec](FAULT): Scheduling is paused 2000-02-09T23:35:21.586Z,950139321.586 [CBIT](INFO): Critical error at 20000209T233521 2000-02-09T23:35:21.586Z,950139321.586 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2000-02-09T23:35:21.970Z,950139321.970 [MissionManager](IMPORTANT): Started mission Startup 2000-02-09T23:35:21.971Z,950139321.971 [Startup] Running Loop=1 2000-02-09T23:35:21.971Z,950139321.971 [Startup](DEBUG): Aggregate::initialize Startup 2000-02-09T23:35:21.971Z,950139321.971 [Startup:A.GoToSurface] Running Loop=1 2000-02-09T23:35:21.971Z,950139321.971 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2000-02-09T23:35:21.972Z,950139321.972 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2000-02-09T23:35:21.972Z,950139321.972 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2000-02-09T23:35:21.972Z,950139321.972 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2000-02-09T23:35:21.973Z,950139321.973 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2000-02-09T23:35:21.973Z,950139321.973 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2000-02-09T23:35:21.974Z,950139321.974 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2000-02-09T23:35:21.975Z,950139321.975 [Startup:StartupSatComms] Running Loop=1 2000-02-09T23:35:21.975Z,950139321.975 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2000-02-09T23:35:21.975Z,950139321.975 [Startup:StartupSatComms:A] Running Loop=1 2000-02-09T23:35:22.371Z,950139322.371 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2000-02-09T23:35:35.674Z,950139335.674 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-09T23:35:49.814Z,950139349.814 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-09T23:36:18.935Z,950139378.935 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2000-02-09T23:36:18.935Z,950139378.935 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-09T23:36:18.961Z,950139378.961 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-09T23:36:19.371Z,950139379.371 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-09T23:36:19.371Z,950139379.371 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2000-02-09T23:36:22.164Z,950139382.164 [Startup:StartupSatComms:A](INFO): Timed out from 2000-02-09T23:35:21.0Z 2000-02-09T23:36:22.164Z,950139382.164 [Startup:StartupSatComms:A] Stopped 2000-02-09T23:36:22.164Z,950139382.164 [Startup:StartupSatComms:B] Running Loop=1 2000-02-09T23:36:22.578Z,950139382.578 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2000-02-09T23:36:29.876Z,950139389.876 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20000208T221543/Courier0000.lzma 2000-02-09T23:36:30.878Z,950139390.878 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221543/Courier0000.lzma.bak 2000-02-09T23:36:30.878Z,950139390.878 [DataOverHttps](INFO): SBD MOMSN=23043381 2000-02-09T23:36:46.446Z,950139406.446 [DataOverHttps](INFO): Sending 248 bytes from file Logs/20000208T221827/Courier0000.lzma 2000-02-09T23:36:47.442Z,950139407.442 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Courier0000.lzma.bak 2000-02-09T23:36:47.442Z,950139407.442 [DataOverHttps](INFO): SBD MOMSN=23043389 2000-02-09T23:36:53.739Z,950139413.739 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2000-02-09T23:37:02.009Z,950139422.009 [DataOverHttps](INFO): Sending 114 bytes from file Logs/20000208T221827/Courier0004.lzma 2000-02-09T23:37:03.010Z,950139423.010 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Courier0004.lzma.bak 2000-02-09T23:37:03.010Z,950139423.010 [DataOverHttps](INFO): SBD MOMSN=23043396 2000-02-09T23:37:18.643Z,950139438.643 [DataOverHttps](INFO): Sending 840 bytes from file Logs/20000208T221827/Courier0007.lzma 2000-02-09T23:37:19.642Z,950139439.642 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Courier0007.lzma.bak 2000-02-09T23:37:19.642Z,950139439.642 [DataOverHttps](INFO): SBD MOMSN=23043404 2000-02-09T23:37:22.342Z,950139442.342 [Startup:StartupSatComms:B](INFO): Timed out from 2000-02-09T23:36:22.2Z 2000-02-09T23:37:22.342Z,950139442.342 [Startup:StartupSatComms:B] Stopped 2000-02-09T23:37:22.342Z,950139442.342 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2000-02-09T23:37:22.343Z,950139442.343 [Startup:StartupSatComms] Stopped 2000-02-09T23:37:22.343Z,950139442.343 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2000-02-09T23:37:22.344Z,950139442.344 [Startup](INFO): Completed Startup 2000-02-09T23:37:22.344Z,950139442.344 [MissionManager](INFO): Startup is completed. 2000-02-09T23:37:22.344Z,950139442.344 [MissionManager](INFO): Uninitializing Mission Startup 2000-02-09T23:37:22.344Z,950139442.344 [Startup] Stopped 2000-02-09T23:37:22.344Z,950139442.344 [Startup](DEBUG): Aggregate::uninitialize Startup 2000-02-09T23:37:22.344Z,950139442.344 [Startup:A.GoToSurface] Stopped 2000-02-09T23:37:22.344Z,950139442.344 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2000-02-09T23:37:22.891Z,950139442.891 [MissionManager](IMPORTANT): Started mission Default 2000-02-09T23:37:22.891Z,950139442.891 [Default] Running Loop=1 2000-02-09T23:37:22.891Z,950139442.891 [Default](DEBUG): Aggregate::initialize Default 2000-02-09T23:37:22.891Z,950139442.891 [Default:B.GoToSurface] Running Loop=1 2000-02-09T23:37:22.891Z,950139442.891 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2000-02-09T23:37:22.892Z,950139442.892 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2000-02-09T23:37:22.896Z,950139442.896 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2000-02-09T23:37:22.896Z,950139442.896 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2000-02-09T23:37:22.897Z,950139442.897 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2000-02-09T23:37:22.897Z,950139442.897 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2000-02-09T23:37:22.897Z,950139442.897 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2000-02-09T23:37:22.898Z,950139442.898 [Default:A.Wait] Running Loop=1 2000-02-09T23:37:22.898Z,950139442.898 [Default:A.Wait](DEBUG): Initialize Wait Component. 2000-02-09T23:37:35.374Z,950139455.374 [DataOverHttps](INFO): Sending 717 bytes from file Logs/20000208T221827/Courier0010.lzma 2000-02-09T23:37:36.119Z,950139456.119 [Default:A.Wait](INFO): Done Waiting. 2000-02-09T23:37:36.119Z,950139456.119 [Default:A.Wait] Stopped 2000-02-09T23:37:36.119Z,950139456.119 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2000-02-09T23:37:36.374Z,950139456.374 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Courier0010.lzma.bak 2000-02-09T23:37:36.374Z,950139456.374 [DataOverHttps](INFO): SBD MOMSN=23043515 2000-02-09T23:37:36.516Z,950139456.516 [Default:CheckIn] Running Loop=1 2000-02-09T23:37:36.517Z,950139456.517 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2000-02-09T23:37:36.517Z,950139456.517 [Default:CheckIn:Read_GPS] Running Loop=1 2000-02-09T23:37:36.890Z,950139456.890 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2000-02-09T23:39:01.374Z,950139541.374 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2000-02-09T23:39:19.981Z,950139559.981 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2000-02-09T23:39:19.981Z,950139559.981 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-09T23:39:19.996Z,950139559.996 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-09T23:39:20.414Z,950139560.414 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-09T23:39:20.414Z,950139560.414 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2000-02-09T23:39:43.042Z,950139583.042 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2000-02-09T23:40:31.926Z,950139631.926 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2000-02-09T23:40:40.817Z,950139640.817 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2000-02-09T23:40:47.621Z,950139647.621 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-09T23:40:54.085Z,950139654.085 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-09T23:40:54.551Z,950139654.551 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2000-02-09T23:41:08.286Z,950139668.286 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2000-02-09T23:41:15.497Z,950139675.497 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-09T23:41:36.565Z,950139696.565 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-09T23:41:36.937Z,950139696.937 [BPC1](INFO): Calculating totals. Valid battery stick count: 38. Valid reserve battery stick count: 4. 2000-02-09T23:41:36.940Z,950139696.940 [BPC1](INFO): Received data from all battery sticks. 2000-02-09T23:42:20.965Z,950139740.965 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2000-02-09T23:42:20.965Z,950139740.965 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-09T23:42:20.976Z,950139740.976 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-09T23:42:21.379Z,950139741.379 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-09T23:42:21.379Z,950139741.379 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2000-02-09T23:42:36.731Z,950139756.731 [Default:CheckIn:Read_GPS](INFO): Timed out from 2000-02-09T23:37:36.5Z 2000-02-09T23:42:36.731Z,950139756.731 [Default:CheckIn:Read_GPS] Stopped 2000-02-09T23:42:36.732Z,950139756.732 [Default:CheckIn:Read_Iridium] Running Loop=1 2000-02-09T23:42:37.142Z,950139757.142 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2000-02-09T23:42:44.210Z,950139764.210 [DataOverHttps](INFO): Sending 673 bytes from file Logs/20000208T221827/Courier0013.lzma 2000-02-09T23:42:45.210Z,950139765.210 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Courier0013.lzma.bak 2000-02-09T23:42:45.210Z,950139765.210 [DataOverHttps](INFO): SBD MOMSN=23043661 2000-02-09T23:43:00.831Z,950139780.831 [DataOverHttps](INFO): Sending 697 bytes from file Logs/20000208T221827/Courier0016.lzma 2000-02-09T23:43:01.843Z,950139781.843 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Courier0016.lzma.bak 2000-02-09T23:43:01.843Z,950139781.843 [DataOverHttps](INFO): SBD MOMSN=23043771 2000-02-09T23:43:17.606Z,950139797.606 [DataOverHttps](INFO): Sending 671 bytes from file Logs/20000208T221827/Courier0019.lzma 2000-02-09T23:43:18.606Z,950139798.606 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Courier0019.lzma.bak 2000-02-09T23:43:18.606Z,950139798.606 [DataOverHttps](INFO): SBD MOMSN=23043884 2000-02-09T23:43:34.111Z,950139814.111 [DataOverHttps](INFO): Sending 591 bytes from file Logs/20000208T221827/Courier0022.lzma 2000-02-09T23:43:35.102Z,950139815.102 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Courier0022.lzma.bak 2000-02-09T23:43:35.102Z,950139815.102 [DataOverHttps](INFO): SBD MOMSN=23043994 2000-02-09T23:43:51.084Z,950139831.084 [DataOverHttps](INFO): Sending 242 bytes from file Logs/20000209T232855/Courier0000.lzma 2000-02-09T23:43:52.086Z,950139832.086 [DataOverHttps](INFO): Moved sent file to Logs/20000209T232855/Courier0000.lzma.bak 2000-02-09T23:43:52.086Z,950139832.086 [DataOverHttps](INFO): SBD MOMSN=23044091 2000-02-09T23:43:59.530Z,950139839.530 [NAL9602](FAULT): GPS failed to acquire within timeout. 2000-02-09T23:43:59.530Z,950139839.530 [NAL9602] Data Fault, FailCount= 1 2000-02-09T23:43:59.530Z,950139839.530 [NAL9602](ERROR): Data Fault 2000-02-09T23:43:59.577Z,950139839.577 [CBIT](ERROR): Data Fault in component: NAL9602 2000-02-09T23:43:59.934Z,950139839.934 [NAL9602](INFO): Powering down 2000-02-09T23:44:00.763Z,950139840.763 [CBIT](INFO): Clearing failed state for component NAL9602 2000-02-09T23:44:00.763Z,950139840.763 [NAL9602] No Fault, FailCount= 1 2000-02-09T23:44:07.576Z,950139847.576 [DataOverHttps](INFO): Sending 224 bytes from file Logs/20000209T233129/Courier0000.lzma 2000-02-09T23:44:08.578Z,950139848.578 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233129/Courier0000.lzma.bak 2000-02-09T23:44:08.578Z,950139848.578 [DataOverHttps](INFO): SBD MOMSN=23044096 2000-02-09T23:44:24.046Z,950139864.046 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20000209T233307/Courier0000.lzma 2000-02-09T23:44:25.046Z,950139865.046 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Courier0000.lzma.bak 2000-02-09T23:44:25.046Z,950139865.046 [DataOverHttps](INFO): SBD MOMSN=23044100 2000-02-09T23:44:30.230Z,950139870.230 [NAL9602](INFO): Powering up NAL9602 2000-02-09T23:44:40.484Z,950139880.484 [DataOverHttps](INFO): Sending 166 bytes from file Logs/20000209T233307/Courier0004.lzma 2000-02-09T23:44:41.142Z,950139881.142 [NAL9602](INFO): NAL9602 initialized 2000-02-09T23:44:41.486Z,950139881.486 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Courier0004.lzma.bak 2000-02-09T23:44:41.486Z,950139881.486 [DataOverHttps](INFO): SBD MOMSN=23044104 2000-02-09T23:44:58.968Z,950139898.968 [DataOverHttps](INFO): Sending 234 bytes from file Logs/20240821T162439/Courier0004.lzma 2000-02-09T23:44:59.970Z,950139899.970 [DataOverHttps](INFO): Moved sent file to Logs/20240821T162439/Courier0004.lzma.bak 2000-02-09T23:44:59.970Z,950139899.970 [DataOverHttps](INFO): SBD MOMSN=23044106 2000-02-09T23:45:18.335Z,950139918.335 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240821T162439/Courier0007.lzma 2000-02-09T23:45:19.322Z,950139919.322 [DataOverHttps](INFO): Moved sent file to Logs/20240821T162439/Courier0007.lzma.bak 2000-02-09T23:45:19.322Z,950139919.322 [DataOverHttps](INFO): SBD MOMSN=23044111 2000-02-09T23:45:21.980Z,950139921.980 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2000-02-09T23:45:21.981Z,950139921.981 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-09T23:45:22.003Z,950139922.003 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-09T23:45:22.375Z,950139922.375 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-09T23:45:22.376Z,950139922.376 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2000-02-09T23:45:36.828Z,950139936.828 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20000208T221543/Express0001.lzma 2000-02-09T23:45:37.830Z,950139937.830 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221543/Express0001.lzma.bak 2000-02-09T23:45:37.830Z,950139937.830 [DataOverHttps](INFO): SBD MOMSN=23044113 2000-02-09T23:45:56.972Z,950139956.972 [DataOverHttps](INFO): Sending 1352 bytes from file Logs/20000208T221827/Express0001.lzma 2000-02-09T23:45:57.970Z,950139957.970 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Express0001.lzma.bak 2000-02-09T23:45:57.970Z,950139957.970 [DataOverHttps](INFO): SBD MOMSN=23044115 2000-02-09T23:46:15.334Z,950139975.334 [DataOverHttps](INFO): Sending 516 bytes from file Logs/20000208T221827/Express0005.lzma 2000-02-09T23:46:16.334Z,950139976.334 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Express0005.lzma.bak 2000-02-09T23:46:16.334Z,950139976.334 [DataOverHttps](INFO): SBD MOMSN=23044163 2000-02-09T23:46:33.629Z,950139993.629 [DataOverHttps](INFO): Sending 4323 bytes from file Logs/20000208T221827/Express0008.lzma 2000-02-09T23:46:34.618Z,950139994.618 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Express0008.lzma.bak 2000-02-09T23:46:34.618Z,950139994.618 [DataOverHttps](INFO): SBD MOMSN=23044191 2000-02-09T23:46:52.094Z,950140012.094 [DataOverHttps](INFO): Sending 4579 bytes from file Logs/20000208T221827/Express0011.lzma 2000-02-09T23:46:53.078Z,950140013.078 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Express0011.lzma.bak 2000-02-09T23:46:53.078Z,950140013.078 [DataOverHttps](INFO): SBD MOMSN=23045040 2000-02-09T23:47:11.986Z,950140031.986 [DataOverHttps](INFO): Sending 4609 bytes from file Logs/20000208T221827/Express0014.lzma 2000-02-09T23:47:12.974Z,950140032.974 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Express0014.lzma.bak 2000-02-09T23:47:12.974Z,950140032.974 [DataOverHttps](INFO): SBD MOMSN=23045901 2000-02-09T23:47:29.286Z,950140049.286 [DataOverHttps](INFO): Sending 4348 bytes from file Logs/20000208T221827/Express0017.lzma 2000-02-09T23:47:30.274Z,950140050.274 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Express0017.lzma.bak 2000-02-09T23:47:30.274Z,950140050.274 [DataOverHttps](INFO): SBD MOMSN=23046747 2000-02-09T23:47:50.266Z,950140070.266 [DataOverHttps](INFO): Sending 4605 bytes from file Logs/20000208T221827/Express0020.lzma 2000-02-09T23:47:51.254Z,950140071.254 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Express0020.lzma.bak 2000-02-09T23:47:51.254Z,950140071.254 [DataOverHttps](INFO): SBD MOMSN=23047600 2000-02-09T23:48:10.759Z,950140090.759 [DataOverHttps](INFO): Sending 4237 bytes from file Logs/20000208T221827/Express0023.lzma 2000-02-09T23:48:11.745Z,950140091.745 [DataOverHttps](INFO): Moved sent file to Logs/20000208T221827/Express0023.lzma.bak 2000-02-09T23:48:11.746Z,950140091.746 [DataOverHttps](INFO): SBD MOMSN=23048452 2000-02-09T23:48:23.028Z,950140103.028 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2000-02-09T23:48:23.028Z,950140103.028 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-09T23:48:23.071Z,950140103.071 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-09T23:48:23.456Z,950140103.456 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-09T23:48:23.457Z,950140103.457 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2000-02-09T23:48:35.827Z,950140115.827 [DataOverHttps](INFO): Sending 1227 bytes from file Logs/20000209T232855/Express0001.lzma 2000-02-09T23:48:36.826Z,950140116.826 [DataOverHttps](INFO): Moved sent file to Logs/20000209T232855/Express0001.lzma.bak 2000-02-09T23:48:36.826Z,950140116.826 [DataOverHttps](INFO): SBD MOMSN=23049205 2000-02-09T23:48:54.647Z,950140134.647 [DataOverHttps](INFO): Sending 780 bytes from file Logs/20000209T233129/Express0001.lzma 2000-02-09T23:48:55.646Z,950140135.646 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233129/Express0001.lzma.bak 2000-02-09T23:48:55.646Z,950140135.646 [DataOverHttps](INFO): SBD MOMSN=23049252 2000-02-09T23:49:15.625Z,950140155.625 [DataOverHttps](INFO): Sending 1081 bytes from file Logs/20000209T233307/Express0001.lzma 2000-02-09T23:49:16.622Z,950140156.622 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Express0001.lzma.bak 2000-02-09T23:49:16.622Z,950140156.622 [DataOverHttps](INFO): SBD MOMSN=23049271 2000-02-09T23:49:34.154Z,950140174.154 [DataOverHttps](INFO): Sending 185 bytes from file Logs/20000209T233307/Express0005.lzma 2000-02-09T23:49:35.154Z,950140175.154 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Express0005.lzma.bak 2000-02-09T23:49:35.154Z,950140175.154 [DataOverHttps](INFO): SBD MOMSN=23049305 2000-02-09T23:49:53.225Z,950140193.225 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20240819T211134/Express0050.lzma 2000-02-09T23:49:54.226Z,950140194.226 [DataOverHttps](INFO): Moved sent file to Logs/20240819T211134/Express0050.lzma.bak 2000-02-09T23:49:54.226Z,950140194.226 [DataOverHttps](INFO): SBD MOMSN=23049309 2000-02-09T23:50:16.082Z,950140216.082 [DataOverHttps](INFO): Sending 657 bytes from file Logs/20240819T235310/Express0001.lzma 2000-02-09T23:50:17.078Z,950140217.078 [DataOverHttps](INFO): Moved sent file to Logs/20240819T235310/Express0001.lzma.bak 2000-02-09T23:50:17.078Z,950140217.078 [DataOverHttps](INFO): SBD MOMSN=23049313 2000-02-09T23:50:37.067Z,950140237.067 [DataOverHttps](INFO): Sending 1345 bytes from file Logs/20240821T162439/Express0001.lzma 2000-02-09T23:50:38.066Z,950140238.066 [DataOverHttps](INFO): Moved sent file to Logs/20240821T162439/Express0001.lzma.bak 2000-02-09T23:50:38.066Z,950140238.066 [DataOverHttps](INFO): SBD MOMSN=23049341 2000-02-09T23:50:57.133Z,950140257.133 [DataOverHttps](INFO): Sending 438 bytes from file Logs/20240821T162439/Express0005.lzma 2000-02-09T23:50:58.134Z,950140258.134 [DataOverHttps](INFO): Moved sent file to Logs/20240821T162439/Express0005.lzma.bak 2000-02-09T23:50:58.134Z,950140258.134 [DataOverHttps](INFO): SBD MOMSN=23049391 2000-02-09T23:51:19.999Z,950140279.999 [DataOverHttps](INFO): Sending 1511 bytes from file Logs/20240821T162439/Express0008.lzma 2000-02-09T23:51:21.001Z,950140281.001 [DataOverHttps](INFO): Moved sent file to Logs/20240821T162439/Express0008.lzma.bak 2000-02-09T23:51:21.001Z,950140281.001 [DataOverHttps](INFO): SBD MOMSN=23049417 2000-02-09T23:51:23.997Z,950140283.997 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2000-02-09T23:51:23.997Z,950140283.997 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-09T23:51:24.011Z,950140284.011 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-09T23:51:24.421Z,950140284.421 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-09T23:51:24.421Z,950140284.421 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2000-02-09T23:51:25.629Z,950140285.629 [Default:CheckIn:Read_Iridium] Stopped 2000-02-09T23:51:25.629Z,950140285.629 [Default:CheckIn:C.Wait] Running Loop=1 2000-02-09T23:51:25.629Z,950140285.629 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2000-02-09T23:54:25.003Z,950140465.003 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2000-02-09T23:54:25.003Z,950140465.003 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-09T23:54:25.031Z,950140465.031 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-09T23:54:25.398Z,950140465.398 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-09T23:54:25.398Z,950140465.398 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2000-02-09T23:54:43.138Z,950140483.138 [NAL9602](FAULT): GPS failed to acquire within timeout. 2000-02-09T23:54:43.138Z,950140483.138 [NAL9602] Data Fault, FailCount= 2 2000-02-09T23:54:43.138Z,950140483.138 [NAL9602](ERROR): Data Fault 2000-02-09T23:54:43.155Z,950140483.155 [CBIT](ERROR): Data Fault in component: NAL9602 2000-02-09T23:54:43.543Z,950140483.543 [NAL9602](INFO): Powering down 2000-02-09T23:54:44.386Z,950140484.386 [CBIT](INFO): Clearing failed state for component NAL9602 2000-02-09T23:54:44.387Z,950140484.387 [NAL9602] No Fault, FailCount= 2 2000-02-09T23:55:13.855Z,950140513.855 [NAL9602](INFO): Powering up NAL9602 2000-02-09T23:55:24.750Z,950140524.750 [NAL9602](INFO): NAL9602 initialized 2000-02-09T23:56:26.186Z,950140586.186 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2000-02-09T23:56:26.186Z,950140586.186 [Default:CheckIn:C.Wait] Stopped 2000-02-09T23:56:26.186Z,950140586.186 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2000-02-09T23:56:26.187Z,950140586.187 [Default:CheckIn:D] Running Loop=1 2000-02-09T23:56:26.601Z,950140586.601 [Default:CheckIn:D] Stopped 2000-02-09T23:56:26.601Z,950140586.601 [Default:CheckIn:E] Running Loop=1 2000-02-09T23:56:26.974Z,950140586.974 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 19.061827 min 2000-02-09T23:56:26.974Z,950140586.974 [Default:CheckIn:E] Stopped 2000-02-09T23:56:26.974Z,950140586.974 [Default:CheckIn](INFO): Completed Default:CheckIn 2000-02-09T23:56:26.974Z,950140586.974 [Default:CheckIn] Stopped 2000-02-09T23:56:26.974Z,950140586.974 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2000-02-09T23:56:26.975Z,950140586.975 [Default:CheckIn](INFO): Running loop #2 2000-02-09T23:56:26.975Z,950140586.975 [Default:CheckIn] Running Loop=2 2000-02-09T23:56:26.975Z,950140586.975 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2000-02-09T23:56:26.975Z,950140586.975 [Default:CheckIn:Read_GPS] Running Loop=1 2000-02-09T23:57:25.957Z,950140645.957 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2000-02-09T23:57:25.957Z,950140645.957 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-09T23:57:25.971Z,950140645.971 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-09T23:57:26.380Z,950140646.380 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-09T23:57:26.381Z,950140646.381 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2000-02-10T00:00:26.949Z,950140826.949 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2000-02-10T00:00:26.949Z,950140826.949 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:00:26.959Z,950140826.959 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:00:27.362Z,950140827.362 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:00:27.362Z,950140827.362 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2000-02-10T00:01:27.153Z,950140887.153 [Default:CheckIn:Read_GPS](INFO): Timed out from 2000-02-09T23:56:26.0Z 2000-02-10T00:01:27.154Z,950140887.154 [Default:CheckIn:Read_GPS] Stopped 2000-02-10T00:01:27.154Z,950140887.154 [Default:CheckIn:Read_Iridium] Running Loop=1 2000-02-10T00:01:34.271Z,950140894.271 [DataOverHttps](INFO): Sending 37 bytes from file Logs/20000209T233307/Courier0007.lzma 2000-02-10T00:01:35.274Z,950140895.274 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Courier0007.lzma.bak 2000-02-10T00:01:35.274Z,950140895.274 [DataOverHttps](INFO): SBD MOMSN=23049668 2000-02-10T00:01:52.796Z,950140912.796 [DataOverHttps](INFO): Sending 189 bytes from file Logs/20000209T233307/Express0008.lzma 2000-02-10T00:01:53.798Z,950140913.798 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Express0008.lzma.bak 2000-02-10T00:01:53.798Z,950140913.798 [DataOverHttps](INFO): SBD MOMSN=23049670 2000-02-10T00:01:58.678Z,950140918.678 [Default:CheckIn:Read_Iridium] Stopped 2000-02-10T00:01:58.678Z,950140918.678 [Default:CheckIn:C.Wait] Running Loop=1 2000-02-10T00:01:58.678Z,950140918.678 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2000-02-10T00:03:27.963Z,950141007.963 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2000-02-10T00:03:27.963Z,950141007.963 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:03:27.973Z,950141007.973 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:03:28.387Z,950141008.387 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:03:28.387Z,950141008.387 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2000-02-10T00:05:27.935Z,950141127.935 [NAL9602](FAULT): GPS failed to acquire within timeout. 2000-02-10T00:05:27.935Z,950141127.935 [NAL9602] Data Fault, FailCount= 3 2000-02-10T00:05:27.935Z,950141127.935 [NAL9602](ERROR): Data Fault 2000-02-10T00:05:27.984Z,950141127.984 [CBIT](ERROR): Data Fault in component: NAL9602 2000-02-10T00:05:28.351Z,950141128.351 [NAL9602](INFO): Powering down 2000-02-10T00:05:29.167Z,950141129.167 [CBIT](INFO): Clearing failed state for component NAL9602 2000-02-10T00:05:29.167Z,950141129.167 [NAL9602] No Fault, FailCount= 3 2000-02-10T00:05:58.642Z,950141158.642 [NAL9602](INFO): Powering up NAL9602 2000-02-10T00:06:09.546Z,950141169.546 [NAL9602](INFO): NAL9602 initialized 2000-02-10T00:06:28.949Z,950141188.949 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2000-02-10T00:06:28.949Z,950141188.949 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:06:28.959Z,950141188.959 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:06:29.371Z,950141189.371 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:06:29.372Z,950141189.372 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2000-02-10T00:06:59.273Z,950141219.273 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2000-02-10T00:06:59.273Z,950141219.273 [Default:CheckIn:C.Wait] Stopped 2000-02-10T00:06:59.273Z,950141219.273 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2000-02-10T00:06:59.274Z,950141219.274 [Default:CheckIn:D] Running Loop=1 2000-02-10T00:06:59.650Z,950141219.650 [Default:CheckIn:D] Stopped 2000-02-10T00:06:59.650Z,950141219.650 [Default:CheckIn:E] Running Loop=1 2000-02-10T00:07:00.059Z,950141220.059 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 29.612653 min 2000-02-10T00:07:00.059Z,950141220.059 [Default:CheckIn:E] Stopped 2000-02-10T00:07:00.059Z,950141220.059 [Default:CheckIn](INFO): Completed Default:CheckIn 2000-02-10T00:07:00.059Z,950141220.059 [Default:CheckIn] Stopped 2000-02-10T00:07:00.059Z,950141220.059 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2000-02-10T00:07:00.060Z,950141220.060 [Default:CheckIn](INFO): Running loop #3 2000-02-10T00:07:00.060Z,950141220.060 [Default:CheckIn] Running Loop=3 2000-02-10T00:07:00.060Z,950141220.060 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2000-02-10T00:07:00.060Z,950141220.060 [Default:CheckIn:Read_GPS] Running Loop=1 2000-02-10T00:09:29.950Z,950141369.950 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2000-02-10T00:09:29.950Z,950141369.950 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:09:29.960Z,950141369.960 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:09:30.373Z,950141370.373 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:09:30.373Z,950141370.373 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2000-02-10T00:12:00.262Z,950141520.262 [Default:CheckIn:Read_GPS](INFO): Timed out from 2000-02-10T00:07:00.1Z 2000-02-10T00:12:00.262Z,950141520.262 [Default:CheckIn:Read_GPS] Stopped 2000-02-10T00:12:00.262Z,950141520.262 [Default:CheckIn:Read_Iridium] Running Loop=1 2000-02-10T00:12:07.151Z,950141527.151 [DataOverHttps](INFO): Sending 37 bytes from file Logs/20000209T233307/Courier0010.lzma 2000-02-10T00:12:08.154Z,950141528.154 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Courier0010.lzma.bak 2000-02-10T00:12:08.154Z,950141528.154 [DataOverHttps](INFO): SBD MOMSN=23049705 2000-02-10T00:12:25.592Z,950141545.592 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20000209T233307/Express0011.lzma 2000-02-10T00:12:26.594Z,950141546.594 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Express0011.lzma.bak 2000-02-10T00:12:26.594Z,950141546.594 [DataOverHttps](INFO): SBD MOMSN=23049707 2000-02-10T00:12:30.955Z,950141550.955 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2000-02-10T00:12:30.955Z,950141550.955 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:12:30.973Z,950141550.973 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:12:31.366Z,950141551.366 [Default:CheckIn:Read_Iridium] Stopped 2000-02-10T00:12:31.366Z,950141551.366 [Default:CheckIn:C.Wait] Running Loop=1 2000-02-10T00:12:31.366Z,950141551.366 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2000-02-10T00:12:31.379Z,950141551.379 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:12:31.379Z,950141551.379 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2000-02-10T00:15:31.933Z,950141731.933 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2000-02-10T00:15:31.933Z,950141731.933 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:15:31.943Z,950141731.943 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:15:32.355Z,950141732.355 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:15:32.355Z,950141732.355 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2000-02-10T00:16:10.706Z,950141770.706 [NAL9602](FAULT): GPS failed to acquire within timeout. 2000-02-10T00:16:10.706Z,950141770.706 [NAL9602] Data Fault, FailCount= 4 2000-02-10T00:16:10.706Z,950141770.706 [NAL9602](ERROR): Data Fault 2000-02-10T00:16:10.723Z,950141770.723 [CBIT](ERROR): Data Fault in component: NAL9602 2000-02-10T00:16:11.121Z,950141771.121 [NAL9602](INFO): Powering down 2000-02-10T00:16:11.967Z,950141771.967 [CBIT](INFO): Clearing failed state for component NAL9602 2000-02-10T00:16:11.967Z,950141771.967 [NAL9602] No Fault, FailCount= 4 2000-02-10T00:16:41.429Z,950141801.429 [NAL9602](INFO): Powering up NAL9602 2000-02-10T00:16:52.318Z,950141812.318 [NAL9602](INFO): NAL9602 initialized 2000-02-10T00:17:31.942Z,950141851.942 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2000-02-10T00:17:31.942Z,950141851.942 [Default:CheckIn:C.Wait] Stopped 2000-02-10T00:17:31.942Z,950141851.942 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2000-02-10T00:17:31.942Z,950141851.942 [Default:CheckIn:D] Running Loop=1 2000-02-10T00:17:32.346Z,950141852.346 [Default:CheckIn:D] Stopped 2000-02-10T00:17:32.346Z,950141852.346 [Default:CheckIn:E] Running Loop=1 2000-02-10T00:17:32.740Z,950141852.740 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 40.157585 min 2000-02-10T00:17:32.740Z,950141852.740 [Default:CheckIn:E] Stopped 2000-02-10T00:17:32.740Z,950141852.740 [Default:CheckIn](INFO): Completed Default:CheckIn 2000-02-10T00:17:32.740Z,950141852.740 [Default:CheckIn] Stopped 2000-02-10T00:17:32.740Z,950141852.740 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2000-02-10T00:17:32.741Z,950141852.741 [Default:CheckIn](INFO): Running loop #4 2000-02-10T00:17:32.741Z,950141852.741 [Default:CheckIn] Running Loop=4 2000-02-10T00:17:32.741Z,950141852.741 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2000-02-10T00:17:32.741Z,950141852.741 [Default:CheckIn:Read_GPS] Running Loop=1 2000-02-10T00:18:32.925Z,950141912.925 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2000-02-10T00:18:32.925Z,950141912.925 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:18:32.935Z,950141912.935 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:18:33.358Z,950141913.358 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:18:33.358Z,950141913.358 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2000-02-10T00:21:33.937Z,950142093.937 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2000-02-10T00:21:33.937Z,950142093.937 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:21:33.947Z,950142093.947 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:21:34.356Z,950142094.356 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:21:34.356Z,950142094.356 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2000-02-10T00:22:32.903Z,950142152.903 [Default:CheckIn:Read_GPS](INFO): Timed out from 2000-02-10T00:17:32.7Z 2000-02-10T00:22:32.903Z,950142152.903 [Default:CheckIn:Read_GPS] Stopped 2000-02-10T00:22:32.903Z,950142152.903 [Default:CheckIn:Read_Iridium] Running Loop=1 2000-02-10T00:22:40.484Z,950142160.484 [DataOverHttps](INFO): Sending 37 bytes from file Logs/20000209T233307/Courier0013.lzma 2000-02-10T00:22:41.486Z,950142161.486 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Courier0013.lzma.bak 2000-02-10T00:22:41.486Z,950142161.486 [DataOverHttps](INFO): SBD MOMSN=23049834 2000-02-10T00:23:01.652Z,950142181.652 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20000209T233307/Express0014.lzma 2000-02-10T00:23:02.654Z,950142182.654 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Express0014.lzma.bak 2000-02-10T00:23:02.654Z,950142182.654 [DataOverHttps](INFO): SBD MOMSN=23049836 2000-02-10T00:23:07.661Z,950142187.661 [Default:CheckIn:Read_Iridium] Stopped 2000-02-10T00:23:07.661Z,950142187.661 [Default:CheckIn:C.Wait] Running Loop=1 2000-02-10T00:23:07.662Z,950142187.662 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2000-02-10T00:24:34.908Z,950142274.908 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2000-02-10T00:24:34.909Z,950142274.909 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:24:34.919Z,950142274.919 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:24:35.331Z,950142275.331 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:24:35.332Z,950142275.332 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2000-02-10T00:26:54.278Z,950142414.278 [NAL9602](FAULT): GPS failed to acquire within timeout. 2000-02-10T00:26:54.278Z,950142414.278 [NAL9602] Data Fault, FailCount= 5 2000-02-10T00:26:54.278Z,950142414.278 [NAL9602](ERROR): Data Fault 2000-02-10T00:26:54.352Z,950142414.352 [CBIT](ERROR): Data Fault in component: NAL9602 2000-02-10T00:26:54.352Z,950142414.352 [CBIT](CRITICAL): Data Fault in component: NAL9602 2000-02-10T00:26:54.682Z,950142414.682 [NAL9602](INFO): Powering down 2000-02-10T00:26:54.744Z,950142414.744 [CBIT](INFO): Critical error at 20000210T002654 2000-02-10T00:27:35.902Z,950142455.902 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2000-02-10T00:27:35.902Z,950142455.902 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:27:35.912Z,950142455.912 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:27:36.320Z,950142456.320 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:27:36.320Z,950142456.320 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2000-02-10T00:28:08.221Z,950142488.221 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2000-02-10T00:28:08.221Z,950142488.221 [Default:CheckIn:C.Wait] Stopped 2000-02-10T00:28:08.221Z,950142488.221 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2000-02-10T00:28:08.221Z,950142488.221 [Default:CheckIn:D] Running Loop=1 2000-02-10T00:28:08.627Z,950142488.627 [Default:CheckIn:D] Stopped 2000-02-10T00:28:08.627Z,950142488.627 [Default:CheckIn:E] Running Loop=1 2000-02-10T00:28:09.037Z,950142489.037 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.762268 min 2000-02-10T00:28:09.037Z,950142489.037 [Default:CheckIn:E] Stopped 2000-02-10T00:28:09.037Z,950142489.037 [Default:CheckIn](INFO): Completed Default:CheckIn 2000-02-10T00:28:09.037Z,950142489.037 [Default:CheckIn] Stopped 2000-02-10T00:28:09.037Z,950142489.037 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2000-02-10T00:28:09.037Z,950142489.037 [Default:CheckIn](INFO): Running loop #5 2000-02-10T00:28:09.037Z,950142489.037 [Default:CheckIn] Running Loop=5 2000-02-10T00:28:09.037Z,950142489.037 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2000-02-10T00:28:09.037Z,950142489.037 [Default:CheckIn:Read_GPS] Running Loop=1 2000-02-10T00:28:54.286Z,950142534.286 [CBIT](INFO): Clearing failed state for component NAL9602 2000-02-10T00:28:54.286Z,950142534.286 [NAL9602] No Fault, FailCount= 5 2000-02-10T00:28:54.687Z,950142534.687 [NAL9602](INFO): Powering up NAL9602 2000-02-10T00:29:05.597Z,950142545.597 [NAL9602](INFO): NAL9602 initialized 2000-02-10T00:30:36.917Z,950142636.917 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2000-02-10T00:30:36.917Z,950142636.917 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:30:36.927Z,950142636.927 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:30:37.332Z,950142637.332 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:30:37.332Z,950142637.332 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2000-02-10T00:33:09.247Z,950142789.247 [Default:CheckIn:Read_GPS](INFO): Timed out from 2000-02-10T00:28:09.0Z 2000-02-10T00:33:09.247Z,950142789.247 [Default:CheckIn:Read_GPS] Stopped 2000-02-10T00:33:09.247Z,950142789.247 [Default:CheckIn:Read_Iridium] Running Loop=1 2000-02-10T00:33:16.100Z,950142796.100 [DataOverHttps](INFO): Sending 102 bytes from file Logs/20000209T233307/Courier0016.lzma 2000-02-10T00:33:17.102Z,950142797.102 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Courier0016.lzma.bak 2000-02-10T00:33:17.102Z,950142797.102 [DataOverHttps](INFO): SBD MOMSN=23049933 2000-02-10T00:33:34.536Z,950142814.536 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20000209T233307/Express0017.lzma 2000-02-10T00:33:35.538Z,950142815.538 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Express0017.lzma.bak 2000-02-10T00:33:35.538Z,950142815.538 [DataOverHttps](INFO): SBD MOMSN=23049936 2000-02-10T00:33:37.967Z,950142817.967 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2000-02-10T00:33:37.967Z,950142817.967 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:33:38.074Z,950142818.074 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:33:38.433Z,950142818.433 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:33:38.433Z,950142818.433 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2000-02-10T00:33:42.342Z,950142822.342 [Default:CheckIn:Read_Iridium] Stopped 2000-02-10T00:33:42.342Z,950142822.342 [Default:CheckIn:C.Wait] Running Loop=1 2000-02-10T00:33:42.342Z,950142822.342 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2000-02-10T00:36:38.915Z,950142998.915 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21 2000-02-10T00:36:38.915Z,950142998.915 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:36:38.925Z,950142998.925 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:36:39.339Z,950142999.339 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:36:39.340Z,950142999.340 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21 2000-02-10T00:38:42.970Z,950143122.970 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2000-02-10T00:38:42.970Z,950143122.970 [Default:CheckIn:C.Wait] Stopped 2000-02-10T00:38:42.970Z,950143122.970 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2000-02-10T00:38:42.970Z,950143122.970 [Default:CheckIn:D] Running Loop=1 2000-02-10T00:38:43.338Z,950143123.338 [Default:CheckIn:D] Stopped 2000-02-10T00:38:43.338Z,950143123.338 [Default:CheckIn:E] Running Loop=1 2000-02-10T00:38:43.741Z,950143123.741 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 61.340788 min 2000-02-10T00:38:43.741Z,950143123.741 [Default:CheckIn:E] Stopped 2000-02-10T00:38:43.741Z,950143123.741 [Default:CheckIn](INFO): Completed Default:CheckIn 2000-02-10T00:38:43.741Z,950143123.741 [Default:CheckIn] Stopped 2000-02-10T00:38:43.741Z,950143123.741 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2000-02-10T00:38:43.741Z,950143123.741 [Default:CheckIn](INFO): Running loop #6 2000-02-10T00:38:43.741Z,950143123.741 [Default:CheckIn] Running Loop=6 2000-02-10T00:38:43.742Z,950143123.742 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2000-02-10T00:38:43.742Z,950143123.742 [Default:CheckIn:Read_GPS] Running Loop=1 2000-02-10T00:39:08.774Z,950143148.774 [NAL9602](FAULT): GPS failed to acquire within timeout. 2000-02-10T00:39:08.774Z,950143148.774 [NAL9602] Data Fault, FailCount= 1 2000-02-10T00:39:08.774Z,950143148.774 [NAL9602](ERROR): Data Fault 2000-02-10T00:39:08.791Z,950143148.791 [CBIT](ERROR): Data Fault in component: NAL9602 2000-02-10T00:39:09.189Z,950143149.189 [NAL9602](INFO): Powering down 2000-02-10T00:39:09.998Z,950143149.998 [CBIT](INFO): Clearing failed state for component NAL9602 2000-02-10T00:39:09.998Z,950143149.998 [NAL9602] No Fault, FailCount= 1 2000-02-10T00:39:39.474Z,950143179.474 [NAL9602](INFO): Powering up NAL9602 2000-02-10T00:39:39.884Z,950143179.884 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22 2000-02-10T00:39:39.885Z,950143179.885 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:39:39.918Z,950143179.918 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:39:40.297Z,950143180.297 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:39:40.297Z,950143180.297 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22 2000-02-10T00:39:50.378Z,950143190.378 [NAL9602](INFO): NAL9602 initialized 2000-02-10T00:42:40.913Z,950143360.913 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23 2000-02-10T00:42:40.913Z,950143360.913 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:42:40.924Z,950143360.924 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:42:41.342Z,950143361.342 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:42:41.342Z,950143361.342 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23 2000-02-10T00:42:43.285Z,950143363.285 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-10T00:42:57.438Z,950143377.438 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-10T00:43:11.161Z,950143391.161 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2000-02-10T00:43:25.301Z,950143405.301 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-10T00:43:39.445Z,950143419.445 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-10T00:43:43.902Z,950143423.902 [Default:CheckIn:Read_GPS](INFO): Timed out from 2000-02-10T00:38:43.7Z 2000-02-10T00:43:43.903Z,950143423.903 [Default:CheckIn:Read_GPS] Stopped 2000-02-10T00:43:43.903Z,950143423.903 [Default:CheckIn:Read_Iridium] Running Loop=1 2000-02-10T00:43:49.101Z,950143429.101 [CommandExec](IMPORTANT): got command failComponent 2000-02-10T00:43:49.101Z,950143429.101 [CommandExec](IMPORTANT): Failed components: 2000-02-10T00:43:49.101Z,950143429.101 [CommandExec](IMPORTANT): No failed Components. 2000-02-10T00:43:51.552Z,950143431.552 [DataOverHttps](INFO): Sending 37 bytes from file Logs/20000209T233307/Courier0019.lzma 2000-02-10T00:43:52.554Z,950143432.554 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Courier0019.lzma.bak 2000-02-10T00:43:52.554Z,950143432.554 [DataOverHttps](INFO): SBD MOMSN=23050071 2000-02-10T00:43:53.597Z,950143433.597 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-10T00:44:07.737Z,950143447.737 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-10T00:44:10.100Z,950143450.100 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20000209T233307/Express0020.lzma 2000-02-10T00:44:11.102Z,950143451.102 [DataOverHttps](INFO): Moved sent file to Logs/20000209T233307/Express0020.lzma.bak 2000-02-10T00:44:11.102Z,950143451.102 [DataOverHttps](INFO): SBD MOMSN=23050074 2000-02-10T00:44:15.849Z,950143455.849 [Default:CheckIn:Read_Iridium] Stopped 2000-02-10T00:44:15.849Z,950143455.849 [Default:CheckIn:C.Wait] Running Loop=1 2000-02-10T00:44:15.849Z,950143455.849 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2000-02-10T00:44:21.877Z,950143461.877 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-10T00:44:36.016Z,950143476.016 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2000-02-10T00:45:42.069Z,950143542.069 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24 2000-02-10T00:45:42.069Z,950143542.069 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2000-02-10T00:45:42.079Z,950143542.079 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2000-02-10T00:45:42.485Z,950143542.485 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2000-02-10T00:45:42.485Z,950143542.485 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24 2000-02-10T00:46:08.073Z,950143568.073 [CommandExec](IMPORTANT): got command quit 2000-02-10T00:46:09.076Z,950143569.076 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-10T00:46:09.076Z,950143569.076 [CommandExec](INFO): Uninitializing the command executive. 2000-02-10T00:46:09.076Z,950143569.076 [CommandExec](INFO): Uninitializing the command scheduler. 2000-02-10T00:46:09.077Z,950143569.077 [CommandExec ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:09.196Z,950143569.196 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2000-02-10T00:46:09.196Z,950143569.196 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2000-02-10T00:46:09.196Z,950143569.196 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:09.197Z,950143569.197 [NavChartDb](INFO): Join timeout helper Thread ID is 4422 2000-02-10T00:46:09.204Z,950143569.204 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-10T00:46:09.204Z,950143569.204 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:09.225Z,950143569.225 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2000-02-10T00:46:09.225Z,950143569.225 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:09.225Z,950143569.225 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4423 2000-02-10T00:46:10.101Z,950143570.101 [CTD_Seabird](INFO): Powering down 2000-02-10T00:46:10.116Z,950143570.116 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-10T00:46:10.116Z,950143570.116 [CTD_Seabird](INFO): Powering down 2000-02-10T00:46:10.128Z,950143570.128 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:10.144Z,950143570.144 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2000-02-10T00:46:10.144Z,950143570.144 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:10.145Z,950143570.145 [Radio_Surface](INFO): Join timeout helper Thread ID is 4424 2000-02-10T00:46:10.312Z,950143570.312 [Radio_Surface](INFO): Powering down 2000-02-10T00:46:10.313Z,950143570.313 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-10T00:46:10.313Z,950143570.313 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:10.324Z,950143570.324 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2000-02-10T00:46:10.324Z,950143570.324 [Onboard ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:10.325Z,950143570.325 [Onboard](INFO): Join timeout helper Thread ID is 4425 2000-02-10T00:46:10.980Z,950143570.980 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2000-02-10T00:46:12.556Z,950143572.556 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-10T00:46:12.557Z,950143572.557 [Onboard ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:12.564Z,950143572.564 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2000-02-10T00:46:12.564Z,950143572.564 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:12.565Z,950143572.565 [DataOverHttps](INFO): Join timeout helper Thread ID is 4426 2000-02-10T00:46:12.988Z,950143572.988 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-10T00:46:12.988Z,950143572.988 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:13.001Z,950143573.001 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2000-02-10T00:46:13.001Z,950143573.001 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:13.001Z,950143573.001 [BackseatComponent](INFO): Join timeout helper Thread ID is 4427 2000-02-10T00:46:13.165Z,950143573.165 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-10T00:46:13.165Z,950143573.165 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:13.166Z,950143573.166 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2000-02-10T00:46:13.166Z,950143573.166 [logger ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:13.167Z,950143573.167 [logger](INFO): Join timeout helper Thread ID is 4428 2000-02-10T00:46:13.169Z,950143573.169 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-10T00:46:13.169Z,950143573.169 [logger ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:13.177Z,950143573.177 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2000-02-10T00:46:13.177Z,950143573.177 [CommandLine ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:13.178Z,950143573.178 [CommandLine](INFO): Join timeout helper Thread ID is 4429 2000-02-10T00:46:13.264Z,950143573.264 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-10T00:46:13.265Z,950143573.265 [CommandLine ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:13.281Z,950143573.281 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2000-02-10T00:46:13.281Z,950143573.281 [CommandExec ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:13.281Z,950143573.281 [CommandExec](INFO): Join timeout helper Thread ID is 4430 2000-02-10T00:46:13.282Z,950143573.282 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2000-02-10T00:46:13.283Z,950143573.283 [controlThread ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:13.283Z,950143573.283 [controlThread](INFO): Join timeout helper Thread ID is 4431 2000-02-10T00:46:13.536Z,950143573.536 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2000-02-10T00:46:13.536Z,950143573.536 [controlThread](DEBUG): Uninitializing ControlThread 2000-02-10T00:46:13.537Z,950143573.537 [AHRS_M2](INFO): Powering down 2000-02-10T00:46:13.704Z,950143573.704 [DVL_micro](INFO): Powering down 2000-02-10T00:46:13.705Z,950143573.705 [NAL9602](INFO): Powering down 2000-02-10T00:46:13.706Z,950143573.706 [Sonardyne_Nano](INFO): Powering down 2000-02-10T00:46:13.825Z,950143573.825 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2000-02-10T00:46:13.826Z,950143573.826 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2000-02-10T00:46:13.826Z,950143573.826 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2000-02-10T00:46:13.827Z,950143573.827 [MissionManager](INFO): Uninitializing Mission Default 2000-02-10T00:46:13.827Z,950143573.827 [Default] Stopped 2000-02-10T00:46:13.827Z,950143573.827 [Default](DEBUG): Aggregate::uninitialize Default 2000-02-10T00:46:13.827Z,950143573.827 [Default:B.GoToSurface] Stopped 2000-02-10T00:46:13.827Z,950143573.827 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2000-02-10T00:46:13.827Z,950143573.827 [Default:CheckIn] Stopped 2000-02-10T00:46:13.827Z,950143573.827 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2000-02-10T00:46:13.828Z,950143573.828 [Default:CheckIn:C.Wait] Stopped 2000-02-10T00:46:13.828Z,950143573.828 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2000-02-10T00:46:13.830Z,950143573.830 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2000-02-10T00:46:13.831Z,950143573.831 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2000-02-10T00:46:13.831Z,950143573.831 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2000-02-10T00:46:13.831Z,950143573.831 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2000-02-10T00:46:13.831Z,950143573.831 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2000-02-10T00:46:13.832Z,950143573.832 [BuoyancyServo](INFO): Powering down 2000-02-10T00:46:13.844Z,950143573.844 [MassServo](DEBUG): Uninitialize Mass Servo. 2000-02-10T00:46:13.844Z,950143573.844 [MassServo](INFO): Powering down 2000-02-10T00:46:13.845Z,950143573.845 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2000-02-10T00:46:13.845Z,950143573.845 [RudderServo](INFO): Powering down 2000-02-10T00:46:13.846Z,950143573.846 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2000-02-10T00:46:13.846Z,950143573.846 [ThrusterHE](INFO): Powering down 2000-02-10T00:46:13.847Z,950143573.847 [SBIT](DEBUG): Uninitialize SBIT Component. 2000-02-10T00:46:13.847Z,950143573.847 [IBIT](DEBUG): Uninitialize IBIT Component. 2000-02-10T00:46:13.847Z,950143573.847 [CBIT](DEBUG): Uninitialize CBIT Component. 2000-02-10T00:46:13.848Z,950143573.848 [CBIT](DEBUG): Powering off loads. 2000-02-10T00:46:13.860Z,950143573.860 [CBIT](DEBUG): Disabling WDT. 2000-02-10T00:46:13.872Z,950143573.872 [CBIT](DEBUG): Opening all GF detection circuits. 2000-02-10T00:46:13.873Z,950143573.873 [controlThread ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:13.919Z,950143573.919 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:13.922Z,950143573.922 [Onboard ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:13.930Z,950143573.930 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:13.974Z,950143573.974 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:14.029Z,950143574.029 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:14.051Z,950143574.051 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2000-02-10T00:46:14.113Z,950143574.113 [logger ThreadHandler](INFO): Thread cancelled.