2021-02-17T20:51:12.157Z,1613595072.157 [CommandLine](IMPORTANT): got command restart logs
2021-02-17T20:51:13.412Z,1613595073.412 [DataOverHttps](INFO): Moved sent file to Logs/20210217T170221/Express0071.lzma.bak
2021-02-17T20:51:13.412Z,1613595073.412 [DataOverHttps](INFO): SBD MOMSN=15232682
2021-02-17T20:51:31.036Z,1613595091.036 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210217T170221/Courier0073.lzma
2021-02-17T20:51:32.040Z,1613595092.040 [DataOverHttps](INFO): Moved sent file to Logs/20210217T170221/Courier0073.lzma.bak
2021-02-17T20:51:32.040Z,1613595092.040 [DataOverHttps](INFO): SBD MOMSN=15232689
2021-02-17T20:51:39.934Z,1613595099.934 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T20:51:54.636Z,1613595114.636 [DataOverHttps](INFO): Sending 94 bytes from file Logs/20210217T170221/Express0074.lzma
2021-02-17T20:51:55.639Z,1613595115.639 [DataOverHttps](INFO): Moved sent file to Logs/20210217T170221/Express0074.lzma.bak
2021-02-17T20:51:55.639Z,1613595115.639 [DataOverHttps](INFO): SBD MOMSN=15232737
2021-02-17T20:51:56.971Z,1613595116.971 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T20:51:56.972Z,1613595116.972 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T20:51:56.972Z,1613595116.972 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T20:56:00.233Z,1613595360.233 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T20:56:31.357Z,1613595391.357 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T20:56:57.593Z,1613595417.593 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T20:56:57.593Z,1613595417.593 [Default:CheckIn:C.Wait] Stopped
2021-02-17T20:56:57.593Z,1613595417.593 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T20:56:57.593Z,1613595417.593 [Default:CheckIn:D] Running Loop=1
2021-02-17T20:56:58.001Z,1613595418.001 [Default:CheckIn:D] Stopped
2021-02-17T20:56:58.001Z,1613595418.001 [Default:CheckIn:E] Running Loop=1
2021-02-17T20:56:58.419Z,1613595418.419 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 19.177730 min 
2021-02-17T20:56:58.419Z,1613595418.419 [Default:CheckIn:E] Stopped
2021-02-17T20:56:58.419Z,1613595418.419 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T20:56:58.419Z,1613595418.419 [Default:CheckIn] Stopped
2021-02-17T20:56:58.419Z,1613595418.419 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T20:56:58.419Z,1613595418.419 [Default:CheckIn](INFO): Running loop #4
2021-02-17T20:56:58.419Z,1613595418.419 [Default:CheckIn] Running Loop=4
2021-02-17T20:56:58.419Z,1613595418.419 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T20:56:58.420Z,1613595418.420 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T20:57:00.414Z,1613595420.414 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205546.00,A,3648.53797,N,12149.22330,W,6.434,114.20,170221,,,D*74
2021-02-17T20:57:00.416Z,1613595420.416 [NAL9602](INFO): GPS fix at 20210217T205546: (36.808966, -121.820388)
2021-02-17T20:57:00.426Z,1613595420.426 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T20:57:00.426Z,1613595420.426 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T20:57:02.509Z,1613595422.509 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T20:57:24.252Z,1613595444.252 [NAL9602](INFO): SBD MO Status=2, MOMSN=25559, MT Status=2, MTMSN=0
2021-02-17T20:57:24.252Z,1613595444.252 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T20:57:33.633Z,1613595453.633 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T20:57:42.840Z,1613595462.840 [NAL9602](INFO): SBD MO Status=2, MOMSN=25559, MT Status=2, MTMSN=0
2021-02-17T20:57:42.840Z,1613595462.840 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T20:58:04.765Z,1613595484.765 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T20:58:05.059Z,1613595485.059 [NAL9602](INFO): SBD MO Status=2, MOMSN=25559, MT Status=2, MTMSN=0
2021-02-17T20:58:05.060Z,1613595485.060 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T20:58:07.778Z,1613595487.778 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.799332
2021-02-17T20:58:22.835Z,1613595502.835 [NAL9602](INFO): SBD MO Status=1, MOMSN=25559, MT Status=0, MTMSN=0
2021-02-17T20:58:22.836Z,1613595502.836 [NAL9602](INFO): No messages in MT queue
2021-02-17T20:58:38.917Z,1613595518.917 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T20:58:50.408Z,1613595530.408 [NAL9602](INFO): SBD MO Status=2, MOMSN=25560, MT Status=2, MTMSN=0
2021-02-17T20:58:50.408Z,1613595530.408 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T20:59:09.444Z,1613595549.444 [NAL9602](INFO): SBD MO Status=1, MOMSN=25560, MT Status=0, MTMSN=0
2021-02-17T20:59:09.509Z,1613595549.509 [NAL9602](INFO): Sent 270 bytes from file Logs/20210217T205112/Courier0003.lzma
2021-02-17T20:59:09.509Z,1613595549.509 [NAL9602](INFO): Packets left to send: 0
2021-02-17T20:59:10.057Z,1613595550.057 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T20:59:22.036Z,1613595562.036 [NAL9602](INFO): SBD MO Status=1, MOMSN=25561, MT Status=0, MTMSN=0
2021-02-17T20:59:22.085Z,1613595562.085 [NAL9602](INFO): Sent 332 bytes from file Logs/20210217T205112/Express0004.lzma
2021-02-17T20:59:22.085Z,1613595562.085 [NAL9602](INFO): Packets left to send: 1
2021-02-17T20:59:28.732Z,1613595568.732 [NAL9602](INFO): SBD MO Status=1, MOMSN=25562, MT Status=0, MTMSN=0
2021-02-17T20:59:28.785Z,1613595568.785 [NAL9602](INFO): Sent 60 bytes from file Logs/20210217T205112/Express0004.lzma
2021-02-17T20:59:28.785Z,1613595568.785 [NAL9602](INFO): Packets left to send: 0
2021-02-17T20:59:39.244Z,1613595579.244 [NAL9602](INFO): SBD MO Status=0, MOMSN=25563, MT Status=0, MTMSN=0
2021-02-17T20:59:39.322Z,1613595579.322 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T20:59:39.323Z,1613595579.323 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T20:59:39.323Z,1613595579.323 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T20:59:41.193Z,1613595581.193 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:00:09.934Z,1613595609.934 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T21:00:12.317Z,1613595612.317 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:00:43.441Z,1613595643.441 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:01:14.573Z,1613595674.573 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:01:45.697Z,1613595705.697 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:02:16.821Z,1613595736.821 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:02:47.945Z,1613595767.945 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:03:19.069Z,1613595799.069 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:03:50.193Z,1613595830.193 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:04:21.341Z,1613595861.341 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:04:39.815Z,1613595879.815 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T21:04:39.815Z,1613595879.815 [Default:CheckIn:C.Wait] Stopped
2021-02-17T21:04:39.815Z,1613595879.815 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T21:04:39.816Z,1613595879.816 [Default:CheckIn:D] Running Loop=1
2021-02-17T21:04:40.223Z,1613595880.223 [Default:CheckIn:D] Stopped
2021-02-17T21:04:40.223Z,1613595880.223 [Default:CheckIn:E] Running Loop=1
2021-02-17T21:04:40.625Z,1613595880.625 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 26.881427 min 
2021-02-17T21:04:40.625Z,1613595880.625 [Default:CheckIn:E] Stopped
2021-02-17T21:04:40.626Z,1613595880.626 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T21:04:40.626Z,1613595880.626 [Default:CheckIn] Stopped
2021-02-17T21:04:40.626Z,1613595880.626 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T21:04:40.626Z,1613595880.626 [Default:CheckIn](INFO): Running loop #5
2021-02-17T21:04:40.626Z,1613595880.626 [Default:CheckIn] Running Loop=5
2021-02-17T21:04:40.626Z,1613595880.626 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T21:04:40.626Z,1613595880.626 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T21:04:42.636Z,1613595882.636 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210328.00,A,3648.32747,N,12148.20863,W,6.862,100.09,170221,,,D*7B
2021-02-17T21:04:42.638Z,1613595882.638 [NAL9602](INFO): GPS fix at 20210217T210328: (36.805458, -121.803477)
2021-02-17T21:04:42.675Z,1613595882.675 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T21:04:42.675Z,1613595882.675 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T21:04:52.465Z,1613595892.465 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:05:10.983Z,1613595910.983 [NAL9602](INFO): SBD MO Status=2, MOMSN=25564, MT Status=2, MTMSN=0
2021-02-17T21:05:10.983Z,1613595910.983 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T21:05:23.589Z,1613595923.589 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:05:36.889Z,1613595936.889 [NAL9602](INFO): SBD MO Status=2, MOMSN=25564, MT Status=2, MTMSN=0
2021-02-17T21:05:36.889Z,1613595936.889 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T21:05:54.713Z,1613595954.713 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:06:11.270Z,1613595971.270 [NAL9602](INFO): SBD MO Status=2, MOMSN=25564, MT Status=2, MTMSN=0
2021-02-17T21:06:11.270Z,1613595971.270 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T21:06:25.853Z,1613595985.853 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-02-17T21:06:29.899Z,1613595989.899 [NAL9602](INFO): SBD MO Status=1, MOMSN=25564, MT Status=0, MTMSN=0
2021-02-17T21:06:29.966Z,1613595989.966 [NAL9602](INFO): Sent 72 bytes from file Logs/20210217T205112/Courier0006.lzma
2021-02-17T21:06:29.966Z,1613595989.966 [NAL9602](INFO): Packets left to send: 0
2021-02-17T21:06:39.403Z,1613595999.403 [NAL9602](INFO): SBD MO Status=1, MOMSN=25565, MT Status=0, MTMSN=0
2021-02-17T21:06:39.453Z,1613595999.453 [NAL9602](INFO): Sent 144 bytes from file Logs/20210217T205112/Express0007.lzma
2021-02-17T21:06:39.453Z,1613595999.453 [NAL9602](INFO): Packets left to send: 0
2021-02-17T21:06:55.221Z,1613596015.221 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002737
2021-02-17T21:06:56.785Z,1613596016.785 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T21:06:56.785Z,1613596016.785 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T21:06:56.785Z,1613596016.785 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T21:07:01.620Z,1613596021.620 [NAL9602](INFO): SBD MO Status=2, MOMSN=25566, MT Status=2, MTMSN=0
2021-02-17T21:07:01.620Z,1613596021.620 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T21:07:32.354Z,1613596052.354 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T21:11:57.489Z,1613596317.489 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T21:11:57.490Z,1613596317.490 [Default:CheckIn:C.Wait] Stopped
2021-02-17T21:11:57.490Z,1613596317.490 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T21:11:57.490Z,1613596317.490 [Default:CheckIn:D] Running Loop=1
2021-02-17T21:11:57.901Z,1613596317.901 [Default:CheckIn:D] Stopped
2021-02-17T21:11:57.902Z,1613596317.902 [Default:CheckIn:E] Running Loop=1
2021-02-17T21:11:58.307Z,1613596318.307 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 34.176066 min 
2021-02-17T21:11:58.307Z,1613596318.307 [Default:CheckIn:E] Stopped
2021-02-17T21:11:58.307Z,1613596318.307 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T21:11:58.307Z,1613596318.307 [Default:CheckIn] Stopped
2021-02-17T21:11:58.307Z,1613596318.307 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T21:11:58.307Z,1613596318.307 [Default:CheckIn](INFO): Running loop #6
2021-02-17T21:11:58.307Z,1613596318.307 [Default:CheckIn] Running Loop=6
2021-02-17T21:11:58.307Z,1613596318.307 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T21:11:58.307Z,1613596318.307 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T21:12:00.316Z,1613596320.316 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211046.00,A,3648.45424,N,12147.29958,W,5.521,51.11,170221,,,D*4D
2021-02-17T21:12:00.328Z,1613596320.328 [NAL9602](INFO): GPS fix at 20210217T211046: (36.807571, -121.788326)
2021-02-17T21:12:00.339Z,1613596320.339 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T21:12:00.339Z,1613596320.339 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T21:12:06.464Z,1613596326.464 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210217T205112/Courier0009.lzma
2021-02-17T21:12:07.467Z,1613596327.467 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0009.lzma.bak
2021-02-17T21:12:07.467Z,1613596327.467 [DataOverHttps](INFO): SBD MOMSN=15232860
2021-02-17T21:12:23.104Z,1613596343.104 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20210217T205112/Express0010.lzma
2021-02-17T21:12:24.107Z,1613596344.107 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0010.lzma.bak
2021-02-17T21:12:24.107Z,1613596344.107 [DataOverHttps](INFO): SBD MOMSN=15232871
2021-02-17T21:12:25.372Z,1613596345.372 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T21:12:25.372Z,1613596345.372 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T21:12:25.372Z,1613596345.372 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T21:12:26.172Z,1613596346.172 [NAL9602](INFO): SBD MO Status=2, MOMSN=25566, MT Status=2, MTMSN=0
2021-02-17T21:12:26.172Z,1613596346.172 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T21:12:43.537Z,1613596363.537 [NAL9602](INFO): SBD MO Status=0, MOMSN=25566, MT Status=0, MTMSN=0
2021-02-17T21:12:43.537Z,1613596363.537 [NAL9602](INFO): No messages in MT queue
2021-02-17T21:13:14.243Z,1613596394.243 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T21:17:26.023Z,1613596646.023 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T21:17:26.023Z,1613596646.023 [Default:CheckIn:C.Wait] Stopped
2021-02-17T21:17:26.023Z,1613596646.023 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T21:17:26.023Z,1613596646.023 [Default:CheckIn:D] Running Loop=1
2021-02-17T21:17:26.438Z,1613596646.438 [Default:CheckIn:D] Stopped
2021-02-17T21:17:26.438Z,1613596646.438 [Default:CheckIn:E] Running Loop=1
2021-02-17T21:17:26.831Z,1613596646.831 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 39.651672 min 
2021-02-17T21:17:26.832Z,1613596646.832 [Default:CheckIn:E] Stopped
2021-02-17T21:17:26.832Z,1613596646.832 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T21:17:26.832Z,1613596646.832 [Default:CheckIn] Stopped
2021-02-17T21:17:26.832Z,1613596646.832 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T21:17:26.832Z,1613596646.832 [Default:CheckIn](INFO): Running loop #7
2021-02-17T21:17:26.832Z,1613596646.832 [Default:CheckIn] Running Loop=7
2021-02-17T21:17:26.832Z,1613596646.832 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T21:17:26.832Z,1613596646.832 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T21:17:28.848Z,1613596648.848 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211614.00,A,3648.27968,N,12147.13604,W,4.004,192.68,170221,,,A*74
2021-02-17T21:17:28.850Z,1613596648.850 [NAL9602](INFO): GPS fix at 20210217T211614: (36.804661, -121.785601)
2021-02-17T21:17:28.860Z,1613596648.860 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T21:17:28.860Z,1613596648.860 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T21:17:38.648Z,1613596658.648 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210217T205112/Courier0012.lzma
2021-02-17T21:17:39.651Z,1613596659.651 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0012.lzma.bak
2021-02-17T21:17:39.651Z,1613596659.651 [DataOverHttps](INFO): SBD MOMSN=15232879
2021-02-17T21:17:45.504Z,1613596665.504 [NAL9602](INFO): SBD MO Status=0, MOMSN=25567, MT Status=0, MTMSN=0
2021-02-17T21:17:45.504Z,1613596665.504 [NAL9602](INFO): No messages in MT queue
2021-02-17T21:17:58.252Z,1613596678.252 [DataOverHttps](INFO): Sending 142 bytes from file Logs/20210217T205112/Express0013.lzma
2021-02-17T21:17:59.255Z,1613596679.255 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0013.lzma.bak
2021-02-17T21:17:59.255Z,1613596679.255 [DataOverHttps](INFO): SBD MOMSN=15232885
2021-02-17T21:18:00.513Z,1613596680.513 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T21:18:00.514Z,1613596680.514 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T21:18:00.514Z,1613596680.514 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T21:18:16.251Z,1613596696.251 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T21:23:01.223Z,1613596981.223 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T21:23:01.223Z,1613596981.223 [Default:CheckIn:C.Wait] Stopped
2021-02-17T21:23:01.224Z,1613596981.224 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T21:23:01.224Z,1613596981.224 [Default:CheckIn:D] Running Loop=1
2021-02-17T21:23:01.611Z,1613596981.611 [Default:CheckIn:D] Stopped
2021-02-17T21:23:01.611Z,1613596981.611 [Default:CheckIn:E] Running Loop=1
2021-02-17T21:23:02.010Z,1613596982.010 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 45.237895 min 
2021-02-17T21:23:02.010Z,1613596982.010 [Default:CheckIn:E] Stopped
2021-02-17T21:23:02.010Z,1613596982.010 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T21:23:02.010Z,1613596982.010 [Default:CheckIn] Stopped
2021-02-17T21:23:02.010Z,1613596982.010 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T21:23:02.011Z,1613596982.011 [Default:CheckIn](INFO): Running loop #8
2021-02-17T21:23:02.011Z,1613596982.011 [Default:CheckIn] Running Loop=8
2021-02-17T21:23:02.011Z,1613596982.011 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T21:23:02.011Z,1613596982.011 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T21:23:04.036Z,1613596984.036 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212150.00,A,3648.16295,N,12147.21648,W,0.039,293.36,170221,,,D*74
2021-02-17T21:23:04.038Z,1613596984.038 [NAL9602](INFO): GPS fix at 20210217T212150: (36.802716, -121.786941)
2021-02-17T21:23:04.048Z,1613596984.048 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T21:23:04.048Z,1613596984.048 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T21:23:10.900Z,1613596990.900 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210217T205112/Courier0015.lzma
2021-02-17T21:23:11.903Z,1613596991.903 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0015.lzma.bak
2021-02-17T21:23:11.903Z,1613596991.903 [DataOverHttps](INFO): SBD MOMSN=15232902
2021-02-17T21:23:20.996Z,1613597000.996 [NAL9602](INFO): SBD MO Status=0, MOMSN=25568, MT Status=0, MTMSN=0
2021-02-17T21:23:20.996Z,1613597000.996 [NAL9602](INFO): No messages in MT queue
2021-02-17T21:23:27.632Z,1613597007.632 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20210217T205112/Express0016.lzma
2021-02-17T21:23:28.635Z,1613597008.635 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0016.lzma.bak
2021-02-17T21:23:28.635Z,1613597008.635 [DataOverHttps](INFO): SBD MOMSN=15232908
2021-02-17T21:23:30.335Z,1613597010.335 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T21:23:30.336Z,1613597010.336 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T21:23:30.336Z,1613597010.336 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T21:23:51.758Z,1613597031.758 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T21:28:31.063Z,1613597311.063 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T21:28:31.063Z,1613597311.063 [Default:CheckIn:C.Wait] Stopped
2021-02-17T21:28:31.063Z,1613597311.063 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T21:28:31.064Z,1613597311.064 [Default:CheckIn:D] Running Loop=1
2021-02-17T21:28:31.461Z,1613597311.461 [Default:CheckIn:D] Stopped
2021-02-17T21:28:31.461Z,1613597311.461 [Default:CheckIn:E] Running Loop=1
2021-02-17T21:28:31.872Z,1613597311.872 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.735388 min 
2021-02-17T21:28:31.872Z,1613597311.872 [Default:CheckIn:E] Stopped
2021-02-17T21:28:31.872Z,1613597311.872 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T21:28:31.872Z,1613597311.872 [Default:CheckIn] Stopped
2021-02-17T21:28:31.872Z,1613597311.872 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T21:28:31.872Z,1613597311.872 [Default:CheckIn](INFO): Running loop #9
2021-02-17T21:28:31.873Z,1613597311.873 [Default:CheckIn] Running Loop=9
2021-02-17T21:28:31.873Z,1613597311.873 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T21:28:31.873Z,1613597311.873 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T21:28:33.880Z,1613597313.880 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212720.00,A,3648.16614,N,12147.21509,W,0.117,227.88,170221,,,D*79
2021-02-17T21:28:33.882Z,1613597313.882 [NAL9602](INFO): GPS fix at 20210217T212720: (36.802769, -121.786918)
2021-02-17T21:28:33.913Z,1613597313.913 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T21:28:33.913Z,1613597313.913 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T21:28:40.720Z,1613597320.720 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210217T205112/Courier0018.lzma
2021-02-17T21:28:40.748Z,1613597320.748 [NAL9602](INFO): SBD MO Status=0, MOMSN=25569, MT Status=0, MTMSN=0
2021-02-17T21:28:40.748Z,1613597320.748 [NAL9602](INFO): No messages in MT queue
2021-02-17T21:28:41.723Z,1613597321.723 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0018.lzma.bak
2021-02-17T21:28:41.723Z,1613597321.723 [DataOverHttps](INFO): SBD MOMSN=15232928
2021-02-17T21:28:57.357Z,1613597337.357 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20210217T205112/Express0019.lzma
2021-02-17T21:28:58.651Z,1613597338.651 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0019.lzma.bak
2021-02-17T21:28:58.651Z,1613597338.651 [DataOverHttps](INFO): SBD MOMSN=15232933
2021-02-17T21:28:59.765Z,1613597339.765 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T21:28:59.765Z,1613597339.765 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T21:28:59.765Z,1613597339.765 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T21:29:11.447Z,1613597351.447 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T21:34:00.522Z,1613597640.522 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T21:34:00.522Z,1613597640.522 [Default:CheckIn:C.Wait] Stopped
2021-02-17T21:34:00.522Z,1613597640.522 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T21:34:00.522Z,1613597640.522 [Default:CheckIn:D] Running Loop=1
2021-02-17T21:34:00.959Z,1613597640.959 [Default:CheckIn:D] Stopped
2021-02-17T21:34:00.959Z,1613597640.959 [Default:CheckIn:E] Running Loop=1
2021-02-17T21:34:01.321Z,1613597641.321 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 56.227022 min 
2021-02-17T21:34:01.322Z,1613597641.322 [Default:CheckIn:E] Stopped
2021-02-17T21:34:01.322Z,1613597641.322 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T21:34:01.322Z,1613597641.322 [Default:CheckIn] Stopped
2021-02-17T21:34:01.322Z,1613597641.322 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T21:34:01.322Z,1613597641.322 [Default:CheckIn](INFO): Running loop #10
2021-02-17T21:34:01.322Z,1613597641.322 [Default:CheckIn] Running Loop=10
2021-02-17T21:34:01.322Z,1613597641.322 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T21:34:01.322Z,1613597641.322 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T21:34:03.338Z,1613597643.338 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213249.00,A,3648.17080,N,12147.28193,W,0.292,216.56,170221,,,D*79
2021-02-17T21:34:03.340Z,1613597643.340 [NAL9602](INFO): GPS fix at 20210217T213249: (36.802847, -121.788032)
2021-02-17T21:34:03.350Z,1613597643.350 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T21:34:03.351Z,1613597643.351 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T21:34:10.308Z,1613597650.308 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210217T205112/Courier0021.lzma
2021-02-17T21:34:11.311Z,1613597651.311 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0021.lzma.bak
2021-02-17T21:34:11.311Z,1613597651.311 [DataOverHttps](INFO): SBD MOMSN=15232941
2021-02-17T21:34:27.104Z,1613597667.104 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20210217T205112/Express0022.lzma
2021-02-17T21:34:28.107Z,1613597668.107 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0022.lzma.bak
2021-02-17T21:34:28.107Z,1613597668.107 [DataOverHttps](INFO): SBD MOMSN=15232947
2021-02-17T21:34:29.609Z,1613597669.609 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T21:34:29.609Z,1613597669.609 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T21:34:29.609Z,1613597669.609 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T21:34:38.084Z,1613597678.084 [NAL9602](INFO): SBD MO Status=0, MOMSN=25570, MT Status=0, MTMSN=0
2021-02-17T21:34:38.084Z,1613597678.084 [NAL9602](INFO): No messages in MT queue
2021-02-17T21:35:08.782Z,1613597708.782 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T21:38:24.098Z,1613597904.098 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T21:38:35.777Z,1613597915.777 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2021-02-17T21:38:35.780Z,1613597915.780 [BPC1](INFO): Received data from all battery sticks.
2021-02-17T21:39:30.304Z,1613597970.304 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T21:39:30.305Z,1613597970.305 [Default:CheckIn:C.Wait] Stopped
2021-02-17T21:39:30.305Z,1613597970.305 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T21:39:30.305Z,1613597970.305 [Default:CheckIn:D] Running Loop=1
2021-02-17T21:39:30.713Z,1613597970.713 [Default:CheckIn:D] Stopped
2021-02-17T21:39:30.713Z,1613597970.713 [Default:CheckIn:E] Running Loop=1
2021-02-17T21:39:31.123Z,1613597971.123 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 61.722917 min 
2021-02-17T21:39:31.123Z,1613597971.123 [Default:CheckIn:E] Stopped
2021-02-17T21:39:31.124Z,1613597971.124 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T21:39:31.124Z,1613597971.124 [Default:CheckIn] Stopped
2021-02-17T21:39:31.124Z,1613597971.124 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T21:39:31.124Z,1613597971.124 [Default:CheckIn](INFO): Running loop #11
2021-02-17T21:39:31.124Z,1613597971.124 [Default:CheckIn] Running Loop=11
2021-02-17T21:39:31.124Z,1613597971.124 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T21:39:31.124Z,1613597971.124 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T21:39:33.128Z,1613597973.128 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213819.00,A,3648.16382,N,12147.27606,W,0.330,273.32,170221,,,A*7F
2021-02-17T21:39:33.134Z,1613597973.134 [NAL9602](INFO): GPS fix at 20210217T213819: (36.802730, -121.787934)
2021-02-17T21:39:33.183Z,1613597973.183 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T21:39:33.183Z,1613597973.183 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T21:39:43.669Z,1613597983.669 [DataOverHttps](INFO): Sending 204 bytes from file Logs/20210217T205112/Courier0024.lzma
2021-02-17T21:39:44.671Z,1613597984.671 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0024.lzma.bak
2021-02-17T21:39:44.671Z,1613597984.671 [DataOverHttps](INFO): SBD MOMSN=15232955
2021-02-17T21:40:04.228Z,1613598004.228 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210217T205112/Express0025.lzma
2021-02-17T21:40:05.231Z,1613598005.231 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0025.lzma.bak
2021-02-17T21:40:05.231Z,1613598005.231 [DataOverHttps](INFO): SBD MOMSN=15232961
2021-02-17T21:40:06.776Z,1613598006.776 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T21:40:06.776Z,1613598006.776 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T21:40:06.776Z,1613598006.776 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T21:43:16.318Z,1613598196.318 [NAL9602](INFO): SBD MO Status=2, MOMSN=25571, MT Status=2, MTMSN=0
2021-02-17T21:43:16.318Z,1613598196.318 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T21:44:35.562Z,1613598275.562 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2021-02-17T21:45:06.266Z,1613598306.266 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T21:45:07.481Z,1613598307.481 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T21:45:07.481Z,1613598307.481 [Default:CheckIn:C.Wait] Stopped
2021-02-17T21:45:07.482Z,1613598307.482 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T21:45:07.482Z,1613598307.482 [Default:CheckIn:D] Running Loop=1
2021-02-17T21:45:07.893Z,1613598307.893 [Default:CheckIn:D] Stopped
2021-02-17T21:45:07.893Z,1613598307.893 [Default:CheckIn:E] Running Loop=1
2021-02-17T21:45:08.299Z,1613598308.299 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 67.342590 min 
2021-02-17T21:45:08.299Z,1613598308.299 [Default:CheckIn:E] Stopped
2021-02-17T21:45:08.300Z,1613598308.300 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T21:45:08.300Z,1613598308.300 [Default:CheckIn] Stopped
2021-02-17T21:45:08.300Z,1613598308.300 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T21:45:08.300Z,1613598308.300 [Default:CheckIn](INFO): Running loop #12
2021-02-17T21:45:08.300Z,1613598308.300 [Default:CheckIn] Running Loop=12
2021-02-17T21:45:08.300Z,1613598308.300 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T21:45:08.300Z,1613598308.300 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T21:45:10.308Z,1613598310.308 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214356.00,A,3648.17054,N,12147.28031,W,0.739,273.32,170221,,,A*71
2021-02-17T21:45:10.320Z,1613598310.320 [NAL9602](INFO): GPS fix at 20210217T214356: (36.802842, -121.788005)
2021-02-17T21:45:10.331Z,1613598310.331 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T21:45:10.331Z,1613598310.331 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T21:45:17.152Z,1613598317.152 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210217T205112/Courier0027.lzma
2021-02-17T21:45:18.155Z,1613598318.155 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0027.lzma.bak
2021-02-17T21:45:18.155Z,1613598318.155 [DataOverHttps](INFO): SBD MOMSN=15232967
2021-02-17T21:45:36.825Z,1613598336.825 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20210217T205112/Express0028.lzma
2021-02-17T21:45:37.827Z,1613598337.827 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0028.lzma.bak
2021-02-17T21:45:37.827Z,1613598337.827 [DataOverHttps](INFO): SBD MOMSN=15232970
2021-02-17T21:45:39.466Z,1613598339.466 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T21:45:39.466Z,1613598339.466 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T21:45:39.466Z,1613598339.466 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T21:45:41.062Z,1613598341.062 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2021-02-17T21:45:41.141Z,1613598341.141 [NAL9602](FAULT): received: 
+CSQ:0

OK571, 2, 0, 0, 0

OK
2021-02-17T21:45:41.141Z,1613598341.141 [NAL9602] Data Fault, FailCount= 1
2021-02-17T21:45:41.141Z,1613598341.141 [NAL9602](ERROR): Data Fault
2021-02-17T21:45:41.285Z,1613598341.285 [CBIT](ERROR): Data Fault in component: NAL9602
2021-02-17T21:45:41.472Z,1613598341.472 [NAL9602](INFO): Powering down
2021-02-17T21:45:42.350Z,1613598342.350 [CBIT](INFO): Clearing failed state for component NAL9602
2021-02-17T21:45:42.350Z,1613598342.350 [NAL9602] No Fault, FailCount= 1
2021-02-17T21:46:11.822Z,1613598371.822 [NAL9602](INFO): Powering up NAL9602
2021-02-17T21:46:22.738Z,1613598382.738 [NAL9602](INFO): NAL9602 initialized
2021-02-17T21:46:53.838Z,1613598413.838 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T21:50:40.161Z,1613598640.161 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T21:50:40.161Z,1613598640.161 [Default:CheckIn:C.Wait] Stopped
2021-02-17T21:50:40.161Z,1613598640.161 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T21:50:40.161Z,1613598640.161 [Default:CheckIn:D] Running Loop=1
2021-02-17T21:50:40.558Z,1613598640.558 [Default:CheckIn:D] Stopped
2021-02-17T21:50:40.558Z,1613598640.558 [Default:CheckIn:E] Running Loop=1
2021-02-17T21:50:40.972Z,1613598640.972 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 72.887004 min 
2021-02-17T21:50:40.972Z,1613598640.972 [Default:CheckIn:E] Stopped
2021-02-17T21:50:40.972Z,1613598640.972 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T21:50:40.972Z,1613598640.972 [Default:CheckIn] Stopped
2021-02-17T21:50:40.973Z,1613598640.973 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T21:50:40.973Z,1613598640.973 [Default:CheckIn](INFO): Running loop #13
2021-02-17T21:50:40.973Z,1613598640.973 [Default:CheckIn] Running Loop=13
2021-02-17T21:50:40.973Z,1613598640.973 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T21:50:40.973Z,1613598640.973 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T21:50:44.998Z,1613598644.998 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2021-02-17T21:54:33.268Z,1613598873.268 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215318.00,A,3648.17378,N,12147.28373,W,0.136,0.00,170221,,,A*7C
2021-02-17T21:54:33.270Z,1613598873.270 [NAL9602](INFO): GPS fix at 20210217T215318: (36.802896, -121.788062)
2021-02-17T21:54:33.304Z,1613598873.304 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T21:54:33.304Z,1613598873.304 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T21:54:40.868Z,1613598880.868 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210217T205112/Courier0030.lzma
2021-02-17T21:54:41.871Z,1613598881.871 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0030.lzma.bak
2021-02-17T21:54:41.871Z,1613598881.871 [DataOverHttps](INFO): SBD MOMSN=15232974
2021-02-17T21:54:57.509Z,1613598897.509 [DataOverHttps](INFO): Sending 247 bytes from file Logs/20210217T205112/Express0031.lzma
2021-02-17T21:54:58.511Z,1613598898.511 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0031.lzma.bak
2021-02-17T21:54:58.511Z,1613598898.511 [DataOverHttps](INFO): SBD MOMSN=15232977
2021-02-17T21:54:59.950Z,1613598899.950 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T21:54:59.950Z,1613598899.950 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T21:54:59.950Z,1613598899.950 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T21:55:05.590Z,1613598905.590 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T22:00:00.676Z,1613599200.676 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T22:00:00.676Z,1613599200.676 [Default:CheckIn:C.Wait] Stopped
2021-02-17T22:00:00.676Z,1613599200.676 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T22:00:00.676Z,1613599200.676 [Default:CheckIn:D] Running Loop=1
2021-02-17T22:00:01.077Z,1613599201.077 [Default:CheckIn:D] Stopped
2021-02-17T22:00:01.077Z,1613599201.077 [Default:CheckIn:E] Running Loop=1
2021-02-17T22:00:01.485Z,1613599201.485 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 82.228996 min 
2021-02-17T22:00:01.485Z,1613599201.485 [Default:CheckIn:E] Stopped
2021-02-17T22:00:01.486Z,1613599201.486 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T22:00:01.486Z,1613599201.486 [Default:CheckIn] Stopped
2021-02-17T22:00:01.486Z,1613599201.486 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T22:00:01.486Z,1613599201.486 [Default:CheckIn](INFO): Running loop #14
2021-02-17T22:00:01.486Z,1613599201.486 [Default:CheckIn] Running Loop=14
2021-02-17T22:00:01.486Z,1613599201.486 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T22:00:01.486Z,1613599201.486 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T22:00:03.500Z,1613599203.500 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215849.00,A,3648.17098,N,12147.27957,W,0.194,144.45,170221,,,A*75
2021-02-17T22:00:03.502Z,1613599203.502 [NAL9602](INFO): GPS fix at 20210217T215849: (36.802850, -121.787993)
2021-02-17T22:00:03.532Z,1613599203.532 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T22:00:03.532Z,1613599203.532 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T22:00:11.344Z,1613599211.344 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210217T205112/Courier0033.lzma
2021-02-17T22:00:12.347Z,1613599212.347 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0033.lzma.bak
2021-02-17T22:00:12.347Z,1613599212.347 [DataOverHttps](INFO): SBD MOMSN=15232982
2021-02-17T22:00:28.212Z,1613599228.212 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20210217T205112/Express0034.lzma
2021-02-17T22:00:29.215Z,1613599229.215 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0034.lzma.bak
2021-02-17T22:00:29.215Z,1613599229.215 [DataOverHttps](INFO): SBD MOMSN=15232985
2021-02-17T22:00:30.597Z,1613599230.597 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T22:00:30.597Z,1613599230.597 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T22:00:30.597Z,1613599230.597 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T22:03:39.772Z,1613599419.772 [NAL9602](INFO): SBD MO Status=2, MOMSN=25571, MT Status=2, MTMSN=0
2021-02-17T22:03:39.772Z,1613599419.772 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T22:05:17.530Z,1613599517.530 [NAL9602](INFO): SBD MO Status=0, MOMSN=25571, MT Status=0, MTMSN=0
2021-02-17T22:05:17.530Z,1613599517.530 [NAL9602](INFO): No messages in MT queue
2021-02-17T22:05:31.280Z,1613599531.280 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T22:05:31.280Z,1613599531.280 [Default:CheckIn:C.Wait] Stopped
2021-02-17T22:05:31.280Z,1613599531.280 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T22:05:31.280Z,1613599531.280 [Default:CheckIn:D] Running Loop=1
2021-02-17T22:05:31.708Z,1613599531.708 [Default:CheckIn:D] Stopped
2021-02-17T22:05:31.708Z,1613599531.708 [Default:CheckIn:E] Running Loop=1
2021-02-17T22:05:32.082Z,1613599532.082 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 87.739510 min 
2021-02-17T22:05:32.082Z,1613599532.082 [Default:CheckIn:E] Stopped
2021-02-17T22:05:32.082Z,1613599532.082 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T22:05:32.082Z,1613599532.082 [Default:CheckIn] Stopped
2021-02-17T22:05:32.082Z,1613599532.082 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T22:05:32.083Z,1613599532.083 [Default:CheckIn](INFO): Running loop #15
2021-02-17T22:05:32.083Z,1613599532.083 [Default:CheckIn] Running Loop=15
2021-02-17T22:05:32.083Z,1613599532.083 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T22:05:32.083Z,1613599532.083 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T22:05:34.100Z,1613599534.100 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220420.00,A,3648.16545,N,12147.28180,W,0.117,182.31,170221,,,A*7B
2021-02-17T22:05:34.102Z,1613599534.102 [NAL9602](INFO): GPS fix at 20210217T220420: (36.802757, -121.788030)
2021-02-17T22:05:34.119Z,1613599534.119 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T22:05:34.119Z,1613599534.119 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T22:05:43.552Z,1613599543.552 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210217T205112/Courier0036.lzma
2021-02-17T22:05:44.555Z,1613599544.555 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0036.lzma.bak
2021-02-17T22:05:44.555Z,1613599544.555 [DataOverHttps](INFO): SBD MOMSN=15232988
2021-02-17T22:06:02.848Z,1613599562.848 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210217T205112/Express0037.lzma
2021-02-17T22:06:03.851Z,1613599563.851 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0037.lzma.bak
2021-02-17T22:06:03.851Z,1613599563.851 [DataOverHttps](INFO): SBD MOMSN=15232991
2021-02-17T22:06:05.309Z,1613599565.309 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T22:06:05.309Z,1613599565.309 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T22:06:05.309Z,1613599565.309 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T22:06:06.907Z,1613599566.907 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T22:11:05.993Z,1613599865.993 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T22:11:05.993Z,1613599865.993 [Default:CheckIn:C.Wait] Stopped
2021-02-17T22:11:05.993Z,1613599865.993 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T22:11:05.993Z,1613599865.993 [Default:CheckIn:D] Running Loop=1
2021-02-17T22:11:06.389Z,1613599866.389 [Default:CheckIn:D] Stopped
2021-02-17T22:11:06.389Z,1613599866.389 [Default:CheckIn:E] Running Loop=1
2021-02-17T22:11:06.798Z,1613599866.798 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 93.317521 min 
2021-02-17T22:11:06.798Z,1613599866.798 [Default:CheckIn:E] Stopped
2021-02-17T22:11:06.798Z,1613599866.798 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T22:11:06.798Z,1613599866.798 [Default:CheckIn] Stopped
2021-02-17T22:11:06.798Z,1613599866.798 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T22:11:06.798Z,1613599866.798 [Default:CheckIn](INFO): Running loop #16
2021-02-17T22:11:06.798Z,1613599866.798 [Default:CheckIn] Running Loop=16
2021-02-17T22:11:06.798Z,1613599866.798 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T22:11:06.798Z,1613599866.798 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T22:11:08.808Z,1613599868.808 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220954.00,A,3648.16857,N,12147.28087,W,0.136,182.31,170221,,,A*7E
2021-02-17T22:11:08.810Z,1613599868.810 [NAL9602](INFO): GPS fix at 20210217T220954: (36.802810, -121.788015)
2021-02-17T22:11:08.841Z,1613599868.841 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T22:11:08.841Z,1613599868.841 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T22:11:16.732Z,1613599876.732 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210217T205112/Courier0039.lzma
2021-02-17T22:11:17.735Z,1613599877.735 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0039.lzma.bak
2021-02-17T22:11:17.735Z,1613599877.735 [DataOverHttps](INFO): SBD MOMSN=15232995
2021-02-17T22:11:36.438Z,1613599896.438 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210217T205112/Express0040.lzma
2021-02-17T22:11:37.439Z,1613599897.439 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0040.lzma.bak
2021-02-17T22:11:37.439Z,1613599897.439 [DataOverHttps](INFO): SBD MOMSN=15232998
2021-02-17T22:11:39.192Z,1613599899.192 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T22:11:39.193Z,1613599899.193 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T22:11:39.193Z,1613599899.193 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T22:12:32.970Z,1613599952.970 [NAL9602](INFO): SBD MO Status=2, MOMSN=25572, MT Status=2, MTMSN=0
2021-02-17T22:12:32.970Z,1613599952.970 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T22:13:20.619Z,1613600000.619 [NAL9602](INFO): SBD MO Status=2, MOMSN=25572, MT Status=2, MTMSN=0
2021-02-17T22:13:20.620Z,1613600000.620 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T22:13:36.372Z,1613600016.372 [NAL9602](INFO): SBD MO Status=2, MOMSN=25572, MT Status=2, MTMSN=0
2021-02-17T22:13:36.372Z,1613600016.372 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T22:14:40.624Z,1613600080.624 [NAL9602](INFO): SBD MO Status=2, MOMSN=25572, MT Status=2, MTMSN=0
2021-02-17T22:14:40.624Z,1613600080.624 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T22:14:57.991Z,1613600097.991 [NAL9602](INFO): SBD MO Status=2, MOMSN=25572, MT Status=2, MTMSN=0
2021-02-17T22:14:57.992Z,1613600097.992 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T22:15:58.196Z,1613600158.196 [NAL9602](INFO): SBD MO Status=2, MOMSN=25572, MT Status=2, MTMSN=0
2021-02-17T22:15:58.196Z,1613600158.196 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T22:16:16.768Z,1613600176.768 [NAL9602](INFO): SBD MO Status=2, MOMSN=25572, MT Status=2, MTMSN=0
2021-02-17T22:16:16.768Z,1613600176.768 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T22:16:17.170Z,1613600177.170 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2021-02-17T22:16:39.811Z,1613600199.811 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T22:16:39.811Z,1613600199.811 [Default:CheckIn:C.Wait] Stopped
2021-02-17T22:16:39.811Z,1613600199.811 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T22:16:39.812Z,1613600199.812 [Default:CheckIn:D] Running Loop=1
2021-02-17T22:16:40.213Z,1613600200.213 [Default:CheckIn:D] Stopped
2021-02-17T22:16:40.213Z,1613600200.213 [Default:CheckIn:E] Running Loop=1
2021-02-17T22:16:40.616Z,1613600200.616 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 98.881266 min 
2021-02-17T22:16:40.616Z,1613600200.616 [Default:CheckIn:E] Stopped
2021-02-17T22:16:40.617Z,1613600200.617 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T22:16:40.641Z,1613600200.641 [Default:CheckIn] Stopped
2021-02-17T22:16:40.641Z,1613600200.641 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T22:16:40.642Z,1613600200.642 [Default:CheckIn](INFO): Running loop #17
2021-02-17T22:16:40.642Z,1613600200.642 [Default:CheckIn] Running Loop=17
2021-02-17T22:16:40.642Z,1613600200.642 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T22:16:40.642Z,1613600200.642 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T22:16:42.622Z,1613600202.622 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221528.00,A,3648.16721,N,12147.27679,W,0.117,0.00,170221,,,A*74
2021-02-17T22:16:42.624Z,1613600202.624 [NAL9602](INFO): GPS fix at 20210217T221528: (36.802787, -121.787947)
2021-02-17T22:16:42.635Z,1613600202.635 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T22:16:42.635Z,1613600202.635 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T22:16:50.380Z,1613600210.380 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210217T205112/Courier0042.lzma
2021-02-17T22:16:51.383Z,1613600211.383 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0042.lzma.bak
2021-02-17T22:16:51.383Z,1613600211.383 [DataOverHttps](INFO): SBD MOMSN=15233001
2021-02-17T22:17:07.041Z,1613600227.041 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20210217T205112/Express0043.lzma
2021-02-17T22:17:08.043Z,1613600228.043 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0043.lzma.bak
2021-02-17T22:17:08.043Z,1613600228.043 [DataOverHttps](INFO): SBD MOMSN=15233004
2021-02-17T22:17:09.298Z,1613600229.298 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T22:17:09.298Z,1613600229.298 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T22:17:09.298Z,1613600229.298 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T22:17:14.544Z,1613600234.544 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T22:22:10.005Z,1613600530.005 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T22:22:10.005Z,1613600530.005 [Default:CheckIn:C.Wait] Stopped
2021-02-17T22:22:10.006Z,1613600530.006 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T22:22:10.006Z,1613600530.006 [Default:CheckIn:D] Running Loop=1
2021-02-17T22:22:10.391Z,1613600530.391 [Default:CheckIn:D] Stopped
2021-02-17T22:22:10.391Z,1613600530.391 [Default:CheckIn:E] Running Loop=1
2021-02-17T22:22:10.799Z,1613600530.799 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 104.384229 min 
2021-02-17T22:22:10.799Z,1613600530.799 [Default:CheckIn:E] Stopped
2021-02-17T22:22:10.800Z,1613600530.800 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T22:22:10.800Z,1613600530.800 [Default:CheckIn] Stopped
2021-02-17T22:22:10.800Z,1613600530.800 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T22:22:10.800Z,1613600530.800 [Default:CheckIn](INFO): Running loop #18
2021-02-17T22:22:10.800Z,1613600530.800 [Default:CheckIn] Running Loop=18
2021-02-17T22:22:10.800Z,1613600530.800 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T22:22:10.800Z,1613600530.800 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T22:22:12.814Z,1613600532.814 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222058.00,A,3648.16218,N,12147.27984,W,1.419,0.00,170221,,,A*7D
2021-02-17T22:22:12.816Z,1613600532.816 [NAL9602](INFO): GPS fix at 20210217T222058: (36.802703, -121.787997)
2021-02-17T22:22:12.826Z,1613600532.826 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T22:22:12.827Z,1613600532.827 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T22:22:20.232Z,1613600540.232 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210217T205112/Courier0045.lzma
2021-02-17T22:22:21.235Z,1613600541.235 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0045.lzma.bak
2021-02-17T22:22:21.235Z,1613600541.235 [DataOverHttps](INFO): SBD MOMSN=15233008
2021-02-17T22:22:37.004Z,1613600557.004 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210217T205112/Express0046.lzma
2021-02-17T22:22:38.007Z,1613600558.007 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0046.lzma.bak
2021-02-17T22:22:38.007Z,1613600558.007 [DataOverHttps](INFO): SBD MOMSN=15233011
2021-02-17T22:22:39.521Z,1613600559.521 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T22:22:39.521Z,1613600559.521 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T22:22:39.521Z,1613600559.521 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T22:23:15.432Z,1613600595.432 [NAL9602](INFO): SBD MO Status=2, MOMSN=25572, MT Status=2, MTMSN=0
2021-02-17T22:23:15.432Z,1613600595.432 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T22:23:44.968Z,1613600624.968 [NAL9602](INFO): SBD MO Status=2, MOMSN=25572, MT Status=2, MTMSN=0
2021-02-17T22:23:44.968Z,1613600624.968 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T22:23:57.900Z,1613600637.900 [NAL9602](INFO): SBD MO Status=2, MOMSN=25572, MT Status=2, MTMSN=0
2021-02-17T22:23:57.900Z,1613600637.900 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T22:24:20.930Z,1613600660.930 [NAL9602](INFO): SBD MO Status=2, MOMSN=25572, MT Status=2, MTMSN=0
2021-02-17T22:24:20.930Z,1613600660.930 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T22:24:49.608Z,1613600689.608 [NAL9602](INFO): SBD MO Status=2, MOMSN=25572, MT Status=2, MTMSN=0
2021-02-17T22:24:49.608Z,1613600689.608 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-02-17T22:25:03.751Z,1613600703.751 [NAL9602](INFO): SBD MO Status=0, MOMSN=25572, MT Status=0, MTMSN=0
2021-02-17T22:25:03.752Z,1613600703.752 [NAL9602](INFO): No messages in MT queue
2021-02-17T22:25:34.458Z,1613600734.458 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T22:27:40.141Z,1613600860.141 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T22:27:40.141Z,1613600860.141 [Default:CheckIn:C.Wait] Stopped
2021-02-17T22:27:40.141Z,1613600860.141 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T22:27:40.142Z,1613600860.142 [Default:CheckIn:D] Running Loop=1
2021-02-17T22:27:40.525Z,1613600860.525 [Default:CheckIn:D] Stopped
2021-02-17T22:27:40.525Z,1613600860.525 [Default:CheckIn:E] Running Loop=1
2021-02-17T22:27:40.932Z,1613600860.932 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 109.886458 min 
2021-02-17T22:27:40.932Z,1613600860.932 [Default:CheckIn:E] Stopped
2021-02-17T22:27:40.932Z,1613600860.932 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T22:27:40.932Z,1613600860.932 [Default:CheckIn] Stopped
2021-02-17T22:27:40.932Z,1613600860.932 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T22:27:40.933Z,1613600860.933 [Default:CheckIn](INFO): Running loop #19
2021-02-17T22:27:40.933Z,1613600860.933 [Default:CheckIn] Running Loop=19
2021-02-17T22:27:40.933Z,1613600860.933 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T22:27:40.933Z,1613600860.933 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T22:27:42.940Z,1613600862.940 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222629.00,A,3648.16796,N,12147.28403,W,0.855,285.09,170221,,,D*75
2021-02-17T22:27:42.954Z,1613600862.954 [NAL9602](INFO): GPS fix at 20210217T222629: (36.802799, -121.788067)
2021-02-17T22:27:42.987Z,1613600862.987 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T22:27:42.987Z,1613600862.987 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T22:27:49.852Z,1613600869.852 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20210217T205112/Courier0048.lzma
2021-02-17T22:27:50.855Z,1613600870.855 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0048.lzma.bak
2021-02-17T22:27:50.855Z,1613600870.855 [DataOverHttps](INFO): SBD MOMSN=15233015
2021-02-17T22:28:06.588Z,1613600886.588 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20210217T205112/Express0049.lzma
2021-02-17T22:28:07.591Z,1613600887.591 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0049.lzma.bak
2021-02-17T22:28:07.591Z,1613600887.591 [DataOverHttps](INFO): SBD MOMSN=15233018
2021-02-17T22:28:09.116Z,1613600889.116 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T22:28:09.116Z,1613600889.116 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T22:28:09.116Z,1613600889.116 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T22:32:45.494Z,1613601165.494 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2021-02-17T22:32:48.726Z,1613601168.726 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2021-02-17T22:32:48.726Z,1613601168.726 [DropWeight] Hardware Fault, FailCount= 1
2021-02-17T22:32:48.726Z,1613601168.726 [DropWeight](ERROR): Hardware Fault
2021-02-17T22:32:48.761Z,1613601168.761 [CommandLine](FAULT): Scheduling is paused
2021-02-17T22:32:48.797Z,1613601168.797 [CBIT](INFO): Critical error at 20210217T223248
2021-02-17T22:32:48.800Z,1613601168.800 [CBIT](ERROR): Hardware Fault in component: DropWeight
2021-02-17T22:32:48.800Z,1613601168.800 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2021-02-17T22:32:49.155Z,1613601169.155 [CBIT](INFO): Critical error at 20210217T223248
2021-02-17T22:33:09.757Z,1613601189.757 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T22:33:09.757Z,1613601189.757 [Default:CheckIn:C.Wait] Stopped
2021-02-17T22:33:09.757Z,1613601189.757 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T22:33:09.757Z,1613601189.757 [Default:CheckIn:D] Running Loop=1
2021-02-17T22:33:10.155Z,1613601190.155 [Default:CheckIn:D] Stopped
2021-02-17T22:33:10.155Z,1613601190.155 [Default:CheckIn:E] Running Loop=1
2021-02-17T22:33:10.552Z,1613601190.552 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 115.380290 min 
2021-02-17T22:33:10.552Z,1613601190.552 [Default:CheckIn:E] Stopped
2021-02-17T22:33:10.552Z,1613601190.552 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T22:33:10.552Z,1613601190.552 [Default:CheckIn] Stopped
2021-02-17T22:33:10.552Z,1613601190.552 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T22:33:10.552Z,1613601190.552 [Default:CheckIn](INFO): Running loop #20
2021-02-17T22:33:10.552Z,1613601190.552 [Default:CheckIn] Running Loop=20
2021-02-17T22:33:10.553Z,1613601190.553 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T22:33:10.553Z,1613601190.553 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T22:33:12.572Z,1613601192.572 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223158.00,A,3648.16618,N,12147.27854,W,1.613,285.09,170221,,,D*7E
2021-02-17T22:33:12.574Z,1613601192.574 [NAL9602](INFO): GPS fix at 20210217T223158: (36.802770, -121.787976)
2021-02-17T22:33:12.584Z,1613601192.584 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T22:33:12.584Z,1613601192.584 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T22:33:20.477Z,1613601200.477 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20210217T205112/Courier0051.lzma
2021-02-17T22:33:21.479Z,1613601201.479 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0051.lzma.bak
2021-02-17T22:33:21.479Z,1613601201.479 [DataOverHttps](INFO): SBD MOMSN=15233021
2021-02-17T22:33:39.985Z,1613601219.985 [DataOverHttps](INFO): Sending 231 bytes from file Logs/20210217T205112/Express0052.lzma
2021-02-17T22:33:40.987Z,1613601220.987 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0052.lzma.bak
2021-02-17T22:33:40.987Z,1613601220.987 [DataOverHttps](INFO): SBD MOMSN=15233026
2021-02-17T22:33:42.525Z,1613601222.525 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T22:33:42.525Z,1613601222.525 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T22:33:42.525Z,1613601222.525 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T22:33:44.558Z,1613601224.558 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T22:38:43.193Z,1613601523.193 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T22:38:43.193Z,1613601523.193 [Default:CheckIn:C.Wait] Stopped
2021-02-17T22:38:43.193Z,1613601523.193 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T22:38:43.193Z,1613601523.193 [Default:CheckIn:D] Running Loop=1
2021-02-17T22:38:43.605Z,1613601523.605 [Default:CheckIn:D] Stopped
2021-02-17T22:38:43.606Z,1613601523.606 [Default:CheckIn:E] Running Loop=1
2021-02-17T22:38:43.993Z,1613601523.993 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 120.937801 min 
2021-02-17T22:38:43.993Z,1613601523.993 [Default:CheckIn:E] Stopped
2021-02-17T22:38:43.993Z,1613601523.993 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T22:38:43.993Z,1613601523.993 [Default:CheckIn] Stopped
2021-02-17T22:38:43.994Z,1613601523.994 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T22:38:43.994Z,1613601523.994 [Default:CheckIn](INFO): Running loop #21
2021-02-17T22:38:43.994Z,1613601523.994 [Default:CheckIn] Running Loop=21
2021-02-17T22:38:43.994Z,1613601523.994 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T22:38:43.994Z,1613601523.994 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T22:38:46.011Z,1613601526.011 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223732.00,A,3648.15652,N,12147.30197,W,1.069,226.47,170221,,,A*74
2021-02-17T22:38:46.014Z,1613601526.014 [NAL9602](INFO): GPS fix at 20210217T223732: (36.802609, -121.788366)
2021-02-17T22:38:46.024Z,1613601526.024 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T22:38:46.024Z,1613601526.024 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T22:38:52.876Z,1613601532.876 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210217T205112/Courier0054.lzma
2021-02-17T22:38:53.879Z,1613601533.879 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0054.lzma.bak
2021-02-17T22:38:53.879Z,1613601533.879 [DataOverHttps](INFO): SBD MOMSN=15233031
2021-02-17T22:39:09.604Z,1613601549.604 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20210217T205112/Express0055.lzma
2021-02-17T22:39:10.607Z,1613601550.607 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0055.lzma.bak
2021-02-17T22:39:10.607Z,1613601550.607 [DataOverHttps](INFO): SBD MOMSN=15233034
2021-02-17T22:39:11.872Z,1613601551.872 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T22:39:11.872Z,1613601551.872 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T22:39:11.872Z,1613601551.872 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T22:39:16.710Z,1613601556.710 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2021-02-17T22:39:16.793Z,1613601556.793 [NAL9602](FAULT): received: 
+CSQ:0

OK572, 0, 0, 0, 0

OK
2021-02-17T22:39:16.793Z,1613601556.793 [NAL9602] Data Fault, FailCount= 1
2021-02-17T22:39:16.793Z,1613601556.793 [NAL9602](ERROR): Data Fault
2021-02-17T22:39:16.830Z,1613601556.830 [CBIT](ERROR): Data Fault in component: NAL9602
2021-02-17T22:39:17.120Z,1613601557.120 [NAL9602](INFO): Powering down
2021-02-17T22:39:17.950Z,1613601557.950 [CBIT](INFO): Clearing failed state for component NAL9602
2021-02-17T22:39:17.950Z,1613601557.950 [NAL9602] No Fault, FailCount= 1
2021-02-17T22:39:42.179Z,1613601582.179 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:39:42.576Z,1613601582.576 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:39:47.414Z,1613601587.414 [NAL9602](INFO): Powering up NAL9602
2021-02-17T22:39:52.323Z,1613601592.323 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:39:53.540Z,1613601593.540 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:39:58.326Z,1613601598.326 [NAL9602](INFO): NAL9602 initialized
2021-02-17T22:40:02.841Z,1613601602.841 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:40:04.482Z,1613601604.482 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:40:13.741Z,1613601613.741 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:40:15.810Z,1613601615.810 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:40:25.055Z,1613601625.055 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:40:26.672Z,1613601626.672 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:40:29.442Z,1613601629.442 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T22:40:35.960Z,1613601635.960 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:40:37.577Z,1613601637.577 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:40:46.924Z,1613601646.924 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:40:48.492Z,1613601648.492 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:40:57.375Z,1613601657.375 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:40:59.397Z,1613601659.397 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:41:07.469Z,1613601667.469 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:41:10.304Z,1613601670.304 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:41:18.427Z,1613601678.427 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:41:21.209Z,1613601681.209 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:41:29.291Z,1613601689.291 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:41:32.155Z,1613601692.155 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:41:39.913Z,1613601699.913 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:41:43.108Z,1613601703.108 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:41:50.897Z,1613601710.897 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:41:53.711Z,1613601713.711 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:42:02.090Z,1613601722.090 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:42:04.484Z,1613601724.484 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:42:12.995Z,1613601732.995 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:42:15.398Z,1613601735.398 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:42:23.922Z,1613601743.922 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:42:26.710Z,1613601746.710 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:42:34.789Z,1613601754.789 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:42:37.606Z,1613601757.606 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:42:45.705Z,1613601765.705 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:42:48.165Z,1613601768.165 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:42:56.623Z,1613601776.623 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:42:59.090Z,1613601779.090 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:43:07.522Z,1613601787.522 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:43:10.387Z,1613601790.387 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:43:18.474Z,1613601798.474 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:43:21.732Z,1613601801.732 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:43:29.339Z,1613601809.339 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:43:32.594Z,1613601812.594 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:44:12.470Z,1613601852.470 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T22:44:12.470Z,1613601852.470 [Default:CheckIn:C.Wait] Stopped
2021-02-17T22:44:12.471Z,1613601852.471 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T22:44:12.471Z,1613601852.471 [Default:CheckIn:D] Running Loop=1
2021-02-17T22:44:12.865Z,1613601852.865 [Default:CheckIn:D] Stopped
2021-02-17T22:44:12.866Z,1613601852.866 [Default:CheckIn:E] Running Loop=1
2021-02-17T22:44:13.298Z,1613601853.298 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 126.425464 min 
2021-02-17T22:44:13.298Z,1613601853.298 [Default:CheckIn:E] Stopped
2021-02-17T22:44:13.298Z,1613601853.298 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T22:44:13.298Z,1613601853.298 [Default:CheckIn] Stopped
2021-02-17T22:44:13.298Z,1613601853.298 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T22:44:13.299Z,1613601853.299 [Default:CheckIn](INFO): Running loop #22
2021-02-17T22:44:13.299Z,1613601853.299 [Default:CheckIn] Running Loop=22
2021-02-17T22:44:13.299Z,1613601853.299 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T22:44:13.299Z,1613601853.299 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T22:44:17.300Z,1613601857.300 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2021-02-17T22:45:08.683Z,1613601908.683 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:45:33.325Z,1613601933.325 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:45:56.470Z,1613601956.470 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:46:03.544Z,1613601963.544 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:46:07.310Z,1613601967.310 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:46:14.565Z,1613601974.565 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:46:18.180Z,1613601978.180 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:46:25.536Z,1613601985.536 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:46:29.159Z,1613601989.159 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:46:36.378Z,1613601996.378 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:46:40.005Z,1613602000.005 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:46:47.738Z,1613602007.738 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:46:50.548Z,1613602010.548 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:46:58.657Z,1613602018.657 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:47:01.060Z,1613602021.060 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:47:09.922Z,1613602029.922 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:47:12.341Z,1613602032.341 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:47:21.234Z,1613602041.234 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:47:23.306Z,1613602043.306 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:47:32.565Z,1613602052.565 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:47:34.155Z,1613602054.155 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:47:43.867Z,1613602063.867 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:47:45.079Z,1613602065.079 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:47:49.074Z,1613602069.074 [CBIT](INFO): Clearing failed state for component DropWeight
2021-02-17T22:47:49.074Z,1613602069.074 [DropWeight] No Fault, FailCount= 1
2021-02-17T22:47:54.865Z,1613602074.865 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:47:56.026Z,1613602076.026 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:48:05.284Z,1613602085.284 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:48:06.900Z,1613602086.900 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:48:16.234Z,1613602096.234 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:48:18.195Z,1613602098.195 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:48:27.128Z,1613602107.128 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:48:29.119Z,1613602109.119 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:48:38.019Z,1613602118.019 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:48:40.450Z,1613602120.450 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:48:48.924Z,1613602128.924 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:48:51.344Z,1613602131.344 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:49:00.257Z,1613602140.257 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:49:02.272Z,1613602142.272 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:49:10.313Z,1613602150.313 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:49:13.155Z,1613602153.155 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:49:13.492Z,1613602153.492 [Default:CheckIn:Read_GPS](INFO): Timed out from 2021-02-17T22:44:13.3Z
2021-02-17T22:49:13.492Z,1613602153.492 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T22:49:13.493Z,1613602153.493 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-02-17T22:49:20.986Z,1613602160.986 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:49:24.209Z,1613602164.209 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:49:25.852Z,1613602165.852 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210217T205112/Courier0057.lzma
2021-02-17T22:49:26.855Z,1613602166.855 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Courier0057.lzma.bak
2021-02-17T22:49:26.855Z,1613602166.855 [DataOverHttps](INFO): SBD MOMSN=15233037
2021-02-17T22:49:31.477Z,1613602171.477 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:49:35.164Z,1613602175.164 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:49:42.378Z,1613602182.378 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:49:46.032Z,1613602186.032 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:49:46.682Z,1613602186.682 [NAL9602](INFO): Not Powering down - fast GPS
2021-02-17T22:49:50.436Z,1613602190.436 [DataOverHttps](INFO): Sending 247 bytes from file Logs/20210217T205112/Express0058.lzma
2021-02-17T22:49:51.419Z,1613602191.419 [DataOverHttps](INFO): Moved sent file to Logs/20210217T205112/Express0058.lzma.bak
2021-02-17T22:49:51.419Z,1613602191.419 [DataOverHttps](INFO): SBD MOMSN=15233039
2021-02-17T22:49:52.880Z,1613602192.880 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:49:52.988Z,1613602192.988 [Default:CheckIn:Read_Iridium] Stopped
2021-02-17T22:49:52.988Z,1613602192.988 [Default:CheckIn:C.Wait] Running Loop=1
2021-02-17T22:49:52.988Z,1613602192.988 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-02-17T22:49:56.939Z,1613602196.939 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:50:04.178Z,1613602204.178 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:50:07.808Z,1613602207.808 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:50:15.460Z,1613602215.460 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:50:18.734Z,1613602218.734 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:50:26.915Z,1613602226.915 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:50:29.725Z,1613602229.725 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:50:37.702Z,1613602237.702 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:50:40.538Z,1613602240.538 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:50:48.207Z,1613602248.207 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-02-17T22:50:51.471Z,1613602251.471 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-02-17T22:50:58.174Z,1613602258.174 [BPC1](ERROR): Failed to receive data from all battery packs.
2021-02-17T22:50:58.174Z,1613602258.174 [BPC1] Communications Fault, FailCount= 1
2021-02-17T22:50:58.174Z,1613602258.174 [BPC1](ERROR): Communications Fault
2021-02-17T22:50:58.247Z,1613602258.247 [CBIT](ERROR): Communications Fault in component: BPC1
2021-02-17T22:54:53.340Z,1613602493.340 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-02-17T22:54:53.340Z,1613602493.340 [Default:CheckIn:C.Wait] Stopped
2021-02-17T22:54:53.340Z,1613602493.340 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-02-17T22:54:53.340Z,1613602493.340 [Default:CheckIn:D] Running Loop=1
2021-02-17T22:54:53.754Z,1613602493.754 [Default:CheckIn:D] Stopped
2021-02-17T22:54:53.754Z,1613602493.754 [Default:CheckIn:E] Running Loop=1
2021-02-17T22:54:54.182Z,1613602494.182 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 137.106950 min 
2021-02-17T22:54:54.182Z,1613602494.182 [Default:CheckIn:E] Stopped
2021-02-17T22:54:54.182Z,1613602494.182 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-02-17T22:54:54.182Z,1613602494.182 [Default:CheckIn] Stopped
2021-02-17T22:54:54.182Z,1613602494.182 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T22:54:54.182Z,1613602494.182 [Default:CheckIn](INFO): Running loop #23
2021-02-17T22:54:54.182Z,1613602494.182 [Default:CheckIn] Running Loop=23
2021-02-17T22:54:54.182Z,1613602494.182 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-02-17T22:54:54.182Z,1613602494.182 [Default:CheckIn:Read_GPS] Running Loop=1
2021-02-17T22:54:55.750Z,1613602495.750 [NAL9602](FAULT): GPS failed to acquire within timeout.
2021-02-17T22:54:55.751Z,1613602495.751 [NAL9602] Data Fault, FailCount= 1
2021-02-17T22:54:55.751Z,1613602495.751 [NAL9602](ERROR): Data Fault
2021-02-17T22:54:55.844Z,1613602495.844 [CBIT](ERROR): Data Fault in component: NAL9602
2021-02-17T22:54:56.146Z,1613602496.146 [NAL9602](INFO): Powering down
2021-02-17T22:54:57.038Z,1613602497.038 [CBIT](INFO): Clearing failed state for component NAL9602
2021-02-17T22:54:57.038Z,1613602497.038 [NAL9602] No Fault, FailCount= 1
2021-02-17T22:55:26.442Z,1613602526.442 [NAL9602](INFO): Powering up NAL9602
2021-02-17T22:55:37.350Z,1613602537.350 [NAL9602](INFO): NAL9602 initialized
2021-02-17T22:59:41.015Z,1613602781.015 [CommandLine](IMPORTANT): got command quit
2021-02-17T22:59:42.041Z,1613602782.041 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2021-02-17T22:59:42.041Z,1613602782.041 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:42.209Z,1613602782.209 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2021-02-17T22:59:42.209Z,1613602782.209 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:42.210Z,1613602782.210 [CommandLine](INFO): Join timeout helper Thread ID is 2313
2021-02-17T22:59:42.237Z,1613602782.237 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2021-02-17T22:59:42.237Z,1613602782.237 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:42.238Z,1613602782.238 [NavChartDb](INFO): Join timeout helper Thread ID is 2314
2021-02-17T22:59:42.485Z,1613602782.485 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2021-02-17T22:59:42.485Z,1613602782.485 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:42.501Z,1613602782.501 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2021-02-17T22:59:42.501Z,1613602782.501 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:42.501Z,1613602782.501 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2315
2021-02-17T22:59:42.613Z,1613602782.613 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2021-02-17T22:59:42.613Z,1613602782.613 [WetLabsBB2FL](INFO): Powering down
2021-02-17T22:59:42.614Z,1613602782.614 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:42.637Z,1613602782.637 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2021-02-17T22:59:42.637Z,1613602782.637 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:42.637Z,1613602782.637 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2316
2021-02-17T22:59:43.473Z,1613602783.473 [CTD_Seabird](INFO): Powering down
2021-02-17T22:59:43.485Z,1613602783.485 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2021-02-17T22:59:43.485Z,1613602783.485 [CTD_Seabird](INFO): Powering down
2021-02-17T22:59:43.497Z,1613602783.497 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:43.513Z,1613602783.513 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2021-02-17T22:59:43.513Z,1613602783.513 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:43.514Z,1613602783.514 [Radio_Surface](INFO): Join timeout helper Thread ID is 2317
2021-02-17T22:59:43.545Z,1613602783.545 [Radio_Surface](INFO): Powering down
2021-02-17T22:59:43.546Z,1613602783.546 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2021-02-17T22:59:43.546Z,1613602783.546 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:43.554Z,1613602783.554 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2021-02-17T22:59:43.555Z,1613602783.555 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:43.555Z,1613602783.555 [Onboard](INFO): Join timeout helper Thread ID is 2318
2021-02-17T22:59:45.497Z,1613602785.497 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2021-02-17T22:59:45.497Z,1613602785.497 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:45.506Z,1613602785.506 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2021-02-17T22:59:45.506Z,1613602785.506 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:45.506Z,1613602785.506 [DataOverHttps](INFO): Join timeout helper Thread ID is 2319
2021-02-17T22:59:45.860Z,1613602785.860 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2021-02-17T22:59:45.875Z,1613602785.875 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:45.886Z,1613602785.886 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2021-02-17T22:59:45.886Z,1613602785.886 [logger ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:45.886Z,1613602785.886 [logger](INFO): Join timeout helper Thread ID is 2320
2021-02-17T22:59:45.895Z,1613602785.895 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2021-02-17T22:59:45.895Z,1613602785.895 [logger ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:45.914Z,1613602785.914 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2021-02-17T22:59:45.914Z,1613602785.914 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:45.914Z,1613602785.914 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2021-02-17T22:59:45.914Z,1613602785.914 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:45.914Z,1613602785.914 [controlThread](INFO): Join timeout helper Thread ID is 2321
2021-02-17T22:59:46.201Z,1613602786.201 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2021-02-17T22:59:46.201Z,1613602786.201 [controlThread](DEBUG): Uninitializing ControlThread
2021-02-17T22:59:46.202Z,1613602786.202 [AHRS_M2](INFO): Powering down
2021-02-17T22:59:46.274Z,1613602786.274 [NAL9602](INFO): Powering down
2021-02-17T22:59:46.275Z,1613602786.275 [AMEcho](INFO): Powering down
2021-02-17T22:59:46.277Z,1613602786.277 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2021-02-17T22:59:46.278Z,1613602786.278 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2021-02-17T22:59:46.278Z,1613602786.278 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2021-02-17T22:59:46.279Z,1613602786.279 [MissionManager](INFO): Uninitializing Mission Default
2021-02-17T22:59:46.279Z,1613602786.279 [Default] Stopped
2021-02-17T22:59:46.279Z,1613602786.279 [Default](DEBUG): Aggregate::uninitialize Default
2021-02-17T22:59:46.279Z,1613602786.279 [Default:B.GoToSurface] Stopped
2021-02-17T22:59:46.279Z,1613602786.279 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2021-02-17T22:59:46.279Z,1613602786.279 [Default:CheckIn] Stopped
2021-02-17T22:59:46.280Z,1613602786.280 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-02-17T22:59:46.280Z,1613602786.280 [Default:CheckIn:Read_GPS] Stopped
2021-02-17T22:59:46.283Z,1613602786.283 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2021-02-17T22:59:46.283Z,1613602786.283 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2021-02-17T22:59:46.283Z,1613602786.283 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2021-02-17T22:59:46.283Z,1613602786.283 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2021-02-17T22:59:46.284Z,1613602786.284 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-02-17T22:59:46.284Z,1613602786.284 [BuoyancyServo](INFO): Powering down
2021-02-17T22:59:46.297Z,1613602786.297 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2021-02-17T22:59:46.297Z,1613602786.297 [ElevatorServo](INFO): Powering down
2021-02-17T22:59:46.298Z,1613602786.298 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-02-17T22:59:46.298Z,1613602786.298 [MassServo](INFO): Powering down
2021-02-17T22:59:46.299Z,1613602786.299 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-02-17T22:59:46.299Z,1613602786.299 [RudderServo](INFO): Powering down
2021-02-17T22:59:46.300Z,1613602786.300 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2021-02-17T22:59:46.300Z,1613602786.300 [ThrusterServo](INFO): Powering down
2021-02-17T22:59:46.301Z,1613602786.301 [SBIT](DEBUG): Uninitialize SBIT Component.
2021-02-17T22:59:46.301Z,1613602786.301 [IBIT](DEBUG): Uninitialize IBIT Component.
2021-02-17T22:59:46.302Z,1613602786.302 [CBIT](DEBUG): Uninitialize CBIT Component.
2021-02-17T22:59:46.302Z,1613602786.302 [CBIT](DEBUG): Powering off loads.
2021-02-17T22:59:46.313Z,1613602786.313 [CBIT](DEBUG): Disabling WDT.
2021-02-17T22:59:46.325Z,1613602786.325 [CBIT](DEBUG): Opening all GF detection circuits.
2021-02-17T22:59:46.326Z,1613602786.326 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:46.372Z,1613602786.372 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:46.374Z,1613602786.374 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:46.380Z,1613602786.380 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:46.450Z,1613602786.450 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:46.454Z,1613602786.454 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:46.500Z,1613602786.500 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-02-17T22:59:46.570Z,1613602786.570 [logger ThreadHandler](INFO): Thread cancelled.