2015-04-17T17:10:24.633Z,1429290624.633 [CommandLine](IMPORTANT): got command restart logs 2015-04-17T17:10:25.073Z,1429290625.073 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:10:25.073Z,1429290625.073 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:10:25.073Z,1429290625.073 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:10:25.485Z,1429290625.485 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:10:25.490Z,1429290625.490 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:10:25.618Z,1429290625.618 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:10:28.263Z,1429290628.263 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T17:10:42.157Z,1429290642.157 [NAL9602](INFO): SBD MO Status=1, MOMSN=52513, MT Status=0, MTMSN=0 2015-04-17T17:10:42.208Z,1429290642.208 [NAL9602](INFO): Sent 44 bytes from file Logs/20150417T155520/Courier0036.lzma 2015-04-17T17:10:42.208Z,1429290642.208 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:10:42.210Z,1429290642.210 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T155520/Courier0036.lzma.parts/0000.sbd 2015-04-17T17:10:42.210Z,1429290642.210 [NAL9602](INFO): Completed sending Logs/20150417T155520/Courier0036.lzma 2015-04-17T17:10:55.522Z,1429290655.522 [NAL9602](INFO): SBD MO Status=1, MOMSN=52514, MT Status=0, MTMSN=0 2015-04-17T17:10:55.569Z,1429290655.569 [NAL9602](INFO): Sent 332 bytes from file Logs/20150417T155520/Express0033.lzma 2015-04-17T17:10:55.569Z,1429290655.569 [NAL9602](INFO): Packets left to send: 1 2015-04-17T17:10:55.571Z,1429290655.571 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T155520/Express0033.lzma.parts/0001.sbd 2015-04-17T17:10:58.739Z,1429290658.739 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T17:10:58.739Z,1429290658.739 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:10:58.740Z,1429290658.740 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T17:10:58.740Z,1429290658.740 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T17:10:58.740Z,1429290658.740 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T17:10:59.160Z,1429290659.160 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 72.680772 min 2015-04-17T17:10:59.160Z,1429290659.160 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T17:10:59.161Z,1429290659.161 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:10:59.161Z,1429290659.161 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T17:10:59.161Z,1429290659.161 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:11:09.449Z,1429290669.449 [NAL9602](INFO): SBD MO Status=1, MOMSN=52515, MT Status=0, MTMSN=0 2015-04-17T17:11:09.503Z,1429290669.503 [NAL9602](INFO): Sent 55 bytes from file Logs/20150417T155520/Express0033.lzma 2015-04-17T17:11:09.503Z,1429290669.503 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:11:09.504Z,1429290669.504 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T155520/Express0033.lzma.parts/0000.sbd 2015-04-17T17:11:09.504Z,1429290669.504 [NAL9602](INFO): Completed sending Logs/20150417T155520/Express0033.lzma 2015-04-17T17:11:28.815Z,1429290688.815 [NAL9602](INFO): SBD MO Status=1, MOMSN=52516, MT Status=0, MTMSN=0 2015-04-17T17:11:28.873Z,1429290688.873 [NAL9602](INFO): Sent 332 bytes from file Logs/20150417T155520/Express0037.lzma 2015-04-17T17:11:28.873Z,1429290688.873 [NAL9602](INFO): Packets left to send: 1 2015-04-17T17:11:28.874Z,1429290688.874 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T155520/Express0037.lzma.parts/0001.sbd 2015-04-17T17:11:40.285Z,1429290700.285 [NAL9602](INFO): SBD MO Status=1, MOMSN=52517, MT Status=0, MTMSN=0 2015-04-17T17:11:40.343Z,1429290700.343 [NAL9602](INFO): Sent 18 bytes from file Logs/20150417T155520/Express0037.lzma 2015-04-17T17:11:40.343Z,1429290700.343 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:11:40.344Z,1429290700.344 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T155520/Express0037.lzma.parts/0000.sbd 2015-04-17T17:11:40.344Z,1429290700.344 [NAL9602](INFO): Completed sending Logs/20150417T155520/Express0037.lzma 2015-04-17T17:12:09.927Z,1429290729.927 [NAL9602](INFO): SBD MO Status=2, MOMSN=52518, MT Status=2, MTMSN=0 2015-04-17T17:12:09.927Z,1429290729.927 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:12:14.701Z,1429290734.701 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:12:20.007Z,1429290740.007 [NAL9602](INFO): SBD MO Status=0, MOMSN=52518, MT Status=0, MTMSN=0 2015-04-17T17:12:24.555Z,1429290744.555 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T17:12:44.805Z,1429290764.805 [NAL9602](INFO): SBD MO Status=2, MOMSN=52519, MT Status=2, MTMSN=0 2015-04-17T17:12:44.805Z,1429290764.805 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:12:55.253Z,1429290775.253 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:12:55.253Z,1429290775.253 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:13:05.535Z,1429290785.535 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:13:05.535Z,1429290785.535 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:13:05.535Z,1429290785.535 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:13:05.966Z,1429290785.966 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:13:06.100Z,1429290786.100 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:13:07.335Z,1429290787.335 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:13:07.335Z,1429290787.335 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:13:11.050Z,1429290791.050 [NAL9602](INFO): SBD MO Status=2, MOMSN=52519, MT Status=2, MTMSN=0 2015-04-17T17:13:11.050Z,1429290791.050 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:13:15.498Z,1429290795.498 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:13:18.574Z,1429290798.574 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:13:18.605Z,1429290798.605 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:13:18.605Z,1429290798.605 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:13:19.007Z,1429290799.007 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:13:19.127Z,1429290799.127 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:13:20.356Z,1429290800.356 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:13:20.356Z,1429290800.356 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:13:30.625Z,1429290810.625 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:13:30.625Z,1429290810.625 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:13:30.625Z,1429290810.625 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:13:31.032Z,1429290811.032 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:13:31.032Z,1429290811.032 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:13:31.154Z,1429290811.154 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:13:36.771Z,1429290816.771 [NAL9602](INFO): SBD MO Status=2, MOMSN=52519, MT Status=2, MTMSN=0 2015-04-17T17:13:36.771Z,1429290816.771 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:13:41.053Z,1429290821.053 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:13:45.156Z,1429290825.156 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:14:06.816Z,1429290846.816 [NAL9602](INFO): SBD MO Status=2, MOMSN=52519, MT Status=2, MTMSN=0 2015-04-17T17:14:06.816Z,1429290846.816 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:14:11.593Z,1429290851.593 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:14:23.384Z,1429290863.384 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:14:38.082Z,1429290878.082 [NAL9602](INFO): SBD MO Status=2, MOMSN=52519, MT Status=2, MTMSN=0 2015-04-17T17:14:38.082Z,1429290878.082 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:14:42.535Z,1429290882.535 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T17:15:03.824Z,1429290903.824 [NAL9602](INFO): SBD MO Status=2, MOMSN=52519, MT Status=2, MTMSN=0 2015-04-17T17:15:03.825Z,1429290903.825 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:15:08.113Z,1429290908.113 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:15:25.314Z,1429290925.314 [CBIT](INFO): Clearing failed count for component DVL_micro 2015-04-17T17:15:25.314Z,1429290925.314 [DVL_micro] No Fault, FailCount= 5 2015-04-17T17:15:25.708Z,1429290925.708 [DVL_micro](INFO): Initializing 2015-04-17T17:15:36.559Z,1429290936.559 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:15:36.559Z,1429290936.559 [DVL_micro] Communications Fault, FailCount= 1 2015-04-17T17:15:36.559Z,1429290936.559 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:15:36.643Z,1429290936.643 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:15:37.081Z,1429290937.081 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:15:37.499Z,1429290937.499 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:15:38.079Z,1429290938.079 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:15:38.079Z,1429290938.079 [DVL_micro] No Fault, FailCount= 1 2015-04-17T17:15:38.475Z,1429290938.475 [DVL_micro](INFO): Initializing 2015-04-17T17:15:42.696Z,1429290942.696 [CBIT](DEBUG): EFC running - data check-sum false 2015-04-17T17:15:49.033Z,1429290949.033 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:15:49.033Z,1429290949.033 [DVL_micro] Communications Fault, FailCount= 2 2015-04-17T17:15:49.033Z,1429290949.033 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:15:49.081Z,1429290949.081 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:15:49.532Z,1429290949.532 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:15:49.953Z,1429290949.953 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:15:50.446Z,1429290950.446 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:15:50.446Z,1429290950.446 [DVL_micro] No Fault, FailCount= 2 2015-04-17T17:15:50.806Z,1429290950.806 [DVL_micro](INFO): Initializing 2015-04-17T17:15:59.019Z,1429290959.019 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T17:15:59.019Z,1429290959.019 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:15:59.019Z,1429290959.019 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T17:15:59.020Z,1429290959.020 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T17:15:59.020Z,1429290959.020 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T17:15:59.554Z,1429290959.554 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 77.718939 min 2015-04-17T17:15:59.554Z,1429290959.554 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T17:15:59.554Z,1429290959.554 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:15:59.554Z,1429290959.554 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T17:15:59.554Z,1429290959.554 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:16:00.890Z,1429290960.890 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:16:00.890Z,1429290960.890 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:16:01.729Z,1429290961.729 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:16:01.729Z,1429290961.729 [DVL_micro] Communications Fault, FailCount= 3 2015-04-17T17:16:01.729Z,1429290961.729 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:16:01.758Z,1429290961.758 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:16:02.232Z,1429290962.232 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:16:02.644Z,1429290962.644 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:16:03.116Z,1429290963.116 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:16:03.116Z,1429290963.116 [DVL_micro] No Fault, FailCount= 3 2015-04-17T17:16:03.510Z,1429290963.510 [DVL_micro](INFO): Initializing 2015-04-17T17:16:11.156Z,1429290971.156 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:16:11.156Z,1429290971.156 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:16:11.156Z,1429290971.156 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:16:11.611Z,1429290971.611 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:16:11.731Z,1429290971.731 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:16:13.170Z,1429290973.170 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:16:13.170Z,1429290973.170 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:16:14.472Z,1429290974.472 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:16:14.472Z,1429290974.472 [DVL_micro] Communications Fault, FailCount= 4 2015-04-17T17:16:14.472Z,1429290974.472 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:16:14.536Z,1429290974.536 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:16:14.972Z,1429290974.972 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:16:15.422Z,1429290975.422 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:16:15.879Z,1429290975.879 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:16:15.879Z,1429290975.879 [DVL_micro] No Fault, FailCount= 4 2015-04-17T17:16:16.285Z,1429290976.285 [DVL_micro](INFO): Initializing 2015-04-17T17:16:23.244Z,1429290983.244 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:16:23.244Z,1429290983.244 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:16:23.244Z,1429290983.244 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:16:23.691Z,1429290983.691 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:16:23.814Z,1429290983.814 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:16:25.140Z,1429290985.140 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:16:25.140Z,1429290985.140 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:16:26.913Z,1429290986.913 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:16:26.913Z,1429290986.913 [DVL_micro] Communications Fault, FailCount= 5 2015-04-17T17:16:26.913Z,1429290986.913 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:16:26.943Z,1429290986.943 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:16:26.944Z,1429290986.944 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2015-04-17T17:16:27.412Z,1429290987.412 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:16:27.861Z,1429290987.861 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:16:35.414Z,1429290995.414 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:16:35.414Z,1429290995.414 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:16:35.414Z,1429290995.414 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:16:35.831Z,1429290995.831 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:16:35.831Z,1429290995.831 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:16:35.977Z,1429290995.977 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:16:38.117Z,1429290998.117 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T17:16:48.844Z,1429291008.844 [NAL9602](INFO): SBD MO Status=1, MOMSN=52519, MT Status=0, MTMSN=0 2015-04-17T17:16:48.893Z,1429291008.893 [NAL9602](INFO): Sent 25 bytes from file Logs/20150417T171024/Courier0000.lzma 2015-04-17T17:16:48.893Z,1429291008.893 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:16:48.894Z,1429291008.894 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Courier0000.lzma.parts/0000.sbd 2015-04-17T17:16:48.895Z,1429291008.895 [NAL9602](INFO): Completed sending Logs/20150417T171024/Courier0000.lzma 2015-04-17T17:16:59.179Z,1429291019.179 [BPC1](ERROR): Failed to receive battery data 2015-04-17T17:16:59.179Z,1429291019.179 [BPC1] Communications Fault, FailCount= 1 2015-04-17T17:16:59.179Z,1429291019.179 [BPC1](ERROR): Communications Fault 2015-04-17T17:16:59.201Z,1429291019.201 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T17:17:00.498Z,1429291020.498 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T17:17:00.498Z,1429291020.498 [BPC1] No Fault, FailCount= 1 2015-04-17T17:17:09.829Z,1429291029.829 [NAL9602](INFO): SBD MO Status=1, MOMSN=52520, MT Status=0, MTMSN=0 2015-04-17T17:17:09.881Z,1429291029.881 [NAL9602](INFO): Sent 332 bytes from file Logs/20150417T171024/Express0001.lzma 2015-04-17T17:17:09.882Z,1429291029.882 [NAL9602](INFO): Packets left to send: 1 2015-04-17T17:17:09.883Z,1429291029.883 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0001.lzma.parts/0001.sbd 2015-04-17T17:17:15.140Z,1429291035.140 [BPC1](FAULT): A bank: No match for serial number:5911 was found in the onboard configuration. 2015-04-17T17:17:15.140Z,1429291035.140 [BPC1](ERROR): Failed to parse bank A battery data 2015-04-17T17:17:15.140Z,1429291035.140 [BPC1] Data Fault, FailCount= 2 2015-04-17T17:17:15.140Z,1429291035.140 [BPC1](ERROR): Data Fault 2015-04-17T17:17:15.162Z,1429291035.162 [CBIT](ERROR): Data Fault in component: BPC1 2015-04-17T17:17:16.468Z,1429291036.468 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T17:17:16.468Z,1429291036.468 [BPC1] No Fault, FailCount= 2 2015-04-17T17:17:21.218Z,1429291041.218 [NAL9602](INFO): SBD MO Status=1, MOMSN=52521, MT Status=0, MTMSN=0 2015-04-17T17:17:21.271Z,1429291041.271 [NAL9602](INFO): Sent 149 bytes from file Logs/20150417T171024/Express0001.lzma 2015-04-17T17:17:21.271Z,1429291041.271 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:17:21.272Z,1429291041.272 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0001.lzma.parts/0000.sbd 2015-04-17T17:17:21.273Z,1429291041.273 [NAL9602](INFO): Completed sending Logs/20150417T171024/Express0001.lzma 2015-04-17T17:17:31.711Z,1429291051.711 [BPC1](DEBUG): Received data from all battery sticks 2015-04-17T17:17:33.069Z,1429291053.069 [NAL9602](INFO): SBD MO Status=0, MOMSN=52522, MT Status=0, MTMSN=0 2015-04-17T17:17:33.175Z,1429291053.175 [Default:CheckIn:Read_Iridium] Stopped 2015-04-17T17:17:33.176Z,1429291053.176 [Default:CheckIn](INFO): Completed Default:CheckIn 2015-04-17T17:17:33.176Z,1429291053.176 [Default:CheckIn] Stopped 2015-04-17T17:17:33.176Z,1429291053.176 [Default:CheckIn](INFO): Aggregate::uninitialize Default:CheckIn 2015-04-17T17:17:33.176Z,1429291053.176 [Default:CheckIn:A.SetSpeed] Stopped 2015-04-17T17:17:33.176Z,1429291053.176 [Default:CheckIn:A.SetSpeed](DEBUG): Uninitialize. 2015-04-17T17:17:43.571Z,1429291063.571 [NAL9602](INFO): Powering down 2015-04-17T17:17:43.685Z,1429291063.685 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:18:28.575Z,1429291108.575 [BPC1](ERROR): Failed to receive battery data 2015-04-17T17:18:28.575Z,1429291108.575 [BPC1] Communications Fault, FailCount= 1 2015-04-17T17:18:28.575Z,1429291108.575 [BPC1](ERROR): Communications Fault 2015-04-17T17:18:28.596Z,1429291108.596 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T17:18:43.597Z,1429291123.597 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T17:18:43.597Z,1429291123.597 [BPC1] No Fault, FailCount= 1 2015-04-17T17:19:08.685Z,1429291148.685 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:19:08.685Z,1429291148.685 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:19:28.235Z,1429291168.235 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:19:28.235Z,1429291168.235 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:19:28.235Z,1429291168.235 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:19:28.651Z,1429291168.651 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:19:33.351Z,1429291173.351 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:19:43.644Z,1429291183.644 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:19:43.644Z,1429291183.644 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:20:03.233Z,1429291203.233 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:20:03.233Z,1429291203.233 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:20:03.233Z,1429291203.233 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:20:03.613Z,1429291203.613 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:20:08.354Z,1429291208.354 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:20:18.625Z,1429291218.625 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:20:18.625Z,1429291218.625 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:20:38.235Z,1429291238.235 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:20:38.235Z,1429291238.235 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:20:38.235Z,1429291238.235 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:20:38.657Z,1429291238.657 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:20:38.658Z,1429291238.658 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:20:43.352Z,1429291243.352 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:21:03.601Z,1429291263.601 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T17:21:03.601Z,1429291263.601 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:21:03.601Z,1429291263.601 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T17:21:03.601Z,1429291263.601 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T17:21:03.601Z,1429291263.601 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T17:21:08.666Z,1429291268.666 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 82.796321 min 2015-04-17T17:21:08.666Z,1429291268.666 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T17:21:08.666Z,1429291268.666 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:21:08.666Z,1429291268.666 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T17:21:08.666Z,1429291268.666 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:22:33.585Z,1429291353.585 [Default:CheckIn] Running Loop=1 2015-04-17T17:22:33.585Z,1429291353.585 [Default:CheckIn](INFO): Aggregate::initialize Default:CheckIn 2015-04-17T17:22:33.585Z,1429291353.585 [Default:CheckIn:A.SetSpeed] Running Loop=1 2015-04-17T17:22:33.585Z,1429291353.585 [Default:CheckIn:A.SetSpeed](DEBUG): Initialize. 2015-04-17T17:22:33.585Z,1429291353.585 [Default:CheckIn:Read_GPS] Running Loop=1 2015-04-17T17:22:33.989Z,1429291353.989 [NAL9602](INFO): Powering up 2015-04-17T17:22:34.090Z,1429291354.090 [Reporter](INFO): NAL9602.sigQuality no_value 2015-04-17T17:22:44.333Z,1429291364.333 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:22:45.160Z,1429291365.160 [NAL9602](INFO): NAL9602 initialized 2015-04-17T17:23:08.611Z,1429291388.611 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:23:08.611Z,1429291388.611 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:23:18.995Z,1429291398.995 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:23:18.995Z,1429291398.995 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:23:18.995Z,1429291398.995 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:23:19.442Z,1429291399.442 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:23:19.443Z,1429291399.443 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:23:19.562Z,1429291399.562 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:23:20.789Z,1429291400.789 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:23:20.789Z,1429291400.789 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:23:31.024Z,1429291411.024 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:23:31.025Z,1429291411.025 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:23:31.025Z,1429291411.025 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:23:31.470Z,1429291411.470 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:23:31.593Z,1429291411.593 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:23:31.982Z,1429291411.982 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:23:32.937Z,1429291412.937 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:23:32.937Z,1429291412.937 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:23:43.252Z,1429291423.252 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:23:43.252Z,1429291423.252 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:23:43.253Z,1429291423.253 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:23:43.653Z,1429291423.653 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:23:43.653Z,1429291423.653 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:23:43.772Z,1429291423.772 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:23:45.063Z,1429291425.063 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:23:54.008Z,1429291434.008 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:24:06.497Z,1429291446.497 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:24:11.538Z,1429291451.538 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:24:19.407Z,1429291459.407 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T17:24:37.814Z,1429291477.814 [NAL9602](INFO): SBD MO Status=2, MOMSN=52523, MT Status=2, MTMSN=0 2015-04-17T17:24:37.815Z,1429291477.815 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:24:42.509Z,1429291482.509 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:25:00.958Z,1429291500.958 [BPC1](DEBUG): Received data from all battery sticks 2015-04-17T17:25:42.777Z,1429291542.777 [CBIT](DEBUG): EFC running - data check-sum false 2015-04-17T17:26:03.686Z,1429291563.686 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T17:26:03.686Z,1429291563.686 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:26:03.686Z,1429291563.686 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T17:26:03.687Z,1429291563.687 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T17:26:03.687Z,1429291563.687 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T17:26:04.123Z,1429291564.123 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 87.797171 min 2015-04-17T17:26:04.123Z,1429291564.123 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T17:26:04.123Z,1429291564.123 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:26:04.123Z,1429291564.123 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T17:26:04.123Z,1429291564.123 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:26:13.619Z,1429291573.619 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:26:13.619Z,1429291573.619 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:26:17.022Z,1429291577.022 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T17:26:23.780Z,1429291583.780 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:26:23.781Z,1429291583.781 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:26:23.781Z,1429291583.781 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:26:24.143Z,1429291584.143 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:26:24.302Z,1429291584.302 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:26:25.582Z,1429291585.582 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:26:25.582Z,1429291585.582 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:26:27.350Z,1429291587.350 [CBIT](INFO): Clearing failed count for component DVL_micro 2015-04-17T17:26:27.350Z,1429291587.350 [DVL_micro] No Fault, FailCount= 5 2015-04-17T17:26:27.747Z,1429291587.747 [DVL_micro](INFO): Initializing 2015-04-17T17:26:27.751Z,1429291587.751 [NAL9602](INFO): SBD MO Status=0, MOMSN=52523, MT Status=0, MTMSN=0 2015-04-17T17:26:27.751Z,1429291587.751 [NAL9602](INFO): No messages in MT queue 2015-04-17T17:26:29.071Z,1429291589.071 [NAL9602](INFO): GPS fix at 20150417T172416: (36.802611, -121.787031) 2015-04-17T17:26:29.089Z,1429291589.089 [Default:CheckIn:Read_GPS] Stopped 2015-04-17T17:26:29.089Z,1429291589.089 [Default:CheckIn:Read_Iridium] Running Loop=1 2015-04-17T17:26:32.359Z,1429291592.359 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T17:26:35.914Z,1429291595.914 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:26:35.914Z,1429291595.914 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:26:35.914Z,1429291595.914 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:26:36.352Z,1429291596.352 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:26:36.481Z,1429291596.481 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:26:37.677Z,1429291597.677 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:26:37.677Z,1429291597.677 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:26:38.480Z,1429291598.480 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:26:38.480Z,1429291598.480 [DVL_micro] Communications Fault, FailCount= 1 2015-04-17T17:26:38.480Z,1429291598.480 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:26:38.553Z,1429291598.553 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:26:38.992Z,1429291598.992 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:26:39.422Z,1429291599.422 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:26:39.957Z,1429291599.957 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:26:39.957Z,1429291599.957 [DVL_micro] No Fault, FailCount= 1 2015-04-17T17:26:40.329Z,1429291600.329 [DVL_micro](INFO): Initializing 2015-04-17T17:26:48.056Z,1429291608.056 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:26:48.056Z,1429291608.056 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:26:48.056Z,1429291608.056 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:26:48.494Z,1429291608.494 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:26:48.494Z,1429291608.494 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:26:48.615Z,1429291608.615 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:26:51.107Z,1429291611.107 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:26:51.107Z,1429291611.107 [DVL_micro] Communications Fault, FailCount= 2 2015-04-17T17:26:51.107Z,1429291611.107 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:26:51.167Z,1429291611.167 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:26:51.607Z,1429291611.607 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:26:52.049Z,1429291612.049 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:26:52.476Z,1429291612.476 [NAL9602](INFO): SBD MO Status=2, MOMSN=52524, MT Status=2, MTMSN=0 2015-04-17T17:26:52.476Z,1429291612.476 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:26:52.524Z,1429291612.524 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:26:52.524Z,1429291612.524 [DVL_micro] No Fault, FailCount= 2 2015-04-17T17:26:52.920Z,1429291612.920 [DVL_micro](INFO): Initializing 2015-04-17T17:26:56.859Z,1429291616.859 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:26:57.776Z,1429291617.776 [BPC1](ERROR): Failed to receive battery data 2015-04-17T17:26:57.776Z,1429291617.776 [BPC1] Communications Fault, FailCount= 1 2015-04-17T17:26:57.776Z,1429291617.776 [BPC1](ERROR): Communications Fault 2015-04-17T17:26:57.834Z,1429291617.834 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T17:26:59.131Z,1429291619.131 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T17:26:59.131Z,1429291619.131 [BPC1] No Fault, FailCount= 1 2015-04-17T17:27:03.564Z,1429291623.564 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:27:03.564Z,1429291623.564 [DVL_micro] Communications Fault, FailCount= 3 2015-04-17T17:27:03.564Z,1429291623.564 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:27:03.592Z,1429291623.592 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:27:04.070Z,1429291624.070 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:27:04.516Z,1429291624.516 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:27:05.015Z,1429291625.015 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:27:05.015Z,1429291625.015 [DVL_micro] No Fault, FailCount= 3 2015-04-17T17:27:05.408Z,1429291625.408 [DVL_micro](INFO): Initializing 2015-04-17T17:27:08.910Z,1429291628.910 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:27:16.106Z,1429291636.106 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:27:16.106Z,1429291636.106 [DVL_micro] Communications Fault, FailCount= 4 2015-04-17T17:27:16.106Z,1429291636.106 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:27:16.162Z,1429291636.162 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:27:16.614Z,1429291636.614 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:27:17.044Z,1429291637.044 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:27:17.524Z,1429291637.524 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:27:17.524Z,1429291637.524 [DVL_micro] No Fault, FailCount= 4 2015-04-17T17:27:17.907Z,1429291637.907 [DVL_micro](INFO): Initializing 2015-04-17T17:27:28.610Z,1429291648.610 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:27:28.610Z,1429291648.610 [DVL_micro] Communications Fault, FailCount= 5 2015-04-17T17:27:28.610Z,1429291648.610 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:27:28.637Z,1429291648.637 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:27:28.638Z,1429291648.638 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2015-04-17T17:27:29.098Z,1429291649.098 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:27:29.523Z,1429291649.523 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:27:32.493Z,1429291652.493 [NAL9602](INFO): SBD MO Status=1, MOMSN=52524, MT Status=0, MTMSN=0 2015-04-17T17:27:32.551Z,1429291652.551 [NAL9602](INFO): Sent 332 bytes from file Logs/20150417T171024/Courier0004.lzma 2015-04-17T17:27:32.551Z,1429291652.551 [NAL9602](INFO): Packets left to send: 1 2015-04-17T17:27:32.552Z,1429291652.552 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Courier0004.lzma.parts/0001.sbd 2015-04-17T17:27:40.018Z,1429291660.018 [NAL9602](INFO): SBD MO Status=1, MOMSN=52525, MT Status=0, MTMSN=0 2015-04-17T17:27:40.062Z,1429291660.062 [NAL9602](INFO): Sent 35 bytes from file Logs/20150417T171024/Courier0004.lzma 2015-04-17T17:27:40.063Z,1429291660.063 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:27:40.064Z,1429291660.064 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Courier0004.lzma.parts/0000.sbd 2015-04-17T17:27:40.064Z,1429291660.064 [NAL9602](INFO): Completed sending Logs/20150417T171024/Courier0004.lzma 2015-04-17T17:27:58.997Z,1429291678.997 [NAL9602](INFO): SBD MO Status=2, MOMSN=52526, MT Status=2, MTMSN=0 2015-04-17T17:27:58.997Z,1429291678.997 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:28:03.337Z,1429291683.337 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T17:28:18.353Z,1429291698.353 [NAL9602](INFO): SBD MO Status=1, MOMSN=52526, MT Status=0, MTMSN=0 2015-04-17T17:28:18.402Z,1429291698.402 [NAL9602](INFO): Sent 332 bytes from file Logs/20150417T171024/Express0005.lzma 2015-04-17T17:28:18.402Z,1429291698.402 [NAL9602](INFO): Packets left to send: 2 2015-04-17T17:28:18.404Z,1429291698.404 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0005.lzma.parts/0002.sbd 2015-04-17T17:28:36.643Z,1429291716.643 [NAL9602](INFO): SBD MO Status=1, MOMSN=52527, MT Status=0, MTMSN=0 2015-04-17T17:28:36.690Z,1429291716.690 [NAL9602](INFO): Sent 332 bytes from file Logs/20150417T171024/Express0005.lzma 2015-04-17T17:28:36.690Z,1429291716.690 [NAL9602](INFO): Packets left to send: 1 2015-04-17T17:28:36.692Z,1429291716.692 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0005.lzma.parts/0001.sbd 2015-04-17T17:28:56.996Z,1429291736.996 [NAL9602](INFO): SBD MO Status=1, MOMSN=52528, MT Status=0, MTMSN=0 2015-04-17T17:28:57.046Z,1429291737.046 [NAL9602](INFO): Sent 2 bytes from file Logs/20150417T171024/Express0005.lzma 2015-04-17T17:28:57.046Z,1429291737.046 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:28:57.047Z,1429291737.047 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0005.lzma.parts/0000.sbd 2015-04-17T17:28:57.047Z,1429291737.047 [NAL9602](INFO): Completed sending Logs/20150417T171024/Express0005.lzma 2015-04-17T17:29:12.544Z,1429291752.544 [NAL9602](INFO): SBD MO Status=2, MOMSN=52529, MT Status=2, MTMSN=0 2015-04-17T17:29:12.545Z,1429291752.545 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:29:16.860Z,1429291756.860 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T17:29:18.350Z,1429291758.350 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:29:18.351Z,1429291758.351 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:29:21.738Z,1429291761.738 [NAL9602](INFO): SBD MO Status=0, MOMSN=52529, MT Status=0, MTMSN=0 2015-04-17T17:29:21.859Z,1429291761.859 [Default:CheckIn:Read_Iridium] Stopped 2015-04-17T17:29:21.859Z,1429291761.859 [Default:CheckIn](INFO): Completed Default:CheckIn 2015-04-17T17:29:21.859Z,1429291761.859 [Default:CheckIn] Stopped 2015-04-17T17:29:21.859Z,1429291761.859 [Default:CheckIn](INFO): Aggregate::uninitialize Default:CheckIn 2015-04-17T17:29:21.859Z,1429291761.859 [Default:CheckIn:A.SetSpeed] Stopped 2015-04-17T17:29:21.859Z,1429291761.859 [Default:CheckIn:A.SetSpeed](DEBUG): Uninitialize. 2015-04-17T17:29:31.874Z,1429291771.874 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:29:31.875Z,1429291771.875 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:29:31.875Z,1429291771.875 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:29:32.234Z,1429291772.234 [NAL9602](INFO): Powering down 2015-04-17T17:29:32.318Z,1429291772.318 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:29:32.320Z,1429291772.320 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:29:36.995Z,1429291776.995 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:29:47.260Z,1429291787.260 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:29:47.260Z,1429291787.260 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:29:52.221Z,1429291792.221 [BPC1](ERROR): Failed to receive battery data 2015-04-17T17:29:52.222Z,1429291792.222 [BPC1] Communications Fault, FailCount= 1 2015-04-17T17:29:52.222Z,1429291792.222 [BPC1](ERROR): Communications Fault 2015-04-17T17:29:52.272Z,1429291792.272 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T17:30:06.877Z,1429291806.877 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:30:06.877Z,1429291806.877 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:30:06.877Z,1429291806.877 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:30:07.253Z,1429291807.253 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:30:07.254Z,1429291807.254 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T17:30:07.254Z,1429291807.254 [BPC1] No Fault, FailCount= 1 2015-04-17T17:30:11.994Z,1429291811.994 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:30:22.268Z,1429291822.268 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:30:22.268Z,1429291822.268 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:30:41.875Z,1429291841.875 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:30:41.875Z,1429291841.875 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:30:41.875Z,1429291841.875 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:30:42.305Z,1429291842.305 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:30:42.305Z,1429291842.305 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:30:46.992Z,1429291846.992 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:31:07.224Z,1429291867.224 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T17:31:07.225Z,1429291867.225 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:31:07.225Z,1429291867.225 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T17:31:07.225Z,1429291867.225 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T17:31:07.225Z,1429291867.225 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T17:31:12.297Z,1429291872.297 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 92.857052 min 2015-04-17T17:31:12.298Z,1429291872.298 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T17:31:12.298Z,1429291872.298 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:31:12.298Z,1429291872.298 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T17:31:12.298Z,1429291872.298 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:33:12.312Z,1429291992.312 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:33:12.313Z,1429291992.313 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:33:31.875Z,1429292011.875 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:33:31.875Z,1429292011.875 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:33:31.875Z,1429292011.875 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:33:32.274Z,1429292012.274 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:33:36.996Z,1429292016.996 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:33:42.218Z,1429292022.218 [BPC1](DEBUG): Received data from all battery sticks 2015-04-17T17:33:47.238Z,1429292027.238 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:33:47.238Z,1429292027.238 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:34:06.877Z,1429292046.877 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:34:06.877Z,1429292046.877 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:34:06.877Z,1429292046.877 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:34:07.241Z,1429292047.241 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:34:11.994Z,1429292051.994 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:34:22.232Z,1429292062.232 [Default:CheckIn] Running Loop=1 2015-04-17T17:34:22.232Z,1429292062.232 [Default:CheckIn](INFO): Aggregate::initialize Default:CheckIn 2015-04-17T17:34:22.232Z,1429292062.232 [Default:CheckIn:A.SetSpeed] Running Loop=1 2015-04-17T17:34:22.232Z,1429292062.232 [Default:CheckIn:A.SetSpeed](DEBUG): Initialize. 2015-04-17T17:34:22.232Z,1429292062.232 [Default:CheckIn:Read_GPS] Running Loop=1 2015-04-17T17:34:22.242Z,1429292062.242 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:34:22.242Z,1429292062.242 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:34:22.643Z,1429292062.643 [NAL9602](INFO): Powering up 2015-04-17T17:34:22.706Z,1429292062.706 [Reporter](INFO): NAL9602.sigQuality no_value 2015-04-17T17:34:32.457Z,1429292072.457 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:34:32.458Z,1429292072.458 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:34:32.458Z,1429292072.458 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:34:32.877Z,1429292072.877 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:34:32.877Z,1429292072.877 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:34:32.879Z,1429292072.879 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:34:32.998Z,1429292072.998 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:34:33.781Z,1429292073.781 [NAL9602](INFO): NAL9602 initialized 2015-04-17T17:34:40.795Z,1429292080.795 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:34:53.697Z,1429292093.697 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:34:57.472Z,1429292097.472 [BPC1](ERROR): A bank expecting battery number:1 and read number: uart read:X $S,01,270F,02,00,04,5C%51 $C1,01,FF,02,00,03,FF,04,00,05,00,06,00,07,00%72 $B11,0A,FFFB%37 $B12,0A,FFFC%35 $B13,0A,FFFD%33 $B14,0A,FFFD%34 $B15,0A,0000%37 $B16,0A,0000%34 $B17,0A,0000%35 $B18,0A,FFD5%4B $S,01,5098,02,00,04,5C%26 $C1,01,FF,02,00,03,FF,04,00,05,00,06,00,07,00%72 $B11,02,000A,01,02A8,03,0001,08,0B55,09,3E64,0A,FFFC,0B,0003%4B $B11,0C,0001,0D,0063,0E,0055,0F,1677,10,18E3,11,FFFF,12,FFFF%38 $B11,13,3070,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3F $B11,1A,0031,1B,458B,1C,0095%46 $B12,02,000A,01,02A8,03,0001,08,0B37,09,3E64,0A,FFFC,0B,0002%4D $B12,0C,0001,0D,0063,0E,0056,0F,16B8,10,194F,11,FFFF,12,FFFF%47 $B12,13,4DB2,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%38 $B12,1A,0031,1B,458B,1C,00BE%4E $B13,02,000A,01,02A8,03,0001,08,0B55,09,3E62,0A,FFFD,0B,0002%49 $B13,0C,0001,0D,005A,0E,0055,0F,1651,10,18F7,11,FFFF,12,FFFF%48 $B13,13,4F74,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%48 $B13,1A,0031,1B,458B,1C,0086%46 $B14,02,000A,01,02A8,03,0001,08,0B4F,09,3E5C,0A,FFFC,0B,0001%4A $B14,0C,0001,0D,0058,0E,0053,0F,15DC,10,18EC,11,FFFF,12,FFFF%47 $B14,13,B7C0,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%38 $B14,1A,0031,1B,458B,1C,00AE%4B $B15,02,000A,01,02A8,03,0001,08,0B33,09,3E6F,0A,0000,0B,0003%38 $B15,0C,0001,0D,005B,0E,0058,0F,174F,10,19A6,11,FFFF,12,FFFF%30 $B15,13,2ECC,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%48 $B15,1A,0031,1B,458C,1C,00CB%4E $B16,02,000A,01,02A8,03,0001,08,0B54,09,3DBA,0A,FFCC,0B,FFD0%3F $B16,0C,0001,0D,0056,0E,0052,0F,1588,10,193C,11,18D8,12,1AEA%3B $B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3C $B16,1A,0031,1B,458C,1C,00F7%3D $B17,02,000A,01,02A8,03,0001,08,0B66,09,3E11,0A,0000,0B,0003%4A $B17,0C,0001,0D,0063,0E,0052,0F,158D,10,18E3,11,FFFF,12,FFFF%46 $B17,13,42B8,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%41 $B17,1A,0031,1B,458B,1C,00A1%3C $B18,02,000A,01,02A8,03,0001,08,0B51,09,3D98,0A,FFCA,0B,FFCD%47 $B18,0C,0001,0D,0059,0E,0052,0F,158F,10,1902,11,17F4,12,195D%3A $B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%32 $B18,1A,0031,1B,458C,1C,00F0%34 2015-04-17T17:34:57.472Z,1429292097.472 [BPC1](ERROR): Failed to parse bank A battery data 2015-04-17T17:34:57.472Z,1429292097.472 [BPC1] Data Fault, FailCount= 1 2015-04-17T17:34:57.472Z,1429292097.472 [BPC1](ERROR): Data Fault 2015-04-17T17:34:57.572Z,1429292097.572 [CBIT](ERROR): Data Fault in component: BPC1 2015-04-17T17:34:58.811Z,1429292098.811 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T17:34:58.811Z,1429292098.811 [BPC1] No Fault, FailCount= 1 2015-04-17T17:35:02.677Z,1429292102.677 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:35:11.199Z,1429292111.199 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:35:19.850Z,1429292119.850 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T17:35:38.330Z,1429292138.330 [NAL9602](INFO): SBD MO Status=2, MOMSN=52530, MT Status=2, MTMSN=0 2015-04-17T17:35:38.331Z,1429292138.331 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:35:42.743Z,1429292142.743 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:35:43.199Z,1429292143.199 [CBIT](DEBUG): EFC running - data check-sum false 2015-04-17T17:35:54.208Z,1429292154.208 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T17:36:07.422Z,1429292167.422 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T17:36:07.423Z,1429292167.423 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:36:07.423Z,1429292167.423 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T17:36:07.423Z,1429292167.423 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T17:36:07.423Z,1429292167.423 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T17:36:07.835Z,1429292167.835 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 97.859639 min 2015-04-17T17:36:07.836Z,1429292167.836 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T17:36:07.836Z,1429292167.836 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:36:07.836Z,1429292167.836 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T17:36:07.836Z,1429292167.836 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:36:08.233Z,1429292168.233 [NAL9602](INFO): SBD MO Status=2, MOMSN=52530, MT Status=2, MTMSN=0 2015-04-17T17:36:08.233Z,1429292168.233 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:36:13.095Z,1429292173.095 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T17:36:20.676Z,1429292180.676 [NAL9602](INFO): SBD MO Status=0, MOMSN=52530, MT Status=0, MTMSN=0 2015-04-17T17:36:20.676Z,1429292180.676 [NAL9602](INFO): No messages in MT queue 2015-04-17T17:36:21.977Z,1429292181.977 [NAL9602](INFO): GPS fix at 20150417T173409: (36.802604, -121.787035) 2015-04-17T17:36:22.009Z,1429292182.009 [Default:CheckIn:Read_GPS] Stopped 2015-04-17T17:36:22.009Z,1429292182.009 [Default:CheckIn:Read_Iridium] Running Loop=1 2015-04-17T17:36:25.331Z,1429292185.331 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T17:36:35.667Z,1429292195.667 [NAL9602](INFO): SBD MO Status=2, MOMSN=52531, MT Status=2, MTMSN=0 2015-04-17T17:36:35.668Z,1429292195.668 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:36:39.988Z,1429292199.988 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:36:56.983Z,1429292216.983 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:36:59.959Z,1429292219.959 [BPC1](ERROR): Failed to receive battery data 2015-04-17T17:36:59.959Z,1429292219.959 [BPC1] Communications Fault, FailCount= 1 2015-04-17T17:36:59.959Z,1429292219.959 [BPC1](ERROR): Communications Fault 2015-04-17T17:36:59.981Z,1429292219.981 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T17:37:01.259Z,1429292221.259 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T17:37:01.259Z,1429292221.259 [BPC1] No Fault, FailCount= 1 2015-04-17T17:37:02.658Z,1429292222.658 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:37:02.658Z,1429292222.658 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:37:12.797Z,1429292232.797 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:37:12.797Z,1429292232.797 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:37:12.797Z,1429292232.797 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:37:13.249Z,1429292233.249 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:37:13.375Z,1429292233.375 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:37:14.649Z,1429292234.649 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:37:14.649Z,1429292234.649 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:37:24.767Z,1429292244.767 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:37:24.767Z,1429292244.767 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:37:24.767Z,1429292244.767 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:37:25.186Z,1429292245.186 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:37:25.310Z,1429292245.310 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:37:25.657Z,1429292245.657 [NAL9602](INFO): SBD MO Status=2, MOMSN=52531, MT Status=0, MTMSN=0 2015-04-17T17:37:25.657Z,1429292245.657 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:37:26.595Z,1429292246.595 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:37:26.595Z,1429292246.595 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:37:28.796Z,1429292248.796 [CBIT](INFO): Clearing failed count for component DVL_micro 2015-04-17T17:37:28.796Z,1429292248.796 [DVL_micro] No Fault, FailCount= 5 2015-04-17T17:37:29.195Z,1429292249.195 [DVL_micro](INFO): Initializing 2015-04-17T17:37:30.158Z,1429292250.158 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T17:37:36.752Z,1429292256.752 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:37:36.752Z,1429292256.752 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:37:36.752Z,1429292256.752 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:37:37.204Z,1429292257.204 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:37:37.204Z,1429292257.204 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:37:37.328Z,1429292257.328 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:37:39.773Z,1429292259.773 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:37:39.773Z,1429292259.773 [DVL_micro] Communications Fault, FailCount= 1 2015-04-17T17:37:39.773Z,1429292259.773 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:37:39.836Z,1429292259.836 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:37:40.281Z,1429292260.281 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:37:40.715Z,1429292260.715 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:37:41.181Z,1429292261.181 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:37:41.182Z,1429292261.182 [DVL_micro] No Fault, FailCount= 1 2015-04-17T17:37:41.574Z,1429292261.574 [DVL_micro](INFO): Initializing 2015-04-17T17:37:52.249Z,1429292272.249 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:37:52.249Z,1429292272.249 [DVL_micro] Communications Fault, FailCount= 2 2015-04-17T17:37:52.249Z,1429292272.249 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:37:52.306Z,1429292272.306 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:37:52.752Z,1429292272.752 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:37:53.182Z,1429292273.182 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:37:53.646Z,1429292273.646 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:37:53.646Z,1429292273.646 [DVL_micro] No Fault, FailCount= 2 2015-04-17T17:37:54.042Z,1429292274.042 [DVL_micro](INFO): Initializing 2015-04-17T17:38:04.527Z,1429292284.527 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:38:04.528Z,1429292284.528 [DVL_micro] Communications Fault, FailCount= 3 2015-04-17T17:38:04.528Z,1429292284.528 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:38:04.661Z,1429292284.661 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:38:05.095Z,1429292285.095 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:38:05.517Z,1429292285.517 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:38:05.973Z,1429292285.973 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:38:05.973Z,1429292285.973 [DVL_micro] No Fault, FailCount= 3 2015-04-17T17:38:06.381Z,1429292286.381 [DVL_micro](INFO): Initializing 2015-04-17T17:38:09.806Z,1429292289.806 [NAL9602](INFO): SBD MO Status=2, MOMSN=52531, MT Status=2, MTMSN=0 2015-04-17T17:38:09.806Z,1429292289.806 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:38:14.256Z,1429292294.256 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:38:17.668Z,1429292297.668 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:38:17.668Z,1429292297.668 [DVL_micro] Communications Fault, FailCount= 4 2015-04-17T17:38:17.668Z,1429292297.668 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:38:17.744Z,1429292297.744 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:38:18.180Z,1429292298.180 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:38:18.614Z,1429292298.614 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:38:19.073Z,1429292299.073 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:38:19.073Z,1429292299.073 [DVL_micro] No Fault, FailCount= 4 2015-04-17T17:38:19.487Z,1429292299.487 [DVL_micro](INFO): Initializing 2015-04-17T17:38:30.207Z,1429292310.207 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:38:30.207Z,1429292310.207 [DVL_micro] Communications Fault, FailCount= 5 2015-04-17T17:38:30.207Z,1429292310.207 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:38:30.259Z,1429292310.259 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:38:30.259Z,1429292310.259 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2015-04-17T17:38:30.723Z,1429292310.723 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:38:31.138Z,1429292311.138 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:38:39.852Z,1429292319.852 [NAL9602](INFO): SBD MO Status=1, MOMSN=52531, MT Status=0, MTMSN=0 2015-04-17T17:38:39.897Z,1429292319.897 [NAL9602](INFO): Sent 132 bytes from file Logs/20150417T171024/Courier0008.lzma 2015-04-17T17:38:39.898Z,1429292319.898 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:38:39.899Z,1429292319.899 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Courier0008.lzma.parts/0000.sbd 2015-04-17T17:38:39.900Z,1429292319.900 [NAL9602](INFO): Completed sending Logs/20150417T171024/Courier0008.lzma 2015-04-17T17:39:19.762Z,1429292359.762 [NAL9602](INFO): SBD MO Status=2, MOMSN=52532, MT Status=2, MTMSN=0 2015-04-17T17:39:19.762Z,1429292359.762 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:39:24.104Z,1429292364.104 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T17:39:28.119Z,1429292368.119 [BPC1](ERROR): Failed to receive battery data 2015-04-17T17:39:28.119Z,1429292368.119 [BPC1] Communications Fault, FailCount= 1 2015-04-17T17:39:28.119Z,1429292368.119 [BPC1](ERROR): Communications Fault 2015-04-17T17:39:28.176Z,1429292368.176 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T17:39:29.500Z,1429292369.500 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T17:39:29.500Z,1429292369.500 [BPC1] No Fault, FailCount= 1 2015-04-17T17:39:38.315Z,1429292378.315 [NAL9602](INFO): SBD MO Status=1, MOMSN=52532, MT Status=0, MTMSN=0 2015-04-17T17:39:38.364Z,1429292378.364 [NAL9602](INFO): Sent 322 bytes from file Logs/20150417T171024/Express0009.lzma 2015-04-17T17:39:38.364Z,1429292378.364 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:39:38.366Z,1429292378.366 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0009.lzma.parts/0000.sbd 2015-04-17T17:39:38.366Z,1429292378.366 [NAL9602](INFO): Completed sending Logs/20150417T171024/Express0009.lzma 2015-04-17T17:39:45.506Z,1429292385.506 [BPC1](DEBUG): Received data from all battery sticks 2015-04-17T17:39:48.457Z,1429292388.457 [NAL9602](INFO): SBD MO Status=0, MOMSN=52533, MT Status=0, MTMSN=0 2015-04-17T17:39:48.548Z,1429292388.548 [Default:CheckIn:Read_Iridium] Stopped 2015-04-17T17:39:48.548Z,1429292388.548 [Default:CheckIn](INFO): Completed Default:CheckIn 2015-04-17T17:39:48.548Z,1429292388.548 [Default:CheckIn] Stopped 2015-04-17T17:39:48.549Z,1429292388.549 [Default:CheckIn](INFO): Aggregate::uninitialize Default:CheckIn 2015-04-17T17:39:48.549Z,1429292388.549 [Default:CheckIn:A.SetSpeed] Stopped 2015-04-17T17:39:48.549Z,1429292388.549 [Default:CheckIn:A.SetSpeed](DEBUG): Uninitialize. 2015-04-17T17:39:58.897Z,1429292398.897 [NAL9602](INFO): Powering down 2015-04-17T17:39:59.004Z,1429292399.004 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:40:08.967Z,1429292408.967 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:40:08.967Z,1429292408.967 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:40:28.565Z,1429292428.565 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:40:28.565Z,1429292428.565 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:40:28.565Z,1429292428.565 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:40:28.981Z,1429292428.981 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:40:33.682Z,1429292433.682 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:40:43.935Z,1429292443.935 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:40:43.935Z,1429292443.935 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:40:58.567Z,1429292458.567 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:40:58.567Z,1429292458.567 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:40:58.567Z,1429292458.567 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:40:58.991Z,1429292458.991 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:41:03.684Z,1429292463.684 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:41:08.923Z,1429292468.923 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T17:41:08.923Z,1429292468.923 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:41:08.923Z,1429292468.923 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T17:41:08.924Z,1429292468.924 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T17:41:08.924Z,1429292468.924 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T17:41:13.927Z,1429292473.927 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 102.885200 min 2015-04-17T17:41:13.927Z,1429292473.927 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T17:41:13.927Z,1429292473.927 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:41:13.927Z,1429292473.927 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T17:41:13.928Z,1429292473.928 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:41:13.937Z,1429292473.937 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:41:13.937Z,1429292473.937 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:41:33.566Z,1429292493.566 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:41:33.566Z,1429292493.566 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:41:33.566Z,1429292493.566 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:41:33.983Z,1429292493.983 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:41:33.984Z,1429292493.984 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:41:38.682Z,1429292498.682 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:44:03.943Z,1429292643.943 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:44:03.943Z,1429292643.943 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:44:23.565Z,1429292663.565 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:44:23.565Z,1429292663.565 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:44:23.565Z,1429292663.565 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:44:24.001Z,1429292664.001 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:44:28.682Z,1429292668.682 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:44:39.012Z,1429292679.012 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:44:39.012Z,1429292679.012 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:44:48.960Z,1429292688.960 [Default:CheckIn] Running Loop=1 2015-04-17T17:44:48.960Z,1429292688.960 [Default:CheckIn](INFO): Aggregate::initialize Default:CheckIn 2015-04-17T17:44:48.960Z,1429292688.960 [Default:CheckIn:A.SetSpeed] Running Loop=1 2015-04-17T17:44:48.960Z,1429292688.960 [Default:CheckIn:A.SetSpeed](DEBUG): Initialize. 2015-04-17T17:44:48.960Z,1429292688.960 [Default:CheckIn:Read_GPS] Running Loop=1 2015-04-17T17:44:49.363Z,1429292689.363 [NAL9602](INFO): Powering up 2015-04-17T17:44:49.405Z,1429292689.405 [Reporter](INFO): NAL9602.sigQuality no_value 2015-04-17T17:44:53.610Z,1429292693.610 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:44:53.610Z,1429292693.610 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:44:53.610Z,1429292693.610 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:44:54.018Z,1429292694.018 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:44:54.139Z,1429292694.139 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:44:55.329Z,1429292695.329 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:44:55.329Z,1429292695.329 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:44:59.559Z,1429292699.559 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:45:00.380Z,1429292700.380 [NAL9602](INFO): NAL9602 initialized 2015-04-17T17:45:05.691Z,1429292705.691 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:45:05.692Z,1429292705.692 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:45:05.692Z,1429292705.692 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:45:06.098Z,1429292706.098 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:45:06.099Z,1429292706.099 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:45:06.244Z,1429292706.244 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:45:11.709Z,1429292711.709 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T17:45:24.059Z,1429292724.059 [NAL9602](INFO): SBD MO Status=0, MOMSN=52534, MT Status=0, MTMSN=0 2015-04-17T17:45:24.059Z,1429292724.059 [NAL9602](INFO): No messages in MT queue 2015-04-17T17:45:25.334Z,1429292725.334 [NAL9602](INFO): GPS fix at 20150417T174312: (36.802630, -121.787004) 2015-04-17T17:45:25.351Z,1429292725.351 [Default:CheckIn:Read_GPS] Stopped 2015-04-17T17:45:25.351Z,1429292725.351 [Default:CheckIn:Read_Iridium] Running Loop=1 2015-04-17T17:45:28.604Z,1429292728.604 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T17:45:43.370Z,1429292743.370 [CBIT](DEBUG): EFC running - data check-sum false 2015-04-17T17:45:43.758Z,1429292743.758 [NAL9602](INFO): SBD MO Status=1, MOMSN=52535, MT Status=0, MTMSN=0 2015-04-17T17:45:43.803Z,1429292743.803 [NAL9602](INFO): Sent 131 bytes from file Logs/20150417T171024/Courier0012.lzma 2015-04-17T17:45:43.803Z,1429292743.803 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:45:43.807Z,1429292743.807 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Courier0012.lzma.parts/0000.sbd 2015-04-17T17:45:43.808Z,1429292743.808 [NAL9602](INFO): Completed sending Logs/20150417T171024/Courier0012.lzma 2015-04-17T17:45:56.337Z,1429292756.337 [NAL9602](INFO): SBD MO Status=1, MOMSN=52536, MT Status=0, MTMSN=0 2015-04-17T17:45:56.394Z,1429292756.394 [NAL9602](INFO): Sent 281 bytes from file Logs/20150417T171024/Express0013.lzma 2015-04-17T17:45:56.394Z,1429292756.394 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:45:56.396Z,1429292756.396 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0013.lzma.parts/0000.sbd 2015-04-17T17:45:56.396Z,1429292756.396 [NAL9602](INFO): Completed sending Logs/20150417T171024/Express0013.lzma 2015-04-17T17:46:09.091Z,1429292769.091 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T17:46:09.091Z,1429292769.091 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:46:09.092Z,1429292769.092 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T17:46:09.092Z,1429292769.092 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T17:46:09.092Z,1429292769.092 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T17:46:09.516Z,1429292769.516 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 107.887382 min 2015-04-17T17:46:09.516Z,1429292769.516 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T17:46:09.516Z,1429292769.516 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:46:09.516Z,1429292769.516 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T17:46:09.517Z,1429292769.517 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:46:14.134Z,1429292774.134 [NAL9602](INFO): SBD MO Status=0, MOMSN=52537, MT Status=0, MTMSN=0 2015-04-17T17:46:14.215Z,1429292774.215 [Default:CheckIn:Read_Iridium] Stopped 2015-04-17T17:46:14.216Z,1429292774.216 [Default:CheckIn](INFO): Completed Default:CheckIn 2015-04-17T17:46:14.216Z,1429292774.216 [Default:CheckIn] Stopped 2015-04-17T17:46:14.216Z,1429292774.216 [Default:CheckIn](INFO): Aggregate::uninitialize Default:CheckIn 2015-04-17T17:46:14.216Z,1429292774.216 [Default:CheckIn:A.SetSpeed] Stopped 2015-04-17T17:46:14.216Z,1429292774.216 [Default:CheckIn:A.SetSpeed](DEBUG): Uninitialize. 2015-04-17T17:46:24.563Z,1429292784.563 [NAL9602](INFO): Powering down 2015-04-17T17:46:24.593Z,1429292784.593 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:47:29.571Z,1429292849.571 [BPC1](DEBUG): Received data from all battery sticks 2015-04-17T17:47:39.658Z,1429292859.658 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:47:39.658Z,1429292859.658 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:47:59.235Z,1429292879.235 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:47:59.235Z,1429292879.235 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:47:59.236Z,1429292879.236 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:47:59.651Z,1429292879.651 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:48:04.352Z,1429292884.352 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:48:14.605Z,1429292894.605 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:48:14.605Z,1429292894.605 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:48:34.234Z,1429292914.234 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:48:34.234Z,1429292914.234 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:48:34.234Z,1429292914.234 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:48:34.713Z,1429292914.713 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:48:34.713Z,1429292914.713 [CBIT](INFO): Clearing failed count for component DVL_micro 2015-04-17T17:48:34.713Z,1429292914.713 [DVL_micro] No Fault, FailCount= 5 2015-04-17T17:48:39.355Z,1429292919.355 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:48:39.693Z,1429292919.693 [DVL_micro](INFO): Initializing 2015-04-17T17:48:49.602Z,1429292929.602 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:48:49.602Z,1429292929.602 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:48:59.580Z,1429292939.580 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:48:59.580Z,1429292939.580 [DVL_micro] Communications Fault, FailCount= 1 2015-04-17T17:48:59.580Z,1429292939.580 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:48:59.693Z,1429292939.693 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:49:04.626Z,1429292944.626 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:49:09.233Z,1429292949.233 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:49:09.233Z,1429292949.233 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:49:09.233Z,1429292949.233 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:49:09.563Z,1429292949.563 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:49:09.614Z,1429292949.614 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:49:09.614Z,1429292949.614 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:49:14.349Z,1429292954.349 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:49:14.716Z,1429292954.716 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:49:14.716Z,1429292954.716 [DVL_micro] No Fault, FailCount= 1 2015-04-17T17:49:19.572Z,1429292959.572 [DVL_micro](INFO): Initializing 2015-04-17T17:49:39.565Z,1429292979.565 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:49:39.565Z,1429292979.565 [DVL_micro] Communications Fault, FailCount= 2 2015-04-17T17:49:39.565Z,1429292979.565 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:49:39.627Z,1429292979.627 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:49:44.640Z,1429292984.640 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:49:49.565Z,1429292989.565 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:49:54.624Z,1429292994.624 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:49:54.624Z,1429292994.624 [DVL_micro] No Fault, FailCount= 2 2015-04-17T17:49:59.581Z,1429292999.581 [DVL_micro](INFO): Initializing 2015-04-17T17:50:09.610Z,1429293009.610 [BPC1](ERROR): Failed to receive battery data 2015-04-17T17:50:09.611Z,1429293009.611 [BPC1] Communications Fault, FailCount= 1 2015-04-17T17:50:09.611Z,1429293009.611 [BPC1](ERROR): Communications Fault 2015-04-17T17:50:09.667Z,1429293009.667 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T17:50:19.575Z,1429293019.575 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:50:19.575Z,1429293019.575 [DVL_micro] Communications Fault, FailCount= 3 2015-04-17T17:50:19.575Z,1429293019.575 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:50:19.627Z,1429293019.627 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:50:24.642Z,1429293024.642 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:50:24.668Z,1429293024.668 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T17:50:24.668Z,1429293024.668 [BPC1] No Fault, FailCount= 1 2015-04-17T17:50:29.565Z,1429293029.565 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:50:34.675Z,1429293034.675 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:50:34.675Z,1429293034.675 [DVL_micro] No Fault, FailCount= 3 2015-04-17T17:50:39.584Z,1429293039.584 [DVL_micro](INFO): Initializing 2015-04-17T17:50:54.574Z,1429293054.574 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:50:54.574Z,1429293054.574 [DVL_micro] Communications Fault, FailCount= 4 2015-04-17T17:50:54.574Z,1429293054.574 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:50:54.634Z,1429293054.634 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:50:59.636Z,1429293059.636 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:51:04.569Z,1429293064.569 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:51:09.618Z,1429293069.618 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T17:51:09.618Z,1429293069.618 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:51:09.618Z,1429293069.618 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T17:51:09.618Z,1429293069.618 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T17:51:09.618Z,1429293069.618 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T17:51:09.629Z,1429293069.629 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T17:51:09.629Z,1429293069.629 [DVL_micro] No Fault, FailCount= 4 2015-04-17T17:51:14.571Z,1429293074.571 [DVL_micro](INFO): Initializing 2015-04-17T17:51:14.626Z,1429293074.626 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 112.896322 min 2015-04-17T17:51:14.626Z,1429293074.626 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T17:51:14.626Z,1429293074.626 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:51:14.626Z,1429293074.626 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T17:51:14.626Z,1429293074.626 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:51:14.626Z,1429293074.626 [Default:CheckIn] Running Loop=1 2015-04-17T17:51:14.627Z,1429293074.627 [Default:CheckIn](INFO): Aggregate::initialize Default:CheckIn 2015-04-17T17:51:14.627Z,1429293074.627 [Default:CheckIn:A.SetSpeed] Running Loop=1 2015-04-17T17:51:14.627Z,1429293074.627 [Default:CheckIn:A.SetSpeed](DEBUG): Initialize. 2015-04-17T17:51:14.627Z,1429293074.627 [Default:CheckIn:Read_GPS] Running Loop=1 2015-04-17T17:51:15.027Z,1429293075.027 [NAL9602](INFO): Powering up 2015-04-17T17:51:15.082Z,1429293075.082 [Reporter](INFO): NAL9602.sigQuality no_value 2015-04-17T17:51:25.117Z,1429293085.117 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T17:51:25.117Z,1429293085.117 [DVL_micro] Communications Fault, FailCount= 5 2015-04-17T17:51:25.117Z,1429293085.117 [DVL_micro](ERROR): Communications Fault 2015-04-17T17:51:25.206Z,1429293085.206 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T17:51:25.206Z,1429293085.206 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2015-04-17T17:51:25.216Z,1429293085.216 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:51:25.644Z,1429293085.644 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T17:51:26.086Z,1429293086.086 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T17:51:26.087Z,1429293086.087 [NAL9602](INFO): NAL9602 initialized 2015-04-17T17:51:36.721Z,1429293096.721 [Reporter](INFO): NAL9602.sigQuality 5 count 2015-04-17T17:51:39.228Z,1429293099.228 [NAL9602](INFO): SBD MO Status=0, MOMSN=52538, MT Status=0, MTMSN=0 2015-04-17T17:51:39.228Z,1429293099.228 [NAL9602](INFO): No messages in MT queue 2015-04-17T17:51:39.283Z,1429293099.283 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:51:39.283Z,1429293099.283 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:51:46.720Z,1429293106.720 [NAL9602](INFO): GPS fix at 20150417T174934: (36.802593, -121.787061) 2015-04-17T17:51:46.737Z,1429293106.737 [Default:CheckIn:Read_GPS] Stopped 2015-04-17T17:51:46.737Z,1429293106.737 [Default:CheckIn:Read_Iridium] Running Loop=1 2015-04-17T17:51:49.566Z,1429293109.566 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:51:49.566Z,1429293109.566 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:51:49.566Z,1429293109.566 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:51:50.015Z,1429293110.015 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:51:50.135Z,1429293110.135 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:51:51.416Z,1429293111.416 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:51:51.416Z,1429293111.416 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:51:53.925Z,1429293113.925 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T17:52:01.645Z,1429293121.645 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:52:01.645Z,1429293121.645 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:52:01.646Z,1429293121.646 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:52:02.086Z,1429293122.086 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:52:02.205Z,1429293122.205 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:52:03.435Z,1429293123.435 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:52:03.435Z,1429293123.435 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:52:06.787Z,1429293126.787 [NAL9602](INFO): SBD MO Status=1, MOMSN=52539, MT Status=0, MTMSN=0 2015-04-17T17:52:06.844Z,1429293126.844 [NAL9602](INFO): Sent 131 bytes from file Logs/20150417T171024/Courier0016.lzma 2015-04-17T17:52:06.845Z,1429293126.845 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:52:06.846Z,1429293126.846 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Courier0016.lzma.parts/0000.sbd 2015-04-17T17:52:06.847Z,1429293126.847 [NAL9602](INFO): Completed sending Logs/20150417T171024/Courier0016.lzma 2015-04-17T17:52:13.508Z,1429293133.508 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:52:13.508Z,1429293133.508 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:52:13.508Z,1429293133.508 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:52:13.943Z,1429293133.943 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:52:13.944Z,1429293133.944 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:52:14.068Z,1429293134.068 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:52:18.626Z,1429293138.626 [NAL9602](INFO): SBD MO Status=1, MOMSN=52540, MT Status=0, MTMSN=0 2015-04-17T17:52:18.675Z,1429293138.675 [NAL9602](INFO): Sent 243 bytes from file Logs/20150417T171024/Express0017.lzma 2015-04-17T17:52:18.675Z,1429293138.675 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:52:18.677Z,1429293138.677 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0017.lzma.parts/0000.sbd 2015-04-17T17:52:18.677Z,1429293138.677 [NAL9602](INFO): Completed sending Logs/20150417T171024/Express0017.lzma 2015-04-17T17:52:27.063Z,1429293147.063 [NAL9602](INFO): SBD MO Status=0, MOMSN=52541, MT Status=0, MTMSN=0 2015-04-17T17:52:27.149Z,1429293147.149 [Default:CheckIn:Read_Iridium] Stopped 2015-04-17T17:52:27.149Z,1429293147.149 [Default:CheckIn](INFO): Completed Default:CheckIn 2015-04-17T17:52:27.150Z,1429293147.150 [Default:CheckIn] Stopped 2015-04-17T17:52:27.150Z,1429293147.150 [Default:CheckIn](INFO): Aggregate::uninitialize Default:CheckIn 2015-04-17T17:52:27.150Z,1429293147.150 [Default:CheckIn:A.SetSpeed] Stopped 2015-04-17T17:52:27.150Z,1429293147.150 [Default:CheckIn:A.SetSpeed](DEBUG): Uninitialize. 2015-04-17T17:52:37.501Z,1429293157.501 [NAL9602](INFO): Powering down 2015-04-17T17:52:37.596Z,1429293157.596 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:54:47.536Z,1429293287.536 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:54:47.537Z,1429293287.537 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:55:07.167Z,1429293307.167 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:55:07.167Z,1429293307.167 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:55:07.167Z,1429293307.167 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:55:07.596Z,1429293307.596 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:55:12.284Z,1429293312.284 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:55:22.576Z,1429293322.576 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:55:22.576Z,1429293322.576 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:55:27.511Z,1429293327.511 [BPC1](DEBUG): Received data from all battery sticks 2015-04-17T17:55:42.165Z,1429293342.165 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:55:42.165Z,1429293342.165 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:55:42.165Z,1429293342.165 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:55:42.537Z,1429293342.537 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:55:47.282Z,1429293347.282 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:55:47.693Z,1429293347.693 [CBIT](DEBUG): EFC running - data check-sum false 2015-04-17T17:55:57.581Z,1429293357.581 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:55:57.581Z,1429293357.581 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:56:12.526Z,1429293372.526 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T17:56:12.526Z,1429293372.526 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:56:12.527Z,1429293372.527 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T17:56:12.527Z,1429293372.527 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T17:56:12.527Z,1429293372.527 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T17:56:17.167Z,1429293377.167 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:56:17.167Z,1429293377.167 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:56:17.167Z,1429293377.167 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:56:17.596Z,1429293377.596 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 117.945218 min 2015-04-17T17:56:17.596Z,1429293377.596 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T17:56:17.596Z,1429293377.596 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:56:17.596Z,1429293377.596 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T17:56:17.596Z,1429293377.596 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T17:56:17.618Z,1429293377.618 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:56:17.619Z,1429293377.619 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:56:22.284Z,1429293382.284 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:57:27.532Z,1429293447.532 [Default:CheckIn] Running Loop=1 2015-04-17T17:57:27.532Z,1429293447.532 [Default:CheckIn](INFO): Aggregate::initialize Default:CheckIn 2015-04-17T17:57:27.532Z,1429293447.532 [Default:CheckIn:A.SetSpeed] Running Loop=1 2015-04-17T17:57:27.532Z,1429293447.532 [Default:CheckIn:A.SetSpeed](DEBUG): Initialize. 2015-04-17T17:57:27.532Z,1429293447.532 [Default:CheckIn:Read_GPS] Running Loop=1 2015-04-17T17:57:27.925Z,1429293447.925 [NAL9602](INFO): Powering up 2015-04-17T17:57:27.953Z,1429293447.953 [Reporter](INFO): NAL9602.sigQuality no_value 2015-04-17T17:57:38.371Z,1429293458.371 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:57:39.198Z,1429293459.198 [NAL9602](INFO): NAL9602 initialized 2015-04-17T17:58:00.642Z,1429293480.642 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T17:58:05.025Z,1429293485.025 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T17:58:16.878Z,1429293496.878 [NAL9602](INFO): SBD MO Status=0, MOMSN=52542, MT Status=0, MTMSN=0 2015-04-17T17:58:16.878Z,1429293496.878 [NAL9602](INFO): No messages in MT queue 2015-04-17T17:58:18.218Z,1429293498.218 [NAL9602](INFO): GPS fix at 20150417T175605: (36.802583, -121.787067) 2015-04-17T17:58:18.284Z,1429293498.284 [Default:CheckIn:Read_GPS] Stopped 2015-04-17T17:58:18.284Z,1429293498.284 [Default:CheckIn:Read_Iridium] Running Loop=1 2015-04-17T17:58:21.214Z,1429293501.214 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T17:58:44.857Z,1429293524.857 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T17:58:47.969Z,1429293527.969 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T17:58:47.969Z,1429293527.969 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T17:58:53.918Z,1429293533.918 [NAL9602](INFO): SBD MO Status=1, MOMSN=52543, MT Status=0, MTMSN=0 2015-04-17T17:58:53.977Z,1429293533.977 [NAL9602](INFO): Sent 80 bytes from file Logs/20150417T171024/Courier0020.lzma 2015-04-17T17:58:53.977Z,1429293533.977 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:58:53.979Z,1429293533.979 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Courier0020.lzma.parts/0000.sbd 2015-04-17T17:58:53.979Z,1429293533.979 [NAL9602](INFO): Completed sending Logs/20150417T171024/Courier0020.lzma 2015-04-17T17:58:58.427Z,1429293538.427 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:58:58.427Z,1429293538.427 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T17:58:58.427Z,1429293538.427 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:58:58.818Z,1429293538.818 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:58:58.943Z,1429293538.943 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:59:00.175Z,1429293540.175 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:59:00.175Z,1429293540.175 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T17:59:05.617Z,1429293545.617 [BPC1](ERROR): Failed to receive battery data 2015-04-17T17:59:05.617Z,1429293545.617 [BPC1] Communications Fault, FailCount= 1 2015-04-17T17:59:05.617Z,1429293545.617 [BPC1](ERROR): Communications Fault 2015-04-17T17:59:05.639Z,1429293545.639 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T17:59:06.905Z,1429293546.905 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T17:59:06.905Z,1429293546.905 [BPC1] No Fault, FailCount= 1 2015-04-17T17:59:10.409Z,1429293550.409 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:59:10.409Z,1429293550.409 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T17:59:10.409Z,1429293550.409 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:59:10.809Z,1429293550.809 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:59:10.939Z,1429293550.939 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:59:12.175Z,1429293552.175 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T17:59:12.175Z,1429293552.175 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T17:59:22.446Z,1429293562.446 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T17:59:22.447Z,1429293562.447 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T17:59:22.447Z,1429293562.447 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T17:59:22.848Z,1429293562.848 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T17:59:22.848Z,1429293562.848 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T17:59:22.972Z,1429293562.972 [Aanderaa_O2](INFO): Powering down 2015-04-17T17:59:31.907Z,1429293571.907 [NAL9602](INFO): SBD MO Status=2, MOMSN=52544, MT Status=2, MTMSN=0 2015-04-17T17:59:31.907Z,1429293571.907 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T17:59:36.366Z,1429293576.366 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T17:59:57.870Z,1429293597.870 [NAL9602](INFO): SBD MO Status=1, MOMSN=52544, MT Status=0, MTMSN=0 2015-04-17T17:59:57.919Z,1429293597.919 [NAL9602](INFO): Sent 248 bytes from file Logs/20150417T171024/Express0021.lzma 2015-04-17T17:59:57.919Z,1429293597.919 [NAL9602](INFO): Packets left to send: 0 2015-04-17T17:59:57.921Z,1429293597.921 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0021.lzma.parts/0000.sbd 2015-04-17T17:59:57.921Z,1429293597.921 [NAL9602](INFO): Completed sending Logs/20150417T171024/Express0021.lzma 2015-04-17T18:00:09.124Z,1429293609.124 [NAL9602](INFO): SBD MO Status=0, MOMSN=52545, MT Status=0, MTMSN=0 2015-04-17T18:00:09.241Z,1429293609.241 [Default:CheckIn:Read_Iridium] Stopped 2015-04-17T18:00:09.241Z,1429293609.241 [Default:CheckIn](INFO): Completed Default:CheckIn 2015-04-17T18:00:09.241Z,1429293609.241 [Default:CheckIn] Stopped 2015-04-17T18:00:09.241Z,1429293609.241 [Default:CheckIn](INFO): Aggregate::uninitialize Default:CheckIn 2015-04-17T18:00:09.241Z,1429293609.241 [Default:CheckIn:A.SetSpeed] Stopped 2015-04-17T18:00:09.242Z,1429293609.242 [Default:CheckIn:A.SetSpeed](DEBUG): Uninitialize. 2015-04-17T18:00:19.598Z,1429293619.598 [NAL9602](INFO): Powering down 2015-04-17T18:00:19.655Z,1429293619.655 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:01:14.611Z,1429293674.611 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T18:01:14.611Z,1429293674.611 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:01:14.611Z,1429293674.611 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T18:01:14.611Z,1429293674.611 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T18:01:14.611Z,1429293674.611 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T18:01:19.607Z,1429293679.607 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 122.980089 min 2015-04-17T18:01:19.607Z,1429293679.607 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T18:01:19.607Z,1429293679.607 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:01:19.607Z,1429293679.607 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T18:01:19.608Z,1429293679.608 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:01:29.624Z,1429293689.624 [CBIT](INFO): Clearing failed count for component DVL_micro 2015-04-17T18:01:29.624Z,1429293689.624 [DVL_micro] No Fault, FailCount= 5 2015-04-17T18:01:34.592Z,1429293694.592 [DVL_micro](INFO): Initializing 2015-04-17T18:01:49.593Z,1429293709.593 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:01:49.593Z,1429293709.593 [DVL_micro] Communications Fault, FailCount= 1 2015-04-17T18:01:49.593Z,1429293709.593 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:01:49.675Z,1429293709.675 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:01:54.668Z,1429293714.668 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:01:54.711Z,1429293714.711 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T18:01:54.711Z,1429293714.711 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T18:01:59.593Z,1429293719.593 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:02:04.663Z,1429293724.663 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:02:04.663Z,1429293724.663 [DVL_micro] No Fault, FailCount= 1 2015-04-17T18:02:09.606Z,1429293729.606 [DVL_micro](INFO): Initializing 2015-04-17T18:02:14.257Z,1429293734.257 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:02:14.257Z,1429293734.257 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T18:02:14.257Z,1429293734.257 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:02:14.665Z,1429293734.665 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:02:19.374Z,1429293739.374 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:02:29.596Z,1429293749.596 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:02:29.596Z,1429293749.596 [DVL_micro] Communications Fault, FailCount= 2 2015-04-17T18:02:29.596Z,1429293749.596 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:02:29.677Z,1429293749.677 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:02:29.677Z,1429293749.677 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T18:02:29.678Z,1429293749.678 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:02:34.670Z,1429293754.670 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:02:34.680Z,1429293754.680 [BPC1](DEBUG): Received data from all battery sticks 2015-04-17T18:02:39.599Z,1429293759.599 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:02:44.723Z,1429293764.723 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:02:44.723Z,1429293764.723 [DVL_micro] No Fault, FailCount= 2 2015-04-17T18:02:49.259Z,1429293769.259 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:02:49.259Z,1429293769.259 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T18:02:49.260Z,1429293769.260 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:02:49.606Z,1429293769.606 [DVL_micro](INFO): Initializing 2015-04-17T18:02:49.633Z,1429293769.633 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:02:54.376Z,1429293774.376 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:03:04.667Z,1429293784.667 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:03:04.667Z,1429293784.667 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T18:03:09.589Z,1429293789.589 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:03:09.589Z,1429293789.589 [DVL_micro] Communications Fault, FailCount= 3 2015-04-17T18:03:09.589Z,1429293789.589 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:03:09.672Z,1429293789.672 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:03:14.680Z,1429293794.680 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:03:19.598Z,1429293799.598 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:03:24.257Z,1429293804.257 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:03:24.257Z,1429293804.257 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T18:03:24.258Z,1429293804.258 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:03:24.713Z,1429293804.713 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:03:24.713Z,1429293804.713 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T18:03:24.713Z,1429293804.713 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:03:24.713Z,1429293804.713 [DVL_micro] No Fault, FailCount= 3 2015-04-17T18:03:29.378Z,1429293809.378 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:03:29.715Z,1429293809.715 [DVL_micro](INFO): Initializing 2015-04-17T18:03:49.587Z,1429293829.587 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:03:49.587Z,1429293829.587 [DVL_micro] Communications Fault, FailCount= 4 2015-04-17T18:03:49.587Z,1429293829.587 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:03:49.672Z,1429293829.672 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:03:54.666Z,1429293834.666 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:03:59.599Z,1429293839.599 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:04:04.713Z,1429293844.713 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:04:04.713Z,1429293844.713 [DVL_micro] No Fault, FailCount= 4 2015-04-17T18:04:09.605Z,1429293849.605 [DVL_micro](INFO): Initializing 2015-04-17T18:04:24.598Z,1429293864.598 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:04:24.598Z,1429293864.598 [DVL_micro] Communications Fault, FailCount= 5 2015-04-17T18:04:24.598Z,1429293864.598 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:04:24.683Z,1429293864.683 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:04:24.683Z,1429293864.683 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2015-04-17T18:04:29.668Z,1429293869.668 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:04:34.601Z,1429293874.601 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:05:09.629Z,1429293909.629 [Default:CheckIn] Running Loop=1 2015-04-17T18:05:09.629Z,1429293909.629 [Default:CheckIn](INFO): Aggregate::initialize Default:CheckIn 2015-04-17T18:05:09.629Z,1429293909.629 [Default:CheckIn:A.SetSpeed] Running Loop=1 2015-04-17T18:05:09.629Z,1429293909.629 [Default:CheckIn:A.SetSpeed](DEBUG): Initialize. 2015-04-17T18:05:09.630Z,1429293909.630 [Default:CheckIn:Read_GPS] Running Loop=1 2015-04-17T18:05:10.024Z,1429293910.024 [NAL9602](INFO): Powering up 2015-04-17T18:05:10.078Z,1429293910.078 [Reporter](INFO): NAL9602.sigQuality no_value 2015-04-17T18:05:20.097Z,1429293920.097 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:05:20.922Z,1429293920.922 [NAL9602](INFO): NAL9602 initialized 2015-04-17T18:05:31.280Z,1429293931.280 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T18:05:48.065Z,1429293948.065 [CBIT](DEBUG): EFC running - data check-sum false 2015-04-17T18:05:48.866Z,1429293948.866 [NAL9602](INFO): SBD MO Status=0, MOMSN=52546, MT Status=0, MTMSN=0 2015-04-17T18:05:48.866Z,1429293948.866 [NAL9602](INFO): No messages in MT queue 2015-04-17T18:05:50.186Z,1429293950.186 [NAL9602](INFO): GPS fix at 20150417T180337: (36.802553, -121.786979) 2015-04-17T18:05:50.259Z,1429293950.259 [Default:CheckIn:Read_GPS] Stopped 2015-04-17T18:05:50.259Z,1429293950.259 [Default:CheckIn:Read_Iridium] Running Loop=1 2015-04-17T18:05:53.250Z,1429293953.250 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:05:54.652Z,1429293954.652 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T18:05:54.652Z,1429293954.652 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T18:06:04.892Z,1429293964.892 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:06:04.892Z,1429293964.892 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T18:06:04.893Z,1429293964.893 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:06:05.358Z,1429293965.358 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:06:05.496Z,1429293965.496 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:06:06.850Z,1429293966.850 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:06:06.850Z,1429293966.850 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T18:06:14.772Z,1429293974.772 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T18:06:14.773Z,1429293974.773 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:06:14.773Z,1429293974.773 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T18:06:14.773Z,1429293974.773 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T18:06:14.773Z,1429293974.773 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T18:06:15.302Z,1429293975.302 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 127.981834 min 2015-04-17T18:06:15.302Z,1429293975.302 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T18:06:15.302Z,1429293975.302 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:06:15.302Z,1429293975.302 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T18:06:15.302Z,1429293975.302 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:06:17.034Z,1429293977.034 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:06:17.034Z,1429293977.034 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T18:06:17.034Z,1429293977.034 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:06:17.472Z,1429293977.472 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:06:17.595Z,1429293977.595 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:06:18.836Z,1429293978.836 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:06:18.836Z,1429293978.836 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T18:06:28.972Z,1429293988.972 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:06:28.972Z,1429293988.972 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T18:06:28.972Z,1429293988.972 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:06:29.418Z,1429293989.418 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:06:29.418Z,1429293989.418 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T18:06:29.538Z,1429293989.538 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:06:50.405Z,1429294010.405 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T18:07:31.585Z,1429294051.585 [NAL9602](INFO): SBD MO Status=2, MOMSN=52547, MT Status=2, MTMSN=0 2015-04-17T18:07:31.585Z,1429294051.585 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:07:53.667Z,1429294073.667 [NAL9602](INFO): SBD MO Status=1, MOMSN=52547, MT Status=0, MTMSN=0 2015-04-17T18:07:53.724Z,1429294073.724 [NAL9602](INFO): Sent 132 bytes from file Logs/20150417T171024/Courier0024.lzma 2015-04-17T18:07:53.725Z,1429294073.725 [NAL9602](INFO): Packets left to send: 0 2015-04-17T18:07:53.727Z,1429294073.727 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Courier0024.lzma.parts/0000.sbd 2015-04-17T18:07:53.731Z,1429294073.731 [NAL9602](INFO): Completed sending Logs/20150417T171024/Courier0024.lzma 2015-04-17T18:08:04.897Z,1429294084.897 [BPC1](ERROR): B bank expecting battery number:1 and read number: uart read:X $S,01,270F,02,00,04,5C%51 $C1,01,FF,02,00,03,FF,04,00,05,00,06,00,07,00%72 $B11,0A,FFFC%36 $B12,0A,FFFC%35 $B13,0A,FFFD%33 $B14,0A,FFFD%34 $B15,0A,0000%37 $B16,0A,FFE0%41 $B17,0A,0000%35 $B18,0A,0000%3A $S,01,270F,02,00,04,5C%51 $C1,01,FF,02,00,03,FF,04,00,05,00,06,00,07,00%72 $B11,02,000A,01,02A8,03,0001,08,0B6D,09,3E6D,0A,FFFC,0B,FFFC%4F $B11,0C,0001,0D,0063,0E,0055,0F,167E,10,190C,11,FFFF,12,FFFF%4E $B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3B $B11,1A,0031,1B,458C,1C,00C9%31 $B12,02,000A,01,02A8,03,0001,08,0B65,09,3E68,0A,FFFC,0B,FFFC%41 $B12,0C,0001,0D,0063,0E,0055,0F,1672,10,191E,11,FFFF,12,FFFF%3D $B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%38 $B12,1A,0031,1B,458C,1C,0103%4A $B13,02,000A,01,02A8,03,0001,08,0B5B,09,3E64,0A,0000,0B,0000%38 $B13,0C,0001,0D,005B,0E,0057,0F,16F1,10,196F,11,FFFF,12,FFFF%3A $B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%39 $B13,1A,0031,1B,458F,1C,0152%4A $B14,02,000A,01,02A8,03,0001,08,0B41,09,3E62,0A,FFFD,0B,FFFD%4B $B14,0C,0001,0D,005A,0E,0054,0F,163F,10,18E1,11,FFFF,12,FFFF%3A $B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3E $B14,1A,0031,1B,458C,1C,014A%3A $B15,02,000A,01,02A8,03,0001,08,0B6E,09,3E72,0A,0000,0B,0000%3D $B15,0C,0001,0D,005A,0E,0056,0F,16B1,10,1941,11,FFFF,12,FFFF%4F $B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3F $B15,1A,0031,1B,458C,1C,0114%4B $B16,02,000A,01,02A8,03,0001,08,0B45,09,3DB1,0A,FFDA,0B,FFDD%3E $B16,0C,0001,0D,0056,0E,0052,0F,159D,10,1961,11,2220,12,250D%41 $B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3C $B16,1A,0031,1B,458F,1C,015E%38 $B17,02,000A,01,02A8,03,0001,08,0B67,09,3E12,0A,0000,0B,0000%4B $B17,0C,0001,0D,0063,0E,0053,0F,15FA,10,194B,11,FFFF,12,FFFF%3D $B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3D $B17,1A,0031,1B,458B,1C,008E%31 $B18,02,000A,01,02A8,03,0001,08,0B70,09,3DED,0A,0000,0B,0000%41 $B18,0C,0001,0D,005A,0E,0056,0F,16A9,10,19F6,11,FFFF,12,FFFF%3C $B18,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%32 $B18,1A,0031,1B,458B,1C,00AC%41 2015-04-17T18:08:04.898Z,1429294084.898 [BPC1](ERROR): Failed to parse bank B battery data 2015-04-17T18:08:04.898Z,1429294084.898 [BPC1] Data Fault, FailCount= 1 2015-04-17T18:08:04.898Z,1429294084.898 [BPC1](ERROR): Data Fault 2015-04-17T18:08:04.994Z,1429294084.994 [CBIT](ERROR): Data Fault in component: BPC1 2015-04-17T18:08:06.269Z,1429294086.269 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T18:08:06.269Z,1429294086.269 [BPC1] No Fault, FailCount= 1 2015-04-17T18:08:12.629Z,1429294092.629 [NAL9602](INFO): SBD MO Status=2, MOMSN=52548, MT Status=2, MTMSN=0 2015-04-17T18:08:12.629Z,1429294092.629 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:08:17.346Z,1429294097.346 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:08:20.269Z,1429294100.269 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T18:08:53.244Z,1429294133.244 [BPC1](ERROR): Failed to receive battery data 2015-04-17T18:08:53.244Z,1429294133.244 [BPC1] Communications Fault, FailCount= 1 2015-04-17T18:08:53.244Z,1429294133.244 [BPC1](ERROR): Communications Fault 2015-04-17T18:08:53.265Z,1429294133.265 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T18:08:54.589Z,1429294134.589 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T18:08:54.589Z,1429294134.589 [BPC1] No Fault, FailCount= 1 2015-04-17T18:08:59.285Z,1429294139.285 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T18:08:59.285Z,1429294139.285 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T18:09:02.183Z,1429294142.183 [NAL9602](INFO): SBD MO Status=2, MOMSN=52548, MT Status=2, MTMSN=0 2015-04-17T18:09:02.184Z,1429294142.184 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:09:06.911Z,1429294146.911 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T18:09:10.232Z,1429294150.232 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:09:10.232Z,1429294150.232 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T18:09:10.232Z,1429294150.232 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:09:10.630Z,1429294150.630 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:09:10.756Z,1429294150.756 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:09:12.068Z,1429294152.068 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:09:12.068Z,1429294152.068 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T18:09:18.427Z,1429294158.427 [BPC1](DEBUG): Received data from all battery sticks 2015-04-17T18:09:20.510Z,1429294160.510 [NAL9602](INFO): SBD MO Status=1, MOMSN=52548, MT Status=0, MTMSN=0 2015-04-17T18:09:20.563Z,1429294160.563 [NAL9602](INFO): Sent 257 bytes from file Logs/20150417T171024/Express0025.lzma 2015-04-17T18:09:20.563Z,1429294160.563 [NAL9602](INFO): Packets left to send: 0 2015-04-17T18:09:20.565Z,1429294160.565 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0025.lzma.parts/0000.sbd 2015-04-17T18:09:20.565Z,1429294160.565 [NAL9602](INFO): Completed sending Logs/20150417T171024/Express0025.lzma 2015-04-17T18:09:22.486Z,1429294162.486 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:09:22.486Z,1429294162.486 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T18:09:22.486Z,1429294162.486 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:09:22.937Z,1429294162.937 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:09:23.063Z,1429294163.063 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:09:24.348Z,1429294164.348 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:09:24.348Z,1429294164.348 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T18:09:29.088Z,1429294169.088 [NAL9602](INFO): SBD MO Status=0, MOMSN=52549, MT Status=0, MTMSN=0 2015-04-17T18:09:29.164Z,1429294169.164 [Default:CheckIn:Read_Iridium] Stopped 2015-04-17T18:09:29.164Z,1429294169.164 [Default:CheckIn](INFO): Completed Default:CheckIn 2015-04-17T18:09:29.164Z,1429294169.164 [Default:CheckIn] Stopped 2015-04-17T18:09:29.164Z,1429294169.164 [Default:CheckIn](INFO): Aggregate::uninitialize Default:CheckIn 2015-04-17T18:09:29.165Z,1429294169.165 [Default:CheckIn:A.SetSpeed] Stopped 2015-04-17T18:09:29.165Z,1429294169.165 [Default:CheckIn:A.SetSpeed](DEBUG): Uninitialize. 2015-04-17T18:09:39.184Z,1429294179.184 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:09:39.184Z,1429294179.184 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T18:09:39.184Z,1429294179.184 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:09:39.526Z,1429294179.526 [NAL9602](INFO): Powering down 2015-04-17T18:09:39.640Z,1429294179.640 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:09:39.641Z,1429294179.641 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T18:09:39.643Z,1429294179.643 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:09:44.300Z,1429294184.300 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:10:19.558Z,1429294219.558 [BPC1](ERROR): Failed to receive battery data 2015-04-17T18:10:19.558Z,1429294219.558 [BPC1] Communications Fault, FailCount= 1 2015-04-17T18:10:19.558Z,1429294219.558 [BPC1](ERROR): Communications Fault 2015-04-17T18:10:19.581Z,1429294219.581 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T18:10:34.567Z,1429294234.567 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T18:10:34.567Z,1429294234.567 [BPC1] No Fault, FailCount= 1 2015-04-17T18:11:19.561Z,1429294279.561 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T18:11:19.561Z,1429294279.561 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:11:19.561Z,1429294279.561 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T18:11:19.561Z,1429294279.561 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T18:11:19.561Z,1429294279.561 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T18:11:24.575Z,1429294284.575 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 133.062120 min 2015-04-17T18:11:24.576Z,1429294284.576 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T18:11:24.576Z,1429294284.576 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:11:24.576Z,1429294284.576 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T18:11:24.576Z,1429294284.576 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:12:09.535Z,1429294329.535 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T18:12:09.535Z,1429294329.535 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T18:12:24.183Z,1429294344.183 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:12:24.183Z,1429294344.183 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T18:12:24.183Z,1429294344.183 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:12:24.595Z,1429294344.595 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:12:29.300Z,1429294349.300 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:12:39.585Z,1429294359.585 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:12:39.585Z,1429294359.585 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T18:12:59.181Z,1429294379.181 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:12:59.181Z,1429294379.181 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T18:12:59.181Z,1429294379.181 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:12:59.619Z,1429294379.619 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:13:04.299Z,1429294384.299 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:13:14.544Z,1429294394.544 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:13:14.544Z,1429294394.544 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T18:13:34.179Z,1429294414.179 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:13:34.179Z,1429294414.179 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T18:13:34.179Z,1429294414.179 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:13:34.599Z,1429294414.599 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:13:34.599Z,1429294414.599 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T18:13:39.300Z,1429294419.300 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:14:29.560Z,1429294469.560 [Default:CheckIn] Running Loop=1 2015-04-17T18:14:29.561Z,1429294469.561 [Default:CheckIn](INFO): Aggregate::initialize Default:CheckIn 2015-04-17T18:14:29.561Z,1429294469.561 [Default:CheckIn:A.SetSpeed] Running Loop=1 2015-04-17T18:14:29.561Z,1429294469.561 [Default:CheckIn:A.SetSpeed](DEBUG): Initialize. 2015-04-17T18:14:29.561Z,1429294469.561 [Default:CheckIn:Read_GPS] Running Loop=1 2015-04-17T18:14:29.586Z,1429294469.586 [CBIT](INFO): Clearing failed count for component DVL_micro 2015-04-17T18:14:29.586Z,1429294469.586 [DVL_micro] No Fault, FailCount= 5 2015-04-17T18:14:29.981Z,1429294469.981 [DVL_micro](INFO): Initializing 2015-04-17T18:14:29.983Z,1429294469.983 [NAL9602](INFO): Powering up 2015-04-17T18:14:30.012Z,1429294470.012 [Reporter](INFO): NAL9602.sigQuality no_value 2015-04-17T18:14:40.327Z,1429294480.327 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:14:40.704Z,1429294480.704 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:14:40.705Z,1429294480.705 [DVL_micro] Communications Fault, FailCount= 1 2015-04-17T18:14:40.705Z,1429294480.705 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:14:40.775Z,1429294480.775 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:14:41.220Z,1429294481.220 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:14:41.222Z,1429294481.222 [NAL9602](INFO): NAL9602 initialized 2015-04-17T18:14:41.666Z,1429294481.666 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:14:42.157Z,1429294482.157 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:14:42.158Z,1429294482.158 [DVL_micro] No Fault, FailCount= 1 2015-04-17T18:14:42.549Z,1429294482.549 [DVL_micro](INFO): Initializing 2015-04-17T18:14:52.999Z,1429294492.999 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T18:14:53.369Z,1429294493.369 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:14:53.369Z,1429294493.369 [DVL_micro] Communications Fault, FailCount= 2 2015-04-17T18:14:53.370Z,1429294493.370 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:14:53.398Z,1429294493.398 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:14:53.864Z,1429294493.864 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:14:54.298Z,1429294494.298 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:14:54.754Z,1429294494.754 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:14:54.754Z,1429294494.754 [DVL_micro] No Fault, FailCount= 2 2015-04-17T18:14:55.150Z,1429294495.150 [DVL_micro](INFO): Initializing 2015-04-17T18:15:05.874Z,1429294505.874 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:15:05.874Z,1429294505.874 [DVL_micro] Communications Fault, FailCount= 3 2015-04-17T18:15:05.874Z,1429294505.874 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:15:05.923Z,1429294505.923 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:15:06.375Z,1429294506.375 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:15:06.806Z,1429294506.806 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:15:07.280Z,1429294507.280 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:15:07.280Z,1429294507.280 [DVL_micro] No Fault, FailCount= 3 2015-04-17T18:15:07.660Z,1429294507.660 [DVL_micro](INFO): Initializing 2015-04-17T18:15:13.226Z,1429294513.226 [NAL9602](INFO): SBD MO Status=2, MOMSN=52550, MT Status=2, MTMSN=0 2015-04-17T18:15:13.226Z,1429294513.226 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:15:18.015Z,1429294518.015 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:15:18.373Z,1429294518.373 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:15:18.373Z,1429294518.373 [DVL_micro] Communications Fault, FailCount= 4 2015-04-17T18:15:18.373Z,1429294518.373 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:15:18.454Z,1429294518.454 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:15:18.895Z,1429294518.895 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:15:19.325Z,1429294519.325 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:15:19.816Z,1429294519.816 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:15:19.816Z,1429294519.816 [DVL_micro] No Fault, FailCount= 4 2015-04-17T18:15:20.231Z,1429294520.231 [DVL_micro](INFO): Initializing 2015-04-17T18:15:30.987Z,1429294530.987 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:15:30.987Z,1429294530.987 [DVL_micro] Communications Fault, FailCount= 5 2015-04-17T18:15:30.987Z,1429294530.987 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:15:31.034Z,1429294531.034 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:15:31.035Z,1429294531.035 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2015-04-17T18:15:31.490Z,1429294531.490 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:15:31.908Z,1429294531.908 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:15:48.344Z,1429294548.344 [CBIT](DEBUG): EFC running - data check-sum false 2015-04-17T18:16:00.889Z,1429294560.889 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T18:16:04.234Z,1429294564.234 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T18:16:04.235Z,1429294564.235 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T18:16:13.215Z,1429294573.215 [NAL9602](INFO): SBD MO Status=2, MOMSN=52550, MT Status=2, MTMSN=0 2015-04-17T18:16:13.215Z,1429294573.215 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:16:14.554Z,1429294574.554 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:16:14.554Z,1429294574.554 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T18:16:14.554Z,1429294574.554 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:16:14.963Z,1429294574.963 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:16:15.086Z,1429294575.086 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:16:16.315Z,1429294576.315 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:16:16.315Z,1429294576.315 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T18:16:17.567Z,1429294577.567 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:16:19.674Z,1429294579.674 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T18:16:19.674Z,1429294579.674 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:16:19.674Z,1429294579.674 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T18:16:19.675Z,1429294579.675 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T18:16:19.675Z,1429294579.675 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T18:16:20.120Z,1429294580.120 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 138.063648 min 2015-04-17T18:16:20.120Z,1429294580.120 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T18:16:20.120Z,1429294580.120 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:16:20.121Z,1429294580.121 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T18:16:20.121Z,1429294580.121 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:16:25.411Z,1429294585.411 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T18:16:26.712Z,1429294586.712 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:16:26.712Z,1429294586.712 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T18:16:26.712Z,1429294586.712 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:16:27.157Z,1429294587.157 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:16:27.281Z,1429294587.281 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:16:28.473Z,1429294588.473 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:16:28.473Z,1429294588.473 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T18:16:38.907Z,1429294598.907 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:16:38.907Z,1429294598.907 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T18:16:38.908Z,1429294598.908 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:16:39.310Z,1429294599.310 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:16:39.311Z,1429294599.311 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T18:16:39.435Z,1429294599.435 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:16:42.363Z,1429294602.363 [BPC1](ERROR): Failed to receive battery data 2015-04-17T18:16:42.363Z,1429294602.363 [BPC1] Communications Fault, FailCount= 1 2015-04-17T18:16:42.363Z,1429294602.363 [BPC1](ERROR): Communications Fault 2015-04-17T18:16:42.410Z,1429294602.410 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T18:16:43.642Z,1429294603.642 [NAL9602](INFO): SBD MO Status=2, MOMSN=52550, MT Status=2, MTMSN=0 2015-04-17T18:16:43.642Z,1429294603.642 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:16:43.669Z,1429294603.669 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T18:16:43.669Z,1429294603.669 [BPC1] No Fault, FailCount= 1 2015-04-17T18:16:47.987Z,1429294607.987 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T18:16:58.180Z,1429294618.180 [BPC1](ERROR): B bank expecting battery number:1 and read number: uart read:X $S,01,270F,02,00,04,5C%51 $C1,01,FF,02,00,03,FF,04,00,05,00,06,00,07,00%72 $B11,0A,FFFB%37 $B12,0A,FFFC%35 $B13,0A,FFFD%33 $B14,0A,FFFD%34 $B15,0A,0000%37 $B16,0A,FFDC%33 $B17,0A,0000%35 $B18,0A,0000%3A $S,01,270F,02,00,04,5C%51 $C1,01,FF,02,00,03,FF,04,00,05,00,06,00,07,00%72 $B11,02,000A,01,02A8,03,0001,08,0B72,09,3E6C,0A,FFFC,0B,FFFC%3F $B11,0C,0001,0D,0063,0E,0055,0F,167E,10,190C,11,FFFF,12,FFFF%4E $B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3B $B11,1A,0031,1B,458C,1C,00C9%31 $B12,02,000A,01,02A8,03,0001,08,0B6A,09,3E69,0A,FFFC,0B,FFFC%34 $B12,0C,0001,0D,0063,0E,0055,0F,1672,10,191E,11,FFFF,12,FFFF%3D $B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%38 $B12,1A,0031,1B,458C,1C,0103%4A $B13,02,000A,01,02A8,03,0001,08,0B5F,09,3E66,0A,FFFD,0B,FFFD%3E $B13,0C,0001,0D,005B,0E,0057,0F,16F1,10,196F,11,FFFF,12,FFFF%3A $B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%39 $B13,1A,0031,1B,458F,1C,0152%4A $B14,02,000A,01,02A8,03,0001,08,0B44,09,3E64,0A,FFFC,0B,FFFD%4F $B14,0C,0001,0D,005A,0E,0054,0F,163F,10,18E1,11,FFFF,12,FFFF%3A $B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3E $B14,1A,0031,1B,458C,1C,014A%3A $B15,02,000A,01,02A8,03,0001,08,0B72,09,3E73,0A,0000,0B,0000%4A $B15,0C,0001,0D,005A,0E,0056,0F,16B1,10,1941,11,FFFF,12,FFFF%4F $B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3F $B15,1A,0031,1B,458C,1C,0114%4B $B16,02,000A,01,02A8,03,0001,08,0B48,09,3DAF,0A,FFE2,0B,FFE0%40 $B16,0C,0001,0D,0056,0E,0052,0F,159A,10,1961,11,2B34,12,2881%41 $B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3C $B16,1A,0031,1B,458F,1C,015E%38 $B17,02,000A,01,02A8,03,0001,08,0B6B,09,3E13,0A,0000,0B,0000%3F $B17,0C,0001,0D,0063,0E,0053,0F,15FA,10,194B,11,FFFF,12,FFFF%3D $B17,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3D $B17,1A,0031,1B,458B,1C,008E%31 $B18,02,000A,01,02A8,03,0001,08,0B73,09,3DED,0A,0000,0B,0001%43 $B18,0C,0001,0D,005A,0E,0056,0F,16A9,10,19F6,11,FFFF,12,FFFF%3C $B18,13,C60C,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%34 $B18,1A,0031,1B,458B,1C,00AC%41 2015-04-17T18:16:58.181Z,1429294618.181 [BPC1](ERROR): Failed to parse bank B battery data 2015-04-17T18:16:58.181Z,1429294618.181 [BPC1] Data Fault, FailCount= 2 2015-04-17T18:16:58.181Z,1429294618.181 [BPC1](ERROR): Data Fault 2015-04-17T18:16:58.204Z,1429294618.204 [CBIT](ERROR): Data Fault in component: BPC1 2015-04-17T18:16:59.522Z,1429294619.522 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T18:16:59.523Z,1429294619.523 [BPC1] No Fault, FailCount= 2 2015-04-17T18:17:07.180Z,1429294627.180 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T18:17:13.182Z,1429294633.182 [NAL9602](INFO): SBD MO Status=0, MOMSN=52550, MT Status=0, MTMSN=0 2015-04-17T18:17:13.183Z,1429294633.183 [NAL9602](INFO): No messages in MT queue 2015-04-17T18:17:14.096Z,1429294634.096 [BPC1](DEBUG): Received data from all battery sticks 2015-04-17T18:17:14.524Z,1429294634.524 [NAL9602](INFO): GPS fix at 20150417T181501: (36.802592, -121.787039) 2015-04-17T18:17:14.547Z,1429294634.547 [Default:CheckIn:Read_GPS] Stopped 2015-04-17T18:17:14.547Z,1429294634.547 [Default:CheckIn:Read_Iridium] Running Loop=1 2015-04-17T18:17:17.765Z,1429294637.765 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T18:17:36.203Z,1429294656.203 [NAL9602](INFO): SBD MO Status=1, MOMSN=52551, MT Status=0, MTMSN=0 2015-04-17T18:17:36.252Z,1429294656.252 [NAL9602](INFO): Sent 131 bytes from file Logs/20150417T171024/Courier0028.lzma 2015-04-17T18:17:36.252Z,1429294656.252 [NAL9602](INFO): Packets left to send: 0 2015-04-17T18:17:36.254Z,1429294656.254 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Courier0028.lzma.parts/0000.sbd 2015-04-17T18:17:36.254Z,1429294656.254 [NAL9602](INFO): Completed sending Logs/20150417T171024/Courier0028.lzma 2015-04-17T18:17:59.434Z,1429294679.434 [NAL9602](INFO): SBD MO Status=1, MOMSN=52552, MT Status=0, MTMSN=0 2015-04-17T18:17:59.484Z,1429294679.484 [NAL9602](INFO): Sent 332 bytes from file Logs/20150417T171024/Express0029.lzma 2015-04-17T18:17:59.484Z,1429294679.484 [NAL9602](INFO): Packets left to send: 1 2015-04-17T18:17:59.486Z,1429294679.486 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0029.lzma.parts/0001.sbd 2015-04-17T18:18:18.408Z,1429294698.408 [NAL9602](INFO): SBD MO Status=1, MOMSN=52553, MT Status=0, MTMSN=0 2015-04-17T18:18:18.461Z,1429294698.461 [NAL9602](INFO): Sent 72 bytes from file Logs/20150417T171024/Express0029.lzma 2015-04-17T18:18:18.461Z,1429294698.461 [NAL9602](INFO): Packets left to send: 0 2015-04-17T18:18:18.462Z,1429294698.462 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0029.lzma.parts/0000.sbd 2015-04-17T18:18:18.463Z,1429294698.463 [NAL9602](INFO): Completed sending Logs/20150417T171024/Express0029.lzma 2015-04-17T18:18:32.386Z,1429294712.386 [NAL9602](INFO): SBD MO Status=0, MOMSN=52554, MT Status=0, MTMSN=0 2015-04-17T18:18:32.468Z,1429294712.468 [Default:CheckIn:Read_Iridium] Stopped 2015-04-17T18:18:32.469Z,1429294712.469 [Default:CheckIn](INFO): Completed Default:CheckIn 2015-04-17T18:18:32.469Z,1429294712.469 [Default:CheckIn] Stopped 2015-04-17T18:18:32.469Z,1429294712.469 [Default:CheckIn](INFO): Aggregate::uninitialize Default:CheckIn 2015-04-17T18:18:32.469Z,1429294712.469 [Default:CheckIn:A.SetSpeed] Stopped 2015-04-17T18:18:32.469Z,1429294712.469 [Default:CheckIn:A.SetSpeed](DEBUG): Uninitialize. 2015-04-17T18:18:42.828Z,1429294722.828 [NAL9602](INFO): Powering down 2015-04-17T18:18:42.836Z,1429294722.836 [BPC1](ERROR): Failed to receive battery data 2015-04-17T18:18:42.836Z,1429294722.836 [BPC1] Communications Fault, FailCount= 1 2015-04-17T18:18:42.836Z,1429294722.836 [BPC1](ERROR): Communications Fault 2015-04-17T18:18:42.858Z,1429294722.858 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T18:18:42.860Z,1429294722.860 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:18:57.845Z,1429294737.845 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T18:18:57.845Z,1429294737.845 [BPC1] No Fault, FailCount= 1 2015-04-17T18:19:12.925Z,1429294752.925 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T18:19:12.925Z,1429294752.925 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T18:19:32.487Z,1429294772.487 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:19:32.487Z,1429294772.487 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T18:19:32.487Z,1429294772.487 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:19:32.904Z,1429294772.904 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:19:37.604Z,1429294777.604 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:19:47.896Z,1429294787.896 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:19:47.896Z,1429294787.896 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T18:20:02.489Z,1429294802.489 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:20:02.489Z,1429294802.489 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T18:20:02.489Z,1429294802.489 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:20:02.939Z,1429294802.939 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:20:07.606Z,1429294807.606 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:20:17.854Z,1429294817.854 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:20:17.854Z,1429294817.854 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T18:20:37.487Z,1429294837.487 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:20:37.488Z,1429294837.488 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T18:20:37.488Z,1429294837.488 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:20:37.872Z,1429294837.872 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:20:37.872Z,1429294837.872 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T18:20:42.604Z,1429294842.604 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:21:22.867Z,1429294882.867 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T18:21:22.867Z,1429294882.867 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:21:22.867Z,1429294882.867 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T18:21:22.868Z,1429294882.868 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T18:21:22.868Z,1429294882.868 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T18:21:27.852Z,1429294887.852 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 143.117248 min 2015-04-17T18:21:27.853Z,1429294887.853 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T18:21:27.853Z,1429294887.853 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:21:27.853Z,1429294887.853 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T18:21:27.853Z,1429294887.853 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:23:07.870Z,1429294987.870 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T18:23:07.870Z,1429294987.870 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T18:23:27.487Z,1429295007.487 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:23:27.487Z,1429295007.487 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T18:23:27.487Z,1429295007.487 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:23:27.864Z,1429295007.864 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:23:32.604Z,1429295012.604 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:23:33.003Z,1429295013.003 [Default:CheckIn] Running Loop=1 2015-04-17T18:23:33.003Z,1429295013.003 [Default:CheckIn](INFO): Aggregate::initialize Default:CheckIn 2015-04-17T18:23:33.003Z,1429295013.003 [Default:CheckIn:A.SetSpeed] Running Loop=1 2015-04-17T18:23:33.003Z,1429295013.003 [Default:CheckIn:A.SetSpeed](DEBUG): Initialize. 2015-04-17T18:23:33.004Z,1429295013.004 [Default:CheckIn:Read_GPS] Running Loop=1 2015-04-17T18:23:33.410Z,1429295013.410 [NAL9602](INFO): Powering up 2015-04-17T18:23:33.461Z,1429295013.461 [Reporter](INFO): NAL9602.sigQuality no_value 2015-04-17T18:23:34.066Z,1429295014.066 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:23:34.067Z,1429295014.067 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T18:23:43.837Z,1429295023.837 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:23:44.303Z,1429295024.303 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:23:44.303Z,1429295024.303 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T18:23:44.303Z,1429295024.303 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:23:44.665Z,1429295024.665 [NAL9602](INFO): NAL9602 initialized 2015-04-17T18:23:44.690Z,1429295024.690 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:23:44.815Z,1429295024.815 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:23:46.050Z,1429295026.050 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:23:46.050Z,1429295026.050 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T18:23:56.365Z,1429295036.365 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:23:56.365Z,1429295036.365 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T18:23:56.365Z,1429295036.365 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:23:56.761Z,1429295036.761 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:23:56.761Z,1429295036.761 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T18:23:56.882Z,1429295036.882 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:24:10.191Z,1429295050.191 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T18:24:18.829Z,1429295058.829 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:24:19.247Z,1429295059.247 [BPC1](DEBUG): Received data from all battery sticks 2015-04-17T18:24:47.772Z,1429295087.772 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T18:25:09.578Z,1429295109.578 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:25:25.962Z,1429295125.962 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T18:25:31.062Z,1429295131.062 [CBIT](INFO): Clearing failed count for component DVL_micro 2015-04-17T18:25:31.062Z,1429295131.062 [DVL_micro] No Fault, FailCount= 5 2015-04-17T18:25:31.468Z,1429295131.468 [DVL_micro](INFO): Initializing 2015-04-17T18:25:42.010Z,1429295142.010 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:25:42.011Z,1429295142.011 [DVL_micro] Communications Fault, FailCount= 1 2015-04-17T18:25:42.011Z,1429295142.011 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:25:42.039Z,1429295142.039 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:25:42.498Z,1429295142.498 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:25:42.940Z,1429295142.940 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:25:43.400Z,1429295143.400 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:25:43.400Z,1429295143.400 [DVL_micro] No Fault, FailCount= 1 2015-04-17T18:25:43.822Z,1429295143.822 [DVL_micro](INFO): Initializing 2015-04-17T18:25:45.559Z,1429295145.559 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:25:48.664Z,1429295148.664 [CBIT](DEBUG): EFC running - data check-sum false 2015-04-17T18:25:54.558Z,1429295154.558 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:25:54.558Z,1429295154.558 [DVL_micro] Communications Fault, FailCount= 2 2015-04-17T18:25:54.558Z,1429295154.558 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:25:54.628Z,1429295154.628 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:25:55.077Z,1429295155.077 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:25:55.519Z,1429295155.519 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:25:55.975Z,1429295155.975 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:25:55.975Z,1429295155.975 [DVL_micro] No Fault, FailCount= 2 2015-04-17T18:25:56.382Z,1429295156.382 [DVL_micro](INFO): Initializing 2015-04-17T18:26:02.882Z,1429295162.882 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T18:26:07.033Z,1429295167.033 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:26:07.033Z,1429295167.033 [DVL_micro] Communications Fault, FailCount= 3 2015-04-17T18:26:07.033Z,1429295167.033 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:26:07.200Z,1429295167.200 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:26:07.640Z,1429295167.640 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:26:08.054Z,1429295168.054 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:26:08.057Z,1429295168.057 [NAL9602](INFO): SBD MO Status=0, MOMSN=52555, MT Status=0, MTMSN=0 2015-04-17T18:26:08.057Z,1429295168.057 [NAL9602](INFO): No messages in MT queue 2015-04-17T18:26:08.546Z,1429295168.546 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:26:08.547Z,1429295168.547 [DVL_micro] No Fault, FailCount= 3 2015-04-17T18:26:08.923Z,1429295168.923 [DVL_micro](INFO): Initializing 2015-04-17T18:26:09.380Z,1429295169.380 [NAL9602](INFO): GPS fix at 20150417T182356: (36.802605, -121.787048) 2015-04-17T18:26:09.397Z,1429295169.397 [Default:CheckIn:Read_GPS] Stopped 2015-04-17T18:26:09.397Z,1429295169.397 [Default:CheckIn:Read_Iridium] Running Loop=1 2015-04-17T18:26:12.623Z,1429295172.623 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T18:26:19.584Z,1429295179.584 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:26:19.584Z,1429295179.584 [DVL_micro] Communications Fault, FailCount= 4 2015-04-17T18:26:19.584Z,1429295179.584 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:26:19.638Z,1429295179.638 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:26:20.116Z,1429295180.116 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:26:20.542Z,1429295180.542 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:26:21.027Z,1429295181.027 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:26:21.027Z,1429295181.027 [DVL_micro] No Fault, FailCount= 4 2015-04-17T18:26:21.405Z,1429295181.405 [DVL_micro](INFO): Initializing 2015-04-17T18:26:23.089Z,1429295183.089 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T18:26:23.089Z,1429295183.089 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:26:23.089Z,1429295183.089 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T18:26:23.090Z,1429295183.090 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T18:26:23.090Z,1429295183.090 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T18:26:23.523Z,1429295183.523 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 148.120693 min 2015-04-17T18:26:23.523Z,1429295183.523 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T18:26:23.523Z,1429295183.523 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:26:23.523Z,1429295183.523 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T18:26:23.523Z,1429295183.523 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:26:26.449Z,1429295186.449 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T18:26:26.449Z,1429295186.449 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T18:26:29.807Z,1429295189.807 [BPC1](ERROR): B bank expecting battery number:1 and read number: uart read:X $S,01,270F,02,00,04,5C%51 $C1,01,FF,02,00,03,FF,04,00,05,00,06,00,07,00%72 $B11,0A,FFFC%36 $B12,0A,FFFC%35 $B13,0A,0000%31 $B14,0A,FFFD%34 $B15,0A,0000%37 $B16,0A,FFDE%35 $B17,0A,0000%35 $B18,0A,0000%3A $S,01,270F,02,00,04,5C%51 $C1,01,FF,02,00,03,FF,04,00,05,00,06,00,07,00%72 $B11,02,000A,01,02A8,03,0001,08,0B76,09,3E6C,0A,FFFC,0B,FFFD%3C $B11,0C,0001,0D,0062,0E,0055,0F,167E,10,190C,11,FFFF,12,FFFF%4F $B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3B $B11,1A,0031,1B,458C,1C,00C9%31 $B12,02,000A,01,02A8,03,0001,08,0B6E,09,3E69,0A,FFFC,0B,FFFD%37 $B12,0C,0001,0D,0063,0E,0055,0F,1672,10,191E,11,FFFF,12,FFFF%3D $B12,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%38 $B12,1A,0031,1B,458C,1C,0103%4A $B13,02,000A,01,02A8,03,0001,08,0B64,09,3E65,0A,0000,0B,0000%4C $B13,0C,0001,0D,005B,0E,0057,0F,16F0,10,196F,11,FFFF,12,FFFF%3B $B13,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%39 $B13,1A,0031,1B,458F,1C,0152%4A $B14,02,000A,01,02A8,03,0001,08,0B47,09,3E64,0A,0000,0B,FFFE%48 $B14,0C,0001,0D,005A,0E,0054,0F,163F,10,18E1,11,FFFF,12,FFFF%3A $B14,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3E $B14,1A,0031,1B,458C,1C,014A%3A $B15,02,000A,01,02A8,03,0001,08,0B76,09,3E73,0A,FFFD,0B,0000%4C $B15,0C,0001,0D,005A,0E,0056,0F,16B1,10,1941,11,FFFF,12,FFFF%4F $B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3F $B15,1A,0031,1B,458C,1C,0114%4B $B16,02,000A,01,02A8,03,0001,08,0B4B,09,3DAE,0A,FFE8,0B,FFE0%33 $B16,0C,0001,0D,0056,0E,0052,0F,1596,10,1961,11,35F7,12,2879%31 $B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%3C $B16,1A,0031,1B,458F,1C,015E%38 $B17,02,000A,01,02A8,03,0001,08,0B6E,09,3E13,0A,0000,0B,0001%39 $B17,0C,0001,0D,0063,0E,0053,0F,15FA,10,194B,11,FFFF,12,FFFF%3D $B17,13,C6FC,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%4D $B17,1A,0031,1B,458B,1C,008E%31 $B18,02,000A,01,02A8,03,0001,08,0B77,09,3DED,0A,0000,0B,0001%47 $B18,0C,0001,0D,005A,0E,0056,0F,16A9,10,19F6,11,FFFF,12,FFFF%3C $B18,13,C60C,14,0BB8,15,41A0,16,00C0,17,0003,18,1A90,19,3840%34 $B18,1A,0031,1B,458B,1C,00AC%41 2015-04-17T18:26:29.807Z,1429295189.807 [BPC1](ERROR): Failed to parse bank B battery data 2015-04-17T18:26:29.807Z,1429295189.807 [BPC1] Data Fault, FailCount= 1 2015-04-17T18:26:29.807Z,1429295189.807 [BPC1](ERROR): Data Fault 2015-04-17T18:26:29.862Z,1429295189.862 [CBIT](ERROR): Data Fault in component: BPC1 2015-04-17T18:26:31.109Z,1429295191.109 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T18:26:31.109Z,1429295191.109 [BPC1] No Fault, FailCount= 1 2015-04-17T18:26:31.531Z,1429295191.531 [NAL9602](INFO): SBD MO Status=2, MOMSN=52556, MT Status=2, MTMSN=0 2015-04-17T18:26:31.531Z,1429295191.531 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:26:32.005Z,1429295192.005 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:26:32.005Z,1429295192.005 [DVL_micro] Communications Fault, FailCount= 5 2015-04-17T18:26:32.006Z,1429295192.006 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:26:32.102Z,1429295192.102 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:26:32.102Z,1429295192.102 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2015-04-17T18:26:32.540Z,1429295192.540 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:26:32.966Z,1429295192.966 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:26:35.742Z,1429295195.742 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:26:36.874Z,1429295196.874 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:26:36.874Z,1429295196.874 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T18:26:36.875Z,1429295196.875 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:26:37.286Z,1429295197.286 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:26:37.419Z,1429295197.419 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:26:38.653Z,1429295198.653 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:26:38.653Z,1429295198.653 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T18:26:47.430Z,1429295207.430 [Reporter](INFO): NAL9602.sigQuality 2 count 2015-04-17T18:26:50.433Z,1429295210.433 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:26:50.433Z,1429295210.433 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T18:26:50.433Z,1429295210.433 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:26:50.851Z,1429295210.851 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:26:51.012Z,1429295211.012 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:26:52.204Z,1429295212.204 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:26:52.204Z,1429295212.204 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T18:27:02.513Z,1429295222.513 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:27:02.513Z,1429295222.513 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T18:27:02.513Z,1429295222.513 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:27:02.977Z,1429295222.977 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:27:02.982Z,1429295222.982 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T18:27:03.110Z,1429295223.110 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:27:04.296Z,1429295224.296 [NAL9602](INFO): SBD MO Status=1, MOMSN=52556, MT Status=0, MTMSN=0 2015-04-17T18:27:04.352Z,1429295224.352 [NAL9602](INFO): Sent 79 bytes from file Logs/20150417T171024/Courier0032.lzma 2015-04-17T18:27:04.353Z,1429295224.353 [NAL9602](INFO): Packets left to send: 0 2015-04-17T18:27:04.354Z,1429295224.354 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Courier0032.lzma.parts/0000.sbd 2015-04-17T18:27:04.355Z,1429295224.355 [NAL9602](INFO): Completed sending Logs/20150417T171024/Courier0032.lzma 2015-04-17T18:27:26.690Z,1429295246.690 [NAL9602](INFO): SBD MO Status=1, MOMSN=52557, MT Status=0, MTMSN=0 2015-04-17T18:27:26.743Z,1429295246.743 [NAL9602](INFO): Sent 300 bytes from file Logs/20150417T171024/Express0033.lzma 2015-04-17T18:27:26.743Z,1429295246.743 [NAL9602](INFO): Packets left to send: 0 2015-04-17T18:27:26.745Z,1429295246.745 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0033.lzma.parts/0000.sbd 2015-04-17T18:27:26.745Z,1429295246.745 [NAL9602](INFO): Completed sending Logs/20150417T171024/Express0033.lzma 2015-04-17T18:27:35.634Z,1429295255.634 [NAL9602](INFO): SBD MO Status=0, MOMSN=52558, MT Status=0, MTMSN=0 2015-04-17T18:27:35.747Z,1429295255.747 [Default:CheckIn:Read_Iridium] Stopped 2015-04-17T18:27:35.748Z,1429295255.748 [Default:CheckIn](INFO): Completed Default:CheckIn 2015-04-17T18:27:35.748Z,1429295255.748 [Default:CheckIn] Stopped 2015-04-17T18:27:35.748Z,1429295255.748 [Default:CheckIn](INFO): Aggregate::uninitialize Default:CheckIn 2015-04-17T18:27:35.748Z,1429295255.748 [Default:CheckIn:A.SetSpeed] Stopped 2015-04-17T18:27:35.748Z,1429295255.748 [Default:CheckIn:A.SetSpeed](DEBUG): Uninitialize. 2015-04-17T18:27:46.146Z,1429295266.146 [NAL9602](INFO): Powering down 2015-04-17T18:27:46.232Z,1429295266.232 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:28:31.151Z,1429295311.151 [BPC1](ERROR): Failed to receive battery data 2015-04-17T18:28:31.151Z,1429295311.151 [BPC1] Communications Fault, FailCount= 1 2015-04-17T18:28:31.151Z,1429295311.151 [BPC1](ERROR): Communications Fault 2015-04-17T18:28:31.172Z,1429295311.172 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T18:28:46.170Z,1429295326.170 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T18:28:46.170Z,1429295326.170 [BPC1] No Fault, FailCount= 1 2015-04-17T18:29:36.211Z,1429295376.211 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T18:29:36.211Z,1429295376.211 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T18:29:55.813Z,1429295395.813 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:29:55.813Z,1429295395.813 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T18:29:55.813Z,1429295395.813 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:29:56.153Z,1429295396.153 [BPC1](ERROR): Failed to receive battery data 2015-04-17T18:29:56.154Z,1429295396.154 [BPC1] Communications Fault, FailCount= 1 2015-04-17T18:29:56.154Z,1429295396.154 [BPC1](ERROR): Communications Fault 2015-04-17T18:29:56.179Z,1429295396.179 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:29:56.180Z,1429295396.180 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T18:30:00.930Z,1429295400.930 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:30:11.184Z,1429295411.184 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:30:11.184Z,1429295411.184 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T18:30:11.185Z,1429295411.185 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T18:30:11.185Z,1429295411.185 [BPC1] No Fault, FailCount= 1 2015-04-17T18:30:30.815Z,1429295430.815 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:30:30.816Z,1429295430.816 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T18:30:30.816Z,1429295430.816 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:30:31.199Z,1429295431.199 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:30:35.932Z,1429295435.932 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:30:46.203Z,1429295446.203 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:30:46.203Z,1429295446.203 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T18:31:05.814Z,1429295465.814 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:31:05.814Z,1429295465.814 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T18:31:05.814Z,1429295465.814 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:31:06.186Z,1429295466.186 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:31:06.187Z,1429295466.187 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T18:31:10.931Z,1429295470.931 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:31:26.204Z,1429295486.204 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T18:31:26.204Z,1429295486.204 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:31:26.204Z,1429295486.204 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T18:31:26.205Z,1429295486.205 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T18:31:26.205Z,1429295486.205 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T18:31:31.160Z,1429295491.160 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 153.172632 min 2015-04-17T18:31:31.160Z,1429295491.160 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T18:31:31.160Z,1429295491.160 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:31:31.160Z,1429295491.160 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T18:31:31.161Z,1429295491.161 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:32:26.150Z,1429295546.150 [BPC1](DEBUG): Received data from all battery sticks 2015-04-17T18:32:36.242Z,1429295556.242 [Default:CheckIn] Running Loop=1 2015-04-17T18:32:36.242Z,1429295556.242 [Default:CheckIn](INFO): Aggregate::initialize Default:CheckIn 2015-04-17T18:32:36.242Z,1429295556.242 [Default:CheckIn:A.SetSpeed] Running Loop=1 2015-04-17T18:32:36.242Z,1429295556.242 [Default:CheckIn:A.SetSpeed](DEBUG): Initialize. 2015-04-17T18:32:36.242Z,1429295556.242 [Default:CheckIn:Read_GPS] Running Loop=1 2015-04-17T18:32:36.653Z,1429295556.653 [NAL9602](INFO): Powering up 2015-04-17T18:32:36.696Z,1429295556.696 [Reporter](INFO): NAL9602.sigQuality no_value 2015-04-17T18:32:46.830Z,1429295566.830 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:32:47.622Z,1429295567.622 [NAL9602](INFO): NAL9602 initialized 2015-04-17T18:32:53.737Z,1429295573.737 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T18:33:04.229Z,1429295584.229 [NAL9602](INFO): SBD MO Status=0, MOMSN=52559, MT Status=0, MTMSN=0 2015-04-17T18:33:04.229Z,1429295584.229 [NAL9602](INFO): No messages in MT queue 2015-04-17T18:33:15.157Z,1429295595.157 [NAL9602](INFO): GPS fix at 20150417T183102: (36.802607, -121.787050) 2015-04-17T18:33:15.194Z,1429295595.194 [Default:CheckIn:Read_GPS] Stopped 2015-04-17T18:33:15.194Z,1429295595.194 [Default:CheckIn:Read_Iridium] Running Loop=1 2015-04-17T18:33:35.908Z,1429295615.908 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T18:33:35.908Z,1429295615.908 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T18:33:46.096Z,1429295626.096 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:33:46.096Z,1429295626.096 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T18:33:46.096Z,1429295626.096 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:33:46.511Z,1429295626.511 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:33:46.656Z,1429295626.656 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:33:47.421Z,1429295627.421 [NAL9602](INFO): SBD MO Status=2, MOMSN=52560, MT Status=2, MTMSN=0 2015-04-17T18:33:47.422Z,1429295627.422 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:33:47.894Z,1429295627.894 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:33:47.894Z,1429295627.894 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T18:33:51.873Z,1429295631.873 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:33:54.599Z,1429295634.599 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T18:33:58.046Z,1429295638.046 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:33:58.046Z,1429295638.046 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T18:33:58.046Z,1429295638.046 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:33:58.486Z,1429295638.486 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:33:58.607Z,1429295638.607 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:33:59.836Z,1429295639.836 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:33:59.837Z,1429295639.837 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T18:34:10.097Z,1429295650.097 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:34:10.097Z,1429295650.097 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T18:34:10.097Z,1429295650.097 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:34:10.468Z,1429295650.468 [NAL9602](INFO): SBD MO Status=2, MOMSN=52560, MT Status=2, MTMSN=0 2015-04-17T18:34:10.468Z,1429295650.468 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:34:10.515Z,1429295650.515 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:34:10.515Z,1429295650.515 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T18:34:10.649Z,1429295650.649 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:34:27.738Z,1429295667.738 [NAL9602](INFO): SBD MO Status=2, MOMSN=52560, MT Status=2, MTMSN=0 2015-04-17T18:34:27.739Z,1429295667.739 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:34:32.448Z,1429295672.448 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:34:54.654Z,1429295694.654 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T18:35:37.136Z,1429295737.136 [NAL9602](INFO): SBD MO Status=2, MOMSN=52560, MT Status=2, MTMSN=0 2015-04-17T18:35:37.136Z,1429295737.136 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:35:41.829Z,1429295741.829 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:35:46.294Z,1429295746.294 [Reporter](INFO): NAL9602.sigQuality 3 count 2015-04-17T18:35:49.466Z,1429295749.466 [CBIT](DEBUG): EFC running - data check-sum false 2015-04-17T18:35:56.625Z,1429295756.625 [NAL9602](INFO): SBD MO Status=1, MOMSN=52560, MT Status=0, MTMSN=0 2015-04-17T18:35:56.677Z,1429295756.677 [NAL9602](INFO): Sent 133 bytes from file Logs/20150417T171024/Courier0036.lzma 2015-04-17T18:35:56.677Z,1429295756.677 [NAL9602](INFO): Packets left to send: 0 2015-04-17T18:35:56.680Z,1429295756.680 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Courier0036.lzma.parts/0000.sbd 2015-04-17T18:35:56.680Z,1429295756.680 [NAL9602](INFO): Completed sending Logs/20150417T171024/Courier0036.lzma 2015-04-17T18:36:26.253Z,1429295786.253 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T18:36:26.253Z,1429295786.253 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:36:26.254Z,1429295786.254 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T18:36:26.254Z,1429295786.254 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T18:36:26.254Z,1429295786.254 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T18:36:26.682Z,1429295786.682 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 158.173272 min 2015-04-17T18:36:26.682Z,1429295786.682 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T18:36:26.682Z,1429295786.682 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:36:26.683Z,1429295786.683 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T18:36:26.683Z,1429295786.683 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:36:32.198Z,1429295792.198 [CBIT](INFO): Clearing failed count for component DVL_micro 2015-04-17T18:36:32.198Z,1429295792.198 [DVL_micro] No Fault, FailCount= 5 2015-04-17T18:36:32.578Z,1429295792.578 [DVL_micro](INFO): Initializing 2015-04-17T18:36:33.064Z,1429295793.064 [NAL9602](INFO): SBD MO Status=2, MOMSN=52561, MT Status=2, MTMSN=0 2015-04-17T18:36:33.064Z,1429295793.064 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:36:35.405Z,1429295795.405 [BPC1](ERROR): Failed to receive battery data 2015-04-17T18:36:35.405Z,1429295795.405 [BPC1] Communications Fault, FailCount= 1 2015-04-17T18:36:35.405Z,1429295795.405 [BPC1](ERROR): Communications Fault 2015-04-17T18:36:35.479Z,1429295795.479 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T18:36:36.726Z,1429295796.726 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T18:36:36.726Z,1429295796.726 [BPC1] No Fault, FailCount= 1 2015-04-17T18:36:37.640Z,1429295797.640 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:36:40.389Z,1429295800.389 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T18:36:40.389Z,1429295800.389 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T18:36:40.852Z,1429295800.852 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T18:36:44.357Z,1429295804.357 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:36:44.357Z,1429295804.357 [DVL_micro] Communications Fault, FailCount= 1 2015-04-17T18:36:44.357Z,1429295804.357 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:36:44.404Z,1429295804.404 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:36:44.861Z,1429295804.861 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:36:45.286Z,1429295805.286 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:36:45.735Z,1429295805.735 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:36:45.735Z,1429295805.735 [DVL_micro] No Fault, FailCount= 1 2015-04-17T18:36:46.110Z,1429295806.110 [DVL_micro](INFO): Initializing 2015-04-17T18:36:50.461Z,1429295810.461 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:36:50.461Z,1429295810.461 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T18:36:50.461Z,1429295810.461 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:36:50.902Z,1429295810.902 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:36:51.026Z,1429295811.026 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:36:52.313Z,1429295812.313 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:36:52.313Z,1429295812.313 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T18:36:56.580Z,1429295816.580 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:36:56.580Z,1429295816.580 [DVL_micro] Communications Fault, FailCount= 2 2015-04-17T18:36:56.580Z,1429295816.580 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:36:56.651Z,1429295816.651 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:36:57.083Z,1429295817.083 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:36:57.522Z,1429295817.522 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:36:57.975Z,1429295817.975 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:36:57.975Z,1429295817.975 [DVL_micro] No Fault, FailCount= 2 2015-04-17T18:36:58.369Z,1429295818.369 [DVL_micro](INFO): Initializing 2015-04-17T18:37:00.864Z,1429295820.864 [NAL9602](INFO): SBD MO Status=2, MOMSN=52561, MT Status=2, MTMSN=0 2015-04-17T18:37:00.864Z,1429295820.864 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:37:02.677Z,1429295822.677 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:37:02.677Z,1429295822.677 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T18:37:02.677Z,1429295822.677 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:37:03.051Z,1429295823.051 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:37:03.173Z,1429295823.173 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:37:04.395Z,1429295824.395 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:37:04.395Z,1429295824.395 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T18:37:05.317Z,1429295825.317 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:37:08.984Z,1429295828.984 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:37:08.984Z,1429295828.984 [DVL_micro] Communications Fault, FailCount= 3 2015-04-17T18:37:08.984Z,1429295828.984 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:37:09.070Z,1429295829.070 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:37:09.510Z,1429295829.510 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:37:09.941Z,1429295829.941 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:37:10.383Z,1429295830.383 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:37:10.383Z,1429295830.383 [DVL_micro] No Fault, FailCount= 3 2015-04-17T18:37:10.776Z,1429295830.776 [DVL_micro](INFO): Initializing 2015-04-17T18:37:14.585Z,1429295834.585 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:37:14.586Z,1429295834.586 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T18:37:14.586Z,1429295834.586 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:37:14.989Z,1429295834.989 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:37:14.989Z,1429295834.989 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T18:37:15.111Z,1429295835.111 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:37:15.941Z,1429295835.941 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T18:37:21.586Z,1429295841.586 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:37:21.586Z,1429295841.586 [DVL_micro] Communications Fault, FailCount= 4 2015-04-17T18:37:21.586Z,1429295841.586 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:37:21.654Z,1429295841.654 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:37:22.090Z,1429295842.090 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:37:22.524Z,1429295842.524 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:37:23.029Z,1429295843.029 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-04-17T18:37:23.030Z,1429295843.030 [DVL_micro] No Fault, FailCount= 4 2015-04-17T18:37:23.420Z,1429295843.420 [DVL_micro](INFO): Initializing 2015-04-17T18:37:33.990Z,1429295853.990 [DVL_micro](ERROR): No DVL communication! Re-initializing 2015-04-17T18:37:33.990Z,1429295853.990 [DVL_micro] Communications Fault, FailCount= 5 2015-04-17T18:37:33.990Z,1429295853.990 [DVL_micro](ERROR): Communications Fault 2015-04-17T18:37:33.993Z,1429295853.993 [NAL9602](INFO): SBD MO Status=2, MOMSN=52561, MT Status=2, MTMSN=0 2015-04-17T18:37:33.993Z,1429295853.993 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:37:34.065Z,1429295854.065 [CBIT](ERROR): Communications Fault in component: DVL_micro 2015-04-17T18:37:34.065Z,1429295854.065 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2015-04-17T18:37:34.501Z,1429295854.501 [DVL_micro](INFO): uninitialize:Powering down 2015-04-17T18:37:35.069Z,1429295855.069 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-04-17T18:37:38.605Z,1429295858.605 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:37:41.469Z,1429295861.469 [Reporter](INFO): NAL9602.sigQuality 1 count 2015-04-17T18:37:59.964Z,1429295879.964 [NAL9602](INFO): SBD MO Status=2, MOMSN=52561, MT Status=2, MTMSN=0 2015-04-17T18:37:59.964Z,1429295879.964 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:38:54.801Z,1429295934.801 [NAL9602](INFO): SBD MO Status=2, MOMSN=52561, MT Status=2, MTMSN=0 2015-04-17T18:38:54.801Z,1429295934.801 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2015-04-17T18:38:59.142Z,1429295939.142 [Reporter](INFO): NAL9602.sigQuality 4 count 2015-04-17T18:39:15.405Z,1429295955.405 [NAL9602](INFO): SBD MO Status=1, MOMSN=52561, MT Status=0, MTMSN=0 2015-04-17T18:39:15.450Z,1429295955.450 [NAL9602](INFO): Sent 269 bytes from file Logs/20150417T171024/Express0037.lzma 2015-04-17T18:39:15.450Z,1429295955.450 [NAL9602](INFO): Packets left to send: 0 2015-04-17T18:39:15.452Z,1429295955.452 [NAL9602](INFO): Stored copy of sent data in Logs/20150417T171024/Express0037.lzma.parts/0000.sbd 2015-04-17T18:39:15.452Z,1429295955.452 [NAL9602](INFO): Completed sending Logs/20150417T171024/Express0037.lzma 2015-04-17T18:39:24.202Z,1429295964.202 [NAL9602](INFO): SBD MO Status=0, MOMSN=52562, MT Status=0, MTMSN=0 2015-04-17T18:39:24.299Z,1429295964.299 [Default:CheckIn:Read_Iridium] Stopped 2015-04-17T18:39:24.300Z,1429295964.300 [Default:CheckIn](INFO): Completed Default:CheckIn 2015-04-17T18:39:24.300Z,1429295964.300 [Default:CheckIn] Stopped 2015-04-17T18:39:24.300Z,1429295964.300 [Default:CheckIn](INFO): Aggregate::uninitialize Default:CheckIn 2015-04-17T18:39:24.300Z,1429295964.300 [Default:CheckIn:A.SetSpeed] Stopped 2015-04-17T18:39:24.300Z,1429295964.300 [Default:CheckIn:A.SetSpeed](DEBUG): Uninitialize. 2015-04-17T18:39:34.651Z,1429295974.651 [NAL9602](INFO): Powering down 2015-04-17T18:39:34.713Z,1429295974.713 [Reporter](INFO): NAL9602.sigQuality 0 count 2015-04-17T18:39:44.682Z,1429295984.682 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T18:39:44.682Z,1429295984.682 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T18:39:59.651Z,1429295999.651 [BPC1](DEBUG): Received data from all battery sticks 2015-04-17T18:40:04.316Z,1429296004.316 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:40:04.317Z,1429296004.317 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T18:40:04.317Z,1429296004.317 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:40:04.685Z,1429296004.685 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:40:09.430Z,1429296009.430 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:40:09.786Z,1429296009.786 [BPC1](ERROR): Failed to receive battery data 2015-04-17T18:40:09.786Z,1429296009.786 [BPC1] Communications Fault, FailCount= 1 2015-04-17T18:40:09.786Z,1429296009.786 [BPC1](ERROR): Communications Fault 2015-04-17T18:40:09.851Z,1429296009.851 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T18:40:19.687Z,1429296019.687 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:40:19.687Z,1429296019.687 [Aanderaa_O2] No Fault, FailCount= 1 2015-04-17T18:40:24.688Z,1429296024.688 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T18:40:24.688Z,1429296024.688 [BPC1] No Fault, FailCount= 1 2015-04-17T18:40:34.319Z,1429296034.319 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:40:34.319Z,1429296034.319 [Aanderaa_O2] Communications Fault, FailCount= 2 2015-04-17T18:40:34.319Z,1429296034.319 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:40:34.865Z,1429296034.865 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:40:39.432Z,1429296039.432 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:40:49.735Z,1429296049.735 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-04-17T18:40:49.740Z,1429296049.740 [Aanderaa_O2] No Fault, FailCount= 2 2015-04-17T18:40:54.670Z,1429296054.670 [BPC1](ERROR): Failed to receive battery data 2015-04-17T18:40:54.671Z,1429296054.671 [BPC1] Communications Fault, FailCount= 2 2015-04-17T18:40:54.671Z,1429296054.671 [BPC1](ERROR): Communications Fault 2015-04-17T18:40:54.693Z,1429296054.693 [CBIT](ERROR): Communications Fault in component: BPC1 2015-04-17T18:41:09.317Z,1429296069.317 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:41:09.317Z,1429296069.317 [Aanderaa_O2] Communications Fault, FailCount= 3 2015-04-17T18:41:09.317Z,1429296069.317 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:41:09.693Z,1429296069.693 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:41:09.694Z,1429296069.694 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2015-04-17T18:41:09.694Z,1429296069.694 [CBIT](INFO): Clearing failed state for component BPC1 2015-04-17T18:41:09.694Z,1429296069.694 [BPC1] No Fault, FailCount= 2 2015-04-17T18:41:14.434Z,1429296074.434 [Aanderaa_O2](INFO): Powering down 2015-04-17T18:41:29.684Z,1429296089.684 [Default:UpdateAndReportMinutesSinceMissionStarted] Running Loop=1 2015-04-17T18:41:29.684Z,1429296089.684 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::initialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:41:29.684Z,1429296089.684 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Running Loop=1 2015-04-17T18:41:29.685Z,1429296089.685 [Default:UpdateAndReportMinutesSinceMissionStarted:A] Stopped 2015-04-17T18:41:29.685Z,1429296089.685 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Running Loop=1 2015-04-17T18:41:34.785Z,1429296094.785 [Default:UpdateAndReportMinutesSinceMissionStarted:B](IMPORTANT): Default mission has been running for 163.231032 min 2015-04-17T18:41:34.785Z,1429296094.785 [Default:UpdateAndReportMinutesSinceMissionStarted:B] Stopped 2015-04-17T18:41:34.786Z,1429296094.786 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Completed Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:41:34.786Z,1429296094.786 [Default:UpdateAndReportMinutesSinceMissionStarted] Stopped 2015-04-17T18:41:34.786Z,1429296094.786 [Default:UpdateAndReportMinutesSinceMissionStarted](INFO): Aggregate::uninitialize Default:UpdateAndReportMinutesSinceMissionStarted 2015-04-17T18:43:39.674Z,1429296219.674 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2015-04-17T18:43:39.674Z,1429296219.674 [Aanderaa_O2] No Fault, FailCount= 3 2015-04-17T18:43:59.317Z,1429296239.317 [Aanderaa_O2](FAULT): Timed out starting 2015-04-17T18:43:59.317Z,1429296239.317 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-04-17T18:43:59.317Z,1429296239.317 [Aanderaa_O2](ERROR): Communications Fault 2015-04-17T18:43:59.718Z,1429296239.718 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-04-17T18:44:04.434Z,1429296244.434 [Aanderaa_O2](INFO): Powering down