2013-06-06T19:53:46.856Z,1370548426.856 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:47.256Z,1370548427.256 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:47.656Z,1370548427.656 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:48.057Z,1370548428.057 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:48.456Z,1370548428.456 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:48.856Z,1370548428.856 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:49.257Z,1370548429.257 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:49.656Z,1370548429.656 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:50.056Z,1370548430.056 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:50.456Z,1370548430.456 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:50.856Z,1370548430.856 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:51.256Z,1370548431.256 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:51.656Z,1370548431.656 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:52.056Z,1370548432.056 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:52.457Z,1370548432.457 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:52.857Z,1370548432.856 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:53.256Z,1370548433.256 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:53.656Z,1370548433.656 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:54.057Z,1370548434.057 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:54.456Z,1370548434.456 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:54.856Z,1370548434.856 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:55.256Z,1370548435.256 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:55.656Z,1370548435.656 [MissionManager](ERROR): No startup, active, or default mission!
2013-06-06T19:53:56.056Z,1370548436.056 [MissionManager](ERROR): No startup, active, or default mission!
lrauv-tethys>JFFS2 notice: (704) check_node_data: wrong data CRC in data node at 0x01893000: read 0x78f95a9b, calculated 0xa628c67e.
JFFS2 notice: (704) check_node_data: wrong data CRC in data node at 0x01892000: read 0x27221b7e, calculated 0xe012f50d.
2013-06-06T19:59:26.276Z,1370548766.276 [CommandLine](INFO): Thread ID is 747
2013-06-06T19:59:26.280Z,1370548766.280 [controlThread](INFO): Thread ID is 746
2013-06-06T19:59:26.280Z,1370548766.280 [CycleStarter](INFO): Thread ID is 745
2013-06-06T19:59:26.281Z,1370548766.281 [SBIT](INFO): Initialize SBIT Component.
2013-06-06T19:59:26.281Z,1370548766.281 [SBIT](IMPORTANT): Tethys CM Info:
$Rev:10393
2013-06-06T19:59:26.281Z,1370548766.281 [SBIT](IMPORTANT): Kernel Release:2.6.27.8
2013-06-06T19:59:26.282Z,1370548766.282 [SBIT](IMPORTANT): Kernel Version:#634 PREEMPT Wed Feb 13 10:21:48 PST 2013
2013-06-06T19:59:26.282Z,1370548766.282 [IBIT](INFO): Initialize IBIT Component.
2013-06-06T19:59:26.283Z,1370548766.283 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2013-06-06T19:59:26.284Z,1370548766.284 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2013-06-06T19:59:26.287Z,1370548766.287 [logger](INFO): Thread ID is 748
2013-06-06T19:59:26.336Z,1370548766.336 [AsyncPiEstimator](INFO): Thread ID is 815
2013-06-06T19:59:26.349Z,1370548766.349 [CTD_NeilBrown](INFO): Thread ID is 816
2013-06-06T19:59:26.352Z,1370548766.352 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2013-06-06T19:59:26.364Z,1370548766.364 [WetLabsBB2FL](INFO): Thread ID is 817
2013-06-06T19:59:26.364Z,1370548766.364 [WetLabsBB2FL](INFO): Powering down
2013-06-06T19:59:26.389Z,1370548766.389 [DVL_micro](INFO): Thread ID is 818
2013-06-06T19:59:26.537Z,1370548766.537 [NavChartDb](INFO): Thread ID is 819
2013-06-06T19:59:26.545Z,1370548766.545 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2013-06-06T19:59:26.546Z,1370548766.546 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2013-06-06T19:59:26.546Z,1370548766.546 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2013-06-06T19:59:26.547Z,1370548766.546 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2013-06-06T19:59:26.547Z,1370548766.547 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2013-06-06T19:59:26.547Z,1370548766.547 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2013-06-06T19:59:26.547Z,1370548766.547 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2013-06-06T19:59:26.548Z,1370548766.548 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2013-06-06T19:59:26.548Z,1370548766.548 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2013-06-06T19:59:26.999Z,1370548766.999 [DVL_micro](INFO): Initializing
2013-06-06T19:59:26.999Z,1370548766.999 [DVL_micro](INFO): start:Powering up
2013-06-06T19:59:27.000Z,1370548767.000 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-06-06T19:59:27.001Z,1370548767.001 [DVL_micro](INFO): Cycling power to configure device.
2013-06-06T19:59:28.078Z,1370548768.078 [Batt_Ocean_Server](INFO): Ocean Server Batteries initialized
2013-06-06T19:59:28.418Z,1370548768.418 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2013-06-06T19:59:28.944Z,1370548768.944 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2013-06-06T19:59:29.052Z,1370548769.052 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2013-06-06T19:59:29.063Z,1370548769.063 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-06-06T19:59:29.064Z,1370548769.064 [DVL_micro](INFO): Querying output modes
2013-06-06T19:59:29.571Z,1370548769.571 [Radio_Freewave](INFO): Powering up
2013-06-06T19:59:29.775Z,1370548769.775 [DVL_micro](INFO): NQ1 output enabled
2013-06-06T19:59:29.864Z,1370548769.864 [DVL_micro](INFO): pause:Powering down
2013-06-06T19:59:30.871Z,1370548770.871 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2013-06-06T19:59:30.871Z,1370548770.871 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2013-06-06T19:59:30.871Z,1370548770.871 [BuoyancyServo](ERROR): Communications Fault
2013-06-06T19:59:31.081Z,1370548771.081 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2013-06-06T19:59:31.422Z,1370548771.422 [NAL9602](INFO): Powering up NAL9602
2013-06-06T19:59:31.469Z,1370548771.469 [BuoyancyServo](INFO): Powering down
2013-06-06T19:59:33.929Z,1370548773.929 [CBIT](INFO): Clearing failed state for component BuoyancyServo
lrauv-tethys>JFFS2 notice: (704) check_node_data: wrong data CRC in data node at 0x01bd1b78: read 0x7fd2c1d3, calculated 0x73c603f1.
2013-06-06T19:59:39.621Z,1370548779.621 [Aanderaa_O2](FAULT): Timed out starting
2013-06-06T19:59:39.622Z,1370548779.622 [Aanderaa_O2](ERROR): Communications Fault
2013-06-06T19:59:39.922Z,1370548779.922 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2013-06-06T19:59:40.135Z,1370548780.135 [Aanderaa_O2](INFO): Powering down
lrauv-tethys>JFFS2 notice: (704) check_node_data: wrong data CRC in data node at 0x02776a00: read 0x15561117, calculated 0x96b9ade3.
JFFS2 notice: (704) check_node_data: wrong data CRC in data node at 0x039f8cf4: read 0x46fad486, calculated 0xf4de45f0.
2013-06-06T19:59:41.053Z,1370548781.053 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2013-06-06T19:59:41.944Z,1370548781.944 [SBIT](IMPORTANT): Beginning Startup BIT
2013-06-06T19:59:41.947Z,1370548781.947 [CBIT](IMPORTANT): Beginning GF scan
2013-06-06T19:59:42.303Z,1370548782.303 [NAL9602](INFO): NAL9602 initialized
2013-06-06T19:59:43.747Z,1370548783.747 [Aanderaa_O2](INFO): Powering down
lrauv-tethys>JFFS2 notice: (704) check_node_data: wrong data CRC in data node at 0x02d12c00: read 0x777a7fb8, calculated 0x634bd9c6.
JFFS2 notice: (704) check_node_data: wrong data CRC in data node at 0x02d11828: read 0x777a7fb8, calculated 0xf2eeb924.
JFFS2 notice: (704) check_node_data: wrong data CRC in data node at 0x02afb800: read 0xb262329f, calculated 0x8fa47049.
JFFS2 notice: (704) check_node_data: wrong data CRC in data node at 0x02afa600: read 0x2d7bdc36, calculated 0xde0bfa75.
JFFS2 notice: (704) check_node_data: wrong data CRC in data node at 0x02fe18b4: read 0xe44b12a8, calculated 0xfa7fa9d1.
JFFS2 notice: (704) check_node_data: wrong data CRC in data node at 0x00a465a4: read 0x45344e09, calculated 0xb9e7e8d4.
2013-06-06T20:00:08.364Z,1370548808.364 [CBIT](IMPORTANT): No ground fault detected
2013-06-06T20:00:35.436Z,1370548835.436 [SBIT](IMPORTANT): SBIT PASSED
2013-06-06T20:00:35.686Z,1370548835.686 [MissionManager](IMPORTANT): Started mission Startup
2013-06-06T20:00:35.687Z,1370548835.687 [Startup](INFO): Aggregate::initialize Startup
2013-06-06T20:00:35.705Z,1370548835.705 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
lrauv-tethys>
lrauv-tethys>
lrauv-tethys>
lrauv-tethys>
lrauv-tethys>restart app
lrauv-tethys>2013-06-06T20:01:12.454Z,1370548872.454 [Supervisor](INFO): Looking for Config files in directory: Config/
2013-06-06T20:01:12.455Z,1370548872.455 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2013-06-06T20:01:13.123Z,1370548873.123 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2013-06-06T20:01:13.504Z,1370548873.504 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2013-06-06T20:01:13.657Z,1370548873.657 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2013-06-06T20:01:13.930Z,1370548873.930 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2013-06-06T20:01:14.191Z,1370548874.191 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2013-06-06T20:01:14.678Z,1370548874.678 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2013-06-06T20:01:15.025Z,1370548875.025 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2013-06-06T20:01:15.697Z,1370548875.697 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2013-06-06T20:01:15.885Z,1370548875.885 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2013-06-06T20:01:16.736Z,1370548876.736 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2013-06-06T20:01:16.932Z,1370548876.932 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2013-06-06T20:01:17.084Z,1370548877.084 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-tethys/
2013-06-06T20:01:17.085Z,1370548877.085 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/vehicle.cfg
2013-06-06T20:01:17.254Z,1370548877.254 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/Sensor.cfg
2013-06-06T20:01:17.478Z,1370548877.478 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/logger.cfg
2013-06-06T20:01:17.636Z,1370548877.635 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/BIT.cfg
2013-06-06T20:01:17.823Z,1370548877.823 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/Servo.cfg
2013-06-06T20:01:18.006Z,1370548878.006 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/Science.cfg
2013-06-06T20:01:18.216Z,1370548878.216 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/Control.cfg
2013-06-06T20:01:18.383Z,1370548878.383 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/workSite.cfg
2013-06-06T20:01:18.527Z,1370548878.527 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/Simulator.cfg
2013-06-06T20:01:18.678Z,1370548878.678 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/Derivation.cfg
2013-06-06T20:01:18.828Z,1370548878.828 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2013-06-06T20:01:30.538Z,1370548890.538 [CommandLine](INFO): Thread ID is 872
2013-06-06T20:01:30.540Z,1370548890.540 [controlThread](INFO): Thread ID is 871
2013-06-06T20:01:30.541Z,1370548890.541 [CycleStarter](INFO): Thread ID is 870
2013-06-06T20:01:30.541Z,1370548890.541 [SBIT](INFO): Initialize SBIT Component.
2013-06-06T20:01:30.542Z,1370548890.542 [SBIT](IMPORTANT): Tethys CM Info:
$Rev:10393
2013-06-06T20:01:30.542Z,1370548890.542 [SBIT](IMPORTANT): Kernel Release:2.6.27.8
2013-06-06T20:01:30.542Z,1370548890.542 [SBIT](IMPORTANT): Kernel Version:#634 PREEMPT Wed Feb 13 10:21:48 PST 2013
2013-06-06T20:01:30.543Z,1370548890.543 [IBIT](INFO): Initialize IBIT Component.
2013-06-06T20:01:30.544Z,1370548890.544 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2013-06-06T20:01:30.556Z,1370548890.556 [logger](INFO): Thread ID is 873
2013-06-06T20:01:30.600Z,1370548890.600 [AsyncPiEstimator](INFO): Thread ID is 940
2013-06-06T20:01:30.620Z,1370548890.620 [CTD_NeilBrown](INFO): Thread ID is 941
2013-06-06T20:01:30.624Z,1370548890.624 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2013-06-06T20:01:30.633Z,1370548890.633 [WetLabsBB2FL](INFO): Thread ID is 942
2013-06-06T20:01:30.633Z,1370548890.633 [WetLabsBB2FL](INFO): Powering down
2013-06-06T20:01:30.680Z,1370548890.680 [DVL_micro](INFO): Thread ID is 943
2013-06-06T20:01:30.690Z,1370548890.690 [DVL_micro](INFO): Initializing
2013-06-06T20:01:30.690Z,1370548890.690 [DVL_micro](INFO): start:Powering up
2013-06-06T20:01:30.691Z,1370548890.691 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-06-06T20:01:30.692Z,1370548890.692 [DVL_micro](INFO): Cycling power to configure device.
2013-06-06T20:01:30.720Z,1370548890.720 [NavChartDb](INFO): Thread ID is 944
2013-06-06T20:01:30.725Z,1370548890.725 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2013-06-06T20:01:30.726Z,1370548890.726 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2013-06-06T20:01:30.726Z,1370548890.726 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2013-06-06T20:01:30.727Z,1370548890.727 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2013-06-06T20:01:30.727Z,1370548890.727 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2013-06-06T20:01:30.728Z,1370548890.728 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2013-06-06T20:01:30.728Z,1370548890.728 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2013-06-06T20:01:30.728Z,1370548890.728 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2013-06-06T20:01:30.728Z,1370548890.728 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2013-06-06T20:01:32.344Z,1370548892.344 [Batt_Ocean_Server](INFO): Ocean Server Batteries initialized
2013-06-06T20:01:32.434Z,1370548892.434 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2013-06-06T20:01:32.747Z,1370548892.747 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-06-06T20:01:32.748Z,1370548892.748 [DVL_micro](INFO): Querying output modes
2013-06-06T20:01:32.783Z,1370548892.783 [DVL_micro](INFO): NQ1 output enabled
2013-06-06T20:01:32.972Z,1370548892.972 [DVL_micro](INFO): pause:Powering down
2013-06-06T20:01:33.327Z,1370548893.327 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2013-06-06T20:01:33.477Z,1370548893.477 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2013-06-06T20:01:34.225Z,1370548894.225 [Radio_Freewave](INFO): Powering up
2013-06-06T20:01:34.983Z,1370548894.983 [NAL9602](INFO): Powering up NAL9602
2013-06-06T20:01:35.615Z,1370548895.615 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2013-06-06T20:01:35.615Z,1370548895.615 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2013-06-06T20:01:35.615Z,1370548895.615 [BuoyancyServo](ERROR): Communications Fault
2013-06-06T20:01:35.817Z,1370548895.817 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2013-06-06T20:01:36.276Z,1370548896.276 [BuoyancyServo](INFO): Powering down
2013-06-06T20:01:39.265Z,1370548899.265 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2013-06-06T20:01:43.913Z,1370548903.913 [Aanderaa_O2](FAULT): Timed out starting
2013-06-06T20:01:43.914Z,1370548903.914 [Aanderaa_O2](ERROR): Communications Fault
2013-06-06T20:01:44.299Z,1370548904.299 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2013-06-06T20:01:44.459Z,1370548904.459 [Aanderaa_O2](INFO): Powering down
2013-06-06T20:01:45.406Z,1370548905.406 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2013-06-06T20:01:45.743Z,1370548905.743 [NAL9602](INFO): NAL9602 initialized
2013-06-06T20:01:46.392Z,1370548906.392 [SBIT](IMPORTANT): Beginning Startup BIT
2013-06-06T20:01:46.394Z,1370548906.395 [CBIT](IMPORTANT): Beginning GF scan
2013-06-06T20:01:48.407Z,1370548908.407 [Aanderaa_O2](INFO): Powering down
2013-06-06T20:02:13.380Z,1370548933.380 [CBIT](IMPORTANT): No ground fault detected
lrauv-tethys>failc
2013-06-06T20:02:20.484Z,1370548940.484 [CommandLine](IMPORTANT): got command failComponent
2013-06-06T20:02:20.484Z,1370548940.484 [CommandLine](IMPORTANT): Failed components:
2013-06-06T20:02:20.484Z,1370548940.484 [CommandLine](IMPORTANT): No failed Components.
2013-06-06T20:02:40.336Z,1370548960.336 [SBIT](IMPORTANT): SBIT PASSED
2013-06-06T20:02:40.679Z,1370548960.679 [MissionManager](IMPORTANT): Started mission Startup
2013-06-06T20:02:40.679Z,1370548960.679 [Startup](INFO): Aggregate::initialize Startup
2013-06-06T20:02:40.694Z,1370548960.694 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2013-06-06T20:03:40.951Z,1370549020.951 [Startup:StartupSatComms:A](INFO): Timed out from 2013-06-06T20:02:40.7Z
2013-06-06T20:03:40.951Z,1370549020.951 [Startup:StartupSatComms:A:A_Timeout](INFO): Aggregate::initialize Startup:StartupSatComms:A:A_Timeout
2013-06-06T20:03:40.951Z,1370549020.951 [Startup:StartupSatComms:A:A_Timeout](INFO): Completed Startup:StartupSatComms:A:A_Timeout
2013-06-06T20:04:41.047Z,1370549081.047 [Startup:StartupSatComms:B](INFO): Timed out from 2013-06-06T20:03:40.0Z
2013-06-06T20:04:41.047Z,1370549081.047 [Startup:StartupSatComms:B:A_Timeout](INFO): Aggregate::initialize Startup:StartupSatComms:B:A_Timeout
2013-06-06T20:04:41.047Z,1370549081.047 [Startup:StartupSatComms:B:A_Timeout](INFO): Completed Startup:StartupSatComms:B:A_Timeout
2013-06-06T20:04:41.048Z,1370549081.048 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2013-06-06T20:04:41.048Z,1370549081.048 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2013-06-06T20:04:41.049Z,1370549081.049 [Startup](INFO): Completed Startup
2013-06-06T20:04:41.049Z,1370549081.049 [Startup](INFO): Aggregate::uninitialize Startup
2013-06-06T20:04:41.905Z,1370549081.905 [MissionManager](IMPORTANT): Started mission Default
2013-06-06T20:04:41.905Z,1370549081.905 [Default](INFO): Aggregate::initialize Default
2013-06-06T20:04:41.906Z,1370549081.906 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-06-06T20:04:41.918Z,1370549081.918 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-06-06T20:04:41.920Z,1370549081.921 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-06-06T20:04:41.931Z,1370549081.931 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-06-06T20:11:50.472Z,1370549510.472 [NAL9602](FAULT): GPS failed to acquire within timeout.
2013-06-06T20:11:50.473Z,1370549510.473 [NAL9602](ERROR): Data Fault
2013-06-06T20:11:50.495Z,1370549510.495 [CBIT](ERROR): Data Fault in component: NAL9602
2013-06-06T20:11:50.864Z,1370549510.864 [NAL9602](INFO): Powering down
2013-06-06T20:11:51.691Z,1370549511.691 [CBIT](INFO): Clearing failed state for component NAL9602
2013-06-06T20:11:56.070Z,1370549516.070 [NAL9602](INFO): Powering up NAL9602
2013-06-06T20:12:06.491Z,1370549526.491 [NAL9602](INFO): NAL9602 initialized
2013-06-06T20:21:41.100Z,1370550101.100 [Batt_Ocean_Server](INFO): Over Temperature Alarm! Battery Bank #9 STATUS: 5911
2013-06-06T20:21:41.100Z,1370550101.100 [Batt_Ocean_Server](INFO): Not Initialized - Battery Bank #9 STATUS: 5911
2013-06-06T20:22:08.112Z,1370550128.112 [NAL9602](FAULT): GPS failed to acquire within timeout.
2013-06-06T20:22:08.112Z,1370550128.112 [NAL9602](ERROR): Data Fault
2013-06-06T20:22:08.135Z,1370550128.135 [CBIT](ERROR): Data Fault in component: NAL9602
2013-06-06T20:22:08.135Z,1370550128.135 [CBIT](CRITICAL): Data Fault in component: NAL9602
2013-06-06T20:22:08.499Z,1370550128.499 [NAL9602](INFO): Powering down
2013-06-06T20:24:08.132Z,1370550248.132 [CBIT](INFO): Clearing failed count for component NAL9602
2013-06-06T20:24:08.500Z,1370550248.500 [NAL9602](INFO): Powering up NAL9602
2013-06-06T20:24:18.979Z,1370550258.979 [NAL9602](INFO): NAL9602 initialized
2013-06-06T20:25:59.314Z,1370550359.314 [NAL9602](IMPORTANT): GPS fix at: 1370550310.00
2013-06-06T20:25:59.754Z,1370550359.754 [Default:GPS](INFO): Completed Default:GPS
2013-06-06T20:25:59.754Z,1370550359.754 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
lrauv-tethys>restart hardware
2013-06-06T20:27:08.227Z,1370550428.227 [CommandLine](IMPORTANT): got command restart hardware
2013-06-06T20:28:24.990Z,1370550504.990 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/Science.cfg
2013-06-06T20:28:25.128Z,1370550505.128 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/Control.cfg
2013-06-06T20:28:25.232Z,1370550505.232 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/workSite.cfg
2013-06-06T20:28:25.330Z,1370550505.330 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/Simulator.cfg
2013-06-06T20:28:25.426Z,1370550505.426 [Supervisor](INFO): Opening Config file at: Config/lrauv-tethys/Derivation.cfg
2013-06-06T20:28:25.522Z,1370550505.522 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
lrauv-tethys>JFFS2 notice: (705) check_node_data: wrong data CRC in data node at 0x01893000: read 0x78f95a9b, calculated 0xa628c67e.
JFFS2 notice: (705) check_node_data: wrong data CRC in data node at 0x01892000: read 0x27221b7e, calculated 0xe012f50d.
2013-06-06T20:28:32.920Z,1370550512.920 [CommandLine](INFO): Thread ID is 748
2013-06-06T20:28:32.923Z,1370550512.923 [controlThread](INFO): Thread ID is 747
2013-06-06T20:28:32.924Z,1370550512.924 [CycleStarter](INFO): Thread ID is 746
2013-06-06T20:28:32.924Z,1370550512.924 [SBIT](INFO): Initialize SBIT Component.
2013-06-06T20:28:32.925Z,1370550512.925 [SBIT](IMPORTANT): Tethys CM Info:
$Rev:10393
2013-06-06T20:28:32.925Z,1370550512.925 [SBIT](IMPORTANT): Kernel Release:2.6.27.8
2013-06-06T20:28:32.926Z,1370550512.926 [SBIT](IMPORTANT): Kernel Version:#634 PREEMPT Wed Feb 13 10:21:48 PST 2013
2013-06-06T20:28:32.926Z,1370550512.926 [IBIT](INFO): Initialize IBIT Component.
2013-06-06T20:28:32.927Z,1370550512.927 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2013-06-06T20:28:32.928Z,1370550512.928 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2013-06-06T20:28:32.931Z,1370550512.931 [logger](INFO): Thread ID is 749
2013-06-06T20:28:32.980Z,1370550512.980 [AsyncPiEstimator](INFO): Thread ID is 816
2013-06-06T20:28:32.993Z,1370550512.993 [CTD_NeilBrown](INFO): Thread ID is 817
2013-06-06T20:28:32.996Z,1370550512.996 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2013-06-06T20:28:33.007Z,1370550513.007 [WetLabsBB2FL](INFO): Thread ID is 818
2013-06-06T20:28:33.008Z,1370550513.008 [WetLabsBB2FL](INFO): Powering down
2013-06-06T20:28:33.034Z,1370550513.033 [DVL_micro](INFO): Thread ID is 819
2013-06-06T20:28:33.172Z,1370550513.172 [NavChartDb](INFO): Thread ID is 820
2013-06-06T20:28:33.181Z,1370550513.181 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2013-06-06T20:28:33.181Z,1370550513.181 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2013-06-06T20:28:33.182Z,1370550513.182 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2013-06-06T20:28:33.182Z,1370550513.182 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2013-06-06T20:28:33.182Z,1370550513.182 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2013-06-06T20:28:33.182Z,1370550513.182 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2013-06-06T20:28:33.183Z,1370550513.183 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2013-06-06T20:28:33.183Z,1370550513.183 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2013-06-06T20:28:33.183Z,1370550513.183 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2013-06-06T20:28:33.803Z,1370550513.803 [DVL_micro](INFO): Initializing
2013-06-06T20:28:33.803Z,1370550513.803 [DVL_micro](INFO): start:Powering up
2013-06-06T20:28:33.804Z,1370550513.804 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-06-06T20:28:33.804Z,1370550513.804 [DVL_micro](INFO): Cycling power to configure device.
2013-06-06T20:28:34.608Z,1370550514.608 [Batt_Ocean_Server](INFO): Ocean Server Batteries initialized
2013-06-06T20:28:34.913Z,1370550514.913 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2013-06-06T20:28:34.986Z,1370550514.986 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2013-06-06T20:28:35.066Z,1370550515.066 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2013-06-06T20:28:35.683Z,1370550515.683 [Radio_Freewave](INFO): Powering up
2013-06-06T20:28:35.875Z,1370550515.875 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-06-06T20:28:35.876Z,1370550515.876 [DVL_micro](INFO): Querying output modes
2013-06-06T20:28:36.579Z,1370550516.579 [DVL_micro](INFO): NQ1 output enabled
2013-06-06T20:28:36.724Z,1370550516.724 [DVL_micro](INFO): pause:Powering down
2013-06-06T20:28:37.890Z,1370550517.890 [NAL9602](INFO): Powering up NAL9602
lrauv-tethys>JFFS2 notice: (705) check_node_data: wrong data CRC in data node at 0x01bd1b78: read 0x7fd2c1d3, calculated 0x73c603f1.
2013-06-06T20:28:45.353Z,1370550525.353 [Aanderaa_O2](FAULT): Timed out starting
2013-06-06T20:28:45.354Z,1370550525.353 [Aanderaa_O2](ERROR): Communications Fault
2013-06-06T20:28:45.602Z,1370550525.602 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2013-06-06T20:28:45.867Z,1370550525.867 [Aanderaa_O2](INFO): Powering down
2013-06-06T20:28:46.823Z,1370550526.823 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2013-06-06T20:29:42.208Z,1370550582.208 [SBIT](IMPORTANT): SBIT PASSEDta node at 0x02776a00: read 0x15561117, calculated 0x96b9ade3.
2013-06-06T20:29:42.452Z,1370550582.453 [MissionManager](IMPORTANT): Started mission Startup486, calculated 0xf4de45f0.
2013-06-06T20:29:42.453Z,1370550582.453 [Startup](INFO): Aggregate::initialize Startup
2013-06-06T20:29:42.471Z,1370550582.471 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
lrauv-tethys>:28:48.586Z,1370550528.586 [CBIT](IMPORTANT): Beginning GF scan