2014-09-23T01:50:18.388Z,1411437018.388 [Supervisor](DEBUG): Initializing supervisor.
2014-09-23T01:50:18.392Z,1411437018.392 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2014-09-23T01:50:18.392Z,1411437018.392 [SyncHandler](INFO): Protected caller Thread ID is 765
2014-09-23T01:50:18.393Z,1411437018.393 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2014-09-23T01:50:18.395Z,1411437018.395 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2014-09-23T01:50:18.395Z,1411437018.395 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 766
2014-09-23T01:50:18.398Z,1411437018.398 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2014-09-23T01:50:18.410Z,1411437018.410 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2014-09-23T01:50:18.415Z,1411437018.415 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2014-09-23T01:50:18.415Z,1411437018.415 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 767
2014-09-23T01:50:18.416Z,1411437018.416 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2014-09-23T01:50:18.419Z,1411437018.419 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2014-09-23T01:50:18.419Z,1411437018.419 [logger ThreadHandler](INFO): Protected caller Thread ID is 768
2014-09-23T01:50:18.421Z,1411437018.421 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2014-09-23T01:50:18.422Z,1411437018.422 [Supervisor](INFO): Looking for Config files in directory: Config/
2014-09-23T01:50:18.425Z,1411437018.425 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2014-09-23T01:50:18.845Z,1411437018.845 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2014-09-23T01:50:18.846Z,1411437018.846 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2014-09-23T01:50:19.032Z,1411437019.032 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2014-09-23T01:50:19.035Z,1411437019.035 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2014-09-23T01:50:19.161Z,1411437019.161 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2014-09-23T01:50:19.164Z,1411437019.164 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2014-09-23T01:50:19.305Z,1411437019.305 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2014-09-23T01:50:19.306Z,1411437019.306 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2014-09-23T01:50:19.404Z,1411437019.404 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2014-09-23T01:50:19.577Z,1411437019.577 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2014-09-23T01:50:19.578Z,1411437019.578 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2014-09-23T01:50:19.676Z,1411437019.676 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2014-09-23T01:50:19.677Z,1411437019.677 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2014-09-23T01:50:19.918Z,1411437019.918 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2014-09-23T01:50:19.920Z,1411437019.920 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2014-09-23T01:50:20.321Z,1411437020.321 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2014-09-23T01:50:20.322Z,1411437020.322 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2014-09-23T01:50:20.695Z,1411437020.695 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2014-09-23T01:50:20.696Z,1411437020.696 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2014-09-23T01:50:21.301Z,1411437021.301 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2014-09-23T01:50:21.302Z,1411437021.302 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2014-09-23T01:50:21.549Z,1411437021.549 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2014-09-23T01:50:21.549Z,1411437021.549 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2014-09-23T01:50:21.669Z,1411437021.669 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2014-09-23T01:50:21.672Z,1411437021.672 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2014-09-23T01:50:22.174Z,1411437022.174 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2014-09-23T01:50:22.175Z,1411437022.175 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2014-09-23T01:50:32.223Z,1411437032.223 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2014-09-23T01:50:32.225Z,1411437032.225 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2014-09-23T01:50:33.010Z,1411437033.010 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2014-09-23T01:50:33.270Z,1411437033.270 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2014-09-23T01:50:33.271Z,1411437033.271 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2014-09-23T01:50:33.397Z,1411437033.397 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Estimation.cfg
2014-09-23T01:50:33.499Z,1411437033.499 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2014-09-23T01:50:33.601Z,1411437033.601 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2014-09-23T01:50:33.704Z,1411437033.704 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2014-09-23T01:50:33.856Z,1411437033.856 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2014-09-23T01:50:34.040Z,1411437034.040 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2014-09-23T01:50:34.146Z,1411437034.146 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2014-09-23T01:50:34.235Z,1411437034.235 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2014-09-23T01:50:34.332Z,1411437034.332 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2014-09-23T01:50:34.436Z,1411437034.436 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2014-09-23T01:50:34.626Z,1411437034.626 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2014-09-23T01:50:34.627Z,1411437034.627 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2014-09-23T01:50:34.632Z,1411437034.632 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2014-09-23T01:50:34.710Z,1411437034.710 [VerticalControl](DEBUG): Construct VerticalControl.
2014-09-23T01:50:34.839Z,1411437034.839 [VerticalControl] Loaded
2014-09-23T01:50:34.839Z,1411437034.839 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2014-09-23T01:50:34.840Z,1411437034.840 [HorizontalControl](DEBUG): Construct HorizontalControl.
2014-09-23T01:50:34.963Z,1411437034.963 [HorizontalControl] Loaded
2014-09-23T01:50:34.963Z,1411437034.963 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2014-09-23T01:50:34.964Z,1411437034.964 [SpeedControl](DEBUG): Construct SpeedControl.
2014-09-23T01:50:34.970Z,1411437034.970 [SpeedControl] Loaded
2014-09-23T01:50:34.971Z,1411437034.971 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2014-09-23T01:50:34.971Z,1411437034.971 [LoopControl](DEBUG): Construct LoopControl.
2014-09-23T01:50:34.972Z,1411437034.972 [LoopControl] Loaded
2014-09-23T01:50:34.972Z,1411437034.972 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2014-09-23T01:50:34.973Z,1411437034.973 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2014-09-23T01:50:34.975Z,1411437034.975 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2014-09-23T01:50:35.108Z,1411437035.108 [SBIT](DEBUG): Construct Startup Built In Test.
2014-09-23T01:50:35.120Z,1411437035.120 [SBIT] Loaded
2014-09-23T01:50:35.120Z,1411437035.120 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2014-09-23T01:50:35.121Z,1411437035.121 [IBIT](DEBUG): Construct Initiated Built In Test.
2014-09-23T01:50:35.152Z,1411437035.152 [IBIT] Loaded
2014-09-23T01:50:35.153Z,1411437035.153 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2014-09-23T01:50:35.155Z,1411437035.155 [CBIT](DEBUG): Construct CBIT Built In Test.
2014-09-23T01:50:35.284Z,1411437035.284 [CBIT] Loaded
2014-09-23T01:50:35.284Z,1411437035.284 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2014-09-23T01:50:35.285Z,1411437035.285 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2014-09-23T01:50:35.285Z,1411437035.285 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2014-09-23T01:50:35.317Z,1411437035.317 [DepthRateCalculator] Loaded
2014-09-23T01:50:35.318Z,1411437035.318 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2014-09-23T01:50:35.323Z,1411437035.323 [PitchRateCalculator] Loaded
2014-09-23T01:50:35.324Z,1411437035.324 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2014-09-23T01:50:35.336Z,1411437035.336 [SpeedCalculator] Loaded
2014-09-23T01:50:35.336Z,1411437035.336 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2014-09-23T01:50:35.354Z,1411437035.354 [TempGradientCalculator] Loaded
2014-09-23T01:50:35.354Z,1411437035.354 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2014-09-23T01:50:35.360Z,1411437035.360 [YawRateCalculator] Loaded
2014-09-23T01:50:35.360Z,1411437035.360 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2014-09-23T01:50:35.360Z,1411437035.360 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2014-09-23T01:50:35.361Z,1411437035.361 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2014-09-23T01:50:36.896Z,1411437036.896 [HFRCMReconstructedInterpolator] Loaded
2014-09-23T01:50:36.896Z,1411437036.896 [ComponentRegistry](DEBUG): SyncComponent "HFRCMReconstructedInterpolator" handled in the control thread.
2014-09-23T01:50:36.897Z,1411437036.897 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2014-09-23T01:50:36.898Z,1411437036.898 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2014-09-23T01:50:37.203Z,1411437037.203 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2014-09-23T01:50:37.204Z,1411437037.204 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2014-09-23T01:50:37.303Z,1411437037.303 [DeadReckonUsingMultipleVelocitySources] Loaded
2014-09-23T01:50:37.304Z,1411437037.304 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2014-09-23T01:50:37.352Z,1411437037.352 [DeadReckonWithRespectToWater] Loaded
2014-09-23T01:50:37.352Z,1411437037.352 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToWater" handled in the control thread.
2014-09-23T01:50:37.401Z,1411437037.401 [DeadReckonWithRespectToSeafloor] Loaded
2014-09-23T01:50:37.401Z,1411437037.401 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2014-09-23T01:50:37.454Z,1411437037.454 [DeadReckonUsingDVLWaterTrack] Loaded
2014-09-23T01:50:37.455Z,1411437037.455 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingDVLWaterTrack" handled in the control thread.
2014-09-23T01:50:37.474Z,1411437037.474 [NavChart] Loaded
2014-09-23T01:50:37.474Z,1411437037.474 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2014-09-23T01:50:37.478Z,1411437037.478 [UniversalFixResidualReporter] Loaded
2014-09-23T01:50:37.479Z,1411437037.479 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2014-09-23T01:50:37.479Z,1411437037.479 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2014-09-23T01:50:37.480Z,1411437037.480 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2014-09-23T01:50:50.579Z,1411437050.579 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2014-09-23T01:50:50.580Z,1411437050.580 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2014-09-23T01:50:51.675Z,1411437051.675 [Aanderaa_O2] Loaded
2014-09-23T01:50:51.675Z,1411437051.675 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2014-09-23T01:50:51.714Z,1411437051.714 [CTD_NeilBrown] Loaded
2014-09-23T01:50:51.715Z,1411437051.715 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2014-09-23T01:50:51.716Z,1411437051.716 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 405D94E0
2014-09-23T01:50:51.716Z,1411437051.716 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 852
2014-09-23T01:50:51.735Z,1411437051.735 [rhodamine] Loaded
2014-09-23T01:50:51.735Z,1411437051.735 [ComponentRegistry](DEBUG): SyncComponent "rhodamine" handled in the control thread.
2014-09-23T01:50:51.774Z,1411437051.774 [WetLabsBB2FL] Loaded
2014-09-23T01:50:51.774Z,1411437051.774 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2014-09-23T01:50:51.775Z,1411437051.775 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406094E0
2014-09-23T01:50:51.775Z,1411437051.775 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 853
2014-09-23T01:50:51.776Z,1411437051.776 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2014-09-23T01:50:51.777Z,1411437051.777 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2014-09-23T01:50:52.501Z,1411437052.501 [AHRS_sp3003D] Loaded
2014-09-23T01:50:52.501Z,1411437052.501 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2014-09-23T01:50:52.539Z,1411437052.539 [AcousticModem_Benthos_ATM900] Loaded
2014-09-23T01:50:52.540Z,1411437052.540 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2014-09-23T01:50:52.703Z,1411437052.703 [DataOverHttps] Loaded
2014-09-23T01:50:52.704Z,1411437052.704 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2014-09-23T01:50:52.718Z,1411437052.718 [Depth_Keller] Loaded
2014-09-23T01:50:52.718Z,1411437052.718 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2014-09-23T01:50:52.724Z,1411437052.724 [DropWeight] Loaded
2014-09-23T01:50:52.724Z,1411437052.724 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2014-09-23T01:50:52.875Z,1411437052.875 [DVL_micro] Loaded
2014-09-23T01:50:52.876Z,1411437052.876 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2014-09-23T01:50:52.986Z,1411437052.986 [NAL9602] Loaded
2014-09-23T01:50:52.986Z,1411437052.986 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2014-09-23T01:50:53.031Z,1411437053.031 [Onboard] Loaded
2014-09-23T01:50:53.031Z,1411437053.031 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2014-09-23T01:50:53.039Z,1411437053.039 [Radio_Surface] Loaded
2014-09-23T01:50:53.039Z,1411437053.039 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2014-09-23T01:50:53.040Z,1411437053.040 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408524E0
2014-09-23T01:50:53.041Z,1411437053.041 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 854
2014-09-23T01:50:55.047Z,1411437055.047 [BPC1] Loaded
2014-09-23T01:50:55.047Z,1411437055.047 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2014-09-23T01:50:55.048Z,1411437055.048 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2014-09-23T01:50:55.048Z,1411437055.048 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2014-09-23T01:50:55.188Z,1411437055.188 [BuoyancyServo] Loaded
2014-09-23T01:50:55.188Z,1411437055.188 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2014-09-23T01:50:55.201Z,1411437055.201 [ElevatorServo] Loaded
2014-09-23T01:50:55.202Z,1411437055.202 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2014-09-23T01:50:55.214Z,1411437055.214 [MassServo] Loaded
2014-09-23T01:50:55.214Z,1411437055.214 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2014-09-23T01:50:55.227Z,1411437055.227 [RudderServo] Loaded
2014-09-23T01:50:55.227Z,1411437055.227 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2014-09-23T01:50:55.239Z,1411437055.239 [ThrusterServo] Loaded
2014-09-23T01:50:55.240Z,1411437055.240 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2014-09-23T01:50:55.240Z,1411437055.240 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2014-09-23T01:50:55.241Z,1411437055.241 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2014-09-23T01:50:55.450Z,1411437055.450 [InternalSim] Loaded
2014-09-23T01:50:55.451Z,1411437055.451 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2014-09-23T01:50:55.451Z,1411437055.451 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2014-09-23T01:50:55.452Z,1411437055.452 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2014-09-23T01:50:55.495Z,1411437055.495 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2014-09-23T01:50:55.497Z,1411437055.497 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2014-09-23T01:50:55.498Z,1411437055.498 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2014-09-23T01:50:55.505Z,1411437055.505 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2014-09-23T01:50:55.506Z,1411437055.506 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409034E0
2014-09-23T01:50:55.506Z,1411437055.506 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 855
2014-09-23T01:50:55.511Z,1411437055.511 [Supervisor](INFO): Main Thread ID is 764
2014-09-23T01:50:55.511Z,1411437055.511 [Supervisor](DEBUG): Running supervisor.
2014-09-23T01:50:55.512Z,1411437055.512 [CommandLine ThreadHandler](INFO): Handler Thread ID is 856
2014-09-23T01:50:55.515Z,1411437055.515 [controlThread ThreadHandler](INFO): Handler Thread ID is 857
2014-09-23T01:50:55.515Z,1411437055.515 [controlThread](DEBUG): Initializing ControlThread
2014-09-23T01:50:55.516Z,1411437055.516 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2014-09-23T01:50:55.518Z,1411437055.518 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2014-09-23T01:50:55.519Z,1411437055.519 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2014-09-23T01:50:55.519Z,1411437055.519 [LoopControl](DEBUG): Initialize LoopControlComponent.
2014-09-23T01:50:55.519Z,1411437055.519 [SBIT](INFO): Initialize SBIT Component.
2014-09-23T01:50:55.520Z,1411437055.520 [SBIT](IMPORTANT): Tethys CM Info: SVN revision:11693
2014-09-23T01:50:55.520Z,1411437055.520 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2014-09-23T01:50:55.520Z,1411437055.520 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2014-09-23T01:50:55.521Z,1411437055.521 [IBIT](INFO): Initialize IBIT Component.
2014-09-23T01:50:55.522Z,1411437055.522 [CBIT](DEBUG): Initialize CBIT Component.
2014-09-23T01:50:55.522Z,1411437055.522 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2014-09-23T01:50:55.522Z,1411437055.522 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2014-09-23T01:50:55.523Z,1411437055.523 [logger ThreadHandler](INFO): Handler Thread ID is 858
2014-09-23T01:50:55.549Z,1411437055.549 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-09-23T01:50:55.549Z,1411437055.549 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2014-09-23T01:50:55.549Z,1411437055.549 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2014-09-23T01:50:55.550Z,1411437055.550 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2014-09-23T01:50:55.550Z,1411437055.550 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2014-09-23T01:50:55.551Z,1411437055.551 [HFRCMReconstructedInterpolator](INFO): Initializing HFRCMReconstructedInterpolator component with velocityAccuracy_ = 0.300000 m/s.
2014-09-23T01:50:55.553Z,1411437055.553 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-09-23T01:50:55.554Z,1411437055.554 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component.
2014-09-23T01:50:55.554Z,1411437055.554 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2014-09-23T01:50:55.554Z,1411437055.554 [DeadReckonUsingDVLWaterTrack](DEBUG): Initializing DeadReckonUsingDVLWaterTrack component.
2014-09-23T01:50:55.555Z,1411437055.555 [NavChart](DEBUG): Initialize NavChart Navigation.
2014-09-23T01:50:55.555Z,1411437055.555 [UniversalFixResidualReporter](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-09-23T01:50:55.565Z,1411437055.565 [InternalSim](DEBUG):  InternalSim initializing...
2014-09-23T01:50:55.569Z,1411437055.569 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 859
2014-09-23T01:50:55.570Z,1411437055.570 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2014-09-23T01:50:55.577Z,1411437055.577 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 861
2014-09-23T01:50:55.578Z,1411437055.578 [WetLabsBB2FL](INFO): Powering down
2014-09-23T01:50:55.597Z,1411437055.597 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2014-09-23T01:50:55.625Z,1411437055.625 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 862
2014-09-23T01:50:55.631Z,1411437055.631 [Radio_Surface](INFO): Powering up
2014-09-23T01:50:55.633Z,1411437055.633 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 863
2014-09-23T01:50:55.649Z,1411437055.649 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2014-09-23T01:50:55.649Z,1411437055.649 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2014-09-23T01:50:55.650Z,1411437055.650 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2014-09-23T01:50:55.650Z,1411437055.650 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2014-09-23T01:50:55.650Z,1411437055.650 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2014-09-23T01:50:55.650Z,1411437055.650 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2014-09-23T01:50:55.651Z,1411437055.651 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2014-09-23T01:50:55.651Z,1411437055.651 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2014-09-23T01:50:55.651Z,1411437055.651 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2014-09-23T01:50:55.957Z,1411437055.957 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2014-09-23T01:50:56.039Z,1411437056.039 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2014-09-23T01:50:56.082Z,1411437056.082 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://aosn.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2014-09-23T01:50:56.083Z,1411437056.083 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2014-09-23T01:50:56.161Z,1411437056.161 [MissionManager](INFO): DefineArg Default.TimeMissionWasStarted = 0.000000 h
2014-09-23T01:50:56.180Z,1411437056.180 [MissionManager](INFO): DefineArg Default.ElapsedSinceMissionWasStarted = 0.000000 h
2014-09-23T01:50:56.185Z,1411437056.185 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2014-09-23T01:50:56.229Z,1411437056.229 [Default:CheckIn:A.SetSpeed](DEBUG): Construct.
2014-09-23T01:50:56.235Z,1411437056.235 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2014-09-23T01:50:56.256Z,1411437056.256 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Construct.
2014-09-23T01:50:56.278Z,1411437056.278 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
xmlns:Control="Tethys/Control"
xmlns:Guidance="Tethys/Guidance" 
xmlns:Units="Tethys/Units"
xmlns:Universal="Tethys/Universal"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
xsi:schemaLocation="Tethys http://aosn.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

    <DefineArg Name="TimeMissionWasStarted"><Units:hour/><Value>0</Value></DefineArg>

    <DefineArg Name="ElapsedSinceMissionWasStarted"><Units:hour/><Value>0</Value></DefineArg>

    <Aggregate Id="StartClock">

        <Sequence/>

        <Assign><Arg Name="TimeMissionWasStarted"/><Universal:time/></Assign>

    </Aggregate>

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

    <Aggregate Id="CheckIn">

        <When>
            <Elapsed><Universal:platform_communications/></Elapsed>
            <Gt><Units:minute/><Value>5.0</Value></Gt>
            <And><Universal:platform_conversation/><Eq><True/></Eq></And>
            <Or><Elapsed><Universal:platform_communications/></Elapsed><Gt><Units:hour/><Value>1.0</Value></Gt></Or>
        </When>

<!-- TODO: Do we really want this When operating on platform_communications? or on something else like time_fix? -->

<!-- Run application at high speed -->

        <Guidance:SetSpeed>
            <Parallel/>
            <Setting><Guidance:SetSpeed.period/><Units:millisecond/><Value>400</Value></Setting>
        </Guidance:SetSpeed>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
<!-- NOTE: Original Default.xml didn't have a timeout on the GPS read, so theoretically could have hung indefinitely there... -->
            <Universal:latitude_fix/>
        </ReadDatum>

<!-- Do data comms -->

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

    </Aggregate>

    <Aggregate Id="UpdateAndReportMinutesSinceMissionStarted">

        <When>
            <Elapsed><Arg Name="ElapsedSinceMissionWasStarted"/></Elapsed>
            <Gt><Units:minute/><Value>5.0</Value></Gt>
        </When>

        <Assign><Arg Name="ElapsedSinceMissionWasStarted"/><Universal:time/><Sub><Arg Name="TimeMissionWasStarted"/></Sub></Assign>

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

    </Aggregate>

    <Aggregate Id="WaitAtTheSurface">

        <Sequence/>

        <Guidance:SetSpeed Id="RunApplicationAtLowSpeed">
            <Parallel/>
            <Setting><Guidance:SetSpeed.period/><Units:second/><Value>5</Value></Setting>
        </Guidance:SetSpeed>

    </Aggregate>

</Mission>


2014-09-23T01:50:56.303Z,1411437056.303 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,Aanderaa_O2,rhodamine,AHRS_sp3003D,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,HFRCMReconstructedInterpolator,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToWater,DeadReckonWithRespectToSeafloor,DeadReckonUsingDVLWaterTrack,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2014-09-23T01:50:56.450Z,1411437056.450 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2014-09-23T01:50:56.473Z,1411437056.473 [AcousticModem_Benthos_ATM900](INFO): Powering up
2014-09-23T01:50:56.473Z,1411437056.473 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2014-09-23T01:50:56.668Z,1411437056.668 [DVL_micro](INFO): Initializing
2014-09-23T01:50:56.974Z,1411437056.974 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:50:56.999Z,1411437056.999 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T01:50:57.019Z,1411437057.019 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T01:50:57.052Z,1411437057.052 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T01:50:57.075Z,1411437057.075 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T01:50:57.195Z,1411437057.195 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2014-09-23T01:50:57.203Z,1411437057.203 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2014-09-23T01:50:57.218Z,1411437057.218 [ElevatorServo](DEBUG): Initializing EZServoServo.
2014-09-23T01:50:57.224Z,1411437057.224 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2014-09-23T01:50:57.237Z,1411437057.237 [MassServo](DEBUG): Initializing EZServoServo.
2014-09-23T01:50:57.245Z,1411437057.245 [MassServo](DEBUG): Initializing MassServo.
2014-09-23T01:50:57.263Z,1411437057.263 [RudderServo](DEBUG): Initializing EZServoServo.
2014-09-23T01:50:57.271Z,1411437057.271 [RudderServo](DEBUG): Initializing RudderServo.
2014-09-23T01:50:57.297Z,1411437057.297 [ThrusterServo](DEBUG): Initializing EZServoServo.
2014-09-23T01:50:57.303Z,1411437057.303 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2014-09-23T01:50:57.669Z,1411437057.669 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:50:57.670Z,1411437057.670 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T01:50:57.672Z,1411437057.672 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T01:50:57.674Z,1411437057.674 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T01:50:57.675Z,1411437057.675 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T01:50:58.176Z,1411437058.176 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:50:58.177Z,1411437058.177 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T01:50:58.178Z,1411437058.178 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T01:50:58.179Z,1411437058.179 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T01:50:58.179Z,1411437058.179 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-09-23T01:50:58.848Z,1411437058.848 [NAL9602](INFO): Powering up NAL9602
2014-09-23T01:50:58.886Z,1411437058.886 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:50:59.522Z,1411437059.522 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:00.239Z,1411437060.239 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:00.556Z,1411437060.556 [Aanderaa_O2](INFO): Powering down
2014-09-23T01:51:00.984Z,1411437060.984 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:01.461Z,1411437061.461 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:02.115Z,1411437062.115 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:03.032Z,1411437063.032 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:03.485Z,1411437063.485 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:04.158Z,1411437064.158 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:04.590Z,1411437064.590 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:04.982Z,1411437064.982 [AcousticModem_Benthos_ATM900](DEBUG): 
2014-09-23T01:51:05.243Z,1411437065.243 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:05.765Z,1411437065.765 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:06.156Z,1411437066.156 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series
2014-09-23T01:51:06.157Z,1411437066.157 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2014-09-23T01:51:06.157Z,1411437066.157 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.8.9
2014-09-23T01:51:06.197Z,1411437066.197 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:06.601Z,1411437066.601 [AcousticModem_Benthos_ATM900](DEBUG): Sep 23 2014 01:48:09 
2014-09-23T01:51:06.654Z,1411437066.654 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:07.086Z,1411437067.086 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:07.501Z,1411437067.501 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2014-09-23T01:51:07.589Z,1411437067.589 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:07.994Z,1411437067.994 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:07.996Z,1411437067.996 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt -1:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>
2014-09-23T01:51:08.183Z,1411437068.183 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:08.583Z,1411437068.583 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:08.632Z,1411437068.632 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:09.016Z,1411437069.016 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:09.109Z,1411437069.109 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:09.529Z,1411437069.529 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:09.578Z,1411437069.578 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:09.977Z,1411437069.977 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:09.982Z,1411437069.982 [NAL9602](INFO): NAL9602 initialized
2014-09-23T01:51:10.079Z,1411437070.079 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:10.462Z,1411437070.462 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:10.549Z,1411437070.549 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:10.967Z,1411437070.967 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:11.060Z,1411437071.060 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:11.105Z,1411437071.105 [SBIT](IMPORTANT): Beginning Startup BIT
2014-09-23T01:51:11.107Z,1411437071.107 [CBIT](IMPORTANT): Beginning GF scan
2014-09-23T01:51:11.471Z,1411437071.471 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:11.536Z,1411437071.536 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:11.976Z,1411437071.976 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:12.074Z,1411437072.074 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:12.493Z,1411437072.493 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:12.549Z,1411437072.549 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:12.938Z,1411437072.938 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:12.978Z,1411437072.978 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:13.474Z,1411437073.474 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:13.508Z,1411437073.508 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:14.368Z,1411437074.368 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:14.461Z,1411437074.461 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:14.981Z,1411437074.981 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:15.022Z,1411437075.022 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:15.558Z,1411437075.558 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:15.614Z,1411437075.614 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:16.059Z,1411437076.059 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:16.083Z,1411437076.083 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:16.580Z,1411437076.580 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize; deviceResponse_ loaded:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>, available: 
2014-09-23T01:51:16.580Z,1411437076.580 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1
2014-09-23T01:51:16.580Z,1411437076.580 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2014-09-23T01:51:16.658Z,1411437076.658 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:16.789Z,1411437076.789 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2014-09-23T01:51:17.144Z,1411437077.144 [AcousticModem_Benthos_ATM900](INFO): Powering down
2014-09-23T01:51:17.341Z,1411437077.341 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:17.954Z,1411437077.954 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:18.479Z,1411437078.479 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:18.605Z,1411437078.605 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2014-09-23T01:51:18.605Z,1411437078.605 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 1
2014-09-23T01:51:18.980Z,1411437078.980 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:19.481Z,1411437079.481 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:19.975Z,1411437079.975 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:20.501Z,1411437080.501 [AcousticModem_Benthos_ATM900](INFO): Powering up
2014-09-23T01:51:20.502Z,1411437080.502 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2014-09-23T01:51:20.572Z,1411437080.572 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:21.091Z,1411437081.091 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:21.580Z,1411437081.580 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:22.053Z,1411437082.053 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:22.535Z,1411437082.535 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:22.983Z,1411437082.983 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:23.430Z,1411437083.430 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:23.866Z,1411437083.866 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:24.436Z,1411437084.436 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:24.988Z,1411437084.988 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:25.434Z,1411437085.434 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:25.895Z,1411437085.895 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:26.343Z,1411437086.343 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:26.816Z,1411437086.816 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:27.769Z,1411437087.769 [BPC1](FAULT): Failed to receive battery data
2014-09-23T01:51:27.769Z,1411437087.769 [BPC1] Communications Fault, FailCount= 1
2014-09-23T01:51:27.770Z,1411437087.770 [BPC1](ERROR): Communications Fault
2014-09-23T01:51:27.792Z,1411437087.792 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:27.922Z,1411437087.922 [CBIT](ERROR): Communications Fault in component: BPC1
2014-09-23T01:51:28.311Z,1411437088.311 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:28.766Z,1411437088.766 [AcousticModem_Benthos_ATM900](DEBUG): 
2014-09-23T01:51:28.799Z,1411437088.799 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:29.276Z,1411437089.276 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:29.417Z,1411437089.417 [CBIT](INFO): Clearing failed state for component BPC1
2014-09-23T01:51:29.417Z,1411437089.417 [BPC1] No Fault, FailCount= 1
2014-09-23T01:51:29.873Z,1411437089.873 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:30.346Z,1411437090.346 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series
2014-09-23T01:51:30.346Z,1411437090.346 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2014-09-23T01:51:30.347Z,1411437090.347 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.8.9
2014-09-23T01:51:30.371Z,1411437090.371 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:30.838Z,1411437090.838 [AcousticModem_Benthos_ATM900](DEBUG): Sep 23 2014 01:48:33 
2014-09-23T01:51:30.943Z,1411437090.943 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:31.515Z,1411437091.515 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:32.095Z,1411437092.095 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2014-09-23T01:51:32.166Z,1411437092.166 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:32.648Z,1411437092.648 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:32.650Z,1411437092.650 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt -1:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>
2014-09-23T01:51:32.688Z,1411437092.688 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:32.723Z,1411437092.723 [CommandLine](IMPORTANT): got command show variable acoustic
2014-09-23T01:51:32.760Z,1411437092.760 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.loadAtStartup (bool)
2014-09-23T01:51:32.761Z,1411437092.761 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.simulateHardware (bool)
2014-09-23T01:51:32.761Z,1411437092.761 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.verbosity (count)
2014-09-23T01:51:32.762Z,1411437092.762 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.localAddress (count)
2014-09-23T01:51:32.804Z,1411437092.804 [CommandLine](IMPORTANT): Rowe_600.acousticBlankingDistance (meter)
2014-09-23T01:51:32.911Z,1411437092.911 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.loadControl (none)
2014-09-23T01:51:32.912Z,1411437092.912 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.uart (none)
2014-09-23T01:51:32.912Z,1411437092.912 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.baud (bit_per_second)
2014-09-23T01:51:32.997Z,1411437092.997 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.modem_receive_time (epoch_second)
2014-09-23T01:51:32.998Z,1411437092.998 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.modem_transmit_time (epoch_second)
2014-09-23T01:51:33.007Z,1411437093.007 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.remote_address (count)
2014-09-23T01:51:33.007Z,1411437093.007 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.local_address (count)
2014-09-23T01:51:33.008Z,1411437093.008 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.range (meter)
2014-09-23T01:51:33.122Z,1411437093.122 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.durationOfLastRun (second)
2014-09-23T01:51:33.137Z,1411437093.137 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_voltage (volt)
2014-09-23T01:51:33.137Z,1411437093.137 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_avgVoltage (volt)
2014-09-23T01:51:33.138Z,1411437093.138 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_current (milliampere)
2014-09-23T01:51:33.138Z,1411437093.138 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_avgCurrent (milliampere)
2014-09-23T01:51:33.358Z,1411437093.358 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:33.447Z,1411437093.447 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:33.926Z,1411437093.926 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:33.967Z,1411437093.967 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:34.427Z,1411437094.427 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:34.520Z,1411437094.520 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:35.004Z,1411437095.004 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:35.033Z,1411437095.033 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:35.521Z,1411437095.521 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:35.554Z,1411437095.554 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:36.025Z,1411437096.025 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:36.059Z,1411437096.059 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:36.522Z,1411437096.522 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:36.555Z,1411437096.555 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:37.015Z,1411437097.015 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:37.064Z,1411437097.064 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:37.524Z,1411437097.524 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:37.585Z,1411437097.585 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:38.073Z,1411437098.073 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:38.170Z,1411437098.170 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:38.684Z,1411437098.684 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:38.715Z,1411437098.715 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:38.921Z,1411437098.921 [CBIT](IMPORTANT): No ground fault detected
2014-09-23T01:51:39.283Z,1411437099.283 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:39.316Z,1411437099.316 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:39.759Z,1411437099.759 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:39.822Z,1411437099.822 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:40.249Z,1411437100.249 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:40.289Z,1411437100.289 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:40.733Z,1411437100.733 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize; deviceResponse_ loaded:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>, available: 
2014-09-23T01:51:40.733Z,1411437100.733 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 2
2014-09-23T01:51:40.733Z,1411437100.733 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2014-09-23T01:51:40.806Z,1411437100.806 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:40.912Z,1411437100.912 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2014-09-23T01:51:41.250Z,1411437101.250 [AcousticModem_Benthos_ATM900](INFO): Powering down
2014-09-23T01:51:41.465Z,1411437101.465 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:41.941Z,1411437101.941 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:42.417Z,1411437102.417 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:42.507Z,1411437102.507 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2014-09-23T01:51:42.507Z,1411437102.507 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 2
2014-09-23T01:51:42.901Z,1411437102.901 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:43.394Z,1411437103.394 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:43.903Z,1411437103.903 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:44.350Z,1411437104.350 [AcousticModem_Benthos_ATM900](INFO): Powering up
2014-09-23T01:51:44.351Z,1411437104.351 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2014-09-23T01:51:44.399Z,1411437104.399 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:44.945Z,1411437104.945 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:45.223Z,1411437105.223 [CommandLine](IMPORTANT): got command failComponent
2014-09-23T01:51:45.223Z,1411437105.223 [CommandLine](IMPORTANT): Failed components:
2014-09-23T01:51:45.223Z,1411437105.223 [CommandLine](IMPORTANT): No failed Components.
2014-09-23T01:51:45.434Z,1411437105.434 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:45.914Z,1411437105.914 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:46.411Z,1411437106.411 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:46.956Z,1411437106.956 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:47.438Z,1411437107.438 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:47.885Z,1411437107.885 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:48.385Z,1411437108.385 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:48.858Z,1411437108.858 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:49.352Z,1411437109.352 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:49.877Z,1411437109.877 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:50.337Z,1411437110.337 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:50.797Z,1411437110.797 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:51.309Z,1411437111.309 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:51.851Z,1411437111.851 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:52.344Z,1411437112.344 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:52.784Z,1411437112.784 [AcousticModem_Benthos_ATM900](DEBUG): 
2014-09-23T01:51:52.825Z,1411437112.825 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:53.265Z,1411437113.265 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:53.697Z,1411437113.697 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:54.190Z,1411437114.190 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series
2014-09-23T01:51:54.190Z,1411437114.190 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2014-09-23T01:51:54.191Z,1411437114.191 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.8.9
2014-09-23T01:51:54.213Z,1411437114.213 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:54.985Z,1411437114.985 [AcousticModem_Benthos_ATM900](DEBUG): Sep 23 2014 01:48:57 
2014-09-23T01:51:55.079Z,1411437115.079 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:55.529Z,1411437115.529 [CommandLine](IMPORTANT): got command failComponent
2014-09-23T01:51:55.529Z,1411437115.529 [CommandLine](IMPORTANT): Failed components:
2014-09-23T01:51:55.529Z,1411437115.529 [CommandLine](IMPORTANT): No failed Components.
2014-09-23T01:51:55.594Z,1411437115.594 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:56.122Z,1411437116.122 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2014-09-23T01:51:56.160Z,1411437116.160 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:56.590Z,1411437116.590 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:56.591Z,1411437116.591 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt -1:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>
2014-09-23T01:51:56.613Z,1411437116.613 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:57.070Z,1411437117.070 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:57.100Z,1411437117.100 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:57.615Z,1411437117.615 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:57.677Z,1411437117.677 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:58.080Z,1411437118.080 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:58.173Z,1411437118.173 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:58.573Z,1411437118.573 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:58.610Z,1411437118.610 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:59.017Z,1411437119.017 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:59.079Z,1411437119.079 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:59.474Z,1411437119.474 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:59.503Z,1411437119.503 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:51:59.614Z,1411437119.614 [CommandLine](IMPORTANT): got command show variable acoustic
2014-09-23T01:51:59.651Z,1411437119.651 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.loadAtStartup (bool)
2014-09-23T01:51:59.651Z,1411437119.651 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.simulateHardware (bool)
2014-09-23T01:51:59.652Z,1411437119.652 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.verbosity (count)
2014-09-23T01:51:59.652Z,1411437119.652 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.localAddress (count)
2014-09-23T01:51:59.658Z,1411437119.658 [CommandLine](IMPORTANT): Rowe_600.acousticBlankingDistance (meter)
2014-09-23T01:51:59.687Z,1411437119.687 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.loadControl (none)
2014-09-23T01:51:59.687Z,1411437119.687 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.uart (none)
2014-09-23T01:51:59.688Z,1411437119.688 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.baud (bit_per_second)
2014-09-23T01:51:59.742Z,1411437119.742 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.modem_receive_time (epoch_second)
2014-09-23T01:51:59.743Z,1411437119.743 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.modem_transmit_time (epoch_second)
2014-09-23T01:51:59.743Z,1411437119.743 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.remote_address (count)
2014-09-23T01:51:59.744Z,1411437119.744 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.local_address (count)
2014-09-23T01:51:59.744Z,1411437119.744 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.range (meter)
2014-09-23T01:51:59.828Z,1411437119.828 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.durationOfLastRun (second)
2014-09-23T01:51:59.846Z,1411437119.846 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_voltage (volt)
2014-09-23T01:51:59.846Z,1411437119.846 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_avgVoltage (volt)
2014-09-23T01:51:59.847Z,1411437119.847 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_current (milliampere)
2014-09-23T01:51:59.847Z,1411437119.847 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_avgCurrent (milliampere)
2014-09-23T01:51:59.911Z,1411437119.911 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:51:59.954Z,1411437119.954 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:00.355Z,1411437120.355 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:00.413Z,1411437120.413 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:00.876Z,1411437120.876 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:00.913Z,1411437120.913 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:01.281Z,1411437121.281 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:01.372Z,1411437121.372 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:01.748Z,1411437121.748 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:01.819Z,1411437121.819 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:02.178Z,1411437122.178 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:02.208Z,1411437122.208 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:02.579Z,1411437122.579 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:02.619Z,1411437122.619 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:03.004Z,1411437123.004 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:03.028Z,1411437123.028 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:03.388Z,1411437123.388 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:03.407Z,1411437123.407 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:03.773Z,1411437123.773 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:03.810Z,1411437123.810 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:04.177Z,1411437124.177 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:04.223Z,1411437124.223 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:04.594Z,1411437124.594 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize; deviceResponse_ loaded:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>, available: 
2014-09-23T01:52:04.594Z,1411437124.594 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 3
2014-09-23T01:52:04.594Z,1411437124.594 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2014-09-23T01:52:04.707Z,1411437124.707 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:04.721Z,1411437124.721 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2014-09-23T01:52:05.059Z,1411437125.059 [AcousticModem_Benthos_ATM900](INFO): Powering down
2014-09-23T01:52:05.200Z,1411437125.200 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:05.582Z,1411437125.582 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:05.594Z,1411437125.594 [SBIT](IMPORTANT): SBIT PASSED
2014-09-23T01:52:05.980Z,1411437125.980 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:05.986Z,1411437125.986 [MissionManager](IMPORTANT): Started mission Startup
2014-09-23T01:52:05.986Z,1411437125.986 [Startup] Running Loop=1
2014-09-23T01:52:05.986Z,1411437125.986 [Startup](INFO): Aggregate::initialize Startup
2014-09-23T01:52:05.986Z,1411437125.986 [Startup:A.GoToSurface] Running Loop=1
2014-09-23T01:52:05.986Z,1411437125.986 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-09-23T01:52:05.987Z,1411437125.987 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2014-09-23T01:52:05.987Z,1411437125.987 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2014-09-23T01:52:05.987Z,1411437125.987 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s.
2014-09-23T01:52:05.993Z,1411437125.993 [Startup:StartupSatComms] Running Loop=1
2014-09-23T01:52:05.994Z,1411437125.994 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2014-09-23T01:52:05.994Z,1411437125.994 [Startup:StartupSatComms:A] Running Loop=1
2014-09-23T01:52:06.050Z,1411437126.050 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2014-09-23T01:52:06.050Z,1411437126.050 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 3
2014-09-23T01:52:06.423Z,1411437126.423 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:06.429Z,1411437126.429 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2014-09-23T01:52:06.846Z,1411437126.846 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:07.270Z,1411437127.270 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:07.672Z,1411437127.672 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:08.086Z,1411437128.086 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:08.452Z,1411437128.452 [AcousticModem_Benthos_ATM900](INFO): Powering up
2014-09-23T01:52:08.452Z,1411437128.452 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2014-09-23T01:52:08.493Z,1411437128.493 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:08.886Z,1411437128.886 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:09.274Z,1411437129.274 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:09.690Z,1411437129.690 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:10.099Z,1411437130.099 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:10.504Z,1411437130.504 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:10.889Z,1411437130.889 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:11.323Z,1411437131.323 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:11.645Z,1411437131.645 [CommandLine](IMPORTANT): got command show variable acoustic
2014-09-23T01:52:11.682Z,1411437131.682 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.loadAtStartup (bool)
2014-09-23T01:52:11.682Z,1411437131.682 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.simulateHardware (bool)
2014-09-23T01:52:11.682Z,1411437131.682 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.verbosity (count)
2014-09-23T01:52:11.683Z,1411437131.683 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.localAddress (count)
2014-09-23T01:52:11.688Z,1411437131.688 [CommandLine](IMPORTANT): Rowe_600.acousticBlankingDistance (meter)
2014-09-23T01:52:11.745Z,1411437131.745 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:11.800Z,1411437131.800 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.loadControl (none)
2014-09-23T01:52:11.800Z,1411437131.800 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.uart (none)
2014-09-23T01:52:11.800Z,1411437131.800 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.baud (bit_per_second)
2014-09-23T01:52:11.855Z,1411437131.855 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.modem_receive_time (epoch_second)
2014-09-23T01:52:11.856Z,1411437131.856 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.modem_transmit_time (epoch_second)
2014-09-23T01:52:11.856Z,1411437131.856 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.remote_address (count)
2014-09-23T01:52:11.857Z,1411437131.857 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.local_address (count)
2014-09-23T01:52:11.857Z,1411437131.857 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.range (meter)
2014-09-23T01:52:11.955Z,1411437131.955 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.durationOfLastRun (second)
2014-09-23T01:52:11.962Z,1411437131.962 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_voltage (volt)
2014-09-23T01:52:11.962Z,1411437131.962 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_avgVoltage (volt)
2014-09-23T01:52:11.963Z,1411437131.963 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_current (milliampere)
2014-09-23T01:52:11.964Z,1411437131.964 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_avgCurrent (milliampere)
2014-09-23T01:52:12.172Z,1411437132.172 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:12.604Z,1411437132.604 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:13.004Z,1411437133.004 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:13.411Z,1411437133.411 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:13.799Z,1411437133.799 [BPC1](FAULT): A bank: No match for serial number:5911 was found in the onboard configuration.
2014-09-23T01:52:13.800Z,1411437133.800 [BPC1](FAULT): Failed to parse bank A battery data
2014-09-23T01:52:13.800Z,1411437133.800 [BPC1] Data Fault, FailCount= 1
2014-09-23T01:52:13.800Z,1411437133.800 [BPC1](ERROR): Data Fault
2014-09-23T01:52:13.805Z,1411437133.805 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:13.820Z,1411437133.820 [CBIT](ERROR): Data Fault in component: BPC1
2014-09-23T01:52:14.212Z,1411437134.212 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:14.630Z,1411437134.630 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:15.047Z,1411437135.047 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:15.077Z,1411437135.077 [CBIT](INFO): Clearing failed state for component BPC1
2014-09-23T01:52:15.078Z,1411437135.078 [BPC1] No Fault, FailCount= 1
2014-09-23T01:52:15.528Z,1411437135.528 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:15.942Z,1411437135.942 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:16.341Z,1411437136.341 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:16.709Z,1411437136.709 [AcousticModem_Benthos_ATM900](DEBUG): 
2014-09-23T01:52:16.727Z,1411437136.727 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:17.126Z,1411437137.126 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:17.196Z,1411437137.196 [CommandLine](IMPORTANT): got command show variable acoustic
2014-09-23T01:52:17.227Z,1411437137.227 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.loadAtStartup (bool)
2014-09-23T01:52:17.243Z,1411437137.243 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.simulateHardware (bool)
2014-09-23T01:52:17.244Z,1411437137.244 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.verbosity (count)
2014-09-23T01:52:17.244Z,1411437137.244 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.localAddress (count)
2014-09-23T01:52:17.266Z,1411437137.266 [CommandLine](IMPORTANT): Rowe_600.acousticBlankingDistance (meter)
2014-09-23T01:52:17.292Z,1411437137.292 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.loadControl (none)
2014-09-23T01:52:17.293Z,1411437137.293 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.uart (none)
2014-09-23T01:52:17.294Z,1411437137.294 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.baud (bit_per_second)
2014-09-23T01:52:17.339Z,1411437137.339 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.modem_receive_time (epoch_second)
2014-09-23T01:52:17.339Z,1411437137.339 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.modem_transmit_time (epoch_second)
2014-09-23T01:52:17.340Z,1411437137.340 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.remote_address (count)
2014-09-23T01:52:17.340Z,1411437137.340 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.local_address (count)
2014-09-23T01:52:17.341Z,1411437137.341 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.range (meter)
2014-09-23T01:52:17.415Z,1411437137.415 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.durationOfLastRun (second)
2014-09-23T01:52:17.422Z,1411437137.422 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_voltage (volt)
2014-09-23T01:52:17.422Z,1411437137.422 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_avgVoltage (volt)
2014-09-23T01:52:17.423Z,1411437137.423 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_current (milliampere)
2014-09-23T01:52:17.423Z,1411437137.423 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.component_avgCurrent (milliampere)
2014-09-23T01:52:17.569Z,1411437137.569 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:17.944Z,1411437137.944 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series
2014-09-23T01:52:17.944Z,1411437137.944 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2014-09-23T01:52:17.945Z,1411437137.945 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.8.9
2014-09-23T01:52:17.993Z,1411437137.993 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:18.368Z,1411437138.368 [AcousticModem_Benthos_ATM900](DEBUG): Sep 23 2014 01:49:21 
2014-09-23T01:52:18.394Z,1411437138.394 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:18.801Z,1411437138.801 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:19.173Z,1411437139.173 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2014-09-23T01:52:19.230Z,1411437139.230 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:19.593Z,1411437139.593 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:19.625Z,1411437139.625 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:20.002Z,1411437140.002 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:20.003Z,1411437140.003 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt -1:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>
2014-09-23T01:52:20.029Z,1411437140.029 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:20.398Z,1411437140.398 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:20.423Z,1411437140.423 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:20.795Z,1411437140.795 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:20.823Z,1411437140.823 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:21.200Z,1411437141.200 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:21.241Z,1411437141.241 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:21.612Z,1411437141.612 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:21.649Z,1411437141.649 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:22.017Z,1411437142.017 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:22.048Z,1411437142.048 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:22.422Z,1411437142.422 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:22.471Z,1411437142.471 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:22.822Z,1411437142.822 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:22.839Z,1411437142.839 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:23.255Z,1411437143.255 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:23.279Z,1411437143.279 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:23.656Z,1411437143.656 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:23.682Z,1411437143.682 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:24.048Z,1411437144.048 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:24.075Z,1411437144.075 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:24.453Z,1411437144.453 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:24.504Z,1411437144.504 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:24.890Z,1411437144.890 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:24.935Z,1411437144.935 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:25.306Z,1411437145.306 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:25.347Z,1411437145.347 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:25.715Z,1411437145.715 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:25.733Z,1411437145.733 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:26.115Z,1411437146.115 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:26.134Z,1411437146.134 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:26.516Z,1411437146.516 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:26.562Z,1411437146.562 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:26.941Z,1411437146.941 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:26.961Z,1411437146.961 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:27.333Z,1411437147.333 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:27.350Z,1411437147.350 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:27.738Z,1411437147.738 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:27.807Z,1411437147.807 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:28.183Z,1411437148.183 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:28.215Z,1411437148.215 [BPC1](FAULT): A bank: No match for serial number:5911 was found in the onboard configuration.
2014-09-23T01:52:28.215Z,1411437148.215 [BPC1](FAULT): Failed to parse bank A battery data
2014-09-23T01:52:28.215Z,1411437148.215 [BPC1] Data Fault, FailCount= 2
2014-09-23T01:52:28.215Z,1411437148.215 [BPC1](ERROR): Data Fault
2014-09-23T01:52:28.257Z,1411437148.257 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:28.294Z,1411437148.294 [CBIT](ERROR): Data Fault in component: BPC1
2014-09-23T01:52:28.644Z,1411437148.644 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize; deviceResponse_ loaded:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>, available: 
2014-09-23T01:52:28.644Z,1411437148.644 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 4
2014-09-23T01:52:28.644Z,1411437148.644 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2014-09-23T01:52:28.715Z,1411437148.715 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:28.754Z,1411437148.754 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2014-09-23T01:52:29.108Z,1411437149.108 [AcousticModem_Benthos_ATM900](INFO): Powering down
2014-09-23T01:52:29.237Z,1411437149.237 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:29.629Z,1411437149.629 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:29.664Z,1411437149.664 [CBIT](INFO): Clearing failed state for component BPC1
2014-09-23T01:52:29.664Z,1411437149.664 [BPC1] No Fault, FailCount= 2
2014-09-23T01:52:30.111Z,1411437150.111 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:30.137Z,1411437150.137 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2014-09-23T01:52:30.137Z,1411437150.137 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 4
2014-09-23T01:52:30.576Z,1411437150.576 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:31.040Z,1411437151.040 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:31.431Z,1411437151.431 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:31.823Z,1411437151.823 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:32.201Z,1411437152.201 [AcousticModem_Benthos_ATM900](INFO): Powering up
2014-09-23T01:52:32.201Z,1411437152.201 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2014-09-23T01:52:32.235Z,1411437152.235 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:32.662Z,1411437152.662 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:33.061Z,1411437153.061 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:33.484Z,1411437153.484 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:33.913Z,1411437153.913 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:34.386Z,1411437154.386 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:34.797Z,1411437154.797 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:35.208Z,1411437155.208 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:35.598Z,1411437155.598 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:36.012Z,1411437156.012 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:36.413Z,1411437156.413 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:36.813Z,1411437156.813 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:37.234Z,1411437157.234 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:37.661Z,1411437157.661 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:37.998Z,1411437157.998 [CommandLine](IMPORTANT): got command report touch AcousticModem_Benthos_ATM900.modem_receive_time
2014-09-23T01:52:38.046Z,1411437158.046 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:38.441Z,1411437158.441 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:38.840Z,1411437158.840 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:39.243Z,1411437159.243 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:39.661Z,1411437159.661 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:39.751Z,1411437159.751 [CommandLine](IMPORTANT): got command report
2014-09-23T01:52:39.752Z,1411437159.752 [Reporter](INFO): AcousticModem_Benthos_ATM900.modem_receive_time reporting when touched
2014-09-23T01:52:40.061Z,1411437160.061 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:40.430Z,1411437160.430 [AcousticModem_Benthos_ATM900](DEBUG): 
2014-09-23T01:52:40.467Z,1411437160.467 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:40.883Z,1411437160.883 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:41.268Z,1411437161.268 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:41.637Z,1411437161.637 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series
2014-09-23T01:52:41.693Z,1411437161.693 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:42.061Z,1411437162.061 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2014-09-23T01:52:42.061Z,1411437162.061 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.8.9
2014-09-23T01:52:42.092Z,1411437162.092 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:42.465Z,1411437162.465 [AcousticModem_Benthos_ATM900](DEBUG): Sep 23 2014 01:49:45 
2014-09-23T01:52:42.542Z,1411437162.542 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:42.937Z,1411437162.937 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:43.299Z,1411437163.299 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2014-09-23T01:52:43.388Z,1411437163.388 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:43.743Z,1411437163.743 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:43.744Z,1411437163.744 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt -1:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>
2014-09-23T01:52:43.765Z,1411437163.765 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:44.156Z,1411437164.156 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:44.245Z,1411437164.245 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:44.608Z,1411437164.608 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:44.666Z,1411437164.666 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:45.025Z,1411437165.025 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:45.049Z,1411437165.049 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:45.422Z,1411437165.422 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:45.453Z,1411437165.453 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:45.826Z,1411437165.826 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:45.867Z,1411437165.867 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:46.235Z,1411437166.235 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:46.266Z,1411437166.266 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:46.635Z,1411437166.635 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:46.654Z,1411437166.654 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:47.040Z,1411437167.040 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:47.058Z,1411437167.058 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:47.437Z,1411437167.437 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:47.471Z,1411437167.471 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:47.857Z,1411437167.857 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:47.880Z,1411437167.880 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:48.254Z,1411437168.254 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:48.272Z,1411437168.272 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:48.650Z,1411437168.650 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:48.682Z,1411437168.682 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:49.059Z,1411437169.059 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:49.104Z,1411437169.104 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:49.464Z,1411437169.464 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:49.505Z,1411437169.505 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:49.852Z,1411437169.852 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:49.871Z,1411437169.871 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:50.257Z,1411437170.257 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:50.276Z,1411437170.276 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:50.654Z,1411437170.654 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:50.711Z,1411437170.711 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:51.082Z,1411437171.082 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:51.108Z,1411437171.108 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:51.495Z,1411437171.495 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:51.532Z,1411437171.532 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:51.904Z,1411437171.904 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:52:51.941Z,1411437171.941 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:52.357Z,1411437172.357 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize; deviceResponse_ loaded:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>, available: Rx Time:01:49:51.5715
range request
Tx time:01:49:53.1744

2014-09-23T01:52:52.357Z,1411437172.357 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 5
2014-09-23T01:52:52.357Z,1411437172.357 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2014-09-23T01:52:52.467Z,1411437172.467 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:52.500Z,1411437172.500 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2014-09-23T01:52:52.861Z,1411437172.861 [AcousticModem_Benthos_ATM900](INFO): Powering down
2014-09-23T01:52:52.998Z,1411437172.998 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:53.430Z,1411437173.430 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:53.896Z,1411437173.896 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:53.952Z,1411437173.952 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2014-09-23T01:52:53.952Z,1411437173.952 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 5
2014-09-23T01:52:54.320Z,1411437174.320 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:54.729Z,1411437174.729 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:55.174Z,1411437175.174 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:55.574Z,1411437175.574 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:55.942Z,1411437175.942 [AcousticModem_Benthos_ATM900](INFO): Powering up
2014-09-23T01:52:55.942Z,1411437175.942 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2014-09-23T01:52:55.976Z,1411437175.976 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:56.477Z,1411437176.477 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:56.885Z,1411437176.885 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:57.273Z,1411437177.273 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:57.716Z,1411437177.716 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:58.117Z,1411437178.117 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:58.551Z,1411437178.551 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:58.965Z,1411437178.965 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:59.342Z,1411437179.342 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:52:59.741Z,1411437179.741 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:00.199Z,1411437180.199 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:00.638Z,1411437180.638 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:01.031Z,1411437181.031 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:01.434Z,1411437181.434 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:01.813Z,1411437181.813 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:02.206Z,1411437182.206 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:02.606Z,1411437182.606 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:03.014Z,1411437183.014 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:03.449Z,1411437183.449 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:03.858Z,1411437183.858 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:04.223Z,1411437184.223 [AcousticModem_Benthos_ATM900](DEBUG): 
2014-09-23T01:53:04.268Z,1411437184.268 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:04.672Z,1411437184.672 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:05.051Z,1411437185.051 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:05.437Z,1411437185.437 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series
2014-09-23T01:53:05.438Z,1411437185.438 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2014-09-23T01:53:05.439Z,1411437185.439 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.8.9
2014-09-23T01:53:05.453Z,1411437185.453 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:05.860Z,1411437185.860 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:06.251Z,1411437186.251 [AcousticModem_Benthos_ATM900](DEBUG): Sep 23 2014 01:50:09 
2014-09-23T01:53:06.291Z,1411437186.291 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:06.297Z,1411437186.297 [Startup:StartupSatComms:A](INFO): Timed out from 2014-09-23T01:52:05.0Z
2014-09-23T01:53:06.297Z,1411437186.297 [Startup:StartupSatComms:A] Stopped
2014-09-23T01:53:06.297Z,1411437186.297 [Startup:StartupSatComms:B] Running Loop=1
2014-09-23T01:53:06.724Z,1411437186.724 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:06.738Z,1411437186.738 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2014-09-23T01:53:07.264Z,1411437187.264 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2014-09-23T01:53:07.310Z,1411437187.310 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:07.668Z,1411437187.668 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:07.670Z,1411437187.670 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt -1:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>
2014-09-23T01:53:07.717Z,1411437187.717 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:07.844Z,1411437187.844 [CommandLine](IMPORTANT): got command failComponent
2014-09-23T01:53:07.844Z,1411437187.844 [CommandLine](IMPORTANT): Failed components:
2014-09-23T01:53:07.845Z,1411437187.845 [CommandLine](IMPORTANT): No failed Components.
2014-09-23T01:53:08.101Z,1411437188.101 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:08.119Z,1411437188.119 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:08.489Z,1411437188.489 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:08.508Z,1411437188.508 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:08.886Z,1411437188.886 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:08.906Z,1411437188.906 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:09.287Z,1411437189.287 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:09.318Z,1411437189.318 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:09.695Z,1411437189.695 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:09.757Z,1411437189.757 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:10.108Z,1411437190.108 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:10.158Z,1411437190.158 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:10.420Z,1411437190.420 [CommandLine](IMPORTANT): got command report
2014-09-23T01:53:10.421Z,1411437190.421 [Reporter](INFO): AcousticModem_Benthos_ATM900.modem_receive_time reporting when touched
2014-09-23T01:53:10.536Z,1411437190.536 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:10.557Z,1411437190.557 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:10.925Z,1411437190.925 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:10.950Z,1411437190.950 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:11.314Z,1411437191.314 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:11.375Z,1411437191.375 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:11.735Z,1411437191.735 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:11.757Z,1411437191.757 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:12.136Z,1411437192.136 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:12.196Z,1411437192.196 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:12.544Z,1411437192.544 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:13.078Z,1411437193.078 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:13.449Z,1411437193.449 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:14.020Z,1411437194.020 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:14.395Z,1411437194.395 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:14.452Z,1411437194.452 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:14.799Z,1411437194.799 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:14.849Z,1411437194.849 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:15.200Z,1411437195.200 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:15.231Z,1411437195.231 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:15.608Z,1411437195.608 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:15.657Z,1411437195.657 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:16.022Z,1411437196.022 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize; deviceResponse_ loaded:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>, available: Rx Time:01:50:21.5846
@<†
2014-09-23T01:53:16.022Z,1411437196.022 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 6
2014-09-23T01:53:16.022Z,1411437196.022 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2014-09-23T01:53:16.094Z,1411437196.094 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:16.109Z,1411437196.109 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2014-09-23T01:53:16.442Z,1411437196.442 [AcousticModem_Benthos_ATM900](INFO): Powering down
2014-09-23T01:53:16.576Z,1411437196.576 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:17.007Z,1411437197.007 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:17.424Z,1411437197.424 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:17.455Z,1411437197.455 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2014-09-23T01:53:17.455Z,1411437197.455 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 6
2014-09-23T01:53:18.321Z,1411437198.321 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:18.822Z,1411437198.822 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:19.225Z,1411437199.225 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:19.587Z,1411437199.587 [AcousticModem_Benthos_ATM900](INFO): Powering up
2014-09-23T01:53:19.587Z,1411437199.587 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2014-09-23T01:53:19.649Z,1411437199.649 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:20.076Z,1411437200.076 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:20.485Z,1411437200.485 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:20.871Z,1411437200.871 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:21.276Z,1411437201.276 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:21.680Z,1411437201.680 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:22.082Z,1411437202.082 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:22.512Z,1411437202.512 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:23.405Z,1411437203.405 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:23.925Z,1411437203.925 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:24.311Z,1411437204.311 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:24.727Z,1411437204.727 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:25.157Z,1411437205.157 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:25.561Z,1411437205.561 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:25.953Z,1411437205.953 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:26.356Z,1411437206.356 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:26.788Z,1411437206.788 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:27.234Z,1411437207.234 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:27.611Z,1411437207.611 [AcousticModem_Benthos_ATM900](DEBUG): 
2014-09-23T01:53:28.170Z,1411437208.170 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:28.834Z,1411437208.834 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:29.211Z,1411437209.211 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series
2014-09-23T01:53:29.211Z,1411437209.211 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2014-09-23T01:53:29.212Z,1411437209.212 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.8.9
2014-09-23T01:53:29.270Z,1411437209.270 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:29.619Z,1411437209.619 [AcousticModem_Benthos_ATM900](DEBUG): Sep 23 2014 01:50:32 
2014-09-23T01:53:29.700Z,1411437209.700 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:30.090Z,1411437210.090 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:30.460Z,1411437210.460 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2014-09-23T01:53:30.557Z,1411437210.557 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:30.908Z,1411437210.908 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:30.909Z,1411437210.909 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt -1:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>
2014-09-23T01:53:30.938Z,1411437210.938 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:31.317Z,1411437211.317 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:31.336Z,1411437211.336 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:31.717Z,1411437211.717 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:31.738Z,1411437211.738 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:32.115Z,1411437212.115 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:32.156Z,1411437212.156 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:32.523Z,1411437212.523 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:33.052Z,1411437213.052 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:33.420Z,1411437213.420 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:33.552Z,1411437213.552 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:33.909Z,1411437213.909 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:33.994Z,1411437213.994 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:34.362Z,1411437214.362 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:34.407Z,1411437214.407 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:34.778Z,1411437214.778 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:34.806Z,1411437214.806 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:35.179Z,1411437215.179 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:35.216Z,1411437215.216 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:35.580Z,1411437215.580 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:35.596Z,1411437215.596 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:35.976Z,1411437215.976 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:35.991Z,1411437215.991 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:36.377Z,1411437216.377 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:36.396Z,1411437216.396 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:36.778Z,1411437216.778 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:36.798Z,1411437216.798 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:37.182Z,1411437217.182 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:37.255Z,1411437217.255 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:37.623Z,1411437217.623 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:38.160Z,1411437218.160 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:38.536Z,1411437218.536 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:38.670Z,1411437218.670 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:39.029Z,1411437219.029 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:39.047Z,1411437219.047 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:39.430Z,1411437219.430 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2014-09-23T01:53:39.466Z,1411437219.466 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:39.834Z,1411437219.834 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize; deviceResponse_ loaded:  1 of 4, Rate 1/2 CC 12.50ms MGP

user:1>, available: 
2014-09-23T01:53:39.835Z,1411437219.835 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 7
2014-09-23T01:53:39.835Z,1411437219.835 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2014-09-23T01:53:39.875Z,1411437219.875 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:39.958Z,1411437219.958 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2014-09-23T01:53:40.307Z,1411437220.307 [AcousticModem_Benthos_ATM900](INFO): Powering down
2014-09-23T01:53:40.513Z,1411437220.513 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:40.915Z,1411437220.915 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:41.320Z,1411437221.320 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:41.334Z,1411437221.334 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2014-09-23T01:53:41.334Z,1411437221.334 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 7
2014-09-23T01:53:41.721Z,1411437221.721 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:42.118Z,1411437222.118 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:43.032Z,1411437223.032 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:43.408Z,1411437223.408 [AcousticModem_Benthos_ATM900](INFO): Powering up
2014-09-23T01:53:43.408Z,1411437223.408 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2014-09-23T01:53:43.577Z,1411437223.577 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:43.984Z,1411437223.984 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:44.398Z,1411437224.398 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:44.798Z,1411437224.798 [BPC1](FAULT): Failed to receive battery data
2014-09-23T01:53:44.799Z,1411437224.799 [BPC1] Communications Fault, FailCount= 1
2014-09-23T01:53:44.799Z,1411437224.799 [BPC1](ERROR): Communications Fault
2014-09-23T01:53:44.842Z,1411437224.842 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:44.865Z,1411437224.865 [CBIT](ERROR): Communications Fault in component: BPC1
2014-09-23T01:53:45.244Z,1411437225.244 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:45.626Z,1411437225.626 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:46.033Z,1411437226.033 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:46.047Z,1411437226.047 [CBIT](INFO): Clearing failed state for component BPC1
2014-09-23T01:53:46.047Z,1411437226.047 [BPC1] No Fault, FailCount= 1
2014-09-23T01:53:46.511Z,1411437226.511 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:47.431Z,1411437227.431 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:47.968Z,1411437227.968 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:48.332Z,1411437228.332 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:48.749Z,1411437228.749 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:48.927Z,1411437228.927 [CommandLine](IMPORTANT): got command quit
2014-09-23T01:53:49.149Z,1411437229.149 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:49.550Z,1411437229.550 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:49.932Z,1411437229.932 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:49.939Z,1411437229.939 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T01:53:49.939Z,1411437229.939 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:49.980Z,1411437229.980 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2014-09-23T01:53:49.980Z,1411437229.980 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:49.981Z,1411437229.981 [CommandLine](INFO): Join timeout helper Thread ID is 900
2014-09-23T01:53:49.991Z,1411437229.991 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2014-09-23T01:53:49.991Z,1411437229.991 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:50.009Z,1411437230.009 [NavChartDb](INFO): Join timeout helper Thread ID is 901
2014-09-23T01:53:50.342Z,1411437230.342 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:50.384Z,1411437230.384 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T01:53:50.385Z,1411437230.385 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:50.392Z,1411437230.392 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2014-09-23T01:53:50.392Z,1411437230.392 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:50.393Z,1411437230.393 [Radio_Surface](INFO): Join timeout helper Thread ID is 902
2014-09-23T01:53:50.737Z,1411437230.737 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T01:53:50.737Z,1411437230.737 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:50.738Z,1411437230.738 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2014-09-23T01:53:50.738Z,1411437230.738 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:50.739Z,1411437230.739 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 903
2014-09-23T01:53:50.754Z,1411437230.754 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:50.877Z,1411437230.877 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T01:53:50.878Z,1411437230.878 [WetLabsBB2FL](INFO): Powering down
2014-09-23T01:53:50.878Z,1411437230.878 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:50.894Z,1411437230.894 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2014-09-23T01:53:50.894Z,1411437230.894 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:50.894Z,1411437230.894 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 904
2014-09-23T01:53:51.014Z,1411437231.014 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T01:53:51.014Z,1411437231.014 [CTD_NeilBrown](INFO): Powering down
2014-09-23T01:53:51.015Z,1411437231.015 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:51.019Z,1411437231.019 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2014-09-23T01:53:51.019Z,1411437231.019 [logger ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:51.019Z,1411437231.019 [logger](INFO): Join timeout helper Thread ID is 905
2014-09-23T01:53:51.027Z,1411437231.027 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T01:53:51.027Z,1411437231.027 [logger ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:51.038Z,1411437231.038 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2014-09-23T01:53:51.038Z,1411437231.038 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:51.038Z,1411437231.038 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2014-09-23T01:53:51.039Z,1411437231.039 [controlThread ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:51.039Z,1411437231.039 [controlThread](INFO): Join timeout helper Thread ID is 906
2014-09-23T01:53:51.175Z,1411437231.175 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2014-09-23T01:53:51.191Z,1411437231.191 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2014-09-23T01:53:51.191Z,1411437231.191 [controlThread](DEBUG): Uninitializing ControlThread
2014-09-23T01:53:51.191Z,1411437231.191 [Aanderaa_O2](INFO): Powering down
2014-09-23T01:53:51.192Z,1411437231.192 [AHRS_sp3003D](INFO): Powering down
2014-09-23T01:53:51.278Z,1411437231.278 [AcousticModem_Benthos_ATM900](INFO): Powering down
2014-09-23T01:53:51.470Z,1411437231.470 [DVL_micro](INFO): uninitialize:Powering down
2014-09-23T01:53:51.471Z,1411437231.471 [NAL9602](INFO): Powering down
2014-09-23T01:53:51.473Z,1411437231.473 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-09-23T01:53:51.475Z,1411437231.475 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2014-09-23T01:53:51.478Z,1411437231.478 [Startup] Stopped
2014-09-23T01:53:51.478Z,1411437231.478 [Startup](INFO): Aggregate::uninitialize Startup
2014-09-23T01:53:51.478Z,1411437231.478 [Startup:A.GoToSurface] Stopped
2014-09-23T01:53:51.478Z,1411437231.478 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-09-23T01:53:51.478Z,1411437231.478 [Startup:StartupSatComms] Stopped
2014-09-23T01:53:51.479Z,1411437231.479 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2014-09-23T01:53:51.479Z,1411437231.479 [Startup:StartupSatComms:B] Stopped
2014-09-23T01:53:51.480Z,1411437231.480 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2014-09-23T01:53:51.480Z,1411437231.480 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2014-09-23T01:53:51.481Z,1411437231.481 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2014-09-23T01:53:51.481Z,1411437231.481 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2014-09-23T01:53:51.481Z,1411437231.481 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2014-09-23T01:53:51.482Z,1411437231.482 [BuoyancyServo](INFO): Powering down
2014-09-23T01:53:51.494Z,1411437231.494 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2014-09-23T01:53:51.494Z,1411437231.494 [ElevatorServo](INFO): Powering down
2014-09-23T01:53:51.495Z,1411437231.495 [MassServo](DEBUG): Uninitialize Mass Servo.
2014-09-23T01:53:51.495Z,1411437231.495 [MassServo](INFO): Powering down
2014-09-23T01:53:51.496Z,1411437231.496 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2014-09-23T01:53:51.496Z,1411437231.496 [RudderServo](INFO): Powering down
2014-09-23T01:53:51.497Z,1411437231.497 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2014-09-23T01:53:51.497Z,1411437231.497 [ThrusterServo](INFO): Powering down
2014-09-23T01:53:51.498Z,1411437231.498 [SBIT](DEBUG): Uninitialize SBIT Component.
2014-09-23T01:53:51.499Z,1411437231.499 [IBIT](DEBUG): Uninitialize IBIT Component.
2014-09-23T01:53:51.499Z,1411437231.499 [CBIT](DEBUG): Uninitialize CBIT Component.
2014-09-23T01:53:51.531Z,1411437231.531 [controlThread ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:51.582Z,1411437231.582 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:51.585Z,1411437231.585 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:51.643Z,1411437231.643 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:51.691Z,1411437231.691 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-09-23T01:53:51.740Z,1411437231.740 [logger ThreadHandler](INFO): Thread cancelled.