2018-08-27T16:31:51.409Z,1535387511.409 [CommandLine](IMPORTANT): got command restart logs
2018-08-27T16:32:00.202Z,1535387520.202 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20180827T122456/Express0047.lzma
2018-08-27T16:32:00.000Z,1535387521.000 [DataOverHttps](INFO): Moved sent file to Logs/20180827T122456/Express0047.lzma.bak
2018-08-27T16:32:00.000Z,1535387521.000 [DataOverHttps](INFO): SBD MOMSN=8448108
2018-08-27T16:32:13.266Z,1535387533.266 [NAL9602](INFO): Powering down
2018-08-27T16:32:13.773Z,1535387533.773 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180827T122456/Courier0049.lzma
2018-08-27T16:32:16.871Z,1535387536.871 [DataOverHttps](INFO): Moved sent file to Logs/20180827T122456/Courier0049.lzma.bak
2018-08-27T16:32:16.871Z,1535387536.871 [DataOverHttps](INFO): SBD MOMSN=8448112
2018-08-27T16:32:29.011Z,1535387549.011 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180827T163151/Courier0000.lzma
2018-08-27T16:32:29.783Z,1535387549.783 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Courier0000.lzma.bak
2018-08-27T16:32:29.784Z,1535387549.784 [DataOverHttps](INFO): SBD MOMSN=8448114
2018-08-27T16:32:41.867Z,1535387561.867 [DataOverHttps](INFO): Sending 115 bytes from file Logs/20180827T122456/Express0050.lzma
2018-08-27T16:32:42.655Z,1535387562.655 [DataOverHttps](INFO): Moved sent file to Logs/20180827T122456/Express0050.lzma.bak
2018-08-27T16:32:42.656Z,1535387562.656 [DataOverHttps](INFO): SBD MOMSN=8448117
2018-08-27T16:32:55.665Z,1535387575.665 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180827T163151/Express0001.lzma
2018-08-27T16:32:56.463Z,1535387576.463 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Express0001.lzma.bak
2018-08-27T16:32:56.463Z,1535387576.463 [DataOverHttps](INFO): SBD MOMSN=8448120
2018-08-27T16:32:58.509Z,1535387578.509 [Default:CheckIn:Read_Iridium] Stopped
2018-08-27T16:32:58.509Z,1535387578.509 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-27T16:32:58.510Z,1535387578.510 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-27T16:37:58.647Z,1535387878.647 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-27T16:37:58.647Z,1535387878.647 [Default:CheckIn:C.Wait] Stopped
2018-08-27T16:37:58.647Z,1535387878.647 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-27T16:37:58.648Z,1535387878.648 [Default:CheckIn:D] Running Loop=1
2018-08-27T16:37:59.055Z,1535387879.055 [Default:CheckIn:D] Stopped
2018-08-27T16:37:59.055Z,1535387879.055 [Default:CheckIn:E] Running Loop=1
2018-08-27T16:37:59.560Z,1535387879.560 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 34.401558 min 
2018-08-27T16:37:59.560Z,1535387879.560 [Default:CheckIn:E] Stopped
2018-08-27T16:37:59.560Z,1535387879.560 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-27T16:37:59.560Z,1535387879.560 [Default:CheckIn] Stopped
2018-08-27T16:37:59.560Z,1535387879.560 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-27T16:37:59.565Z,1535387879.565 [Default:CheckIn](INFO): Running loop #6
2018-08-27T16:37:59.565Z,1535387879.565 [Default:CheckIn] Running Loop=6
2018-08-27T16:37:59.565Z,1535387879.565 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-27T16:37:59.565Z,1535387879.565 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-27T16:38:03.370Z,1535387883.370 [NAL9602](INFO): Powering up
2018-08-27T16:38:14.380Z,1535387894.380 [NAL9602](INFO): NAL9602 initialized
2018-08-27T16:38:46.364Z,1535387926.364 [NAL9602](INFO): SBD MO Status=2, MOMSN=24166, MT Status=2, MTMSN=0
2018-08-27T16:38:46.364Z,1535387926.364 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-27T16:39:05.228Z,1535387945.228 [NAL9602](INFO): SBD MO Status=2, MOMSN=24166, MT Status=2, MTMSN=0
2018-08-27T16:39:05.228Z,1535387945.228 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-27T16:39:32.423Z,1535387972.423 [NAL9602](INFO): SBD MO Status=2, MOMSN=24166, MT Status=2, MTMSN=0
2018-08-27T16:39:32.424Z,1535387972.424 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-27T16:40:14.716Z,1535388014.716 [NAL9602](INFO): SBD MO Status=0, MOMSN=24166, MT Status=0, MTMSN=0
2018-08-27T16:40:14.716Z,1535388014.716 [NAL9602](INFO): No messages in MT queue
2018-08-27T16:40:15.906Z,1535388015.906 [NAL9602](INFO): GPS fix at 20180827T163928: (41.853893, -83.338808)
2018-08-27T16:40:15.960Z,1535388015.960 [Default:CheckIn:Read_GPS] Stopped
2018-08-27T16:40:15.965Z,1535388015.965 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-27T16:40:21.760Z,1535388021.760 [DataOverHttps](INFO): Sending 311 bytes from file Logs/20180827T163151/Courier0003.lzma
2018-08-27T16:40:22.550Z,1535388022.550 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Courier0003.lzma.bak
2018-08-27T16:40:22.550Z,1535388022.550 [DataOverHttps](INFO): SBD MOMSN=8448123
2018-08-27T16:40:38.278Z,1535388038.278 [DataOverHttps](INFO): Sending 383 bytes from file Logs/20180827T163151/Express0004.lzma
2018-08-27T16:40:39.075Z,1535388039.075 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Express0004.lzma.bak
2018-08-27T16:40:39.075Z,1535388039.075 [DataOverHttps](INFO): SBD MOMSN=8448126
2018-08-27T16:40:41.136Z,1535388041.136 [Default:CheckIn:Read_Iridium] Stopped
2018-08-27T16:40:41.136Z,1535388041.136 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-27T16:40:41.136Z,1535388041.136 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-27T16:40:47.666Z,1535388047.666 [NAL9602](INFO): Powering down
2018-08-27T16:45:17.474Z,1535388317.474 [BPC1](ERROR): Failed to receive data from both battery packs
2018-08-27T16:45:17.474Z,1535388317.474 [BPC1] Communications Fault, FailCount= 1
2018-08-27T16:45:17.474Z,1535388317.474 [BPC1](ERROR): Communications Fault
2018-08-27T16:45:17.499Z,1535388317.499 [CBIT](ERROR): Communications Fault in component: BPC1
2018-08-27T16:45:18.724Z,1535388318.724 [CBIT](INFO): Clearing failed state for component BPC1
2018-08-27T16:45:18.724Z,1535388318.724 [BPC1] No Fault, FailCount= 1
2018-08-27T16:45:41.483Z,1535388341.483 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-27T16:45:41.483Z,1535388341.483 [Default:CheckIn:C.Wait] Stopped
2018-08-27T16:45:41.483Z,1535388341.483 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-27T16:45:41.483Z,1535388341.483 [Default:CheckIn:D] Running Loop=1
2018-08-27T16:45:41.884Z,1535388341.884 [Default:CheckIn:D] Stopped
2018-08-27T16:45:41.884Z,1535388341.884 [Default:CheckIn:E] Running Loop=1
2018-08-27T16:45:45.475Z,1535388345.475 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.115381 min 
2018-08-27T16:45:45.475Z,1535388345.475 [Default:CheckIn:E] Stopped
2018-08-27T16:45:45.475Z,1535388345.475 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-27T16:45:45.476Z,1535388345.476 [Default:CheckIn] Stopped
2018-08-27T16:45:45.476Z,1535388345.476 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-27T16:45:45.476Z,1535388345.476 [Default:CheckIn](INFO): Running loop #7
2018-08-27T16:45:45.476Z,1535388345.476 [Default:CheckIn] Running Loop=7
2018-08-27T16:45:45.476Z,1535388345.476 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-27T16:45:45.476Z,1535388345.476 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-27T16:45:45.918Z,1535388345.918 [NAL9602](INFO): Powering up
2018-08-27T16:45:57.119Z,1535388357.119 [NAL9602](INFO): NAL9602 initialized
2018-08-27T16:46:11.512Z,1535388371.512 [NAL9602](INFO): SBD MO Status=0, MOMSN=24167, MT Status=0, MTMSN=0
2018-08-27T16:46:11.512Z,1535388371.512 [NAL9602](INFO): No messages in MT queue
2018-08-27T16:46:50.843Z,1535388410.843 [BPC1](ERROR): Bank A: No match for stick 3 serial number:1717 in the onboard configuration file.
2018-08-27T16:46:50.844Z,1535388410.844 [BPC1](ERROR): Failed to parse Bank A battery data
2018-08-27T16:48:11.646Z,1535388491.646 [NAL9602](INFO): GPS fix at 20180827T164724: (41.850578, -83.348223)
2018-08-27T16:48:11.709Z,1535388491.709 [Default:CheckIn:Read_GPS] Stopped
2018-08-27T16:48:11.709Z,1535388491.709 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-27T16:48:19.301Z,1535388499.301 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20180827T163151/Courier0006.lzma
2018-08-27T16:48:21.992Z,1535388501.992 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Courier0006.lzma.bak
2018-08-27T16:48:21.992Z,1535388501.992 [DataOverHttps](INFO): SBD MOMSN=8448131
2018-08-27T16:48:34.134Z,1535388514.134 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20180827T163151/Express0007.lzma
2018-08-27T16:48:34.931Z,1535388514.931 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Express0007.lzma.bak
2018-08-27T16:48:34.931Z,1535388514.931 [DataOverHttps](INFO): SBD MOMSN=8448135
2018-08-27T16:48:36.982Z,1535388516.982 [Default:CheckIn:Read_Iridium] Stopped
2018-08-27T16:48:36.982Z,1535388516.982 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-27T16:48:36.982Z,1535388516.982 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-27T16:48:43.451Z,1535388523.451 [NAL9602](INFO): Powering down
2018-08-27T16:53:37.140Z,1535388817.140 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-27T16:53:37.141Z,1535388817.141 [Default:CheckIn:C.Wait] Stopped
2018-08-27T16:53:37.141Z,1535388817.141 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-27T16:53:37.142Z,1535388817.142 [Default:CheckIn:D] Running Loop=1
2018-08-27T16:53:37.546Z,1535388817.546 [Default:CheckIn:D] Stopped
2018-08-27T16:53:37.546Z,1535388817.546 [Default:CheckIn:E] Running Loop=1
2018-08-27T16:53:37.993Z,1535388817.993 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.043070 min 
2018-08-27T16:53:37.993Z,1535388817.993 [Default:CheckIn:E] Stopped
2018-08-27T16:53:37.993Z,1535388817.993 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-27T16:53:37.994Z,1535388817.994 [Default:CheckIn] Stopped
2018-08-27T16:53:37.994Z,1535388817.994 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-27T16:53:37.994Z,1535388817.994 [Default:CheckIn](INFO): Running loop #8
2018-08-27T16:53:37.994Z,1535388817.994 [Default:CheckIn] Running Loop=8
2018-08-27T16:53:37.994Z,1535388817.994 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-27T16:53:37.994Z,1535388817.994 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-27T16:53:38.694Z,1535388818.694 [NAL9602](INFO): Powering up
2018-08-27T16:53:49.522Z,1535388829.522 [NAL9602](INFO): NAL9602 initialized
2018-08-27T16:54:13.524Z,1535388853.524 [NAL9602](INFO): SBD MO Status=2, MOMSN=24168, MT Status=2, MTMSN=0
2018-08-27T16:54:13.524Z,1535388853.524 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-27T16:54:23.929Z,1535388863.929 [NAL9602](INFO): SBD MO Status=0, MOMSN=24168, MT Status=0, MTMSN=0
2018-08-27T16:54:23.929Z,1535388863.929 [NAL9602](INFO): No messages in MT queue
2018-08-27T16:57:37.308Z,1535389057.308 [BPC1](ERROR): Failed to receive data from both battery packs
2018-08-27T16:57:37.308Z,1535389057.308 [BPC1] Communications Fault, FailCount= 2
2018-08-27T16:57:37.314Z,1535389057.314 [BPC1](ERROR): Communications Fault
2018-08-27T16:57:37.368Z,1535389057.368 [CBIT](ERROR): Communications Fault in component: BPC1
2018-08-27T16:57:38.546Z,1535389058.546 [CBIT](INFO): Clearing failed state for component BPC1
2018-08-27T16:57:38.546Z,1535389058.546 [BPC1] No Fault, FailCount= 2
2018-08-27T16:58:38.029Z,1535389118.029 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-08-27T16:53:37.0Z
2018-08-27T16:58:38.029Z,1535389118.029 [Default:CheckIn:Read_GPS] Stopped
2018-08-27T16:58:38.029Z,1535389118.029 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-27T16:58:43.267Z,1535389123.267 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180827T163151/Courier0009.lzma
2018-08-27T16:58:44.055Z,1535389124.055 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Courier0009.lzma.bak
2018-08-27T16:58:44.055Z,1535389124.055 [DataOverHttps](INFO): SBD MOMSN=8448139
2018-08-27T16:58:56.090Z,1535389136.090 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20180827T163151/Express0010.lzma
2018-08-27T16:58:56.887Z,1535389136.887 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Express0010.lzma.bak
2018-08-27T16:58:56.887Z,1535389136.887 [DataOverHttps](INFO): SBD MOMSN=8448141
2018-08-27T16:58:58.923Z,1535389138.923 [Default:CheckIn:Read_Iridium] Stopped
2018-08-27T16:58:58.923Z,1535389138.923 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-27T16:58:58.923Z,1535389138.923 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-27T16:59:16.380Z,1535389156.380 [NAL9602](INFO): Powering down
2018-08-27T17:03:42.962Z,1535389422.962 [BPC1](ERROR): Failed to receive data from both battery packs
2018-08-27T17:03:42.962Z,1535389422.962 [BPC1] Communications Fault, FailCount= 3
2018-08-27T17:03:42.962Z,1535389422.962 [BPC1](ERROR): Communications Fault
2018-08-27T17:03:42.999Z,1535389422.999 [CBIT](ERROR): Communications Fault in component: BPC1
2018-08-27T17:03:44.186Z,1535389424.186 [CBIT](INFO): Clearing failed state for component BPC1
2018-08-27T17:03:44.186Z,1535389424.186 [BPC1] No Fault, FailCount= 3
2018-08-27T17:03:59.386Z,1535389439.386 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-27T17:03:59.386Z,1535389439.386 [Default:CheckIn:C.Wait] Stopped
2018-08-27T17:03:59.386Z,1535389439.386 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-27T17:03:59.387Z,1535389439.387 [Default:CheckIn:D] Running Loop=1
2018-08-27T17:03:59.902Z,1535389439.902 [Default:CheckIn:D] Stopped
2018-08-27T17:03:59.902Z,1535389439.902 [Default:CheckIn:E] Running Loop=1
2018-08-27T17:04:03.354Z,1535389443.354 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 60.415645 min 
2018-08-27T17:04:03.354Z,1535389443.354 [Default:CheckIn:E] Stopped
2018-08-27T17:04:03.354Z,1535389443.354 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-27T17:04:03.354Z,1535389443.354 [Default:CheckIn] Stopped
2018-08-27T17:04:03.355Z,1535389443.355 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-27T17:04:03.355Z,1535389443.355 [Default:CheckIn](INFO): Running loop #9
2018-08-27T17:04:03.355Z,1535389443.355 [Default:CheckIn] Running Loop=9
2018-08-27T17:04:03.355Z,1535389443.355 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-27T17:04:03.355Z,1535389443.355 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-27T17:04:03.801Z,1535389443.801 [NAL9602](INFO): Powering up
2018-08-27T17:04:14.986Z,1535389454.986 [NAL9602](INFO): NAL9602 initialized
2018-08-27T17:04:15.803Z,1535389455.803 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-08-27T17:04:15.804Z,1535389455.804 [NAL9602] Data Fault, FailCount= 1
2018-08-27T17:04:15.804Z,1535389455.804 [NAL9602](ERROR): Data Fault
2018-08-27T17:04:15.957Z,1535389455.957 [CBIT](ERROR): Data Fault in component: NAL9602
2018-08-27T17:04:16.186Z,1535389456.186 [NAL9602](INFO): Powering down
2018-08-27T17:04:17.050Z,1535389457.050 [CBIT](INFO): Clearing failed state for component NAL9602
2018-08-27T17:04:17.050Z,1535389457.050 [NAL9602] No Fault, FailCount= 1
2018-08-27T17:04:46.589Z,1535389486.589 [NAL9602](INFO): Powering up NAL9602
2018-08-27T17:04:57.798Z,1535389497.798 [NAL9602](INFO): NAL9602 initialized
2018-08-27T17:05:32.224Z,1535389532.224 [NAL9602](INFO): SBD MO Status=0, MOMSN=24169, MT Status=0, MTMSN=0
2018-08-27T17:05:32.224Z,1535389532.224 [NAL9602](INFO): No messages in MT queue
2018-08-27T17:09:04.995Z,1535389744.995 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-08-27T17:04:03.4Z
2018-08-27T17:09:04.995Z,1535389744.995 [Default:CheckIn:Read_GPS] Stopped
2018-08-27T17:09:04.995Z,1535389744.995 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-27T17:09:06.357Z,1535389746.357 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180827T163151/Courier0012.lzma
2018-08-27T17:09:07.271Z,1535389747.271 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Courier0012.lzma.bak
2018-08-27T17:09:07.271Z,1535389747.271 [DataOverHttps](INFO): SBD MOMSN=8448145
2018-08-27T17:09:19.026Z,1535389759.026 [DataOverHttps](INFO): Sending 196 bytes from file Logs/20180827T163151/Express0013.lzma
2018-08-27T17:09:19.823Z,1535389759.823 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Express0013.lzma.bak
2018-08-27T17:09:19.823Z,1535389759.823 [DataOverHttps](INFO): SBD MOMSN=8448147
2018-08-27T17:09:21.925Z,1535389761.925 [Default:CheckIn:Read_Iridium] Stopped
2018-08-27T17:09:21.926Z,1535389761.926 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-27T17:09:21.926Z,1535389761.926 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-27T17:09:39.214Z,1535389779.214 [NAL9602](INFO): Powering down
2018-08-27T17:13:05.330Z,1535389985.330 [BPC1](ERROR): Failed to receive data from both battery packs
2018-08-27T17:13:05.330Z,1535389985.330 [BPC1] Communications Fault, FailCount= 4
2018-08-27T17:13:05.330Z,1535389985.330 [BPC1](ERROR): Communications Fault
2018-08-27T17:13:05.387Z,1535389985.387 [CBIT](ERROR): Communications Fault in component: BPC1
2018-08-27T17:13:06.560Z,1535389986.560 [CBIT](INFO): Clearing failed state for component BPC1
2018-08-27T17:13:06.560Z,1535389986.560 [BPC1] No Fault, FailCount= 4
2018-08-27T17:14:22.203Z,1535390062.203 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-27T17:14:22.204Z,1535390062.204 [Default:CheckIn:C.Wait] Stopped
2018-08-27T17:14:22.204Z,1535390062.204 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-27T17:14:22.204Z,1535390062.204 [Default:CheckIn:D] Running Loop=1
2018-08-27T17:14:22.611Z,1535390062.611 [Default:CheckIn:D] Stopped
2018-08-27T17:14:22.611Z,1535390062.611 [Default:CheckIn:E] Running Loop=1
2018-08-27T17:14:26.162Z,1535390066.162 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 70.794165 min 
2018-08-27T17:14:26.162Z,1535390066.162 [Default:CheckIn:E] Stopped
2018-08-27T17:14:26.163Z,1535390066.163 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-27T17:14:26.163Z,1535390066.163 [Default:CheckIn] Stopped
2018-08-27T17:14:26.163Z,1535390066.163 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-27T17:14:26.163Z,1535390066.163 [Default:CheckIn](INFO): Running loop #10
2018-08-27T17:14:26.163Z,1535390066.163 [Default:CheckIn] Running Loop=10
2018-08-27T17:14:26.163Z,1535390066.163 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-27T17:14:26.163Z,1535390066.163 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-27T17:14:26.594Z,1535390066.594 [NAL9602](INFO): Powering up
2018-08-27T17:14:37.791Z,1535390077.791 [NAL9602](INFO): NAL9602 initialized
2018-08-27T17:14:54.588Z,1535390094.588 [NAL9602](INFO): SBD MO Status=0, MOMSN=24170, MT Status=0, MTMSN=0
2018-08-27T17:14:54.588Z,1535390094.588 [NAL9602](INFO): No messages in MT queue
2018-08-27T17:14:58.594Z,1535390098.594 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-08-27T17:14:58.594Z,1535390098.594 [NAL9602] Data Fault, FailCount= 1
2018-08-27T17:14:58.594Z,1535390098.594 [NAL9602](ERROR): Data Fault
2018-08-27T17:14:58.668Z,1535390098.668 [CBIT](ERROR): Data Fault in component: NAL9602
2018-08-27T17:14:58.986Z,1535390098.986 [NAL9602](INFO): Powering down
2018-08-27T17:14:59.955Z,1535390099.955 [CBIT](INFO): Clearing failed state for component NAL9602
2018-08-27T17:14:59.956Z,1535390099.956 [NAL9602] No Fault, FailCount= 1
2018-08-27T17:15:29.110Z,1535390129.110 [NAL9602](INFO): Powering up NAL9602
2018-08-27T17:15:40.314Z,1535390140.314 [NAL9602](INFO): NAL9602 initialized
2018-08-27T17:19:07.386Z,1535390347.386 [BPC1](ERROR): Failed to receive data from both battery packs
2018-08-27T17:19:07.386Z,1535390347.386 [BPC1] Communications Fault, FailCount= 5
2018-08-27T17:19:07.386Z,1535390347.386 [BPC1](ERROR): Communications Fault
2018-08-27T17:19:07.412Z,1535390347.412 [CBIT](ERROR): Communications Fault in component: BPC1
2018-08-27T17:19:08.621Z,1535390348.621 [CBIT](INFO): Clearing failed state for component BPC1
2018-08-27T17:19:08.621Z,1535390348.621 [BPC1] No Fault, FailCount= 5
2018-08-27T17:19:26.956Z,1535390366.956 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-08-27T17:14:26.2Z
2018-08-27T17:19:26.956Z,1535390366.956 [Default:CheckIn:Read_GPS] Stopped
2018-08-27T17:19:26.956Z,1535390366.956 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-27T17:19:28.175Z,1535390368.175 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180827T163151/Courier0015.lzma
2018-08-27T17:19:28.791Z,1535390368.791 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Courier0015.lzma.bak
2018-08-27T17:19:28.791Z,1535390368.791 [DataOverHttps](INFO): SBD MOMSN=8448153
2018-08-27T17:19:48.248Z,1535390388.248 [DataOverHttps](INFO): Sending 172 bytes from file Logs/20180827T163151/Express0016.lzma
2018-08-27T17:19:49.036Z,1535390389.036 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Express0016.lzma.bak
2018-08-27T17:19:49.037Z,1535390389.037 [DataOverHttps](INFO): SBD MOMSN=8448155
2018-08-27T17:19:50.982Z,1535390390.982 [Default:CheckIn:Read_Iridium] Stopped
2018-08-27T17:19:50.982Z,1535390390.982 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-27T17:19:50.982Z,1535390390.982 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-27T17:19:58.659Z,1535390398.659 [NAL9602](INFO): Powering down
2018-08-27T17:21:32.545Z,1535390492.545 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T17:21:32.545Z,1535390492.545 [Rowe_600LCM] Communications Fault, FailCount= 1
2018-08-27T17:21:32.545Z,1535390492.545 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T17:21:32.713Z,1535390492.713 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T17:21:32.949Z,1535390492.949 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T17:21:33.129Z,1535390493.129 [Rowe_600LCM](INFO): Powering down
2018-08-27T17:21:34.515Z,1535390494.515 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T17:21:34.516Z,1535390494.516 [Rowe_600LCM] No Fault, FailCount= 1
2018-08-27T17:21:34.745Z,1535390494.745 [Rowe_600LCM](INFO): Initializing
2018-08-27T17:21:34.745Z,1535390494.745 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T17:21:34.746Z,1535390494.746 [Rowe_600LCM](INFO): LCM OK
2018-08-27T17:21:34.746Z,1535390494.746 [Rowe_600LCM](INFO): Powering up
2018-08-27T17:21:38.996Z,1535390498.996 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T17:21:39.060Z,1535390499.060 [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-27T17:21:39.062Z,1535390499.062 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T17:21:39.063Z,1535390499.063 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T17:21:39.064Z,1535390499.064 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T17:24:51.155Z,1535390691.155 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-27T17:24:51.156Z,1535390691.156 [Default:CheckIn:C.Wait] Stopped
2018-08-27T17:24:51.156Z,1535390691.156 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-27T17:24:51.156Z,1535390691.156 [Default:CheckIn:D] Running Loop=1
2018-08-27T17:24:51.555Z,1535390691.555 [Default:CheckIn:D] Stopped
2018-08-27T17:24:51.555Z,1535390691.555 [Default:CheckIn:E] Running Loop=1
2018-08-27T17:24:51.963Z,1535390691.963 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 81.276562 min 
2018-08-27T17:24:51.963Z,1535390691.963 [Default:CheckIn:E] Stopped
2018-08-27T17:24:51.964Z,1535390691.964 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-27T17:24:51.964Z,1535390691.964 [Default:CheckIn] Stopped
2018-08-27T17:24:51.964Z,1535390691.964 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-27T17:24:51.964Z,1535390691.964 [Default:CheckIn](INFO): Running loop #11
2018-08-27T17:24:51.964Z,1535390691.964 [Default:CheckIn] Running Loop=11
2018-08-27T17:24:51.964Z,1535390691.964 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-27T17:24:51.964Z,1535390691.964 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-27T17:24:52.710Z,1535390692.710 [NAL9602](INFO): Powering up
2018-08-27T17:25:03.871Z,1535390703.871 [NAL9602](INFO): NAL9602 initialized
2018-08-27T17:25:34.668Z,1535390734.668 [NAL9602](INFO): SBD MO Status=0, MOMSN=24171, MT Status=0, MTMSN=0
2018-08-27T17:25:34.669Z,1535390734.669 [NAL9602](INFO): No messages in MT queue
2018-08-27T17:25:41.472Z,1535390741.472 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-08-27T17:25:41.472Z,1535390741.472 [NAL9602] Data Fault, FailCount= 1
2018-08-27T17:25:41.472Z,1535390741.472 [NAL9602](ERROR): Data Fault
2018-08-27T17:25:41.572Z,1535390741.572 [CBIT](ERROR): Data Fault in component: NAL9602
2018-08-27T17:25:41.871Z,1535390741.871 [NAL9602](INFO): Powering down
2018-08-27T17:25:42.845Z,1535390742.845 [CBIT](INFO): Clearing failed state for component NAL9602
2018-08-27T17:25:42.846Z,1535390742.846 [NAL9602] No Fault, FailCount= 1
2018-08-27T17:26:12.218Z,1535390772.218 [NAL9602](INFO): Powering up NAL9602
2018-08-27T17:26:23.414Z,1535390783.414 [NAL9602](INFO): NAL9602 initialized
2018-08-27T17:26:25.866Z,1535390785.866 [BPC1](ERROR): Failed to receive data from both battery packs
2018-08-27T17:26:25.866Z,1535390785.866 [BPC1] Communications Fault, FailCount= 6
2018-08-27T17:26:25.866Z,1535390785.866 [BPC1](ERROR): Communications Fault
2018-08-27T17:26:25.982Z,1535390785.982 [CBIT](ERROR): Communications Fault in component: BPC1
2018-08-27T17:26:27.077Z,1535390787.077 [CBIT](INFO): Clearing failed state for component BPC1
2018-08-27T17:26:27.077Z,1535390787.077 [BPC1] No Fault, FailCount= 6
2018-08-27T17:29:52.199Z,1535390992.199 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-08-27T17:24:51.0Z
2018-08-27T17:29:52.199Z,1535390992.199 [Default:CheckIn:Read_GPS] Stopped
2018-08-27T17:29:52.199Z,1535390992.199 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-27T17:29:58.123Z,1535390998.123 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180827T163151/Courier0018.lzma
2018-08-27T17:29:58.919Z,1535390998.919 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Courier0018.lzma.bak
2018-08-27T17:29:58.919Z,1535390998.919 [DataOverHttps](INFO): SBD MOMSN=8448160
2018-08-27T17:30:10.826Z,1535391010.826 [DataOverHttps](INFO): Sending 265 bytes from file Logs/20180827T163151/Express0019.lzma
2018-08-27T17:30:11.623Z,1535391011.623 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Express0019.lzma.bak
2018-08-27T17:30:11.624Z,1535391011.624 [DataOverHttps](INFO): SBD MOMSN=8448162
2018-08-27T17:30:13.643Z,1535391013.643 [Default:CheckIn:Read_Iridium] Stopped
2018-08-27T17:30:13.643Z,1535391013.643 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-27T17:30:13.643Z,1535391013.643 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-27T17:30:28.174Z,1535391028.174 [NAL9602](INFO): Powering down
2018-08-27T17:31:14.389Z,1535391074.389 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T17:31:14.389Z,1535391074.389 [Rowe_600LCM] Communications Fault, FailCount= 2
2018-08-27T17:31:14.389Z,1535391074.389 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T17:31:14.793Z,1535391074.793 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T17:31:14.947Z,1535391074.947 [Rowe_600LCM](INFO): Powering down
2018-08-27T17:31:17.459Z,1535391077.459 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T17:31:17.459Z,1535391077.459 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T17:31:17.459Z,1535391077.459 [Rowe_600LCM] No Fault, FailCount= 2
2018-08-27T17:31:17.773Z,1535391077.773 [Rowe_600LCM](INFO): Initializing
2018-08-27T17:31:17.773Z,1535391077.773 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T17:31:17.774Z,1535391077.774 [Rowe_600LCM](INFO): LCM OK
2018-08-27T17:31:17.774Z,1535391077.774 [Rowe_600LCM](INFO): Powering up
2018-08-27T17:31:22.004Z,1535391082.004 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T17:31:22.079Z,1535391082.079 [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-27T17:31:22.080Z,1535391082.080 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T17:31:22.081Z,1535391082.081 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T17:31:22.082Z,1535391082.082 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T17:33:18.397Z,1535391198.397 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T17:33:18.397Z,1535391198.397 [Rowe_600LCM] Communications Fault, FailCount= 3
2018-08-27T17:33:18.397Z,1535391198.397 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T17:33:18.687Z,1535391198.687 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T17:33:18.801Z,1535391198.801 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T17:33:18.889Z,1535391198.889 [Rowe_600LCM](INFO): Powering down
2018-08-27T17:33:20.287Z,1535391200.287 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T17:33:20.287Z,1535391200.287 [Rowe_600LCM] No Fault, FailCount= 3
2018-08-27T17:33:20.505Z,1535391200.505 [Rowe_600LCM](INFO): Initializing
2018-08-27T17:33:20.505Z,1535391200.505 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T17:33:20.506Z,1535391200.506 [Rowe_600LCM](INFO): LCM OK
2018-08-27T17:33:20.506Z,1535391200.506 [Rowe_600LCM](INFO): Powering up
2018-08-27T17:33:24.730Z,1535391204.730 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T17:33:24.819Z,1535391204.819 [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-27T17:33:24.820Z,1535391204.820 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T17:33:24.823Z,1535391204.823 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T17:33:24.824Z,1535391204.824 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T17:35:13.798Z,1535391313.798 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-27T17:35:13.799Z,1535391313.799 [Default:CheckIn:C.Wait] Stopped
2018-08-27T17:35:13.799Z,1535391313.799 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-27T17:35:13.799Z,1535391313.799 [Default:CheckIn:D] Running Loop=1
2018-08-27T17:35:14.197Z,1535391314.197 [Default:CheckIn:D] Stopped
2018-08-27T17:35:14.197Z,1535391314.197 [Default:CheckIn:E] Running Loop=1
2018-08-27T17:35:14.608Z,1535391314.608 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 91.653931 min 
2018-08-27T17:35:14.617Z,1535391314.617 [Default:CheckIn:E] Stopped
2018-08-27T17:35:14.617Z,1535391314.617 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-27T17:35:14.618Z,1535391314.618 [Default:CheckIn] Stopped
2018-08-27T17:35:14.618Z,1535391314.618 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-27T17:35:14.618Z,1535391314.618 [Default:CheckIn](INFO): Running loop #12
2018-08-27T17:35:14.619Z,1535391314.619 [Default:CheckIn] Running Loop=12
2018-08-27T17:35:14.619Z,1535391314.619 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-27T17:35:14.619Z,1535391314.619 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-27T17:35:18.416Z,1535391318.416 [NAL9602](INFO): Powering up
2018-08-27T17:35:20.585Z,1535391320.585 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T17:35:20.585Z,1535391320.585 [Rowe_600LCM] Communications Fault, FailCount= 4
2018-08-27T17:35:20.585Z,1535391320.585 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T17:35:20.974Z,1535391320.974 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T17:35:20.989Z,1535391320.989 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T17:35:21.112Z,1535391321.112 [Rowe_600LCM](INFO): Powering down
2018-08-27T17:35:22.571Z,1535391322.571 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T17:35:22.571Z,1535391322.571 [Rowe_600LCM] No Fault, FailCount= 4
2018-08-27T17:35:22.730Z,1535391322.730 [Rowe_600LCM](INFO): Initializing
2018-08-27T17:35:22.731Z,1535391322.731 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T17:35:22.731Z,1535391322.731 [Rowe_600LCM](INFO): LCM OK
2018-08-27T17:35:22.731Z,1535391322.731 [Rowe_600LCM](INFO): Powering up
2018-08-27T17:35:26.855Z,1535391326.855 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T17:35:27.015Z,1535391327.015 [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-27T17:35:27.017Z,1535391327.017 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T17:35:27.018Z,1535391327.018 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T17:35:27.019Z,1535391327.019 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T17:35:29.286Z,1535391329.286 [NAL9602](INFO): NAL9602 initialized
2018-08-27T17:35:58.088Z,1535391358.088 [NAL9602](INFO): SBD MO Status=2, MOMSN=24172, MT Status=2, MTMSN=0
2018-08-27T17:35:58.088Z,1535391358.088 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-27T17:36:27.524Z,1535391387.524 [NAL9602](INFO): SBD MO Status=2, MOMSN=24172, MT Status=2, MTMSN=0
2018-08-27T17:36:27.524Z,1535391387.524 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-27T17:36:45.120Z,1535391405.120 [NAL9602](INFO): SBD MO Status=2, MOMSN=24172, MT Status=2, MTMSN=0
2018-08-27T17:36:45.120Z,1535391405.120 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-27T17:36:53.928Z,1535391413.928 [NAL9602](INFO): SBD MO Status=0, MOMSN=24172, MT Status=0, MTMSN=0
2018-08-27T17:36:53.928Z,1535391413.928 [NAL9602](INFO): No messages in MT queue
2018-08-27T17:36:54.718Z,1535391414.718 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-08-27T17:36:54.718Z,1535391414.718 [NAL9602] Data Fault, FailCount= 1
2018-08-27T17:36:54.719Z,1535391414.719 [NAL9602](ERROR): Data Fault
2018-08-27T17:36:54.880Z,1535391414.880 [CBIT](ERROR): Data Fault in component: NAL9602
2018-08-27T17:36:55.122Z,1535391415.122 [NAL9602](INFO): Powering down
2018-08-27T17:36:55.983Z,1535391415.983 [CBIT](INFO): Clearing failed state for component NAL9602
2018-08-27T17:36:55.983Z,1535391415.983 [NAL9602] No Fault, FailCount= 1
2018-08-27T17:37:22.777Z,1535391442.777 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T17:37:22.777Z,1535391442.777 [Rowe_600LCM] Communications Fault, FailCount= 5
2018-08-27T17:37:22.777Z,1535391442.777 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T17:37:23.169Z,1535391443.169 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T17:37:23.170Z,1535391443.170 [CBIT](FAULT): Communications Fault in component: Rowe_600LCM
2018-08-27T17:37:23.181Z,1535391443.181 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T17:37:23.286Z,1535391443.286 [Rowe_600LCM](INFO): Powering down
2018-08-27T17:37:25.474Z,1535391445.474 [NAL9602](INFO): Powering up NAL9602
2018-08-27T17:37:36.674Z,1535391456.674 [NAL9602](INFO): NAL9602 initialized
2018-08-27T17:38:43.067Z,1535391523.067 [NAL9602](INFO): GPS fix at 20180827T173749: (41.829527, -83.412421)
2018-08-27T17:38:43.163Z,1535391523.163 [Default:CheckIn:Read_GPS] Stopped
2018-08-27T17:38:43.164Z,1535391523.164 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-27T17:38:48.714Z,1535391528.714 [DataOverHttps](INFO): Sending 65 bytes from file Logs/20180827T163151/Courier0021.lzma
2018-08-27T17:38:49.512Z,1535391529.512 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Courier0021.lzma.bak
2018-08-27T17:38:49.512Z,1535391529.512 [DataOverHttps](INFO): SBD MOMSN=8448168
2018-08-27T17:39:05.751Z,1535391545.751 [DataOverHttps](INFO): Sending 326 bytes from file Logs/20180827T163151/Express0022.lzma
2018-08-27T17:39:06.547Z,1535391546.547 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Express0022.lzma.bak
2018-08-27T17:39:06.547Z,1535391546.547 [DataOverHttps](INFO): SBD MOMSN=8448171
2018-08-27T17:39:08.336Z,1535391548.336 [Default:CheckIn:Read_Iridium] Stopped
2018-08-27T17:39:08.336Z,1535391548.336 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-27T17:39:08.336Z,1535391548.336 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-27T17:39:18.394Z,1535391558.394 [NAL9602](INFO): Powering down
2018-08-27T17:44:08.835Z,1535391848.835 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-27T17:44:08.835Z,1535391848.835 [Default:CheckIn:C.Wait] Stopped
2018-08-27T17:44:08.835Z,1535391848.835 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-27T17:44:08.836Z,1535391848.836 [Default:CheckIn:D] Running Loop=1
2018-08-27T17:44:09.239Z,1535391849.239 [Default:CheckIn:D] Stopped
2018-08-27T17:44:09.240Z,1535391849.240 [Default:CheckIn:E] Running Loop=1
2018-08-27T17:44:09.647Z,1535391849.647 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 100.571297 min 
2018-08-27T17:44:09.647Z,1535391849.647 [Default:CheckIn:E] Stopped
2018-08-27T17:44:09.648Z,1535391849.648 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-27T17:44:09.648Z,1535391849.648 [Default:CheckIn] Stopped
2018-08-27T17:44:09.648Z,1535391849.648 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-27T17:44:09.648Z,1535391849.648 [Default:CheckIn](INFO): Running loop #13
2018-08-27T17:44:09.648Z,1535391849.648 [Default:CheckIn] Running Loop=13
2018-08-27T17:44:09.648Z,1535391849.648 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-27T17:44:09.648Z,1535391849.648 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-27T17:44:13.102Z,1535391853.102 [NAL9602](INFO): Powering up
2018-08-27T17:44:24.006Z,1535391864.006 [NAL9602](INFO): NAL9602 initialized
2018-08-27T17:44:46.008Z,1535391886.008 [NAL9602](INFO): SBD MO Status=0, MOMSN=24173, MT Status=0, MTMSN=0
2018-08-27T17:44:46.008Z,1535391886.008 [NAL9602](INFO): No messages in MT queue
2018-08-27T17:45:26.818Z,1535391926.818 [NAL9602](INFO): GPS fix at 20180827T174433: (41.827625, -83.412051)
2018-08-27T17:45:26.886Z,1535391926.886 [Default:CheckIn:Read_GPS] Stopped
2018-08-27T17:45:26.887Z,1535391926.887 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-27T17:45:33.950Z,1535391933.950 [DataOverHttps](INFO): Sending 65 bytes from file Logs/20180827T163151/Courier0024.lzma
2018-08-27T17:45:34.747Z,1535391934.747 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Courier0024.lzma.bak
2018-08-27T17:45:34.747Z,1535391934.747 [DataOverHttps](INFO): SBD MOMSN=8448180
2018-08-27T17:45:50.649Z,1535391950.649 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20180827T163151/Express0025.lzma
2018-08-27T17:45:51.443Z,1535391951.443 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Express0025.lzma.bak
2018-08-27T17:45:51.443Z,1535391951.443 [DataOverHttps](INFO): SBD MOMSN=8448183
2018-08-27T17:45:53.193Z,1535391953.193 [Default:CheckIn:Read_Iridium] Stopped
2018-08-27T17:45:53.194Z,1535391953.194 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-27T17:45:53.194Z,1535391953.194 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-27T17:45:58.878Z,1535391958.878 [NAL9602](INFO): Powering down
2018-08-27T17:46:36.113Z,1535391996.113 [BPC1](ERROR): Failed to receive data from both battery packs
2018-08-27T17:46:36.113Z,1535391996.113 [BPC1] Communications Fault, FailCount= 7
2018-08-27T17:46:36.113Z,1535391996.113 [BPC1](ERROR): Communications Fault
2018-08-27T17:46:36.173Z,1535391996.173 [CBIT](ERROR): Communications Fault in component: BPC1
2018-08-27T17:46:37.338Z,1535391997.338 [CBIT](INFO): Clearing failed state for component BPC1
2018-08-27T17:46:37.338Z,1535391997.338 [BPC1] No Fault, FailCount= 7
2018-08-27T17:47:22.935Z,1535392042.935 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T17:47:22.936Z,1535392042.936 [Rowe_600LCM] No Fault, FailCount= 5
2018-08-27T17:47:23.146Z,1535392043.146 [Rowe_600LCM](INFO): Initializing
2018-08-27T17:47:23.146Z,1535392043.146 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T17:47:23.147Z,1535392043.147 [Rowe_600LCM](INFO): LCM OK
2018-08-27T17:47:23.147Z,1535392043.147 [Rowe_600LCM](INFO): Powering up
2018-08-27T17:47:27.266Z,1535392047.266 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T17:47:27.408Z,1535392047.408 [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-27T17:47:27.409Z,1535392047.409 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T17:47:27.410Z,1535392047.410 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T17:47:27.411Z,1535392047.411 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T17:49:23.286Z,1535392163.286 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T17:49:23.286Z,1535392163.286 [Rowe_600LCM] Communications Fault, FailCount= 1
2018-08-27T17:49:23.286Z,1535392163.286 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T17:49:23.592Z,1535392163.592 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T17:49:23.689Z,1535392163.689 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T17:49:23.779Z,1535392163.779 [Rowe_600LCM](INFO): Powering down
2018-08-27T17:49:25.196Z,1535392165.196 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T17:49:25.196Z,1535392165.196 [Rowe_600LCM] No Fault, FailCount= 1
2018-08-27T17:49:25.393Z,1535392165.393 [Rowe_600LCM](INFO): Initializing
2018-08-27T17:49:25.393Z,1535392165.393 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T17:49:25.393Z,1535392165.393 [Rowe_600LCM](INFO): LCM OK
2018-08-27T17:49:25.394Z,1535392165.394 [Rowe_600LCM](INFO): Powering up
2018-08-27T17:49:29.515Z,1535392169.515 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T17:49:29.640Z,1535392169.640 [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-27T17:49:29.641Z,1535392169.641 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T17:49:29.642Z,1535392169.642 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T17:49:29.643Z,1535392169.643 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T17:50:53.529Z,1535392253.529 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-27T17:50:53.529Z,1535392253.529 [Default:CheckIn:C.Wait] Stopped
2018-08-27T17:50:53.529Z,1535392253.529 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-27T17:50:53.529Z,1535392253.529 [Default:CheckIn:D] Running Loop=1
2018-08-27T17:50:53.935Z,1535392253.935 [Default:CheckIn:D] Stopped
2018-08-27T17:50:53.935Z,1535392253.935 [Default:CheckIn:E] Running Loop=1
2018-08-27T17:50:54.340Z,1535392254.340 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 107.316227 min 
2018-08-27T17:50:54.340Z,1535392254.340 [Default:CheckIn:E] Stopped
2018-08-27T17:50:54.340Z,1535392254.340 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-27T17:50:54.340Z,1535392254.340 [Default:CheckIn] Stopped
2018-08-27T17:50:54.340Z,1535392254.340 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-27T17:50:54.340Z,1535392254.340 [Default:CheckIn](INFO): Running loop #14
2018-08-27T17:50:54.341Z,1535392254.341 [Default:CheckIn] Running Loop=14
2018-08-27T17:50:54.341Z,1535392254.341 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-27T17:50:54.341Z,1535392254.341 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-27T17:50:58.146Z,1535392258.146 [NAL9602](INFO): Powering up
2018-08-27T17:51:09.087Z,1535392269.087 [NAL9602](INFO): NAL9602 initialized
2018-08-27T17:51:26.053Z,1535392286.053 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T17:51:26.053Z,1535392286.053 [Rowe_600LCM] Communications Fault, FailCount= 2
2018-08-27T17:51:26.053Z,1535392286.053 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T17:51:26.349Z,1535392286.349 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T17:51:26.457Z,1535392286.457 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T17:51:26.545Z,1535392286.545 [Rowe_600LCM](INFO): Powering down
2018-08-27T17:51:27.954Z,1535392287.954 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T17:51:27.954Z,1535392287.954 [Rowe_600LCM] No Fault, FailCount= 2
2018-08-27T17:51:28.161Z,1535392288.161 [Rowe_600LCM](INFO): Initializing
2018-08-27T17:51:28.162Z,1535392288.162 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T17:51:28.162Z,1535392288.162 [Rowe_600LCM](INFO): LCM OK
2018-08-27T17:51:28.162Z,1535392288.162 [Rowe_600LCM](INFO): Powering up
2018-08-27T17:51:29.888Z,1535392289.888 [NAL9602](INFO): SBD MO Status=2, MOMSN=24174, MT Status=2, MTMSN=0
2018-08-27T17:51:29.888Z,1535392289.888 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-27T17:51:32.343Z,1535392292.343 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T17:51:32.420Z,1535392292.420 [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-27T17:51:32.429Z,1535392292.429 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T17:51:32.430Z,1535392292.430 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T17:51:32.431Z,1535392292.431 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T17:51:53.092Z,1535392313.092 [NAL9602](INFO): SBD MO Status=0, MOMSN=24174, MT Status=0, MTMSN=0
2018-08-27T17:51:53.092Z,1535392313.092 [NAL9602](INFO): No messages in MT queue
2018-08-27T17:51:54.297Z,1535392314.297 [NAL9602](INFO): GPS fix at 20180827T175059: (41.827115, -83.413140)
2018-08-27T17:51:54.494Z,1535392314.494 [Default:CheckIn:Read_GPS] Stopped
2018-08-27T17:51:54.494Z,1535392314.494 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-27T17:52:02.042Z,1535392322.042 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20180827T163151/Courier0027.lzma
2018-08-27T17:52:02.839Z,1535392322.839 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Courier0027.lzma.bak
2018-08-27T17:52:02.839Z,1535392322.839 [DataOverHttps](INFO): SBD MOMSN=8448187
2018-08-27T17:52:15.760Z,1535392335.760 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20180827T163151/Express0028.lzma
2018-08-27T17:52:16.555Z,1535392336.555 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Express0028.lzma.bak
2018-08-27T17:52:16.556Z,1535392336.556 [DataOverHttps](INFO): SBD MOMSN=8448190
2018-08-27T17:52:18.639Z,1535392338.639 [Default:CheckIn:Read_Iridium] Stopped
2018-08-27T17:52:18.639Z,1535392338.639 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-27T17:52:18.640Z,1535392338.640 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-27T17:52:31.054Z,1535392351.054 [NAL9602](INFO): Powering down
2018-08-27T17:53:28.253Z,1535392408.253 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T17:53:28.253Z,1535392408.253 [Rowe_600LCM] Communications Fault, FailCount= 3
2018-08-27T17:53:28.253Z,1535392408.253 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T17:53:28.630Z,1535392408.630 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T17:53:28.657Z,1535392408.657 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T17:53:28.790Z,1535392408.790 [Rowe_600LCM](INFO): Powering down
2018-08-27T17:53:30.246Z,1535392410.246 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T17:53:30.246Z,1535392410.246 [Rowe_600LCM] No Fault, FailCount= 3
2018-08-27T17:53:30.405Z,1535392410.405 [Rowe_600LCM](INFO): Initializing
2018-08-27T17:53:30.405Z,1535392410.405 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T17:53:30.406Z,1535392410.406 [Rowe_600LCM](INFO): LCM OK
2018-08-27T17:53:30.406Z,1535392410.406 [Rowe_600LCM](INFO): Powering up
2018-08-27T17:53:34.528Z,1535392414.528 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T17:53:34.688Z,1535392414.688 [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-27T17:53:34.689Z,1535392414.689 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T17:53:34.690Z,1535392414.690 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T17:53:34.691Z,1535392414.691 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T17:55:30.433Z,1535392530.433 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T17:55:30.433Z,1535392530.433 [Rowe_600LCM] Communications Fault, FailCount= 4
2018-08-27T17:55:30.433Z,1535392530.433 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T17:55:30.638Z,1535392530.638 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T17:55:30.837Z,1535392530.837 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T17:55:30.987Z,1535392530.987 [Rowe_600LCM](INFO): Powering down
2018-08-27T17:55:32.562Z,1535392532.562 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T17:55:32.562Z,1535392532.562 [Rowe_600LCM] No Fault, FailCount= 4
2018-08-27T17:55:32.602Z,1535392532.602 [Rowe_600LCM](INFO): Initializing
2018-08-27T17:55:32.602Z,1535392532.602 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T17:55:32.603Z,1535392532.603 [Rowe_600LCM](INFO): LCM OK
2018-08-27T17:55:32.603Z,1535392532.603 [Rowe_600LCM](INFO): Powering up
2018-08-27T17:55:36.820Z,1535392536.820 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T17:55:36.958Z,1535392536.958 [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-27T17:55:36.959Z,1535392536.959 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T17:55:36.960Z,1535392536.960 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T17:55:36.961Z,1535392536.961 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T17:57:18.887Z,1535392638.887 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-27T17:57:18.887Z,1535392638.887 [Default:CheckIn:C.Wait] Stopped
2018-08-27T17:57:18.887Z,1535392638.887 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-27T17:57:18.887Z,1535392638.887 [Default:CheckIn:D] Running Loop=1
2018-08-27T17:57:19.295Z,1535392639.295 [Default:CheckIn:D] Stopped
2018-08-27T17:57:19.295Z,1535392639.295 [Default:CheckIn:E] Running Loop=1
2018-08-27T17:57:19.760Z,1535392639.760 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 113.738892 min 
2018-08-27T17:57:19.760Z,1535392639.760 [Default:CheckIn:E] Stopped
2018-08-27T17:57:19.770Z,1535392639.770 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-27T17:57:19.771Z,1535392639.771 [Default:CheckIn] Stopped
2018-08-27T17:57:19.771Z,1535392639.771 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-27T17:57:19.772Z,1535392639.772 [Default:CheckIn](INFO): Running loop #15
2018-08-27T17:57:19.772Z,1535392639.772 [Default:CheckIn] Running Loop=15
2018-08-27T17:57:19.772Z,1535392639.772 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-27T17:57:19.772Z,1535392639.772 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-27T17:57:23.497Z,1535392643.497 [NAL9602](INFO): Powering up
2018-08-27T17:57:32.629Z,1535392652.629 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T17:57:32.629Z,1535392652.629 [Rowe_600LCM] Communications Fault, FailCount= 5
2018-08-27T17:57:32.629Z,1535392652.629 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T17:57:32.885Z,1535392652.885 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T17:57:32.886Z,1535392652.886 [CBIT](FAULT): Communications Fault in component: Rowe_600LCM
2018-08-27T17:57:33.033Z,1535392653.033 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T17:57:33.125Z,1535392653.125 [Rowe_600LCM](INFO): Powering down
2018-08-27T17:57:34.374Z,1535392654.374 [NAL9602](INFO): NAL9602 initialized
2018-08-27T17:59:15.576Z,1535392755.576 [NAL9602](INFO): SBD MO Status=0, MOMSN=24175, MT Status=0, MTMSN=0
2018-08-27T17:59:15.576Z,1535392755.576 [NAL9602](INFO): No messages in MT queue
2018-08-27T18:02:06.198Z,1535392926.198 [NAL9602](INFO): GPS fix at 20180827T180111: (41.828523, -83.411169)
2018-08-27T18:02:06.236Z,1535392926.236 [Default:CheckIn:Read_GPS] Stopped
2018-08-27T18:02:06.236Z,1535392926.236 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-27T18:02:11.802Z,1535392931.802 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20180827T163151/Courier0030.lzma
2018-08-27T18:02:12.599Z,1535392932.599 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Courier0030.lzma.bak
2018-08-27T18:02:12.600Z,1535392932.600 [DataOverHttps](INFO): SBD MOMSN=8448197
2018-08-27T18:02:24.126Z,1535392944.126 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20180827T163151/Express0031.lzma
2018-08-27T18:02:24.919Z,1535392944.919 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Express0031.lzma.bak
2018-08-27T18:02:24.920Z,1535392944.920 [DataOverHttps](INFO): SBD MOMSN=8448200
2018-08-27T18:02:26.705Z,1535392946.705 [Default:CheckIn:Read_Iridium] Stopped
2018-08-27T18:02:26.705Z,1535392946.705 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-27T18:02:26.705Z,1535392946.705 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-27T18:02:41.538Z,1535392961.538 [NAL9602](INFO): Powering down
2018-08-27T18:04:56.778Z,1535393096.778 [BPC1](ERROR): Failed to receive data from both battery packs
2018-08-27T18:04:56.779Z,1535393096.779 [BPC1] Communications Fault, FailCount= 1
2018-08-27T18:04:56.779Z,1535393096.779 [BPC1](ERROR): Communications Fault
2018-08-27T18:04:56.804Z,1535393096.804 [CBIT](ERROR): Communications Fault in component: BPC1
2018-08-27T18:04:58.009Z,1535393098.009 [CBIT](INFO): Clearing failed state for component BPC1
2018-08-27T18:04:58.009Z,1535393098.009 [BPC1] No Fault, FailCount= 1
2018-08-27T18:07:27.206Z,1535393247.206 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-27T18:07:27.207Z,1535393247.207 [Default:CheckIn:C.Wait] Stopped
2018-08-27T18:07:27.207Z,1535393247.207 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-27T18:07:27.207Z,1535393247.207 [Default:CheckIn:D] Running Loop=1
2018-08-27T18:07:27.615Z,1535393247.615 [Default:CheckIn:D] Stopped
2018-08-27T18:07:27.615Z,1535393247.615 [Default:CheckIn:E] Running Loop=1
2018-08-27T18:07:28.012Z,1535393248.012 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 123.877563 min 
2018-08-27T18:07:28.012Z,1535393248.012 [Default:CheckIn:E] Stopped
2018-08-27T18:07:28.012Z,1535393248.012 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-27T18:07:28.012Z,1535393248.012 [Default:CheckIn] Stopped
2018-08-27T18:07:28.012Z,1535393248.012 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-27T18:07:28.013Z,1535393248.013 [Default:CheckIn](INFO): Running loop #16
2018-08-27T18:07:28.013Z,1535393248.013 [Default:CheckIn] Running Loop=16
2018-08-27T18:07:28.013Z,1535393248.013 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-27T18:07:28.013Z,1535393248.013 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-27T18:07:28.762Z,1535393248.762 [NAL9602](INFO): Powering up
2018-08-27T18:07:33.127Z,1535393253.127 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T18:07:33.127Z,1535393253.127 [Rowe_600LCM] No Fault, FailCount= 5
2018-08-27T18:07:33.374Z,1535393253.374 [Rowe_600LCM](INFO): Initializing
2018-08-27T18:07:33.375Z,1535393253.375 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T18:07:33.375Z,1535393253.375 [Rowe_600LCM](INFO): LCM OK
2018-08-27T18:07:33.375Z,1535393253.375 [Rowe_600LCM](INFO): Powering up
2018-08-27T18:07:37.500Z,1535393257.500 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T18:07:37.624Z,1535393257.624 [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-27T18:07:37.625Z,1535393257.625 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T18:07:37.626Z,1535393257.626 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T18:07:37.627Z,1535393257.627 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T18:07:39.942Z,1535393259.942 [NAL9602](INFO): NAL9602 initialized
2018-08-27T18:08:57.108Z,1535393337.108 [NAL9602](INFO): SBD MO Status=2, MOMSN=24176, MT Status=2, MTMSN=0
2018-08-27T18:08:57.108Z,1535393337.108 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-27T18:09:33.160Z,1535393373.160 [NAL9602](INFO): SBD MO Status=2, MOMSN=24176, MT Status=2, MTMSN=0
2018-08-27T18:09:33.160Z,1535393373.160 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-27T18:09:33.733Z,1535393373.733 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T18:09:33.733Z,1535393373.733 [Rowe_600LCM] Communications Fault, FailCount= 1
2018-08-27T18:09:33.733Z,1535393373.733 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T18:09:34.035Z,1535393374.035 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T18:09:34.137Z,1535393374.137 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T18:09:34.228Z,1535393374.228 [Rowe_600LCM](INFO): Powering down
2018-08-27T18:09:35.627Z,1535393375.627 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T18:09:35.628Z,1535393375.628 [Rowe_600LCM] No Fault, FailCount= 1
2018-08-27T18:09:35.845Z,1535393375.845 [Rowe_600LCM](INFO): Initializing
2018-08-27T18:09:35.845Z,1535393375.845 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T18:09:35.846Z,1535393375.846 [Rowe_600LCM](INFO): LCM OK
2018-08-27T18:09:35.846Z,1535393375.846 [Rowe_600LCM](INFO): Powering up
2018-08-27T18:09:40.095Z,1535393380.095 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T18:09:40.233Z,1535393380.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-27T18:09:40.235Z,1535393380.235 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T18:09:40.235Z,1535393380.235 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T18:09:40.236Z,1535393380.236 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T18:10:58.920Z,1535393458.920 [BPC1](ERROR): Failed to receive data from both battery packs
2018-08-27T18:10:58.921Z,1535393458.921 [BPC1] Communications Fault, FailCount= 2
2018-08-27T18:10:58.921Z,1535393458.921 [BPC1](ERROR): Communications Fault
2018-08-27T18:10:59.035Z,1535393459.035 [CBIT](ERROR): Communications Fault in component: BPC1
2018-08-27T18:11:00.139Z,1535393460.139 [CBIT](INFO): Clearing failed state for component BPC1
2018-08-27T18:11:00.139Z,1535393460.139 [BPC1] No Fault, FailCount= 2
2018-08-27T18:11:35.925Z,1535393495.925 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T18:11:35.925Z,1535393495.925 [Rowe_600LCM] Communications Fault, FailCount= 2
2018-08-27T18:11:35.925Z,1535393495.925 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T18:11:36.230Z,1535393496.230 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T18:11:36.329Z,1535393496.329 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T18:11:36.419Z,1535393496.419 [Rowe_600LCM](INFO): Powering down
2018-08-27T18:11:37.784Z,1535393497.784 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T18:11:37.784Z,1535393497.784 [Rowe_600LCM] No Fault, FailCount= 2
2018-08-27T18:11:38.033Z,1535393498.033 [Rowe_600LCM](INFO): Initializing
2018-08-27T18:11:38.033Z,1535393498.033 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T18:11:38.034Z,1535393498.034 [Rowe_600LCM](INFO): LCM OK
2018-08-27T18:11:38.034Z,1535393498.034 [Rowe_600LCM](INFO): Powering up
2018-08-27T18:11:42.291Z,1535393502.291 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T18:11:42.362Z,1535393502.362 [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-27T18:11:42.363Z,1535393502.363 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T18:11:42.364Z,1535393502.364 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T18:11:42.365Z,1535393502.365 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T18:12:28.169Z,1535393548.169 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-08-27T18:07:28.0Z
2018-08-27T18:12:28.169Z,1535393548.169 [Default:CheckIn:Read_GPS] Stopped
2018-08-27T18:12:28.170Z,1535393548.170 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-27T18:12:36.582Z,1535393556.582 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180827T163151/Courier0033.lzma
2018-08-27T18:12:37.379Z,1535393557.379 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Courier0033.lzma.bak
2018-08-27T18:12:37.380Z,1535393557.380 [DataOverHttps](INFO): SBD MOMSN=8448207
2018-08-27T18:12:43.312Z,1535393563.312 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-08-27T18:12:50.650Z,1535393570.650 [DataOverHttps](INFO): Sending 201 bytes from file Logs/20180827T163151/Express0034.lzma
2018-08-27T18:12:51.451Z,1535393571.451 [DataOverHttps](INFO): Moved sent file to Logs/20180827T163151/Express0034.lzma.bak
2018-08-27T18:12:51.451Z,1535393571.451 [DataOverHttps](INFO): SBD MOMSN=8448209
2018-08-27T18:12:53.453Z,1535393573.453 [Default:CheckIn:Read_Iridium] Stopped
2018-08-27T18:12:53.453Z,1535393573.453 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-27T18:12:53.454Z,1535393573.454 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-27T18:13:05.577Z,1535393585.577 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.441733 seconds old.
2018-08-27T18:13:05.980Z,1535393585.980 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.864936 seconds old.
2018-08-27T18:13:06.330Z,1535393586.330 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.215582 seconds old.
2018-08-27T18:13:06.700Z,1535393586.700 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.585263 seconds old.
2018-08-27T18:13:13.453Z,1535393593.453 [NAL9602](INFO): Powering down
2018-08-27T18:13:38.305Z,1535393618.305 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T18:13:38.306Z,1535393618.306 [Rowe_600LCM] Communications Fault, FailCount= 3
2018-08-27T18:13:38.306Z,1535393618.306 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T18:13:38.384Z,1535393618.384 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T18:13:38.709Z,1535393618.709 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T18:13:38.884Z,1535393618.884 [Rowe_600LCM](INFO): Powering down
2018-08-27T18:13:40.364Z,1535393620.364 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T18:13:40.364Z,1535393620.364 [Rowe_600LCM] No Fault, FailCount= 3
2018-08-27T18:13:40.501Z,1535393620.501 [Rowe_600LCM](INFO): Initializing
2018-08-27T18:13:40.501Z,1535393620.501 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T18:13:40.502Z,1535393620.502 [Rowe_600LCM](INFO): LCM OK
2018-08-27T18:13:40.502Z,1535393620.502 [Rowe_600LCM](INFO): Powering up
2018-08-27T18:13:44.631Z,1535393624.631 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T18:13:44.752Z,1535393624.752 [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-27T18:13:44.754Z,1535393624.754 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T18:13:44.754Z,1535393624.754 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T18:13:44.755Z,1535393624.755 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T18:15:40.706Z,1535393740.706 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T18:15:40.707Z,1535393740.707 [Rowe_600LCM] Communications Fault, FailCount= 4
2018-08-27T18:15:40.707Z,1535393740.707 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T18:15:41.016Z,1535393741.016 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T18:15:41.109Z,1535393741.109 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T18:15:41.288Z,1535393741.288 [Rowe_600LCM](INFO): Powering down
2018-08-27T18:15:42.623Z,1535393742.623 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-08-27T18:15:42.624Z,1535393742.624 [Rowe_600LCM] No Fault, FailCount= 4
2018-08-27T18:15:42.909Z,1535393742.909 [Rowe_600LCM](INFO): Initializing
2018-08-27T18:15:42.910Z,1535393742.910 [Rowe_600LCM](INFO): Checking LCM
2018-08-27T18:15:42.911Z,1535393742.911 [Rowe_600LCM](INFO): LCM OK
2018-08-27T18:15:42.911Z,1535393742.911 [Rowe_600LCM](INFO): Powering up
2018-08-27T18:15:47.103Z,1535393747.103 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-08-27T18:15:47.164Z,1535393747.164 [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-27T18:15:47.166Z,1535393747.166 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-08-27T18:15:47.167Z,1535393747.167 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-08-27T18:15:47.167Z,1535393747.167 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-08-27T18:17:01.090Z,1535393821.090 [BPC1](ERROR): Failed to receive data from both battery packs
2018-08-27T18:17:01.090Z,1535393821.090 [BPC1] Communications Fault, FailCount= 3
2018-08-27T18:17:01.090Z,1535393821.090 [BPC1](ERROR): Communications Fault
2018-08-27T18:17:01.118Z,1535393821.118 [CBIT](ERROR): Communications Fault in component: BPC1
2018-08-27T18:17:02.325Z,1535393822.325 [CBIT](INFO): Clearing failed state for component BPC1
2018-08-27T18:17:02.325Z,1535393822.325 [BPC1] No Fault, FailCount= 3
2018-08-27T18:17:43.100Z,1535393863.100 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-08-27T18:17:43.100Z,1535393863.100 [Rowe_600LCM] Communications Fault, FailCount= 5
2018-08-27T18:17:43.100Z,1535393863.100 [Rowe_600LCM](ERROR): Communications Fault
2018-08-27T18:17:43.201Z,1535393863.201 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-08-27T18:17:43.201Z,1535393863.201 [CBIT](FAULT): Communications Fault in component: Rowe_600LCM
2018-08-27T18:17:43.513Z,1535393863.513 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-08-27T18:17:43.767Z,1535393863.767 [Rowe_600LCM](INFO): Powering down
2018-08-27T18:17:53.910Z,1535393873.910 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-27T18:17:53.910Z,1535393873.910 [Default:CheckIn:C.Wait] Stopped
2018-08-27T18:17:53.910Z,1535393873.910 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-27T18:17:53.910Z,1535393873.910 [Default:CheckIn:D] Running Loop=1
2018-08-27T18:17:54.311Z,1535393874.311 [Default:CheckIn:D] Stopped
2018-08-27T18:17:54.311Z,1535393874.311 [Default:CheckIn:E] Running Loop=1
2018-08-27T18:17:54.714Z,1535393874.714 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 134.322485 min 
2018-08-27T18:17:54.714Z,1535393874.714 [Default:CheckIn:E] Stopped
2018-08-27T18:17:54.714Z,1535393874.714 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-27T18:17:54.714Z,1535393874.714 [Default:CheckIn] Stopped
2018-08-27T18:17:54.714Z,1535393874.714 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-27T18:17:54.715Z,1535393874.715 [Default:CheckIn](INFO): Running loop #17
2018-08-27T18:17:54.715Z,1535393874.715 [Default:CheckIn] Running Loop=17
2018-08-27T18:17:54.715Z,1535393874.715 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-27T18:17:54.715Z,1535393874.715 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-27T18:17:59.647Z,1535393879.647 [NAL9602](INFO): Powering up
2018-08-27T18:18:10.578Z,1535393890.578 [NAL9602](INFO): NAL9602 initialized
2018-08-27T18:18:11.379Z,1535393891.379 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-08-27T18:18:11.379Z,1535393891.379 [NAL9602] Data Fault, FailCount= 1
2018-08-27T18:18:11.379Z,1535393891.379 [NAL9602](ERROR): Data Fault
2018-08-27T18:18:11.469Z,1535393891.469 [CBIT](ERROR): Data Fault in component: NAL9602
2018-08-27T18:18:11.778Z,1535393891.778 [NAL9602](INFO): Powering down
2018-08-27T18:18:12.641Z,1535393892.641 [CBIT](INFO): Clearing failed state for component NAL9602
2018-08-27T18:18:12.641Z,1535393892.641 [NAL9602] No Fault, FailCount= 1
2018-08-27T18:18:42.178Z,1535393922.178 [NAL9602](INFO): Powering up NAL9602
2018-08-27T18:18:53.378Z,1535393933.378 [NAL9602](INFO): NAL9602 initialized
2018-08-27T18:18:59.787Z,1535393939.787 [DataOverHttps](IMPORTANT): SBD MTMSN=20180827T181803
2018-08-27T18:19:04.194Z,1535393944.194 [DataOverHttps](INFO): Received command:restart logs