2018-08-01T21:01:45.720Z,1533157305.720 [CommandLine](IMPORTANT): got command restart logs
2018-08-01T21:01:55.487Z,1533157315.487 [NAL9602](INFO): Powering down
2018-08-01T21:01:56.403Z,1533157316.403 [DataOverHttps](INFO): Sending 363 bytes from file Logs/20180801T170753/Express0068.lzma
2018-08-01T21:01:57.000Z,1533157318.000 [DataOverHttps](INFO): Moved sent file to Logs/20180801T170753/Express0068.lzma.bak
2018-08-01T21:01:58.000Z,1533157318.000 [DataOverHttps](INFO): SBD MOMSN=8392185
2018-08-01T21:02:11.474Z,1533157331.474 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180801T170753/Courier0070.lzma
2018-08-01T21:02:13.056Z,1533157333.056 [DataOverHttps](INFO): Moved sent file to Logs/20180801T170753/Courier0070.lzma.bak
2018-08-01T21:02:13.056Z,1533157333.056 [DataOverHttps](INFO): SBD MOMSN=8392197
2018-08-01T21:02:29.338Z,1533157349.338 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180801T210145/Courier0000.lzma
2018-08-01T21:02:31.336Z,1533157351.336 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Courier0000.lzma.bak
2018-08-01T21:02:31.336Z,1533157351.336 [DataOverHttps](INFO): SBD MOMSN=8392199
2018-08-01T21:02:48.343Z,1533157368.343 [DataOverHttps](INFO): Sending 106 bytes from file Logs/20180801T170753/Express0071.lzma
2018-08-01T21:02:50.338Z,1533157370.338 [DataOverHttps](INFO): Moved sent file to Logs/20180801T170753/Express0071.lzma.bak
2018-08-01T21:02:50.338Z,1533157370.338 [DataOverHttps](INFO): SBD MOMSN=8392202
2018-08-01T21:03:07.302Z,1533157387.302 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180801T210145/Express0001.lzma
2018-08-01T21:03:09.699Z,1533157389.699 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Express0001.lzma.bak
2018-08-01T21:03:09.700Z,1533157389.700 [DataOverHttps](INFO): SBD MOMSN=8392205
2018-08-01T21:03:10.249Z,1533157390.249 [Default:CheckIn:Read_Iridium] Stopped
2018-08-01T21:03:10.250Z,1533157390.250 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-01T21:03:10.250Z,1533157390.250 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-01T21:04:36.239Z,1533157476.239 [BPC1](FAULT): Failed to receive data from all sticks prior to timeout. Missing data from 9 sticks.
2018-08-01T21:04:36.239Z,1533157476.239 [BPC1] Data Fault, FailCount= 1
2018-08-01T21:04:36.240Z,1533157476.240 [BPC1](ERROR): Data Fault
2018-08-01T21:04:36.265Z,1533157476.265 [CBIT](ERROR): Data Fault in component: BPC1
2018-08-01T21:04:37.471Z,1533157477.471 [CBIT](INFO): Clearing failed state for component BPC1
2018-08-01T21:04:37.471Z,1533157477.471 [BPC1] No Fault, FailCount= 1
2018-08-01T21:08:10.903Z,1533157690.903 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-01T21:08:10.903Z,1533157690.903 [Default:CheckIn:C.Wait] Stopped
2018-08-01T21:08:10.903Z,1533157690.903 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-01T21:08:10.903Z,1533157690.903 [Default:CheckIn:D] Running Loop=1
2018-08-01T21:08:11.292Z,1533157691.292 [Default:CheckIn:D] Stopped
2018-08-01T21:08:11.292Z,1533157691.292 [Default:CheckIn:E] Running Loop=1
2018-08-01T21:08:11.690Z,1533157691.690 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 37.866223 min 
2018-08-01T21:08:11.690Z,1533157691.690 [Default:CheckIn:E] Stopped
2018-08-01T21:08:11.690Z,1533157691.690 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-01T21:08:11.690Z,1533157691.690 [Default:CheckIn] Stopped
2018-08-01T21:08:11.690Z,1533157691.690 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-01T21:08:11.691Z,1533157691.691 [Default:CheckIn](INFO): Running loop #5
2018-08-01T21:08:11.691Z,1533157691.691 [Default:CheckIn] Running Loop=5
2018-08-01T21:08:11.691Z,1533157691.691 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-01T21:08:11.691Z,1533157691.691 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-01T21:08:15.177Z,1533157695.177 [NAL9602](INFO): Powering up
2018-08-01T21:08:26.082Z,1533157706.082 [NAL9602](INFO): NAL9602 initialized
2018-08-01T21:08:42.884Z,1533157722.884 [NAL9602](INFO): SBD MO Status=0, MOMSN=8017, MT Status=0, MTMSN=0
2018-08-01T21:08:42.884Z,1533157722.884 [NAL9602](INFO): No messages in MT queue
2018-08-01T21:09:21.407Z,1533157761.407 [NAL9602](INFO): GPS fix at 20180801T210902: (36.800711, -121.811220)
2018-08-01T21:09:21.464Z,1533157761.464 [Default:CheckIn:Read_GPS] Stopped
2018-08-01T21:09:21.464Z,1533157761.464 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-01T21:09:28.318Z,1533157768.318 [DataOverHttps](INFO): Sending 212 bytes from file Logs/20180801T210145/Courier0003.lzma
2018-08-01T21:09:30.715Z,1533157770.715 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Courier0003.lzma.bak
2018-08-01T21:09:30.716Z,1533157770.716 [DataOverHttps](INFO): SBD MOMSN=8392208
2018-08-01T21:09:44.323Z,1533157784.323 [DataOverHttps](INFO): Sending 416 bytes from file Logs/20180801T210145/Express0004.lzma
2018-08-01T21:09:46.320Z,1533157786.320 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Express0004.lzma.bak
2018-08-01T21:09:46.320Z,1533157786.320 [DataOverHttps](INFO): SBD MOMSN=8392211
2018-08-01T21:09:46.878Z,1533157786.878 [Default:CheckIn:Read_Iridium] Stopped
2018-08-01T21:09:46.878Z,1533157786.878 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-01T21:09:46.878Z,1533157786.878 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-01T21:09:53.998Z,1533157793.998 [NAL9602](INFO): Powering down
2018-08-01T21:10:36.094Z,1533157836.094 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-01T21:10:36.094Z,1533157836.094 [Rowe_600LCM] No Fault, FailCount= 5
2018-08-01T21:10:36.129Z,1533157836.129 [Rowe_600LCM](INFO): Initializing
2018-08-01T21:10:36.129Z,1533157836.129 [Rowe_600LCM](INFO): Checking LCM
2018-08-01T21:10:36.130Z,1533157836.130 [Rowe_600LCM](INFO): LCM OK
2018-08-01T21:10:36.130Z,1533157836.130 [Rowe_600LCM](INFO): Powering up
2018-08-01T21:10:40.367Z,1533157840.367 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-01T21:10:40.533Z,1533157840.533 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-08-01T21:10:40.534Z,1533157840.534 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-01T21:10:40.535Z,1533157840.535 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-01T21:10:40.536Z,1533157840.536 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-01T21:12:36.921Z,1533157956.921 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-01T21:12:36.921Z,1533157956.921 [Rowe_600LCM] Communications Fault, FailCount= 1
2018-08-01T21:12:36.921Z,1533157956.921 [Rowe_600LCM](ERROR): Communications Fault
2018-08-01T21:12:37.036Z,1533157957.036 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-01T21:12:37.325Z,1533157957.325 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-01T21:12:37.582Z,1533157957.582 [Rowe_600LCM](INFO): Powering down
2018-08-01T21:12:38.983Z,1533157958.983 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-01T21:12:38.983Z,1533157958.983 [Rowe_600LCM] No Fault, FailCount= 1
2018-08-01T21:12:39.197Z,1533157959.197 [Rowe_600LCM](INFO): Initializing
2018-08-01T21:12:39.198Z,1533157959.198 [Rowe_600LCM](INFO): Checking LCM
2018-08-01T21:12:39.198Z,1533157959.198 [Rowe_600LCM](INFO): LCM OK
2018-08-01T21:12:39.198Z,1533157959.198 [Rowe_600LCM](INFO): Powering up
2018-08-01T21:12:43.447Z,1533157963.447 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-01T21:12:43.649Z,1533157963.649 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-08-01T21:12:43.650Z,1533157963.650 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-01T21:12:43.651Z,1533157963.651 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-01T21:12:43.652Z,1533157963.652 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-01T21:14:39.273Z,1533158079.273 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-01T21:14:39.273Z,1533158079.273 [Rowe_600LCM] Communications Fault, FailCount= 2
2018-08-01T21:14:39.273Z,1533158079.273 [Rowe_600LCM](ERROR): Communications Fault
2018-08-01T21:14:39.380Z,1533158079.380 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-01T21:14:39.677Z,1533158079.677 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-01T21:14:39.928Z,1533158079.928 [Rowe_600LCM](INFO): Powering down
2018-08-01T21:14:41.348Z,1533158081.348 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-01T21:14:41.348Z,1533158081.348 [Rowe_600LCM] No Fault, FailCount= 2
2018-08-01T21:14:41.541Z,1533158081.541 [Rowe_600LCM](INFO): Initializing
2018-08-01T21:14:41.542Z,1533158081.542 [Rowe_600LCM](INFO): Checking LCM
2018-08-01T21:14:41.542Z,1533158081.542 [Rowe_600LCM](INFO): LCM OK
2018-08-01T21:14:41.542Z,1533158081.542 [Rowe_600LCM](INFO): Powering up
2018-08-01T21:14:45.702Z,1533158085.702 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-01T21:14:45.856Z,1533158085.856 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-08-01T21:14:45.857Z,1533158085.857 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-01T21:14:45.858Z,1533158085.858 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-01T21:14:45.859Z,1533158085.859 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-01T21:14:47.403Z,1533158087.403 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-01T21:14:47.403Z,1533158087.403 [Default:CheckIn:C.Wait] Stopped
2018-08-01T21:14:47.403Z,1533158087.403 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-01T21:14:47.404Z,1533158087.404 [Default:CheckIn:D] Running Loop=1
2018-08-01T21:14:47.761Z,1533158087.761 [Default:CheckIn:D] Stopped
2018-08-01T21:14:47.761Z,1533158087.761 [Default:CheckIn:E] Running Loop=1
2018-08-01T21:14:48.124Z,1533158088.124 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.474040 min 
2018-08-01T21:14:48.124Z,1533158088.124 [Default:CheckIn:E] Stopped
2018-08-01T21:14:48.124Z,1533158088.124 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-01T21:14:48.125Z,1533158088.125 [Default:CheckIn] Stopped
2018-08-01T21:14:48.125Z,1533158088.125 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-01T21:14:48.125Z,1533158088.125 [Default:CheckIn](INFO): Running loop #6
2018-08-01T21:14:48.125Z,1533158088.125 [Default:CheckIn] Running Loop=6
2018-08-01T21:14:48.125Z,1533158088.125 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-01T21:14:48.126Z,1533158088.126 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-01T21:14:48.878Z,1533158088.878 [NAL9602](INFO): Powering up
2018-08-01T21:14:59.395Z,1533158099.395 [NAL9602](INFO): NAL9602 initialized
2018-08-01T21:15:18.596Z,1533158118.596 [NAL9602](INFO): SBD MO Status=0, MOMSN=8018, MT Status=0, MTMSN=0
2018-08-01T21:15:18.596Z,1533158118.596 [NAL9602](INFO): No messages in MT queue
2018-08-01T21:15:19.795Z,1533158119.795 [NAL9602](INFO): GPS fix at 20180801T211500: (36.806696, -121.785352)
2018-08-01T21:15:19.886Z,1533158119.886 [Default:CheckIn:Read_GPS] Stopped
2018-08-01T21:15:19.886Z,1533158119.886 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-01T21:15:27.964Z,1533158127.964 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20180801T210145/Courier0006.lzma
2018-08-01T21:15:29.561Z,1533158129.561 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Courier0006.lzma.bak
2018-08-01T21:15:29.561Z,1533158129.561 [DataOverHttps](INFO): SBD MOMSN=8392217
2018-08-01T21:15:45.240Z,1533158145.240 [DataOverHttps](INFO): Sending 243 bytes from file Logs/20180801T210145/Express0007.lzma
2018-08-01T21:15:47.236Z,1533158147.236 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Express0007.lzma.bak
2018-08-01T21:15:47.237Z,1533158147.237 [DataOverHttps](INFO): SBD MOMSN=8392220
2018-08-01T21:15:47.798Z,1533158147.798 [Default:CheckIn:Read_Iridium] Stopped
2018-08-01T21:15:47.798Z,1533158147.798 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-01T21:15:47.798Z,1533158147.798 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-01T21:15:54.914Z,1533158154.914 [NAL9602](INFO): Powering down
2018-08-01T21:16:42.241Z,1533158202.241 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-01T21:16:42.241Z,1533158202.241 [Rowe_600LCM] Communications Fault, FailCount= 3
2018-08-01T21:16:42.241Z,1533158202.241 [Rowe_600LCM](ERROR): Communications Fault
2018-08-01T21:16:42.369Z,1533158202.369 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-01T21:16:42.645Z,1533158202.645 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-01T21:16:42.889Z,1533158202.889 [Rowe_600LCM](INFO): Powering down
2018-08-01T21:16:44.355Z,1533158204.355 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-01T21:16:44.355Z,1533158204.355 [Rowe_600LCM] No Fault, FailCount= 3
2018-08-01T21:16:44.505Z,1533158204.505 [Rowe_600LCM](INFO): Initializing
2018-08-01T21:16:44.505Z,1533158204.505 [Rowe_600LCM](INFO): Checking LCM
2018-08-01T21:16:44.506Z,1533158204.506 [Rowe_600LCM](INFO): LCM OK
2018-08-01T21:16:44.506Z,1533158204.506 [Rowe_600LCM](INFO): Powering up
2018-08-01T21:16:48.638Z,1533158208.638 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-01T21:16:48.784Z,1533158208.784 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-08-01T21:16:48.785Z,1533158208.785 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-01T21:16:48.786Z,1533158208.786 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-01T21:16:48.787Z,1533158208.787 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-01T21:18:26.478Z,1533158306.478 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2018-08-01T21:18:27.274Z,1533158307.274 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2018-08-01T21:18:45.273Z,1533158325.273 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-01T21:18:45.273Z,1533158325.273 [Rowe_600LCM] Communications Fault, FailCount= 4
2018-08-01T21:18:45.273Z,1533158325.273 [Rowe_600LCM](ERROR): Communications Fault
2018-08-01T21:18:45.386Z,1533158325.386 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-01T21:18:45.677Z,1533158325.677 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-01T21:18:45.939Z,1533158325.939 [Rowe_600LCM](INFO): Powering down
2018-08-01T21:18:47.338Z,1533158327.338 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-01T21:18:47.338Z,1533158327.338 [Rowe_600LCM] No Fault, FailCount= 4
2018-08-01T21:18:47.553Z,1533158327.553 [Rowe_600LCM](INFO): Initializing
2018-08-01T21:18:47.553Z,1533158327.553 [Rowe_600LCM](INFO): Checking LCM
2018-08-01T21:18:47.553Z,1533158327.553 [Rowe_600LCM](INFO): LCM OK
2018-08-01T21:18:47.554Z,1533158327.554 [Rowe_600LCM](INFO): Powering up
2018-08-01T21:18:51.793Z,1533158331.793 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-01T21:18:51.892Z,1533158331.892 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-08-01T21:18:51.893Z,1533158331.893 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-01T21:18:51.894Z,1533158331.894 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-01T21:18:51.895Z,1533158331.895 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-01T21:20:47.589Z,1533158447.589 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-01T21:20:47.589Z,1533158447.589 [Rowe_600LCM] Communications Fault, FailCount= 5
2018-08-01T21:20:47.589Z,1533158447.589 [Rowe_600LCM](ERROR): Communications Fault
2018-08-01T21:20:47.746Z,1533158447.746 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-01T21:20:47.747Z,1533158447.747 [CBIT](FAULT): Communications Fault in component: Rowe_600LCM
2018-08-01T21:20:47.993Z,1533158447.993 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-01T21:20:48.168Z,1533158448.168 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-01T21:20:48.169Z,1533158448.169 [Default:CheckIn:C.Wait] Stopped
2018-08-01T21:20:48.169Z,1533158448.169 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-01T21:20:48.175Z,1533158448.175 [Default:CheckIn:D] Running Loop=1
2018-08-01T21:20:48.276Z,1533158448.276 [Rowe_600LCM](INFO): Powering down
2018-08-01T21:20:48.488Z,1533158448.488 [Default:CheckIn:D] Stopped
2018-08-01T21:20:48.488Z,1533158448.488 [Default:CheckIn:E] Running Loop=1
2018-08-01T21:20:48.840Z,1533158448.840 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.486153 min 
2018-08-01T21:20:48.840Z,1533158448.840 [Default:CheckIn:E] Stopped
2018-08-01T21:20:48.842Z,1533158448.842 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-01T21:20:48.842Z,1533158448.842 [Default:CheckIn] Stopped
2018-08-01T21:20:48.842Z,1533158448.842 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-01T21:20:48.842Z,1533158448.842 [Default:CheckIn](INFO): Running loop #7
2018-08-01T21:20:48.842Z,1533158448.842 [Default:CheckIn] Running Loop=7
2018-08-01T21:20:48.842Z,1533158448.842 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-01T21:20:48.843Z,1533158448.843 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-01T21:20:49.598Z,1533158449.598 [NAL9602](INFO): Powering up
2018-08-01T21:21:00.758Z,1533158460.758 [NAL9602](INFO): NAL9602 initialized
2018-08-01T21:21:27.560Z,1533158487.560 [NAL9602](INFO): SBD MO Status=0, MOMSN=8019, MT Status=0, MTMSN=0
2018-08-01T21:21:27.560Z,1533158487.560 [NAL9602](INFO): No messages in MT queue
2018-08-01T21:22:21.319Z,1533158541.319 [NAL9602](INFO): GPS fix at 20180801T212201: (36.802743, -121.786939)
2018-08-01T21:22:21.382Z,1533158541.382 [Default:CheckIn:Read_GPS] Stopped
2018-08-01T21:22:21.382Z,1533158541.382 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-01T21:22:27.838Z,1533158547.838 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20180801T210145/Courier0009.lzma
2018-08-01T21:22:29.435Z,1533158549.435 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Courier0009.lzma.bak
2018-08-01T21:22:29.436Z,1533158549.436 [DataOverHttps](INFO): SBD MOMSN=8392226
2018-08-01T21:22:43.443Z,1533158563.443 [DataOverHttps](INFO): Sending 286 bytes from file Logs/20180801T210145/Express0010.lzma
2018-08-01T21:22:45.839Z,1533158565.839 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Express0010.lzma.bak
2018-08-01T21:22:45.840Z,1533158565.840 [DataOverHttps](INFO): SBD MOMSN=8392229
2018-08-01T21:22:46.525Z,1533158566.525 [Default:CheckIn:Read_Iridium] Stopped
2018-08-01T21:22:46.525Z,1533158566.525 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-01T21:22:46.525Z,1533158566.525 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-01T21:22:53.998Z,1533158573.998 [NAL9602](INFO): Powering down
2018-08-01T21:25:38.333Z,1533158738.333 [BPC1](FAULT): Failed to receive data from all sticks prior to timeout. Missing data from 9 sticks.
2018-08-01T21:25:38.333Z,1533158738.333 [BPC1] Data Fault, FailCount= 2
2018-08-01T21:25:38.333Z,1533158738.333 [BPC1](ERROR): Data Fault
2018-08-01T21:25:38.393Z,1533158738.393 [CBIT](ERROR): Data Fault in component: BPC1
2018-08-01T21:25:39.568Z,1533158739.568 [CBIT](INFO): Clearing failed state for component BPC1
2018-08-01T21:25:39.568Z,1533158739.568 [BPC1] No Fault, FailCount= 2
2018-08-01T21:27:47.085Z,1533158867.085 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-01T21:27:47.085Z,1533158867.085 [Default:CheckIn:C.Wait] Stopped
2018-08-01T21:27:47.085Z,1533158867.085 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-01T21:27:47.086Z,1533158867.086 [Default:CheckIn:D] Running Loop=1
2018-08-01T21:27:47.512Z,1533158867.512 [Default:CheckIn:D] Stopped
2018-08-01T21:27:47.512Z,1533158867.512 [Default:CheckIn:E] Running Loop=1
2018-08-01T21:27:47.875Z,1533158867.875 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 57.469893 min 
2018-08-01T21:27:47.875Z,1533158867.875 [Default:CheckIn:E] Stopped
2018-08-01T21:27:47.875Z,1533158867.875 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-01T21:27:47.875Z,1533158867.875 [Default:CheckIn] Stopped
2018-08-01T21:27:47.875Z,1533158867.875 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-01T21:27:47.875Z,1533158867.875 [Default:CheckIn](INFO): Running loop #8
2018-08-01T21:27:47.876Z,1533158867.876 [Default:CheckIn] Running Loop=8
2018-08-01T21:27:47.876Z,1533158867.876 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-01T21:27:47.876Z,1533158867.876 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-01T21:27:48.595Z,1533158868.595 [NAL9602](INFO): Powering up
2018-08-01T21:27:59.566Z,1533158879.566 [NAL9602](INFO): NAL9602 initialized
2018-08-01T21:28:12.768Z,1533158892.768 [NAL9602](INFO): SBD MO Status=0, MOMSN=8020, MT Status=0, MTMSN=0
2018-08-01T21:28:12.768Z,1533158892.768 [NAL9602](INFO): No messages in MT queue
2018-08-01T21:28:25.566Z,1533158905.566 [NAL9602](INFO): GPS fix at 20180801T212806: (36.802759, -121.786927)
2018-08-01T21:28:25.644Z,1533158905.644 [Default:CheckIn:Read_GPS] Stopped
2018-08-01T21:28:25.644Z,1533158905.644 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-01T21:28:31.715Z,1533158911.715 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20180801T210145/Courier0012.lzma
2018-08-01T21:28:33.312Z,1533158913.312 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Courier0012.lzma.bak
2018-08-01T21:28:33.312Z,1533158913.312 [DataOverHttps](INFO): SBD MOMSN=8392237
2018-08-01T21:28:48.766Z,1533158928.766 [DataOverHttps](INFO): Sending 191 bytes from file Logs/20180801T210145/Express0013.lzma
2018-08-01T21:28:51.164Z,1533158931.164 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Express0013.lzma.bak
2018-08-01T21:28:51.164Z,1533158931.164 [DataOverHttps](INFO): SBD MOMSN=8392240
2018-08-01T21:28:51.699Z,1533158931.699 [Default:CheckIn:Read_Iridium] Stopped
2018-08-01T21:28:51.699Z,1533158931.699 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-01T21:28:51.699Z,1533158931.699 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-01T21:28:57.722Z,1533158937.722 [NAL9602](INFO): Powering down
2018-08-01T21:30:47.970Z,1533159047.970 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-01T21:30:47.970Z,1533159047.970 [Rowe_600LCM] No Fault, FailCount= 5
2018-08-01T21:30:48.125Z,1533159048.125 [Rowe_600LCM](INFO): Initializing
2018-08-01T21:30:48.125Z,1533159048.125 [Rowe_600LCM](INFO): Checking LCM
2018-08-01T21:30:48.125Z,1533159048.125 [Rowe_600LCM](INFO): LCM OK
2018-08-01T21:30:48.126Z,1533159048.126 [Rowe_600LCM](INFO): Powering up
2018-08-01T21:30:52.254Z,1533159052.254 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-01T21:30:52.392Z,1533159052.392 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-08-01T21:30:52.393Z,1533159052.393 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-01T21:30:52.394Z,1533159052.394 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-01T21:30:52.395Z,1533159052.395 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-01T21:31:23.870Z,1533159083.870 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2018-08-01T21:31:24.680Z,1533159084.680 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2018-08-01T21:32:48.133Z,1533159168.133 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-01T21:32:48.133Z,1533159168.133 [Rowe_600LCM] Communications Fault, FailCount= 1
2018-08-01T21:32:48.133Z,1533159168.133 [Rowe_600LCM](ERROR): Communications Fault
2018-08-01T21:32:48.247Z,1533159168.247 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-01T21:32:48.537Z,1533159168.537 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-01T21:32:48.791Z,1533159168.791 [Rowe_600LCM](INFO): Powering down
2018-08-01T21:32:50.232Z,1533159170.232 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-01T21:32:50.232Z,1533159170.232 [Rowe_600LCM] No Fault, FailCount= 1
2018-08-01T21:32:50.405Z,1533159170.405 [Rowe_600LCM](INFO): Initializing
2018-08-01T21:32:50.405Z,1533159170.405 [Rowe_600LCM](INFO): Checking LCM
2018-08-01T21:32:50.406Z,1533159170.406 [Rowe_600LCM](INFO): LCM OK
2018-08-01T21:32:50.406Z,1533159170.406 [Rowe_600LCM](INFO): Powering up
2018-08-01T21:32:54.585Z,1533159174.585 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-01T21:32:54.725Z,1533159174.725 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-08-01T21:32:54.727Z,1533159174.727 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-01T21:32:54.728Z,1533159174.728 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-01T21:32:54.728Z,1533159174.728 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-01T21:33:52.285Z,1533159232.285 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-01T21:33:52.286Z,1533159232.286 [Default:CheckIn:C.Wait] Stopped
2018-08-01T21:33:52.286Z,1533159232.286 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-01T21:33:52.286Z,1533159232.286 [Default:CheckIn:D] Running Loop=1
2018-08-01T21:33:52.681Z,1533159232.681 [Default:CheckIn:D] Stopped
2018-08-01T21:33:52.681Z,1533159232.681 [Default:CheckIn:E] Running Loop=1
2018-08-01T21:33:53.080Z,1533159233.080 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.555969 min 
2018-08-01T21:33:53.080Z,1533159233.080 [Default:CheckIn:E] Stopped
2018-08-01T21:33:53.080Z,1533159233.080 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-01T21:33:53.080Z,1533159233.080 [Default:CheckIn] Stopped
2018-08-01T21:33:53.080Z,1533159233.080 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-01T21:33:53.081Z,1533159233.081 [Default:CheckIn](INFO): Running loop #9
2018-08-01T21:33:53.081Z,1533159233.081 [Default:CheckIn] Running Loop=9
2018-08-01T21:33:53.081Z,1533159233.081 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-01T21:33:53.081Z,1533159233.081 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-01T21:33:53.810Z,1533159233.810 [NAL9602](INFO): Powering up
2018-08-01T21:34:04.675Z,1533159244.675 [NAL9602](INFO): NAL9602 initialized
2018-08-01T21:34:32.454Z,1533159272.454 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2018-08-01T21:34:33.250Z,1533159273.250 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2018-08-01T21:34:51.161Z,1533159291.161 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-01T21:34:51.161Z,1533159291.161 [Rowe_600LCM] Communications Fault, FailCount= 2
2018-08-01T21:34:51.161Z,1533159291.161 [Rowe_600LCM](ERROR): Communications Fault
2018-08-01T21:34:51.245Z,1533159291.245 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-01T21:34:51.565Z,1533159291.565 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-01T21:34:51.849Z,1533159291.849 [Rowe_600LCM](INFO): Powering down
2018-08-01T21:34:53.239Z,1533159293.239 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-01T21:34:53.239Z,1533159293.239 [Rowe_600LCM] No Fault, FailCount= 2
2018-08-01T21:34:53.483Z,1533159293.483 [Rowe_600LCM](INFO): Initializing
2018-08-01T21:34:53.485Z,1533159293.485 [Rowe_600LCM](INFO): Checking LCM
2018-08-01T21:34:53.485Z,1533159293.485 [Rowe_600LCM](INFO): LCM OK
2018-08-01T21:34:53.485Z,1533159293.485 [Rowe_600LCM](INFO): Powering up
2018-08-01T21:34:57.769Z,1533159297.769 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-01T21:34:57.919Z,1533159297.919 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-08-01T21:34:57.921Z,1533159297.921 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-01T21:34:57.922Z,1533159297.922 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-01T21:34:57.923Z,1533159297.923 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-01T21:36:53.685Z,1533159413.685 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-01T21:36:53.685Z,1533159413.685 [Rowe_600LCM] Communications Fault, FailCount= 3
2018-08-01T21:36:53.685Z,1533159413.685 [Rowe_600LCM](ERROR): Communications Fault
2018-08-01T21:36:53.813Z,1533159413.813 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-01T21:36:54.089Z,1533159414.089 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-01T21:36:54.348Z,1533159414.348 [Rowe_600LCM](INFO): Powering down
2018-08-01T21:36:55.802Z,1533159415.802 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-01T21:36:55.802Z,1533159415.802 [Rowe_600LCM] No Fault, FailCount= 3
2018-08-01T21:36:55.965Z,1533159415.965 [Rowe_600LCM](INFO): Initializing
2018-08-01T21:36:55.965Z,1533159415.965 [Rowe_600LCM](INFO): Checking LCM
2018-08-01T21:36:55.965Z,1533159415.965 [Rowe_600LCM](INFO): LCM OK
2018-08-01T21:36:55.966Z,1533159415.966 [Rowe_600LCM](INFO): Powering up
2018-08-01T21:37:00.171Z,1533159420.171 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-01T21:37:00.279Z,1533159420.279 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-08-01T21:37:00.281Z,1533159420.281 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-01T21:37:00.282Z,1533159420.282 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-01T21:37:00.283Z,1533159420.283 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-01T21:37:16.568Z,1533159436.568 [NAL9602](INFO): SBD MO Status=0, MOMSN=8021, MT Status=0, MTMSN=0
2018-08-01T21:37:16.569Z,1533159436.569 [NAL9602](INFO): No messages in MT queue
2018-08-01T21:38:53.160Z,1533159533.160 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-08-01T21:33:53.1Z
2018-08-01T21:38:53.160Z,1533159533.160 [Default:CheckIn:Read_GPS] Stopped
2018-08-01T21:38:53.160Z,1533159533.160 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-01T21:38:56.673Z,1533159536.673 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-01T21:38:56.673Z,1533159536.673 [Rowe_600LCM] Communications Fault, FailCount= 4
2018-08-01T21:38:56.673Z,1533159536.673 [Rowe_600LCM](ERROR): Communications Fault
2018-08-01T21:38:56.781Z,1533159536.781 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-01T21:38:57.087Z,1533159537.087 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-01T21:38:57.342Z,1533159537.342 [Rowe_600LCM](INFO): Powering down
2018-08-01T21:38:58.752Z,1533159538.752 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-01T21:38:58.757Z,1533159538.757 [Rowe_600LCM] No Fault, FailCount= 4
2018-08-01T21:38:58.957Z,1533159538.957 [Rowe_600LCM](INFO): Initializing
2018-08-01T21:38:58.957Z,1533159538.957 [Rowe_600LCM](INFO): Checking LCM
2018-08-01T21:38:58.958Z,1533159538.958 [Rowe_600LCM](INFO): LCM OK
2018-08-01T21:38:58.958Z,1533159538.958 [Rowe_600LCM](INFO): Powering up
2018-08-01T21:39:03.134Z,1533159543.134 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-01T21:39:03.233Z,1533159543.233 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-08-01T21:39:03.234Z,1533159543.234 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-01T21:39:03.235Z,1533159543.235 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-01T21:39:03.236Z,1533159543.236 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-01T21:39:08.406Z,1533159548.406 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180801T210145/Courier0015.lzma
2018-08-01T21:39:10.004Z,1533159550.004 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Courier0015.lzma.bak
2018-08-01T21:39:10.004Z,1533159550.004 [DataOverHttps](INFO): SBD MOMSN=8392246
2018-08-01T21:39:24.867Z,1533159564.867 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20180801T210145/Express0016.lzma
2018-08-01T21:39:25.666Z,1533159565.666 [NAL9602](INFO): Powering down
2018-08-01T21:39:27.264Z,1533159567.264 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Express0016.lzma.bak
2018-08-01T21:39:27.264Z,1533159567.264 [DataOverHttps](INFO): SBD MOMSN=8392248
2018-08-01T21:39:27.875Z,1533159567.875 [Default:CheckIn:Read_Iridium] Stopped
2018-08-01T21:39:27.875Z,1533159567.875 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-01T21:39:27.875Z,1533159567.875 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-01T21:40:04.942Z,1533159604.942 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2018-08-01T21:40:05.738Z,1533159605.738 [Rowe_600LCM](DEBUG): LCB error: Software Overcurrent.
2018-08-01T21:40:59.537Z,1533159659.537 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-01T21:40:59.537Z,1533159659.537 [Rowe_600LCM] Communications Fault, FailCount= 5
2018-08-01T21:40:59.537Z,1533159659.537 [Rowe_600LCM](ERROR): Communications Fault
2018-08-01T21:40:59.710Z,1533159659.710 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-01T21:40:59.710Z,1533159659.710 [CBIT](FAULT): Communications Fault in component: Rowe_600LCM
2018-08-01T21:40:59.941Z,1533159659.941 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-01T21:41:00.133Z,1533159660.133 [Rowe_600LCM](INFO): Powering down
2018-08-01T21:44:28.260Z,1533159868.260 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-01T21:44:28.260Z,1533159868.260 [Default:CheckIn:C.Wait] Stopped
2018-08-01T21:44:28.260Z,1533159868.260 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-01T21:44:28.260Z,1533159868.260 [Default:CheckIn:D] Running Loop=1
2018-08-01T21:44:28.681Z,1533159868.681 [Default:CheckIn:D] Stopped
2018-08-01T21:44:28.681Z,1533159868.681 [Default:CheckIn:E] Running Loop=1
2018-08-01T21:44:29.065Z,1533159869.065 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 74.155900 min 
2018-08-01T21:44:29.065Z,1533159869.065 [Default:CheckIn:E] Stopped
2018-08-01T21:44:29.065Z,1533159869.065 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-01T21:44:29.065Z,1533159869.065 [Default:CheckIn] Stopped
2018-08-01T21:44:29.065Z,1533159869.065 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-01T21:44:29.066Z,1533159869.066 [Default:CheckIn](INFO): Running loop #10
2018-08-01T21:44:29.066Z,1533159869.066 [Default:CheckIn] Running Loop=10
2018-08-01T21:44:29.066Z,1533159869.066 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-01T21:44:29.066Z,1533159869.066 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-01T21:44:29.802Z,1533159869.802 [NAL9602](INFO): Powering up
2018-08-01T21:44:40.750Z,1533159880.750 [NAL9602](INFO): NAL9602 initialized
2018-08-01T21:44:41.550Z,1533159881.550 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-08-01T21:44:41.550Z,1533159881.550 [NAL9602] Data Fault, FailCount= 1
2018-08-01T21:44:41.550Z,1533159881.550 [NAL9602](ERROR): Data Fault
2018-08-01T21:44:41.693Z,1533159881.693 [CBIT](ERROR): Data Fault in component: NAL9602
2018-08-01T21:44:41.950Z,1533159881.950 [NAL9602](INFO): Powering down
2018-08-01T21:44:42.883Z,1533159882.883 [CBIT](INFO): Clearing failed state for component NAL9602
2018-08-01T21:44:42.883Z,1533159882.883 [NAL9602] No Fault, FailCount= 1
2018-08-01T21:45:12.350Z,1533159912.350 [NAL9602](INFO): Powering up NAL9602
2018-08-01T21:45:23.550Z,1533159923.550 [NAL9602](INFO): NAL9602 initialized
2018-08-01T21:46:40.291Z,1533160000.291 [BPC1](FAULT): Failed to receive data from all sticks prior to timeout. Missing data from 9 sticks.
2018-08-01T21:46:40.291Z,1533160000.291 [BPC1] Data Fault, FailCount= 3
2018-08-01T21:46:40.291Z,1533160000.291 [BPC1](ERROR): Data Fault
2018-08-01T21:46:40.377Z,1533160000.377 [CBIT](ERROR): Data Fault in component: BPC1
2018-08-01T21:46:41.554Z,1533160001.554 [CBIT](INFO): Clearing failed state for component BPC1
2018-08-01T21:46:41.554Z,1533160001.554 [BPC1] No Fault, FailCount= 3
2018-08-01T21:49:03.420Z,1533160143.420 [NAL9602](INFO): SBD MO Status=2, MOMSN=8022, MT Status=2, MTMSN=0
2018-08-01T21:49:03.420Z,1533160143.420 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-01T21:49:21.012Z,1533160161.012 [NAL9602](INFO): SBD MO Status=2, MOMSN=8022, MT Status=2, MTMSN=0
2018-08-01T21:49:21.012Z,1533160161.012 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-01T21:49:29.070Z,1533160169.070 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-08-01T21:44:29.1Z
2018-08-01T21:49:29.070Z,1533160169.070 [Default:CheckIn:Read_GPS] Stopped
2018-08-01T21:49:29.071Z,1533160169.071 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-01T21:49:33.096Z,1533160173.096 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180801T210145/Courier0018.lzma
2018-08-01T21:49:33.896Z,1533160173.896 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Courier0018.lzma.bak
2018-08-01T21:49:33.896Z,1533160173.896 [DataOverHttps](INFO): SBD MOMSN=8392254
2018-08-01T21:49:42.846Z,1533160182.846 [DataOverHttps](INFO): Sending 349 bytes from file Logs/20180801T210145/Express0019.lzma
2018-08-01T21:49:43.635Z,1533160183.635 [DataOverHttps](INFO): Moved sent file to Logs/20180801T210145/Express0019.lzma.bak
2018-08-01T21:49:43.636Z,1533160183.636 [DataOverHttps](INFO): SBD MOMSN=8392256
2018-08-01T21:49:44.182Z,1533160184.182 [Default:CheckIn:Read_Iridium] Stopped
2018-08-01T21:49:44.182Z,1533160184.182 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-01T21:49:44.182Z,1533160184.182 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-01T21:50:27.268Z,1533160227.268 [NAL9602](INFO): SBD MO Status=2, MOMSN=8022, MT Status=2, MTMSN=0
2018-08-01T21:50:27.268Z,1533160227.268 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-01T21:50:27.666Z,1533160227.666 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-08-01T21:50:58.210Z,1533160258.210 [NAL9602](INFO): Powering down
2018-08-01T21:50:59.871Z,1533160259.871 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-01T21:50:59.871Z,1533160259.871 [Rowe_600LCM] No Fault, FailCount= 5
2018-08-01T21:51:00.005Z,1533160260.005 [Rowe_600LCM](INFO): Initializing
2018-08-01T21:51:00.005Z,1533160260.005 [Rowe_600LCM](INFO): Checking LCM
2018-08-01T21:51:00.005Z,1533160260.005 [Rowe_600LCM](INFO): LCM OK
2018-08-01T21:51:00.006Z,1533160260.006 [Rowe_600LCM](INFO): Powering up
2018-08-01T21:51:04.134Z,1533160264.134 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-01T21:51:04.248Z,1533160264.248 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-08-01T21:51:04.261Z,1533160264.261 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-01T21:51:04.262Z,1533160264.262 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-01T21:51:04.263Z,1533160264.263 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-01T21:53:00.641Z,1533160380.641 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-01T21:53:00.641Z,1533160380.641 [Rowe_600LCM] Communications Fault, FailCount= 1
2018-08-01T21:53:00.641Z,1533160380.641 [Rowe_600LCM](ERROR): Communications Fault
2018-08-01T21:53:00.759Z,1533160380.759 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-01T21:53:01.045Z,1533160381.045 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-01T21:53:01.290Z,1533160381.290 [Rowe_600LCM](INFO): Powering down
2018-08-01T21:53:02.709Z,1533160382.709 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-01T21:53:02.709Z,1533160382.709 [Rowe_600LCM] No Fault, FailCount= 1
2018-08-01T21:53:02.905Z,1533160382.905 [Rowe_600LCM](INFO): Initializing
2018-08-01T21:53:02.905Z,1533160382.905 [Rowe_600LCM](INFO): Checking LCM
2018-08-01T21:53:02.906Z,1533160382.906 [Rowe_600LCM](INFO): LCM OK
2018-08-01T21:53:02.906Z,1533160382.906 [Rowe_600LCM](INFO): Powering up
2018-08-01T21:53:07.094Z,1533160387.094 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-01T21:53:07.219Z,1533160387.219 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-08-01T21:53:07.221Z,1533160387.221 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-01T21:53:07.222Z,1533160387.222 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-01T21:53:07.222Z,1533160387.222 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-01T21:53:12.681Z,1533160392.681 [BPC1](ERROR): Bank A: No match for stick 6 serial number:1717 in the onboard configuration file.
2018-08-01T21:53:12.681Z,1533160392.681 [BPC1](ERROR): Failed to parse Bank A battery data
2018-08-01T21:54:44.691Z,1533160484.691 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-01T21:54:44.692Z,1533160484.692 [Default:CheckIn:C.Wait] Stopped
2018-08-01T21:54:44.692Z,1533160484.692 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-01T21:54:44.692Z,1533160484.692 [Default:CheckIn:D] Running Loop=1
2018-08-01T21:54:45.106Z,1533160485.106 [Default:CheckIn:D] Stopped
2018-08-01T21:54:45.106Z,1533160485.106 [Default:CheckIn:E] Running Loop=1
2018-08-01T21:54:45.478Z,1533160485.478 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.429793 min 
2018-08-01T21:54:45.478Z,1533160485.478 [Default:CheckIn:E] Stopped
2018-08-01T21:54:45.479Z,1533160485.479 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-01T21:54:45.479Z,1533160485.479 [Default:CheckIn] Stopped
2018-08-01T21: