2021-08-16T18:38:10.103Z,1629139090.103 [DVL_micro](ERROR): Failed to parse: 9.99,+9999.99,+9999.99,+9999.99 2021-08-16T18:38:20.070Z,1629139100.070 [DataOverHttps](IMPORTANT): SBD MTMSN=20210816T183817 2021-08-16T18:38:31.213Z,1629139111.213 [DataOverHttps](INFO): Received command:strobe off 2021-08-16T18:38:31.222Z,1629139111.222 [CommandLine](IMPORTANT): got command strobe off 2021-08-16T18:38:31.222Z,1629139111.222 [CommandLine](IMPORTANT): Deactivating strobe 2021-08-16T18:39:52.424Z,1629139192.424 [CBIT](IMPORTANT): Beginning ground fault scan 2021-08-16T18:39:52.838Z,1629139192.838 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T18:39:52.839Z,1629139192.839 [Default:CheckIn:C.Wait] Stopped 2021-08-16T18:39:52.839Z,1629139192.839 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T18:39:52.840Z,1629139192.840 [Default:CheckIn:D] Running Loop=1 2021-08-16T18:39:53.222Z,1629139193.222 [Default:CheckIn:D] Stopped 2021-08-16T18:39:53.222Z,1629139193.222 [Default:CheckIn:E] Running Loop=1 2021-08-16T18:39:53.680Z,1629139193.680 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.400311 min 2021-08-16T18:39:53.680Z,1629139193.680 [Default:CheckIn:E] Stopped 2021-08-16T18:39:53.680Z,1629139193.680 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T18:39:53.680Z,1629139193.680 [Default:CheckIn] Stopped 2021-08-16T18:39:53.680Z,1629139193.680 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T18:39:53.680Z,1629139193.680 [Default:CheckIn](INFO): Running loop #4 2021-08-16T18:39:53.705Z,1629139193.705 [Default:CheckIn] Running Loop=4 2021-08-16T18:39:53.705Z,1629139193.705 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T18:39:53.705Z,1629139193.705 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T18:39:55.624Z,1629139195.624 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183953.00,A,4149.62422,N,08322.74102,W,17.650,265.63,160821,,,D*42 2021-08-16T18:39:55.627Z,1629139195.627 [NAL9602](INFO): GPS fix at 20210816T183953: (41.827070, -83.379017) 2021-08-16T18:39:55.645Z,1629139195.645 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T18:39:55.645Z,1629139195.645 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T18:40:03.504Z,1629139203.504 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.016687 CHAN A1 (24V): 0.033584 CHAN A2 (12V): 0.004333 CHAN A3 (5V): -0.008603 CHAN B0 (3.3V): -0.007064 CHAN B1 (3.15aV): -0.005517 CHAN B2 (3.15bV): -0.004010 CHAN B3 (GND): -0.008077 OPEN: 0.004315 Full Scale Calc: 4.765 mA, -1.589 mA 2021-08-16T18:40:07.428Z,1629139207.428 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210816T123843/Courier0100.lzma 2021-08-16T18:40:08.431Z,1629139208.431 [DataOverHttps](INFO): Moved sent file to Logs/20210816T123843/Courier0100.lzma.bak 2021-08-16T18:40:08.431Z,1629139208.431 [DataOverHttps](INFO): SBD MOMSN=15889879 2021-08-16T18:40:08.632Z,1629139208.632 [NAL9602](INFO): SBD MO Status=0, MOMSN=5449, MT Status=0, MTMSN=0 2021-08-16T18:40:08.632Z,1629139208.632 [NAL9602](INFO): No messages in MT queue 2021-08-16T18:40:29.433Z,1629139229.433 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20210816T183557/Courier0000.lzma 2021-08-16T18:40:30.435Z,1629139230.435 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0000.lzma.bak 2021-08-16T18:40:30.435Z,1629139230.435 [DataOverHttps](INFO): SBD MOMSN=15889881 2021-08-16T18:40:39.420Z,1629139239.420 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T18:40:48.328Z,1629139248.328 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20210816T123843/Express0101.lzma 2021-08-16T18:40:49.331Z,1629139249.331 [DataOverHttps](INFO): Moved sent file to Logs/20210816T123843/Express0101.lzma.bak 2021-08-16T18:40:49.331Z,1629139249.331 [DataOverHttps](INFO): SBD MOMSN=15889886 2021-08-16T18:41:07.602Z,1629139267.602 [DataOverHttps](INFO): Sending 478 bytes from file Logs/20210816T183557/Express0001.lzma 2021-08-16T18:41:08.602Z,1629139268.602 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0001.lzma.bak 2021-08-16T18:41:08.603Z,1629139268.603 [DataOverHttps](INFO): SBD MOMSN=15889890 2021-08-16T18:41:26.669Z,1629139286.669 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20210816T183557/Express0004.lzma 2021-08-16T18:41:27.672Z,1629139287.672 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0004.lzma.bak 2021-08-16T18:41:27.672Z,1629139287.672 [DataOverHttps](INFO): SBD MOMSN=15889897 2021-08-16T18:41:29.970Z,1629139289.970 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T18:41:29.971Z,1629139289.971 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T18:41:29.971Z,1629139289.971 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T18:45:33.204Z,1629139533.204 [DVL_micro](ERROR): Failed to parse: :T00000000,35.0,+24.2,0000.0,1489.0,000 2021-08-16T18:46:30.683Z,1629139590.683 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T18:46:30.683Z,1629139590.683 [Default:CheckIn:C.Wait] Stopped 2021-08-16T18:46:30.683Z,1629139590.683 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T18:46:30.684Z,1629139590.684 [Default:CheckIn:D] Running Loop=1 2021-08-16T18:46:31.099Z,1629139591.099 [Default:CheckIn:D] Stopped 2021-08-16T18:46:31.099Z,1629139591.099 [Default:CheckIn:E] Running Loop=1 2021-08-16T18:46:31.499Z,1629139591.499 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 27.031608 min 2021-08-16T18:46:31.499Z,1629139591.499 [Default:CheckIn:E] Stopped 2021-08-16T18:46:31.500Z,1629139591.500 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T18:46:31.500Z,1629139591.500 [Default:CheckIn] Stopped 2021-08-16T18:46:31.500Z,1629139591.500 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T18:46:31.500Z,1629139591.500 [Default:CheckIn](INFO): Running loop #5 2021-08-16T18:46:31.500Z,1629139591.500 [Default:CheckIn] Running Loop=5 2021-08-16T18:46:31.500Z,1629139591.500 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T18:46:31.500Z,1629139591.500 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T18:46:33.464Z,1629139593.464 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184631.00,A,4149.70855,N,08324.66471,W,2.857,282.16,160821,,,D*73 2021-08-16T18:46:33.467Z,1629139593.467 [NAL9602](INFO): GPS fix at 20210816T184631: (41.828476, -83.411079) 2021-08-16T18:46:33.496Z,1629139593.496 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T18:46:33.496Z,1629139593.496 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T18:46:41.852Z,1629139601.852 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0006.lzma 2021-08-16T18:46:42.855Z,1629139602.855 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0006.lzma.bak 2021-08-16T18:46:42.855Z,1629139602.855 [DataOverHttps](INFO): SBD MOMSN=15889902 2021-08-16T18:46:45.996Z,1629139605.996 [NAL9602](INFO): SBD MO Status=0, MOMSN=5450, MT Status=0, MTMSN=0 2021-08-16T18:46:45.996Z,1629139605.996 [NAL9602](INFO): No messages in MT queue 2021-08-16T18:47:00.914Z,1629139620.914 [DataOverHttps](INFO): Sending 309 bytes from file Logs/20210816T183557/Express0007.lzma 2021-08-16T18:47:01.915Z,1629139621.915 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0007.lzma.bak 2021-08-16T18:47:01.915Z,1629139621.915 [DataOverHttps](INFO): SBD MOMSN=15889905 2021-08-16T18:47:04.248Z,1629139624.248 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T18:47:04.248Z,1629139624.248 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T18:47:04.273Z,1629139624.273 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T18:47:16.690Z,1629139636.690 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T18:48:53.316Z,1629139733.316 [DVL_micro](ERROR): only read 0 of 4 data items 2021-08-16T18:48:53.316Z,1629139733.316 [DVL_micro](ERROR): Failed to parse: :RD,++9999.99,,+9999.99 2021-08-16T18:52:04.943Z,1629139924.943 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T18:52:04.943Z,1629139924.943 [Default:CheckIn:C.Wait] Stopped 2021-08-16T18:52:04.944Z,1629139924.944 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T18:52:04.944Z,1629139924.944 [Default:CheckIn:D] Running Loop=1 2021-08-16T18:52:05.346Z,1629139925.346 [Default:CheckIn:D] Stopped 2021-08-16T18:52:05.346Z,1629139925.346 [Default:CheckIn:E] Running Loop=1 2021-08-16T18:52:05.755Z,1629139925.755 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.602386 min 2021-08-16T18:52:05.755Z,1629139925.755 [Default:CheckIn:E] Stopped 2021-08-16T18:52:05.755Z,1629139925.755 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T18:52:05.755Z,1629139925.755 [Default:CheckIn] Stopped 2021-08-16T18:52:05.756Z,1629139925.756 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T18:52:05.756Z,1629139925.756 [Default:CheckIn](INFO): Running loop #6 2021-08-16T18:52:05.756Z,1629139925.756 [Default:CheckIn] Running Loop=6 2021-08-16T18:52:05.756Z,1629139925.756 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T18:52:05.756Z,1629139925.756 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T18:52:07.786Z,1629139927.786 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185205.00,A,4149.69451,N,08324.71415,W,0.019,156.26,160821,,,D*7C 2021-08-16T18:52:07.789Z,1629139927.789 [NAL9602](INFO): GPS fix at 20210816T185205: (41.828242, -83.411902) 2021-08-16T18:52:07.820Z,1629139927.820 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T18:52:07.820Z,1629139927.820 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T18:52:15.761Z,1629139935.761 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0009.lzma 2021-08-16T18:52:16.751Z,1629139936.751 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0009.lzma.bak 2021-08-16T18:52:16.751Z,1629139936.751 [DataOverHttps](INFO): SBD MOMSN=15889910 2021-08-16T18:52:22.768Z,1629139942.768 [NAL9602](INFO): SBD MO Status=0, MOMSN=5451, MT Status=0, MTMSN=0 2021-08-16T18:52:22.768Z,1629139942.768 [NAL9602](INFO): No messages in MT queue 2021-08-16T18:52:38.469Z,1629139958.469 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210816T183557/Express0010.lzma 2021-08-16T18:52:39.471Z,1629139959.471 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0010.lzma.bak 2021-08-16T18:52:39.471Z,1629139959.471 [DataOverHttps](INFO): SBD MOMSN=15889913 2021-08-16T18:52:42.229Z,1629139962.229 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T18:52:42.229Z,1629139962.229 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T18:52:42.230Z,1629139962.230 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T18:52:53.518Z,1629139973.518 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T18:57:43.019Z,1629140263.019 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T18:57:43.019Z,1629140263.019 [Default:CheckIn:C.Wait] Stopped 2021-08-16T18:57:43.020Z,1629140263.020 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T18:57:43.021Z,1629140263.021 [Default:CheckIn:D] Running Loop=1 2021-08-16T18:57:43.422Z,1629140263.422 [Default:CheckIn:D] Stopped 2021-08-16T18:57:43.422Z,1629140263.422 [Default:CheckIn:E] Running Loop=1 2021-08-16T18:57:43.813Z,1629140263.813 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 38.236991 min 2021-08-16T18:57:43.813Z,1629140263.813 [Default:CheckIn:E] Stopped 2021-08-16T18:57:43.814Z,1629140263.814 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T18:57:43.814Z,1629140263.814 [Default:CheckIn] Stopped 2021-08-16T18:57:43.814Z,1629140263.814 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T18:57:43.814Z,1629140263.814 [Default:CheckIn](INFO): Running loop #7 2021-08-16T18:57:43.814Z,1629140263.814 [Default:CheckIn] Running Loop=7 2021-08-16T18:57:43.814Z,1629140263.814 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T18:57:43.814Z,1629140263.814 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T18:57:45.785Z,1629140265.785 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185743.00,A,4149.69355,N,08324.71262,W,0.019,156.26,160821,,,D*7E 2021-08-16T18:57:45.787Z,1629140265.787 [NAL9602](INFO): GPS fix at 20210816T185743: (41.828226, -83.411877) 2021-08-16T18:57:45.806Z,1629140265.806 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T18:57:45.806Z,1629140265.806 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T18:57:55.828Z,1629140275.828 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0012.lzma 2021-08-16T18:57:56.831Z,1629140276.831 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0012.lzma.bak 2021-08-16T18:57:56.831Z,1629140276.831 [DataOverHttps](INFO): SBD MOMSN=15889917 2021-08-16T18:58:02.360Z,1629140282.360 [NAL9602](INFO): SBD MO Status=0, MOMSN=5452, MT Status=0, MTMSN=0 2021-08-16T18:58:02.360Z,1629140282.360 [NAL9602](INFO): No messages in MT queue 2021-08-16T18:58:14.893Z,1629140294.893 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210816T183557/Express0013.lzma 2021-08-16T18:58:15.894Z,1629140295.894 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0013.lzma.bak 2021-08-16T18:58:15.895Z,1629140295.895 [DataOverHttps](INFO): SBD MOMSN=15889920 2021-08-16T18:58:19.418Z,1629140299.418 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T18:58:19.418Z,1629140299.418 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T18:58:19.418Z,1629140299.418 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T18:58:32.774Z,1629140312.774 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T18:58:51.373Z,1629140331.373 [DVL_micro](ERROR): only read 3 of 4 data items 2021-08-16T18:58:51.373Z,1629140331.373 [DVL_micro](ERROR): Failed to parse: :BI,+01506,+00144,-0069,I 2021-08-16T19:02:19.185Z,1629140539.185 [DVL_micro](ERROR): only read 3 of 4 data items 2021-08-16T19:02:19.185Z,1629140539.185 [DVL_micro](ERROR): Failed to parse: :RD,+9999.999,+9999.99,+9999.99 2021-08-16T19:03:19.827Z,1629140599.827 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T19:03:19.827Z,1629140599.827 [Default:CheckIn:C.Wait] Stopped 2021-08-16T19:03:19.827Z,1629140599.827 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T19:03:19.828Z,1629140599.828 [Default:CheckIn:D] Running Loop=1 2021-08-16T19:03:20.218Z,1629140600.218 [Default:CheckIn:D] Stopped 2021-08-16T19:03:20.218Z,1629140600.218 [Default:CheckIn:E] Running Loop=1 2021-08-16T19:03:20.641Z,1629140600.641 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 43.850252 min 2021-08-16T19:03:20.641Z,1629140600.641 [Default:CheckIn:E] Stopped 2021-08-16T19:03:20.641Z,1629140600.641 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T19:03:20.641Z,1629140600.641 [Default:CheckIn] Stopped 2021-08-16T19:03:20.641Z,1629140600.641 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T19:03:20.642Z,1629140600.642 [Default:CheckIn](INFO): Running loop #8 2021-08-16T19:03:20.642Z,1629140600.642 [Default:CheckIn] Running Loop=8 2021-08-16T19:03:20.642Z,1629140600.642 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T19:03:20.642Z,1629140600.642 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T19:03:22.624Z,1629140602.624 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190320.00,A,4149.69466,N,08324.71138,W,0.097,156.26,160821,,,D*76 2021-08-16T19:03:22.627Z,1629140602.627 [NAL9602](INFO): GPS fix at 20210816T190320: (41.828244, -83.411856) 2021-08-16T19:03:22.638Z,1629140602.638 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T19:03:22.638Z,1629140602.638 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T19:03:31.212Z,1629140611.212 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20210816T183557/Courier0015.lzma 2021-08-16T19:03:32.214Z,1629140612.214 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0015.lzma.bak 2021-08-16T19:03:32.215Z,1629140612.215 [DataOverHttps](INFO): SBD MOMSN=15889938 2021-08-16T19:03:37.583Z,1629140617.583 [NAL9602](INFO): SBD MO Status=0, MOMSN=5453, MT Status=0, MTMSN=0 2021-08-16T19:03:37.583Z,1629140617.583 [NAL9602](INFO): No messages in MT queue 2021-08-16T19:03:50.601Z,1629140630.601 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20210816T183557/Express0016.lzma 2021-08-16T19:03:51.603Z,1629140631.603 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0016.lzma.bak 2021-08-16T19:03:51.603Z,1629140631.603 [DataOverHttps](INFO): SBD MOMSN=15889946 2021-08-16T19:03:54.634Z,1629140634.634 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T19:03:54.634Z,1629140634.634 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T19:03:54.634Z,1629140634.634 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T19:04:07.972Z,1629140647.972 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T19:05:29.193Z,1629140729.193 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T19:05:29.193Z,1629140729.193 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+24.2,0000.0000 2021-08-16T19:08:55.257Z,1629140935.257 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T19:08:55.257Z,1629140935.257 [Default:CheckIn:C.Wait] Stopped 2021-08-16T19:08:55.257Z,1629140935.257 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T19:08:55.257Z,1629140935.257 [Default:CheckIn:D] Running Loop=1 2021-08-16T19:08:55.641Z,1629140935.641 [Default:CheckIn:D] Stopped 2021-08-16T19:08:55.641Z,1629140935.641 [Default:CheckIn:E] Running Loop=1 2021-08-16T19:08:56.045Z,1629140936.045 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 49.440560 min 2021-08-16T19:08:56.045Z,1629140936.045 [Default:CheckIn:E] Stopped 2021-08-16T19:08:56.045Z,1629140936.045 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T19:08:56.045Z,1629140936.045 [Default:CheckIn] Stopped 2021-08-16T19:08:56.045Z,1629140936.045 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T19:08:56.046Z,1629140936.046 [Default:CheckIn](INFO): Running loop #9 2021-08-16T19:08:56.046Z,1629140936.046 [Default:CheckIn] Running Loop=9 2021-08-16T19:08:56.046Z,1629140936.046 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T19:08:56.046Z,1629140936.046 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T19:08:58.051Z,1629140938.051 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190856.00,A,4149.69085,N,08324.71700,W,0.175,357.02,160821,,,D*70 2021-08-16T19:08:58.065Z,1629140938.065 [NAL9602](INFO): GPS fix at 20210816T190856: (41.828181, -83.411950) 2021-08-16T19:08:58.085Z,1629140938.085 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T19:08:58.085Z,1629140938.085 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T19:09:06.600Z,1629140946.600 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20210816T183557/Courier0018.lzma 2021-08-16T19:09:07.603Z,1629140947.603 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0018.lzma.bak 2021-08-16T19:09:07.603Z,1629140947.603 [DataOverHttps](INFO): SBD MOMSN=15889992 2021-08-16T19:09:09.852Z,1629140949.852 [DVL_micro](ERROR): Failed to parse: 9.99,+99999.99,+9999.99 2021-08-16T19:09:26.005Z,1629140966.005 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210816T183557/Express0019.lzma 2021-08-16T19:09:27.007Z,1629140967.007 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0019.lzma.bak 2021-08-16T19:09:27.007Z,1629140967.007 [DataOverHttps](INFO): SBD MOMSN=15889995 2021-08-16T19:09:29.235Z,1629140969.235 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T19:09:29.235Z,1629140969.235 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T19:09:29.235Z,1629140969.235 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T19:09:32.020Z,1629140972.020 [NAL9602](INFO): SBD MO Status=0, MOMSN=5454, MT Status=0, MTMSN=0 2021-08-16T19:09:32.020Z,1629140972.020 [NAL9602](INFO): No messages in MT queue 2021-08-16T19:10:02.802Z,1629141002.802 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T19:11:57.194Z,1629141117.194 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T19:11:57.194Z,1629141117.194 [DVL_micro](ERROR): Failed to parse: :TS,00000000000,+24.2,0000.0,1489.0,000 2021-08-16T19:14:29.646Z,1629141269.646 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T19:14:29.646Z,1629141269.646 [Default:CheckIn:C.Wait] Stopped 2021-08-16T19:14:29.647Z,1629141269.647 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T19:14:29.647Z,1629141269.647 [Default:CheckIn:D] Running Loop=1 2021-08-16T19:14:30.085Z,1629141270.085 [Default:CheckIn:D] Stopped 2021-08-16T19:14:30.085Z,1629141270.085 [Default:CheckIn:E] Running Loop=1 2021-08-16T19:14:30.570Z,1629141270.570 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 55.014628 min 2021-08-16T19:14:30.570Z,1629141270.570 [Default:CheckIn:E] Stopped 2021-08-16T19:14:30.570Z,1629141270.570 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T19:14:30.570Z,1629141270.570 [Default:CheckIn] Stopped 2021-08-16T19:14:30.570Z,1629141270.570 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T19:14:30.570Z,1629141270.570 [Default:CheckIn](INFO): Running loop #10 2021-08-16T19:14:30.570Z,1629141270.570 [Default:CheckIn] Running Loop=10 2021-08-16T19:14:30.570Z,1629141270.570 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T19:14:30.571Z,1629141270.571 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T19:14:32.437Z,1629141272.437 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191430.00,A,4149.68401,N,08324.71687,W,3.207,178.42,160821,,,A*71 2021-08-16T19:14:32.439Z,1629141272.439 [NAL9602](INFO): GPS fix at 20210816T191430: (41.828067, -83.411948) 2021-08-16T19:14:32.469Z,1629141272.469 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T19:14:32.469Z,1629141272.469 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T19:14:41.804Z,1629141281.804 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0021.lzma 2021-08-16T19:14:42.807Z,1629141282.807 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0021.lzma.bak 2021-08-16T19:14:42.807Z,1629141282.807 [DataOverHttps](INFO): SBD MOMSN=15890006 2021-08-16T19:14:59.997Z,1629141299.997 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20210816T183557/Express0022.lzma 2021-08-16T19:15:00.446Z,1629141300.446 [NAL9602](INFO): SBD MO Status=0, MOMSN=5455, MT Status=0, MTMSN=0 2021-08-16T19:15:00.446Z,1629141300.446 [NAL9602](INFO): No messages in MT queue 2021-08-16T19:15:00.999Z,1629141300.999 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0022.lzma.bak 2021-08-16T19:15:00.999Z,1629141300.999 [DataOverHttps](INFO): SBD MOMSN=15890011 2021-08-16T19:15:04.102Z,1629141304.102 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T19:15:04.102Z,1629141304.102 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T19:15:04.102Z,1629141304.102 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T19:15:14.607Z,1629141314.607 [DVL_micro](ERROR): Failed to parse: :BI,+00170,-00052,+00039,+00BD,+00000000.00,+00000000.00,+00000000.00,9999.99,000.00 2021-08-16T19:15:31.146Z,1629141331.146 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T19:18:24.985Z,1629141504.985 [DVL_micro](ERROR): Failed to parse: :WI,+02965,-00034,-00467,+00000,A 2021-08-16T19:20:04.825Z,1629141604.825 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T19:20:04.825Z,1629141604.825 [Default:CheckIn:C.Wait] Stopped 2021-08-16T19:20:04.825Z,1629141604.825 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T19:20:04.825Z,1629141604.825 [Default:CheckIn:D] Running Loop=1 2021-08-16T19:20:05.202Z,1629141605.202 [Default:CheckIn:D] Stopped 2021-08-16T19:20:05.202Z,1629141605.202 [Default:CheckIn:E] Running Loop=1 2021-08-16T19:20:05.613Z,1629141605.613 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 60.599984 min 2021-08-16T19:20:05.613Z,1629141605.613 [Default:CheckIn:E] Stopped 2021-08-16T19:20:05.613Z,1629141605.613 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T19:20:05.613Z,1629141605.613 [Default:CheckIn] Stopped 2021-08-16T19:20:05.613Z,1629141605.613 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T19:20:05.613Z,1629141605.613 [Default:CheckIn](INFO): Running loop #11 2021-08-16T19:20:05.614Z,1629141605.614 [Default:CheckIn] Running Loop=11 2021-08-16T19:20:05.614Z,1629141605.614 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T19:20:05.614Z,1629141605.614 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T19:20:07.622Z,1629141607.622 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192005.00,A,4149.67413,N,08324.69429,W,0.039,56.63,160821,,,A*41 2021-08-16T19:20:07.624Z,1629141607.624 [NAL9602](INFO): GPS fix at 20210816T192005: (41.827902, -83.411571) 2021-08-16T19:20:07.635Z,1629141607.635 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T19:20:07.635Z,1629141607.635 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T19:20:15.936Z,1629141615.936 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0024.lzma 2021-08-16T19:20:17.521Z,1629141617.521 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0024.lzma.bak 2021-08-16T19:20:17.522Z,1629141617.522 [DataOverHttps](INFO): SBD MOMSN=15890024 2021-08-16T19:20:35.608Z,1629141635.608 [NAL9602](INFO): SBD MO Status=0, MOMSN=5456, MT Status=0, MTMSN=0 2021-08-16T19:20:35.608Z,1629141635.608 [NAL9602](INFO): No messages in MT queue 2021-08-16T19:20:40.553Z,1629141640.553 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210816T183557/Express0025.lzma 2021-08-16T19:20:41.554Z,1629141641.554 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0025.lzma.bak 2021-08-16T19:20:41.555Z,1629141641.555 [DataOverHttps](INFO): SBD MOMSN=15890027 2021-08-16T19:20:43.698Z,1629141643.698 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T19:20:43.699Z,1629141643.699 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T19:20:43.699Z,1629141643.699 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T19:21:06.322Z,1629141666.322 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T19:25:44.362Z,1629141944.362 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T19:25:44.362Z,1629141944.362 [Default:CheckIn:C.Wait] Stopped 2021-08-16T19:25:44.362Z,1629141944.362 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T19:25:44.363Z,1629141944.363 [Default:CheckIn:D] Running Loop=1 2021-08-16T19:25:44.777Z,1629141944.777 [Default:CheckIn:D] Stopped 2021-08-16T19:25:44.777Z,1629141944.777 [Default:CheckIn:E] Running Loop=1 2021-08-16T19:25:45.174Z,1629141945.174 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 66.259566 min 2021-08-16T19:25:45.174Z,1629141945.174 [Default:CheckIn:E] Stopped 2021-08-16T19:25:45.174Z,1629141945.174 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T19:25:45.174Z,1629141945.174 [Default:CheckIn] Stopped 2021-08-16T19:25:45.174Z,1629141945.174 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T19:25:45.174Z,1629141945.174 [Default:CheckIn](INFO): Running loop #12 2021-08-16T19:25:45.174Z,1629141945.174 [Default:CheckIn] Running Loop=12 2021-08-16T19:25:45.175Z,1629141945.175 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T19:25:45.175Z,1629141945.175 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T19:25:47.181Z,1629141947.181 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192545.00,A,4149.84567,N,08324.81913,W,11.994,164.02,160821,,,A*44 2021-08-16T19:25:47.190Z,1629141947.190 [NAL9602](INFO): GPS fix at 20210816T192545: (41.830761, -83.413652) 2021-08-16T19:25:47.202Z,1629141947.202 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T19:25:47.202Z,1629141947.202 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T19:25:56.824Z,1629141956.824 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0027.lzma 2021-08-16T19:25:57.826Z,1629141957.826 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0027.lzma.bak 2021-08-16T19:25:57.827Z,1629141957.827 [DataOverHttps](INFO): SBD MOMSN=15890042 2021-08-16T19:26:19.677Z,1629141979.677 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210816T183557/Express0028.lzma 2021-08-16T19:26:20.679Z,1629141980.679 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0028.lzma.bak 2021-08-16T19:26:20.679Z,1629141980.679 [DataOverHttps](INFO): SBD MOMSN=15890046 2021-08-16T19:26:23.648Z,1629141983.648 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T19:26:23.648Z,1629141983.648 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T19:26:23.648Z,1629141983.648 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T19:26:37.370Z,1629141997.370 [NAL9602](INFO): SBD MO Status=0, MOMSN=5457, MT Status=0, MTMSN=0 2021-08-16T19:26:37.370Z,1629141997.370 [NAL9602](INFO): No messages in MT queue 2021-08-16T19:27:08.066Z,1629142028.066 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T19:28:07.965Z,1629142087.965 [DVL_micro](ERROR): only read 3 of 4 data items 2021-08-16T19:28:07.965Z,1629142087.965 [DVL_micro](ERROR): Failed to parse: :BI,+03219,-00012,+0000,I 2021-08-16T19:31:15.656Z,1629142275.656 [DVL_micro](ERROR): only read 3 of 4 data items 2021-08-16T19:31:15.656Z,1629142275.656 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+9999.99, 2021-08-16T19:31:24.173Z,1629142284.173 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T19:31:24.173Z,1629142284.173 [Default:CheckIn:C.Wait] Stopped 2021-08-16T19:31:24.173Z,1629142284.173 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T19:31:24.173Z,1629142284.173 [Default:CheckIn:D] Running Loop=1 2021-08-16T19:31:24.553Z,1629142284.553 [Default:CheckIn:D] Stopped 2021-08-16T19:31:24.553Z,1629142284.553 [Default:CheckIn:E] Running Loop=1 2021-08-16T19:31:24.965Z,1629142284.965 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 71.922502 min 2021-08-16T19:31:24.965Z,1629142284.965 [Default:CheckIn:E] Stopped 2021-08-16T19:31:24.965Z,1629142284.965 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T19:31:24.965Z,1629142284.965 [Default:CheckIn] Stopped 2021-08-16T19:31:24.965Z,1629142284.965 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T19:31:24.966Z,1629142284.966 [Default:CheckIn](INFO): Running loop #13 2021-08-16T19:31:24.966Z,1629142284.966 [Default:CheckIn] Running Loop=13 2021-08-16T19:31:24.966Z,1629142284.966 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T19:31:24.966Z,1629142284.966 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T19:31:26.953Z,1629142286.953 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193125.00,A,4149.79950,N,08324.78862,W,0.253,128.92,160821,,,A*7D 2021-08-16T19:31:26.955Z,1629142286.955 [NAL9602](INFO): GPS fix at 20210816T193125: (41.829992, -83.413144) 2021-08-16T19:31:26.994Z,1629142286.994 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T19:31:26.994Z,1629142286.994 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T19:31:28.374Z,1629142288.374 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0030.lzma 2021-08-16T19:31:28.778Z,1629142288.778 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0030.lzma.bak 2021-08-16T19:31:28.779Z,1629142288.779 [DataOverHttps](INFO): SBD MOMSN=15890101 2021-08-16T19:31:51.313Z,1629142311.313 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210816T183557/Express0031.lzma 2021-08-16T19:31:52.315Z,1629142312.315 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0031.lzma.bak 2021-08-16T19:31:52.315Z,1629142312.315 [DataOverHttps](INFO): SBD MOMSN=15890104 2021-08-16T19:31:54.804Z,1629142314.804 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T19:31:54.804Z,1629142314.804 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T19:31:54.805Z,1629142314.805 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T19:32:31.747Z,1629142351.747 [DVL_micro](ERROR): Failed to parse: :SA,-03.08,-02.74,047.0 2021-08-16T19:32:58.894Z,1629142378.894 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2021-08-16T19:33:04.024Z,1629142384.024 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2021-08-16T19:33:04.031Z,1629142384.031 [BPC1](ERROR): Battery stick #6 (s/n: 00CA) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2021-08-16T19:33:04.032Z,1629142384.032 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6. 2021-08-16T19:33:04.035Z,1629142384.035 [BPC1](INFO): Received data from all battery sticks. 2021-08-16T19:33:44.064Z,1629142424.064 [NAL9602](INFO): SBD MO Status=2, MOMSN=5458, MT Status=2, MTMSN=0 2021-08-16T19:33:44.064Z,1629142424.064 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T19:36:37.873Z,1629142597.873 [NAL9602](INFO): SBD MO Status=2, MOMSN=5458, MT Status=2, MTMSN=0 2021-08-16T19:36:37.874Z,1629142597.874 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T19:36:38.266Z,1629142598.266 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-08-16T19:36:55.253Z,1629142615.253 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T19:36:55.253Z,1629142615.253 [Default:CheckIn:C.Wait] Stopped 2021-08-16T19:36:55.253Z,1629142615.253 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T19:36:55.254Z,1629142615.254 [Default:CheckIn:D] Running Loop=1 2021-08-16T19:36:55.645Z,1629142615.645 [Default:CheckIn:D] Stopped 2021-08-16T19:36:55.646Z,1629142615.646 [Default:CheckIn:E] Running Loop=1 2021-08-16T19:36:56.045Z,1629142616.045 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 77.440706 min 2021-08-16T19:36:56.045Z,1629142616.045 [Default:CheckIn:E] Stopped 2021-08-16T19:36:56.046Z,1629142616.046 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T19:36:56.046Z,1629142616.046 [Default:CheckIn] Stopped 2021-08-16T19:36:56.046Z,1629142616.046 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T19:36:56.046Z,1629142616.046 [Default:CheckIn](INFO): Running loop #14 2021-08-16T19:36:56.046Z,1629142616.046 [Default:CheckIn] Running Loop=14 2021-08-16T19:36:56.046Z,1629142616.046 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T19:36:56.046Z,1629142616.046 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T19:36:58.076Z,1629142618.076 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193656.00,A,4150.57083,N,08325.02904,W,26.670,267.32,160821,,,A*43 2021-08-16T19:36:58.079Z,1629142618.079 [NAL9602](INFO): GPS fix at 20210816T193656: (41.842847, -83.417151) 2021-08-16T19:36:58.094Z,1629142618.094 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T19:36:58.094Z,1629142618.094 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T19:37:05.777Z,1629142625.777 [DataOverHttps](INFO): Sending 201 bytes from file Logs/20210816T183557/Courier0033.lzma 2021-08-16T19:37:06.779Z,1629142626.779 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0033.lzma.bak 2021-08-16T19:37:06.779Z,1629142626.779 [DataOverHttps](INFO): SBD MOMSN=15890109 2021-08-16T19:37:24.617Z,1629142644.617 [DataOverHttps](INFO): Sending 239 bytes from file Logs/20210816T183557/Express0034.lzma 2021-08-16T19:37:25.625Z,1629142645.625 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0034.lzma.bak 2021-08-16T19:37:25.626Z,1629142645.626 [DataOverHttps](INFO): SBD MOMSN=15890112 2021-08-16T19:37:27.981Z,1629142647.981 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T19:37:27.982Z,1629142647.982 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T19:37:27.982Z,1629142647.982 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T19:37:30.792Z,1629142650.792 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T19:42:28.732Z,1629142948.732 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T19:42:28.732Z,1629142948.732 [Default:CheckIn:C.Wait] Stopped 2021-08-16T19:42:28.732Z,1629142948.732 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T19:42:28.773Z,1629142948.773 [Default:CheckIn:D] Running Loop=1 2021-08-16T19:42:29.171Z,1629142949.171 [Default:CheckIn:D] Stopped 2021-08-16T19:42:29.171Z,1629142949.171 [Default:CheckIn:E] Running Loop=1 2021-08-16T19:42:29.542Z,1629142949.542 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 82.999463 min 2021-08-16T19:42:29.543Z,1629142949.543 [Default:CheckIn:E] Stopped 2021-08-16T19:42:29.543Z,1629142949.543 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T19:42:29.543Z,1629142949.543 [Default:CheckIn] Stopped 2021-08-16T19:42:29.543Z,1629142949.543 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T19:42:29.543Z,1629142949.543 [Default:CheckIn](INFO): Running loop #15 2021-08-16T19:42:29.543Z,1629142949.543 [Default:CheckIn] Running Loop=15 2021-08-16T19:42:29.543Z,1629142949.543 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T19:42:29.543Z,1629142949.543 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T19:42:31.517Z,1629142951.517 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194229.00,A,4154.28376,N,08322.17898,W,58.510,28.42,160821,,,A*78 2021-08-16T19:42:31.519Z,1629142951.519 [NAL9602](INFO): GPS fix at 20210816T194229: (41.904729, -83.369650) 2021-08-16T19:42:31.586Z,1629142951.586 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T19:42:31.586Z,1629142951.586 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T19:42:40.152Z,1629142960.152 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0036.lzma 2021-08-16T19:42:41.155Z,1629142961.155 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0036.lzma.bak 2021-08-16T19:42:41.155Z,1629142961.155 [DataOverHttps](INFO): SBD MOMSN=15890116 2021-08-16T19:42:59.453Z,1629142979.453 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20210816T183557/Express0037.lzma 2021-08-16T19:43:00.461Z,1629142980.461 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0037.lzma.bak 2021-08-16T19:43:00.462Z,1629142980.462 [DataOverHttps](INFO): SBD MOMSN=15890119 2021-08-16T19:43:02.852Z,1629142982.852 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T19:43:02.861Z,1629142982.861 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T19:43:02.861Z,1629142982.861 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T19:43:43.624Z,1629143023.624 [DVL_micro](ERROR): Failed to parse: :BD,+00000000.00,+00000000.00,+00000000.00,9999.99,0RD,+9999.99,+9999..99,+9999.99 2021-08-16T19:46:49.161Z,1629143209.161 [DVL_micro](ERROR): Failed to parse: 72,+00162,+0000,I 2021-08-16T19:47:33.603Z,1629143253.603 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-08-16T19:48:03.504Z,1629143283.504 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T19:48:03.504Z,1629143283.504 [Default:CheckIn:C.Wait] Stopped 2021-08-16T19:48:03.505Z,1629143283.505 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T19:48:03.506Z,1629143283.506 [Default:CheckIn:D] Running Loop=1 2021-08-16T19:48:03.913Z,1629143283.913 [Default:CheckIn:D] Stopped 2021-08-16T19:48:03.914Z,1629143283.914 [Default:CheckIn:E] Running Loop=1 2021-08-16T19:48:04.303Z,1629143284.303 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T19:48:04.315Z,1629143284.315 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 88.578507 min 2021-08-16T19:48:04.316Z,1629143284.316 [Default:CheckIn:E] Stopped 2021-08-16T19:48:04.316Z,1629143284.316 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T19:48:04.316Z,1629143284.316 [Default:CheckIn] Stopped 2021-08-16T19:48:04.316Z,1629143284.316 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T19:48:04.316Z,1629143284.316 [Default:CheckIn](INFO): Running loop #16 2021-08-16T19:48:04.316Z,1629143284.316 [Default:CheckIn] Running Loop=16 2021-08-16T19:48:04.317Z,1629143284.317 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T19:48:04.317Z,1629143284.317 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T19:48:06.339Z,1629143286.339 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194804.00,A,4159.26871,N,08319.67078,W,50.715,31.84,160821,,,A*76 2021-08-16T19:48:06.356Z,1629143286.356 [NAL9602](INFO): GPS fix at 20210816T194804: (41.987812, -83.327846) 2021-08-16T19:48:06.367Z,1629143286.367 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T19:48:06.367Z,1629143286.367 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T19:48:14.072Z,1629143294.072 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20210816T183557/Courier0039.lzma 2021-08-16T19:48:15.075Z,1629143295.075 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0039.lzma.bak 2021-08-16T19:48:15.075Z,1629143295.075 [DataOverHttps](INFO): SBD MOMSN=15890122 2021-08-16T19:48:37.107Z,1629143317.107 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-08-16T19:48:37.181Z,1629143317.181 [NAL9602](ERROR): received: +CSQ:0 OK58, 2, 0, 0, 0 OK 2021-08-16T19:48:37.441Z,1629143317.441 [DataOverHttps](INFO): Sending 221 bytes from file Logs/20210816T183557/Express0040.lzma 2021-08-16T19:48:38.443Z,1629143318.443 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0040.lzma.bak 2021-08-16T19:48:38.443Z,1629143318.443 [DataOverHttps](INFO): SBD MOMSN=15890125 2021-08-16T19:48:40.801Z,1629143320.801 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T19:48:40.801Z,1629143320.801 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T19:48:40.801Z,1629143320.801 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T19:49:46.596Z,1629143386.596 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T19:49:46.596Z,1629143386.596 [DVL_micro](ERROR): Failed to parse: :TS,000000,35.0000.0,10 2021-08-16T19:53:08.704Z,1629143588.704 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-08-16T19:53:39.406Z,1629143619.406 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T19:53:41.441Z,1629143621.441 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T19:53:41.441Z,1629143621.441 [Default:CheckIn:C.Wait] Stopped 2021-08-16T19:53:41.441Z,1629143621.441 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T19:53:41.442Z,1629143621.442 [Default:CheckIn:D] Running Loop=1 2021-08-16T19:53:41.850Z,1629143621.850 [Default:CheckIn:D] Stopped 2021-08-16T19:53:41.850Z,1629143621.850 [Default:CheckIn:E] Running Loop=1 2021-08-16T19:53:42.248Z,1629143622.248 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.210783 min 2021-08-16T19:53:42.248Z,1629143622.248 [Default:CheckIn:E] Stopped 2021-08-16T19:53:42.270Z,1629143622.270 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T19:53:42.270Z,1629143622.270 [Default:CheckIn] Stopped 2021-08-16T19:53:42.271Z,1629143622.271 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T19:53:42.271Z,1629143622.271 [Default:CheckIn](INFO): Running loop #17 2021-08-16T19:53:42.271Z,1629143622.271 [Default:CheckIn] Running Loop=17 2021-08-16T19:53:42.271Z,1629143622.271 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T19:53:42.271Z,1629143622.271 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T19:53:44.256Z,1629143624.256 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195342.00,A,4204.29225,N,08321.96844,W,60.628,332.32,160821,,,A*42 2021-08-16T19:53:44.259Z,1629143624.259 [NAL9602](INFO): GPS fix at 20210816T195342: (42.071537, -83.366141) 2021-08-16T19:53:44.270Z,1629143624.270 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T19:53:44.270Z,1629143624.270 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T19:53:51.916Z,1629143631.916 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0042.lzma 2021-08-16T19:53:52.919Z,1629143632.919 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0042.lzma.bak 2021-08-16T19:53:52.919Z,1629143632.919 [DataOverHttps](INFO): SBD MOMSN=15890129 2021-08-16T19:54:13.873Z,1629143653.873 [DataOverHttps](INFO): Sending 220 bytes from file Logs/20210816T183557/Express0043.lzma 2021-08-16T19:54:14.875Z,1629143654.875 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0043.lzma.bak 2021-08-16T19:54:14.875Z,1629143654.875 [DataOverHttps](INFO): SBD MOMSN=15890132 2021-08-16T19:54:15.039Z,1629143655.039 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-08-16T19:54:15.117Z,1629143655.117 [NAL9602](ERROR): received: +CSQ:0 OK58, 2, 0, 0, 0 OK 2021-08-16T19:54:17.101Z,1629143657.101 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T19:54:17.101Z,1629143657.101 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T19:54:17.101Z,1629143657.101 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T19:55:40.392Z,1629143740.392 [NAL9602](INFO): SBD MO Status=2, MOMSN=5458, MT Status=2, MTMSN=0 2021-08-16T19:55:40.399Z,1629143740.399 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T19:55:54.530Z,1629143754.530 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T19:55:54.530Z,1629143754.530 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+24.1,0000.0,148 2021-08-16T19:58:32.972Z,1629143912.972 [NAL9602](INFO): SBD MO Status=2, MOMSN=5458, MT Status=2, MTMSN=0 2021-08-16T19:58:32.972Z,1629143912.972 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T19:58:46.299Z,1629143926.299 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-08-16T19:59:08.829Z,1629143948.829 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-16T19:59:10.837Z,1629143950.837 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.239216 2021-08-16T19:59:17.002Z,1629143957.002 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T19:59:17.832Z,1629143957.832 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T19:59:17.832Z,1629143957.832 [Default:CheckIn:C.Wait] Stopped 2021-08-16T19:59:17.832Z,1629143957.832 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T19:59:17.833Z,1629143957.833 [Default:CheckIn:D] Running Loop=1 2021-08-16T19:59:18.224Z,1629143958.224 [Default:CheckIn:D] Stopped 2021-08-16T19:59:18.224Z,1629143958.224 [Default:CheckIn:E] Running Loop=1 2021-08-16T19:59:18.629Z,1629143958.629 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 99.817017 min 2021-08-16T19:59:18.629Z,1629143958.629 [Default:CheckIn:E] Stopped 2021-08-16T19:59:18.629Z,1629143958.629 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T19:59:18.629Z,1629143958.629 [Default:CheckIn] Stopped 2021-08-16T19:59:18.630Z,1629143958.630 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T19:59:18.630Z,1629143958.630 [Default:CheckIn](INFO): Running loop #18 2021-08-16T19:59:18.630Z,1629143958.630 [Default:CheckIn] Running Loop=18 2021-08-16T19:59:18.630Z,1629143958.630 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T19:59:18.630Z,1629143958.630 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T19:59:20.645Z,1629143960.645 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195918.00,A,4209.21256,N,08323.05138,W,31.685,341.48,160821,,,A*46 2021-08-16T19:59:20.647Z,1629143960.647 [NAL9602](INFO): GPS fix at 20210816T195918: (42.153543, -83.384190) 2021-08-16T19:59:20.678Z,1629143960.678 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T19:59:20.678Z,1629143960.678 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T19:59:24.553Z,1629143964.553 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003152 2021-08-16T19:59:31.936Z,1629143971.936 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0045.lzma 2021-08-16T19:59:32.939Z,1629143972.939 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0045.lzma.bak 2021-08-16T19:59:32.939Z,1629143972.939 [DataOverHttps](INFO): SBD MOMSN=15890136 2021-08-16T19:59:51.411Z,1629143991.411 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response. 2021-08-16T19:59:51.489Z,1629143991.489 [NAL9602](ERROR): received: +CSQ:0 OK58, 2, 0, 0, 0 OK 2021-08-16T19:59:54.621Z,1629143994.621 [DataOverHttps](INFO): Sending 220 bytes from file Logs/20210816T183557/Express0046.lzma 2021-08-16T19:59:55.623Z,1629143995.623 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0046.lzma.bak 2021-08-16T19:59:55.623Z,1629143995.623 [DataOverHttps](INFO): SBD MOMSN=15890139 2021-08-16T19:59:58.755Z,1629143998.755 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T19:59:58.755Z,1629143998.755 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T19:59:58.755Z,1629143998.755 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T20:00:22.194Z,1629144022.194 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T20:04:59.432Z,1629144299.432 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T20:04:59.432Z,1629144299.432 [Default:CheckIn:C.Wait] Stopped 2021-08-16T20:04:59.437Z,1629144299.437 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T20:04:59.437Z,1629144299.437 [Default:CheckIn:D] Running Loop=1 2021-08-16T20:04:59.910Z,1629144299.910 [Default:CheckIn:D] Stopped 2021-08-16T20:04:59.910Z,1629144299.910 [Default:CheckIn:E] Running Loop=1 2021-08-16T20:05:00.226Z,1629144300.226 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 105.511784 min 2021-08-16T20:05:00.226Z,1629144300.226 [Default:CheckIn:E] Stopped 2021-08-16T20:05:00.226Z,1629144300.226 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T20:05:00.226Z,1629144300.226 [Default:CheckIn] Stopped 2021-08-16T20:05:00.226Z,1629144300.226 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T20:05:00.227Z,1629144300.227 [Default:CheckIn](INFO): Running loop #19 2021-08-16T20:05:00.227Z,1629144300.227 [Default:CheckIn] Running Loop=19 2021-08-16T20:05:00.227Z,1629144300.227 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T20:05:00.227Z,1629144300.227 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T20:05:02.244Z,1629144302.244 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200500.00,A,4209.98726,N,08323.25026,W,3.829,0.92,160821,,,A*78 2021-08-16T20:05:02.247Z,1629144302.247 [NAL9602](INFO): GPS fix at 20210816T200500: (42.166454, -83.387504) 2021-08-16T20:05:02.257Z,1629144302.257 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T20:05:02.257Z,1629144302.257 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T20:05:09.508Z,1629144309.508 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20210816T183557/Courier0048.lzma 2021-08-16T20:05:10.511Z,1629144310.511 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0048.lzma.bak 2021-08-16T20:05:10.511Z,1629144310.511 [DataOverHttps](INFO): SBD MOMSN=15890143 2021-08-16T20:05:27.213Z,1629144327.213 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20210816T183557/Express0049.lzma 2021-08-16T20:05:28.215Z,1629144328.215 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0049.lzma.bak 2021-08-16T20:05:28.215Z,1629144328.215 [DataOverHttps](INFO): SBD MOMSN=15890146 2021-08-16T20:05:30.590Z,1629144330.590 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T20:05:30.590Z,1629144330.590 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T20:05:30.590Z,1629144330.590 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T20:06:22.304Z,1629144382.304 [NAL9602](INFO): SBD MO Status=2, MOMSN=5458, MT Status=2, MTMSN=0 2021-08-16T20:06:22.304Z,1629144382.304 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T20:09:19.636Z,1629144559.636 [NAL9602](INFO): SBD MO Status=2, MOMSN=5458, MT Status=2, MTMSN=0 2021-08-16T20:09:19.636Z,1629144559.636 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T20:10:17.021Z,1629144617.021 [NAL9602](INFO): SBD MO Status=2, MOMSN=5458, MT Status=2, MTMSN=0 2021-08-16T20:10:17.021Z,1629144617.021 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T20:10:17.407Z,1629144617.407 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-08-16T20:10:31.167Z,1629144631.167 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T20:10:31.168Z,1629144631.168 [Default:CheckIn:C.Wait] Stopped 2021-08-16T20:10:31.168Z,1629144631.168 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T20:10:31.168Z,1629144631.168 [Default:CheckIn:D] Running Loop=1 2021-08-16T20:10:31.556Z,1629144631.556 [Default:CheckIn:D] Stopped 2021-08-16T20:10:31.556Z,1629144631.556 [Default:CheckIn:E] Running Loop=1 2021-08-16T20:10:31.965Z,1629144631.965 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 111.039217 min 2021-08-16T20:10:31.965Z,1629144631.965 [Default:CheckIn:E] Stopped 2021-08-16T20:10:31.965Z,1629144631.965 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T20:10:31.965Z,1629144631.965 [Default:CheckIn] Stopped 2021-08-16T20:10:31.965Z,1629144631.965 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T20:10:31.966Z,1629144631.966 [Default:CheckIn](INFO): Running loop #20 2021-08-16T20:10:31.966Z,1629144631.966 [Default:CheckIn] Running Loop=20 2021-08-16T20:10:31.966Z,1629144631.966 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T20:10:31.966Z,1629144631.966 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T20:10:33.976Z,1629144633.976 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201032.00,A,4210.99287,N,08323.28250,W,4.004,359.42,160821,,,A*76 2021-08-16T20:10:33.978Z,1629144633.978 [NAL9602](INFO): GPS fix at 20210816T201032: (42.183214, -83.388042) 2021-08-16T20:10:33.989Z,1629144633.989 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T20:10:33.989Z,1629144633.989 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T20:10:40.844Z,1629144640.844 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20210816T183557/Courier0051.lzma 2021-08-16T20:10:42.667Z,1629144642.667 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0051.lzma.bak 2021-08-16T20:10:42.667Z,1629144642.667 [DataOverHttps](INFO): SBD MOMSN=15890149 2021-08-16T20:10:58.549Z,1629144658.549 [DataOverHttps](INFO): Sending 215 bytes from file Logs/20210816T183557/Express0052.lzma 2021-08-16T20:10:59.551Z,1629144659.551 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0052.lzma.bak 2021-08-16T20:10:59.551Z,1629144659.551 [DataOverHttps](INFO): SBD MOMSN=15890152 2021-08-16T20:11:01.520Z,1629144661.520 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T20:11:01.520Z,1629144661.520 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T20:11:01.520Z,1629144661.520 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T20:11:06.750Z,1629144666.750 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T20:14:00.473Z,1629144840.473 [DVL_micro](ERROR): only read 3 of 4 data items 2021-08-16T20:14:00.473Z,1629144840.473 [DVL_micro](ERROR): Failed to parse: :BI,+01430,+0009,+00000,I 2021-08-16T20:16:02.100Z,1629144962.100 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T20:16:02.100Z,1629144962.100 [Default:CheckIn:C.Wait] Stopped 2021-08-16T20:16:02.100Z,1629144962.100 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T20:16:02.100Z,1629144962.100 [Default:CheckIn:D] Running Loop=1 2021-08-16T20:16:02.504Z,1629144962.504 [Default:CheckIn:D] Stopped 2021-08-16T20:16:02.504Z,1629144962.504 [Default:CheckIn:E] Running Loop=1 2021-08-16T20:16:02.897Z,1629144962.897 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 116.555013 min 2021-08-16T20:16:02.897Z,1629144962.897 [Default:CheckIn:E] Stopped 2021-08-16T20:16:02.897Z,1629144962.897 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T20:16:02.897Z,1629144962.897 [Default:CheckIn] Stopped 2021-08-16T20:16:02.898Z,1629144962.898 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T20:16:02.898Z,1629144962.898 [Default:CheckIn](INFO): Running loop #21 2021-08-16T20:16:02.898Z,1629144962.898 [Default:CheckIn] Running Loop=21 2021-08-16T20:16:02.898Z,1629144962.898 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T20:16:02.898Z,1629144962.898 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T20:16:04.904Z,1629144964.904 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201603.00,A,4211.35981,N,08323.29978,W,6.259,358.07,160821,,,A*70 2021-08-16T20:16:04.907Z,1629144964.907 [NAL9602](INFO): GPS fix at 20210816T201603: (42.189330, -83.388330) 2021-08-16T20:16:04.917Z,1629144964.917 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T20:16:04.917Z,1629144964.917 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T20:16:12.496Z,1629144972.496 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0054.lzma 2021-08-16T20:16:13.499Z,1629144973.499 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0054.lzma.bak 2021-08-16T20:16:13.499Z,1629144973.499 [DataOverHttps](INFO): SBD MOMSN=15890156 2021-08-16T20:16:33.297Z,1629144993.297 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20210816T183557/Express0055.lzma 2021-08-16T20:16:34.291Z,1629144994.291 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0055.lzma.bak 2021-08-16T20:16:34.291Z,1629144994.291 [DataOverHttps](INFO): SBD MOMSN=15890159 2021-08-16T20:16:36.488Z,1629144996.488 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T20:16:36.488Z,1629144996.488 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T20:16:36.488Z,1629144996.488 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T20:16:57.875Z,1629145017.875 [DVL_micro](ERROR): Failed to parse:129,-0011,+00000,I0000000.0000.00,+00000000.00,9999.99,000.00 2021-08-16T20:17:09.184Z,1629145029.184 [NAL9602](INFO): SBD MO Status=2, MOMSN=5458, MT Status=2, MTMSN=0 2021-08-16T20:17:09.184Z,1629145029.184 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T20:17:27.365Z,1629145047.365 [NAL9602](INFO): SBD MO Status=0, MOMSN=5458, MT Status=0, MTMSN=0 2021-08-16T20:17:27.365Z,1629145047.365 [NAL9602](INFO): No messages in MT queue 2021-08-16T20:17:58.082Z,1629145078.082 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T20:21:37.139Z,1629145297.139 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T20:21:37.140Z,1629145297.140 [Default:CheckIn:C.Wait] Stopped 2021-08-16T20:21:37.140Z,1629145297.140 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T20:21:37.140Z,1629145297.140 [Default:CheckIn:D] Running Loop=1 2021-08-16T20:21:37.547Z,1629145297.547 [Default:CheckIn:D] Stopped 2021-08-16T20:21:37.547Z,1629145297.547 [Default:CheckIn:E] Running Loop=1 2021-08-16T20:21:37.949Z,1629145297.949 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 122.139071 min 2021-08-16T20:21:37.949Z,1629145297.949 [Default:CheckIn:E] Stopped 2021-08-16T20:21:37.949Z,1629145297.949 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T20:21:37.949Z,1629145297.949 [Default:CheckIn] Stopped 2021-08-16T20:21:37.950Z,1629145297.950 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T20:21:37.950Z,1629145297.950 [Default:CheckIn](INFO): Running loop #22 2021-08-16T20:21:37.950Z,1629145297.950 [Default:CheckIn] Running Loop=22 2021-08-16T20:21:37.950Z,1629145297.950 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T20:21:37.950Z,1629145297.950 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T20:21:39.960Z,1629145299.960 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202138.00,A,4211.73892,N,08323.31316,W,11.333,357.50,160821,,,A*40 2021-08-16T20:21:39.963Z,1629145299.963 [NAL9602](INFO): GPS fix at 20210816T202138: (42.195649, -83.388553) 2021-08-16T20:21:39.989Z,1629145299.989 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T20:21:39.989Z,1629145299.989 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T20:21:47.242Z,1629145307.242 [DVL_micro](ERROR): only read 3 of 4 data items 2021-08-16T20:21:47.242Z,1629145307.242 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+9999.999 2021-08-16T20:21:47.544Z,1629145307.544 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0057.lzma 2021-08-16T20:21:48.547Z,1629145308.547 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0057.lzma.bak 2021-08-16T20:21:48.547Z,1629145308.547 [DataOverHttps](INFO): SBD MOMSN=15890163 2021-08-16T20:22:09.613Z,1629145329.613 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20210816T183557/Express0058.lzma 2021-08-16T20:22:10.615Z,1629145330.615 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0058.lzma.bak 2021-08-16T20:22:10.615Z,1629145330.615 [DataOverHttps](INFO): SBD MOMSN=15890166 2021-08-16T20:22:12.765Z,1629145332.765 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T20:22:12.766Z,1629145332.766 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T20:22:12.766Z,1629145332.766 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T20:22:16.368Z,1629145336.368 [NAL9602](INFO): SBD MO Status=0, MOMSN=5459, MT Status=0, MTMSN=0 2021-08-16T20:22:16.368Z,1629145336.368 [NAL9602](INFO): No messages in MT queue 2021-08-16T20:22:47.134Z,1629145367.134 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T20:23:18.243Z,1629145398.243 [DVL_micro](ERROR): Failed to parse: :2,-00110,-00107,+00000,I 2021-08-16T20:27:13.455Z,1629145633.455 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T20:27:13.455Z,1629145633.455 [Default:CheckIn:C.Wait] Stopped 2021-08-16T20:27:13.455Z,1629145633.455 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T20:27:13.455Z,1629145633.455 [Default:CheckIn:D] Running Loop=1 2021-08-16T20:27:13.839Z,1629145633.839 [Default:CheckIn:D] Stopped 2021-08-16T20:27:13.839Z,1629145633.839 [Default:CheckIn:E] Running Loop=1 2021-08-16T20:27:14.256Z,1629145634.256 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 127.743937 min 2021-08-16T20:27:14.256Z,1629145634.256 [Default:CheckIn:E] Stopped 2021-08-16T20:27:14.256Z,1629145634.256 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T20:27:14.257Z,1629145634.257 [Default:CheckIn] Stopped 2021-08-16T20:27:14.257Z,1629145634.257 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T20:27:14.257Z,1629145634.257 [Default:CheckIn](INFO): Running loop #23 2021-08-16T20:27:14.257Z,1629145634.257 [Default:CheckIn] Running Loop=23 2021-08-16T20:27:14.257Z,1629145634.257 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T20:27:14.257Z,1629145634.257 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T20:27:16.257Z,1629145636.257 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202714.00,A,4212.77308,N,08324.36851,W,47.294,299.28,160821,,,A*4C 2021-08-16T20:27:16.259Z,1629145636.259 [NAL9602](INFO): GPS fix at 20210816T202714: (42.212885, -83.406142) 2021-08-16T20:27:16.291Z,1629145636.291 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T20:27:16.291Z,1629145636.291 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T20:27:23.945Z,1629145643.945 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0060.lzma 2021-08-16T20:27:24.947Z,1629145644.947 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0060.lzma.bak 2021-08-16T20:27:24.947Z,1629145644.947 [DataOverHttps](INFO): SBD MOMSN=15890170 2021-08-16T20:27:41.709Z,1629145661.709 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20210816T183557/Express0061.lzma 2021-08-16T20:27:42.711Z,1629145662.711 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0061.lzma.bak 2021-08-16T20:27:42.711Z,1629145662.711 [DataOverHttps](INFO): SBD MOMSN=15890173 2021-08-16T20:27:45.011Z,1629145665.011 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T20:27:45.011Z,1629145665.011 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T20:27:45.011Z,1629145665.011 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T20:29:00.128Z,1629145740.128 [NAL9602](INFO): SBD MO Status=2, MOMSN=5460, MT Status=2, MTMSN=0 2021-08-16T20:29:00.128Z,1629145740.128 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T20:29:33.665Z,1629145773.665 [DVL_micro](ERROR): Failed to parse: :WI,-01406,-01169,-00117,+00000-01406,-01169,-00117,+00000,I 2021-08-16T20:30:48.421Z,1629145848.421 [NAL9602](INFO): SBD MO Status=2, MOMSN=5460, MT Status=2, MTMSN=0 2021-08-16T20:30:48.421Z,1629145848.421 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T20:31:05.389Z,1629145865.389 [NAL9602](INFO): SBD MO Status=2, MOMSN=5460, MT Status=2, MTMSN=0 2021-08-16T20:31:05.389Z,1629145865.389 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T20:32:18.525Z,1629145938.525 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-08-16T20:32:45.591Z,1629145965.591 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T20:32:45.592Z,1629145965.592 [Default:CheckIn:C.Wait] Stopped 2021-08-16T20:32:45.592Z,1629145965.592 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T20:32:45.592Z,1629145965.592 [Default:CheckIn:D] Running Loop=1 2021-08-16T20:32:45.992Z,1629145965.992 [Default:CheckIn:D] Stopped 2021-08-16T20:32:45.992Z,1629145965.992 [Default:CheckIn:E] Running Loop=1 2021-08-16T20:32:46.407Z,1629145966.407 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 133.279818 min 2021-08-16T20:32:46.408Z,1629145966.408 [Default:CheckIn:E] Stopped 2021-08-16T20:32:46.408Z,1629145966.408 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T20:32:46.408Z,1629145966.408 [Default:CheckIn] Stopped 2021-08-16T20:32:46.408Z,1629145966.408 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T20:32:46.408Z,1629145966.408 [Default:CheckIn](INFO): Running loop #24 2021-08-16T20:32:46.408Z,1629145966.408 [Default:CheckIn] Running Loop=24 2021-08-16T20:32:46.408Z,1629145966.408 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T20:32:46.409Z,1629145966.409 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T20:32:48.419Z,1629145968.419 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203246.00,A,4213.17457,N,08329.82925,W,61.756,267.20,160821,,,A*43 2021-08-16T20:32:48.422Z,1629145968.422 [NAL9602](INFO): GPS fix at 20210816T203246: (42.219576, -83.497154) 2021-08-16T20:32:48.431Z,1629145968.431 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T20:32:48.432Z,1629145968.432 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T20:32:56.616Z,1629145976.616 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0063.lzma 2021-08-16T20:32:57.619Z,1629145977.619 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0063.lzma.bak 2021-08-16T20:32:57.619Z,1629145977.619 [DataOverHttps](INFO): SBD MOMSN=15890176 2021-08-16T20:33:14.301Z,1629145994.301 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20210816T183557/Express0064.lzma 2021-08-16T20:33:15.303Z,1629145995.303 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0064.lzma.bak 2021-08-16T20:33:15.303Z,1629145995.303 [DataOverHttps](INFO): SBD MOMSN=15890179 2021-08-16T20:33:17.503Z,1629145997.503 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T20:33:17.503Z,1629145997.503 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T20:33:17.503Z,1629145997.503 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T20:33:20.726Z,1629146000.726 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T20:38:18.210Z,1629146298.210 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T20:38:18.210Z,1629146298.210 [Default:CheckIn:C.Wait] Stopped 2021-08-16T20:38:18.211Z,1629146298.211 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T20:38:18.211Z,1629146298.211 [Default:CheckIn:D] Running Loop=1 2021-08-16T20:38:18.554Z,1629146298.554 [Default:CheckIn:D] Stopped 2021-08-16T20:38:18.554Z,1629146298.554 [Default:CheckIn:E] Running Loop=1 2021-08-16T20:38:18.936Z,1629146298.936 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 138.822510 min 2021-08-16T20:38:18.936Z,1629146298.936 [Default:CheckIn:E] Stopped 2021-08-16T20:38:18.936Z,1629146298.936 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T20:38:18.957Z,1629146298.957 [Default:CheckIn] Stopped 2021-08-16T20:38:18.957Z,1629146298.957 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T20:38:18.957Z,1629146298.957 [Default:CheckIn](INFO): Running loop #25 2021-08-16T20:38:18.957Z,1629146298.957 [Default:CheckIn] Running Loop=25 2021-08-16T20:38:18.957Z,1629146298.957 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T20:38:18.957Z,1629146298.957 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T20:38:20.963Z,1629146300.963 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203819.00,A,4213.78055,N,08336.82830,W,61.717,251.53,160821,,,A*43 2021-08-16T20:38:20.966Z,1629146300.966 [NAL9602](INFO): GPS fix at 20210816T203819: (42.229676, -83.613805) 2021-08-16T20:38:21.007Z,1629146301.007 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T20:38:21.007Z,1629146301.007 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T20:38:32.364Z,1629146312.364 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0066.lzma 2021-08-16T20:38:33.367Z,1629146313.367 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0066.lzma.bak 2021-08-16T20:38:33.367Z,1629146313.367 [DataOverHttps](INFO): SBD MOMSN=15890183 2021-08-16T20:38:50.121Z,1629146330.121 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20210816T183557/Express0067.lzma 2021-08-16T20:38:51.115Z,1629146331.115 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0067.lzma.bak 2021-08-16T20:38:51.115Z,1629146331.115 [DataOverHttps](INFO): SBD MOMSN=15890186 2021-08-16T20:38:51.684Z,1629146331.684 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-08-16T20:38:51.761Z,1629146331.761 [NAL9602](ERROR): received: +CSQ:0 OK60, 2, 0, 0, 0 OK 2021-08-16T20:38:53.312Z,1629146333.312 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T20:38:53.317Z,1629146333.317 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T20:38:53.317Z,1629146333.317 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T20:40:39.566Z,1629146439.566 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2021-08-16T20:40:39.993Z,1629146439.993 [NAL9602](INFO): SBD MO Status=2, MOMSN=5460, MT Status=2, MTMSN=0 2021-08-16T20:40:39.993Z,1629146439.993 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T20:40:45.216Z,1629146445.216 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2021-08-16T20:40:45.224Z,1629146445.224 [BPC1](ERROR): Battery stick #6 (s/n: 00CA) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2021-08-16T20:40:45.225Z,1629146445.225 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6. 2021-08-16T20:40:45.227Z,1629146445.227 [BPC1](INFO): Received data from all battery sticks. 2021-08-16T20:43:23.586Z,1629146603.586 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-08-16T20:43:53.896Z,1629146633.896 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T20:43:53.896Z,1629146633.896 [Default:CheckIn:C.Wait] Stopped 2021-08-16T20:43:53.897Z,1629146633.897 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T20:43:53.897Z,1629146633.897 [Default:CheckIn:D] Running Loop=1 2021-08-16T20:43:54.295Z,1629146634.295 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T20:43:54.316Z,1629146634.316 [Default:CheckIn:D] Stopped 2021-08-16T20:43:54.316Z,1629146634.316 [Default:CheckIn:E] Running Loop=1 2021-08-16T20:43:54.736Z,1629146634.736 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 144.418538 min 2021-08-16T20:43:54.736Z,1629146634.736 [Default:CheckIn:E] Stopped 2021-08-16T20:43:54.736Z,1629146634.736 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T20:43:54.736Z,1629146634.736 [Default:CheckIn] Stopped 2021-08-16T20:43:54.736Z,1629146634.736 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T20:43:54.737Z,1629146634.737 [Default:CheckIn](INFO): Running loop #26 2021-08-16T20:43:54.737Z,1629146634.737 [Default:CheckIn] Running Loop=26 2021-08-16T20:43:54.737Z,1629146634.737 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T20:43:54.737Z,1629146634.737 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T20:43:56.717Z,1629146636.717 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204354.00,A,4214.24253,N,08343.44532,W,53.242,267.79,160821,,,A*42 2021-08-16T20:43:56.719Z,1629146636.719 [NAL9602](INFO): GPS fix at 20210816T204354: (42.237375, -83.724089) 2021-08-16T20:43:56.738Z,1629146636.738 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T20:43:56.738Z,1629146636.738 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T20:44:06.948Z,1629146646.948 [DataOverHttps](INFO): Sending 84 bytes from file Logs/20210816T183557/Courier0069.lzma 2021-08-16T20:44:07.951Z,1629146647.951 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0069.lzma.bak 2021-08-16T20:44:07.951Z,1629146647.951 [DataOverHttps](INFO): SBD MOMSN=15890189 2021-08-16T20:44:27.483Z,1629146667.483 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-08-16T20:44:27.565Z,1629146667.565 [NAL9602](ERROR): received: +CSQ:0 OK60, 2, 0, 0, 0 OK 2021-08-16T20:44:28.441Z,1629146668.441 [DataOverHttps](INFO): Sending 221 bytes from file Logs/20210816T183557/Express0070.lzma 2021-08-16T20:44:29.443Z,1629146669.443 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0070.lzma.bak 2021-08-16T20:44:29.443Z,1629146669.443 [DataOverHttps](INFO): SBD MOMSN=15890192 2021-08-16T20:44:31.948Z,1629146671.948 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T20:44:31.969Z,1629146671.969 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T20:44:31.969Z,1629146671.969 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T20:47:15.000Z,1629146836.000 [NAL9602](INFO): SBD MO Status=2, MOMSN=5460, MT Status=2, MTMSN=0 2021-08-16T20:47:16.000Z,1629146836.000 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T20:47:53.590Z,1629146873.590 [NAL9602](INFO): SBD MO Status=2, MOMSN=5460, MT Status=2, MTMSN=0 2021-08-16T20:47:53.590Z,1629146873.590 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T20:48:58.614Z,1629146938.614 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-08-16T20:49:29.323Z,1629146969.323 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T20:49:32.562Z,1629146972.562 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T20:49:32.562Z,1629146972.562 [Default:CheckIn:C.Wait] Stopped 2021-08-16T20:49:32.562Z,1629146972.562 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T20:49:32.562Z,1629146972.562 [Default:CheckIn:D] Running Loop=1 2021-08-16T20:49:32.972Z,1629146972.972 [Default:CheckIn:D] Stopped 2021-08-16T20:49:32.972Z,1629146972.972 [Default:CheckIn:E] Running Loop=1 2021-08-16T20:49:33.368Z,1629146973.368 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 150.062809 min 2021-08-16T20:49:33.368Z,1629146973.368 [Default:CheckIn:E] Stopped 2021-08-16T20:49:33.368Z,1629146973.368 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T20:49:33.368Z,1629146973.368 [Default:CheckIn] Stopped 2021-08-16T20:49:33.368Z,1629146973.368 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T20:49:33.369Z,1629146973.369 [Default:CheckIn](INFO): Running loop #27 2021-08-16T20:49:33.369Z,1629146973.369 [Default:CheckIn] Running Loop=27 2021-08-16T20:49:33.369Z,1629146973.369 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T20:49:33.369Z,1629146973.369 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T20:49:35.384Z,1629146975.384 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204933.00,A,4213.01908,N,08344.21621,W,7.911,239.97,160821,,,A*7E 2021-08-16T20:49:35.387Z,1629146975.387 [NAL9602](INFO): GPS fix at 20210816T204933: (42.216985, -83.736937) 2021-08-16T20:49:35.397Z,1629146975.397 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T20:49:35.397Z,1629146975.397 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T20:49:42.536Z,1629146982.536 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0072.lzma 2021-08-16T20:49:43.539Z,1629146983.539 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0072.lzma.bak 2021-08-16T20:49:43.539Z,1629146983.539 [DataOverHttps](INFO): SBD MOMSN=15890196 2021-08-16T20:50:03.017Z,1629147003.017 [DataOverHttps](INFO): Sending 224 bytes from file Logs/20210816T183557/Express0073.lzma 2021-08-16T20:50:04.019Z,1629147004.019 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0073.lzma.bak 2021-08-16T20:50:04.020Z,1629147004.020 [DataOverHttps](INFO): SBD MOMSN=15890199 2021-08-16T20:50:06.123Z,1629147006.123 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-08-16T20:50:06.197Z,1629147006.197 [NAL9602](ERROR): received: +CSQ:0 OK60, 2, 0, 0, 0 OK 2021-08-16T20:50:07.365Z,1629147007.365 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T20:50:07.366Z,1629147007.366 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T20:50:07.366Z,1629147007.366 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T20:52:19.140Z,1629147139.140 [NAL9602](INFO): SBD MO Status=0, MOMSN=5460, MT Status=0, MTMSN=0 2021-08-16T20:52:19.140Z,1629147139.140 [NAL9602](INFO): No messages in MT queue 2021-08-16T20:52:49.840Z,1629147169.840 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T20:55:08.013Z,1629147308.013 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T20:55:08.013Z,1629147308.013 [Default:CheckIn:C.Wait] Stopped 2021-08-16T20:55:08.013Z,1629147308.013 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T20:55:08.014Z,1629147308.014 [Default:CheckIn:D] Running Loop=1 2021-08-16T20:55:08.409Z,1629147308.409 [Default:CheckIn:D] Stopped 2021-08-16T20:55:08.409Z,1629147308.409 [Default:CheckIn:E] Running Loop=1 2021-08-16T20:55:08.809Z,1629147308.809 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 155.653434 min 2021-08-16T20:55:08.809Z,1629147308.809 [Default:CheckIn:E] Stopped 2021-08-16T20:55:08.810Z,1629147308.810 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T20:55:08.810Z,1629147308.810 [Default:CheckIn] Stopped 2021-08-16T20:55:08.810Z,1629147308.810 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T20:55:08.810Z,1629147308.810 [Default:CheckIn](INFO): Running loop #28 2021-08-16T20:55:08.810Z,1629147308.810 [Default:CheckIn] Running Loop=28 2021-08-16T20:55:08.810Z,1629147308.810 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T20:55:08.810Z,1629147308.810 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T20:55:10.823Z,1629147310.823 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205508.00,A,4212.99704,N,08344.18790,W,0.039,337.72,160821,,,A*78 2021-08-16T20:55:10.825Z,1629147310.825 [NAL9602](INFO): GPS fix at 20210816T205508: (42.216617, -83.736465) 2021-08-16T20:55:10.835Z,1629147310.835 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T20:55:10.835Z,1629147310.835 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T20:55:18.192Z,1629147318.192 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20210816T183557/Courier0075.lzma 2021-08-16T20:55:19.195Z,1629147319.195 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0075.lzma.bak 2021-08-16T20:55:19.195Z,1629147319.195 [DataOverHttps](INFO): SBD MOMSN=15890222 2021-08-16T20:55:35.929Z,1629147335.929 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20210816T183557/Express0076.lzma 2021-08-16T20:55:36.931Z,1629147336.931 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0076.lzma.bak 2021-08-16T20:55:36.931Z,1629147336.931 [DataOverHttps](INFO): SBD MOMSN=15890227 2021-08-16T20:55:39.132Z,1629147339.132 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T20:55:39.132Z,1629147339.132 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T20:55:39.132Z,1629147339.132 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T20:56:04.963Z,1629147364.963 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T20:56:04.964Z,1629147364.964 [DVL_micro](ERROR): Failed to parse: :TS,000000,35.0000.0,1489.0,000 2021-08-16T20:57:49.628Z,1629147469.628 [NAL9602](INFO): SBD MO Status=2, MOMSN=5461, MT Status=2, MTMSN=0 2021-08-16T20:57:49.628Z,1629147469.628 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T20:58:15.084Z,1629147495.084 [NAL9602](INFO): SBD MO Status=2, MOMSN=5461, MT Status=2, MTMSN=0 2021-08-16T20:58:15.084Z,1629147495.084 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T20:58:25.584Z,1629147505.584 [NAL9602](INFO): SBD MO Status=0, MOMSN=5461, MT Status=0, MTMSN=0 2021-08-16T20:58:25.584Z,1629147505.584 [NAL9602](INFO): No messages in MT queue 2021-08-16T20:58:56.292Z,1629147536.292 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T20:59:37.906Z,1629147577.906 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T20:59:37.906Z,1629147577.906 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+2.0,1489.0,000 2021-08-16T21:00:39.783Z,1629147639.783 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T21:00:39.783Z,1629147639.783 [Default:CheckIn:C.Wait] Stopped 2021-08-16T21:00:39.783Z,1629147639.783 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T21:00:39.784Z,1629147639.784 [Default:CheckIn:D] Running Loop=1 2021-08-16T21:00:40.171Z,1629147640.171 [Default:CheckIn:D] Stopped 2021-08-16T21:00:40.171Z,1629147640.171 [Default:CheckIn:E] Running Loop=1 2021-08-16T21:00:40.576Z,1629147640.576 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 161.182813 min 2021-08-16T21:00:40.577Z,1629147640.577 [Default:CheckIn:E] Stopped 2021-08-16T21:00:40.577Z,1629147640.577 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T21:00:40.577Z,1629147640.577 [Default:CheckIn] Stopped 2021-08-16T21:00:40.577Z,1629147640.577 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T21:00:40.578Z,1629147640.578 [Default:CheckIn](INFO): Running loop #29 2021-08-16T21:00:40.578Z,1629147640.578 [Default:CheckIn] Running Loop=29 2021-08-16T21:00:40.578Z,1629147640.578 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T21:00:40.578Z,1629147640.578 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T21:00:42.590Z,1629147642.590 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210040.00,A,4212.98897,N,08344.18342,W,0.175,337.72,160821,,,A*73 2021-08-16T21:00:42.592Z,1629147642.592 [NAL9602](INFO): GPS fix at 20210816T210040: (42.216483, -83.736390) 2021-08-16T21:00:42.602Z,1629147642.602 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T21:00:42.602Z,1629147642.602 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T21:00:50.375Z,1629147650.375 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20210816T183557/Courier0078.lzma 2021-08-16T21:00:51.375Z,1629147651.375 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0078.lzma.bak 2021-08-16T21:00:51.375Z,1629147651.375 [DataOverHttps](INFO): SBD MOMSN=15890236 2021-08-16T21:01:08.084Z,1629147668.084 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210816T183557/Express0079.lzma 2021-08-16T21:01:09.087Z,1629147669.087 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0079.lzma.bak 2021-08-16T21:01:09.087Z,1629147669.087 [DataOverHttps](INFO): SBD MOMSN=15890240 2021-08-16T21:01:11.311Z,1629147671.311 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T21:01:11.311Z,1629147671.311 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T21:01:11.311Z,1629147671.311 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T21:01:23.796Z,1629147683.796 [NAL9602](INFO): SBD MO Status=2, MOMSN=5462, MT Status=2, MTMSN=0 2021-08-16T21:01:23.796Z,1629147683.796 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:01:44.418Z,1629147704.418 [NAL9602](INFO): SBD MO Status=0, MOMSN=5462, MT Status=0, MTMSN=0 2021-08-16T21:01:44.418Z,1629147704.418 [NAL9602](INFO): No messages in MT queue 2021-08-16T21:02:15.163Z,1629147735.163 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T21:03:05.244Z,1629147785.244 [DVL_micro](ERROR): Failed to parse: :WI,+0181,-00337,+0:BI,+0182,-00337,+00000,I 2021-08-16T21:06:12.256Z,1629147972.256 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T21:06:12.256Z,1629147972.256 [Default:CheckIn:C.Wait] Stopped 2021-08-16T21:06:12.256Z,1629147972.256 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T21:06:12.256Z,1629147972.256 [Default:CheckIn:D] Running Loop=1 2021-08-16T21:06:12.430Z,1629147972.430 [Default:CheckIn:D] Stopped 2021-08-16T21:06:12.430Z,1629147972.430 [Default:CheckIn:E] Running Loop=1 2021-08-16T21:06:12.780Z,1629147972.780 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 166.720443 min 2021-08-16T21:06:12.780Z,1629147972.780 [Default:CheckIn:E] Stopped 2021-08-16T21:06:12.780Z,1629147972.780 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T21:06:12.780Z,1629147972.780 [Default:CheckIn] Stopped 2021-08-16T21:06:12.780Z,1629147972.780 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T21:06:12.780Z,1629147972.780 [Default:CheckIn](INFO): Running loop #30 2021-08-16T21:06:12.780Z,1629147972.780 [Default:CheckIn] Running Loop=30 2021-08-16T21:06:12.781Z,1629147972.781 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T21:06:12.781Z,1629147972.781 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T21:06:14.777Z,1629147974.777 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210612.00,A,4212.98585,N,08344.18878,W,0.214,320.41,160821,,,A*7C 2021-08-16T21:06:14.779Z,1629147974.779 [NAL9602](INFO): GPS fix at 20210816T210612: (42.216431, -83.736480) 2021-08-16T21:06:14.812Z,1629147974.812 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T21:06:14.817Z,1629147974.817 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T21:06:25.165Z,1629147985.165 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20210816T183557/Courier0081.lzma 2021-08-16T21:06:26.175Z,1629147986.175 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0081.lzma.bak 2021-08-16T21:06:26.175Z,1629147986.175 [DataOverHttps](INFO): SBD MOMSN=15890244 2021-08-16T21:06:43.876Z,1629148003.876 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210816T183557/Express0082.lzma 2021-08-16T21:06:44.879Z,1629148004.879 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0082.lzma.bak 2021-08-16T21:06:44.879Z,1629148004.879 [DataOverHttps](INFO): SBD MOMSN=15890248 2021-08-16T21:06:45.136Z,1629148005.136 [NAL9602](INFO): SBD MO Status=0, MOMSN=5463, MT Status=0, MTMSN=0 2021-08-16T21:06:45.137Z,1629148005.137 [NAL9602](INFO): No messages in MT queue 2021-08-16T21:06:47.163Z,1629148007.163 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T21:06:47.163Z,1629148007.163 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T21:06:47.163Z,1629148007.163 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T21:07:15.858Z,1629148035.858 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T21:10:35.876Z,1629148235.876 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T21:10:35.888Z,1629148235.888 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+25.21489.0,000 2021-08-16T21:11:47.796Z,1629148307.796 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T21:11:47.796Z,1629148307.796 [Default:CheckIn:C.Wait] Stopped 2021-08-16T21:11:47.796Z,1629148307.796 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T21:11:47.796Z,1629148307.796 [Default:CheckIn:D] Running Loop=1 2021-08-16T21:11:48.198Z,1629148308.198 [Default:CheckIn:D] Stopped 2021-08-16T21:11:48.198Z,1629148308.198 [Default:CheckIn:E] Running Loop=1 2021-08-16T21:11:48.611Z,1629148308.611 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 172.316585 min 2021-08-16T21:11:48.612Z,1629148308.612 [Default:CheckIn:E] Stopped 2021-08-16T21:11:48.612Z,1629148308.612 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T21:11:48.612Z,1629148308.612 [Default:CheckIn] Stopped 2021-08-16T21:11:48.612Z,1629148308.612 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T21:11:48.612Z,1629148308.612 [Default:CheckIn](INFO): Running loop #31 2021-08-16T21:11:48.612Z,1629148308.612 [Default:CheckIn] Running Loop=31 2021-08-16T21:11:48.612Z,1629148308.612 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T21:11:48.613Z,1629148308.613 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T21:11:50.616Z,1629148310.616 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211148.00,A,4212.99041,N,08344.18907,W,0.039,320.41,160821,,,D*78 2021-08-16T21:11:50.619Z,1629148310.619 [NAL9602](INFO): GPS fix at 20210816T211148: (42.216507, -83.736485) 2021-08-16T21:11:50.667Z,1629148310.667 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T21:11:50.667Z,1629148310.667 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T21:12:01.125Z,1629148321.125 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20210816T183557/Courier0084.lzma 2021-08-16T21:12:02.127Z,1629148322.127 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0084.lzma.bak 2021-08-16T21:12:02.127Z,1629148322.127 [DataOverHttps](INFO): SBD MOMSN=15890253 2021-08-16T21:12:09.672Z,1629148329.672 [NAL9602](INFO): SBD MO Status=0, MOMSN=5464, MT Status=0, MTMSN=0 2021-08-16T21:12:09.673Z,1629148329.673 [NAL9602](INFO): No messages in MT queue 2021-08-16T21:12:20.503Z,1629148340.503 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210816T183557/Express0085.lzma 2021-08-16T21:12:21.503Z,1629148341.503 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0085.lzma.bak 2021-08-16T21:12:21.503Z,1629148341.503 [DataOverHttps](INFO): SBD MOMSN=15890256 2021-08-16T21:12:24.278Z,1629148344.278 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T21:12:24.279Z,1629148344.279 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T21:12:24.279Z,1629148344.279 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T21:12:40.434Z,1629148360.434 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T21:17:24.926Z,1629148644.926 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T21:17:24.926Z,1629148644.926 [Default:CheckIn:C.Wait] Stopped 2021-08-16T21:17:24.926Z,1629148644.926 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T21:17:24.926Z,1629148644.926 [Default:CheckIn:D] Running Loop=1 2021-08-16T21:17:25.347Z,1629148645.347 [Default:CheckIn:D] Stopped 2021-08-16T21:17:25.347Z,1629148645.347 [Default:CheckIn:E] Running Loop=1 2021-08-16T21:17:25.717Z,1629148645.717 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 177.935726 min 2021-08-16T21:17:25.717Z,1629148645.717 [Default:CheckIn:E] Stopped 2021-08-16T21:17:25.718Z,1629148645.718 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T21:17:25.718Z,1629148645.718 [Default:CheckIn] Stopped 2021-08-16T21:17:25.718Z,1629148645.718 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T21:17:25.718Z,1629148645.718 [Default:CheckIn](INFO): Running loop #32 2021-08-16T21:17:25.718Z,1629148645.718 [Default:CheckIn] Running Loop=32 2021-08-16T21:17:25.718Z,1629148645.718 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T21:17:25.718Z,1629148645.718 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T21:17:27.752Z,1629148647.752 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211725.00,A,4212.99430,N,08344.18689,W,0.058,320.41,160821,,,D*79 2021-08-16T21:17:27.754Z,1629148647.754 [NAL9602](INFO): GPS fix at 20210816T211725: (42.216572, -83.736448) 2021-08-16T21:17:27.764Z,1629148647.764 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T21:17:27.764Z,1629148647.764 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T21:17:34.772Z,1629148654.772 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0087.lzma 2021-08-16T21:17:35.775Z,1629148655.775 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0087.lzma.bak 2021-08-16T21:17:35.775Z,1629148655.775 [DataOverHttps](INFO): SBD MOMSN=15890262 2021-08-16T21:17:53.133Z,1629148673.133 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20210816T183557/Express0088.lzma 2021-08-16T21:17:54.135Z,1629148674.135 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0088.lzma.bak 2021-08-16T21:17:54.135Z,1629148674.135 [DataOverHttps](INFO): SBD MOMSN=15890265 2021-08-16T21:17:57.345Z,1629148677.345 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T21:17:57.345Z,1629148677.345 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T21:17:57.345Z,1629148677.345 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T21:18:48.655Z,1629148728.655 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T21:18:48.655Z,1629148728.655 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,34,0000.0,1489.0,000 2021-08-16T21:19:24.206Z,1629148764.206 [NAL9602](INFO): SBD MO Status=2, MOMSN=5465, MT Status=2, MTMSN=0 2021-08-16T21:19:24.206Z,1629148764.206 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:20:00.588Z,1629148800.588 [NAL9602](INFO): SBD MO Status=2, MOMSN=5465, MT Status=2, MTMSN=0 2021-08-16T21:20:00.588Z,1629148800.588 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:20:17.954Z,1629148817.954 [NAL9602](INFO): SBD MO Status=2, MOMSN=5465, MT Status=2, MTMSN=0 2021-08-16T21:20:17.954Z,1629148817.954 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:20:45.428Z,1629148845.428 [NAL9602](INFO): SBD MO Status=0, MOMSN=5465, MT Status=0, MTMSN=0 2021-08-16T21:20:45.428Z,1629148845.428 [NAL9602](INFO): No messages in MT queue 2021-08-16T21:21:16.162Z,1629148876.162 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T21:22:58.009Z,1629148978.009 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T21:22:58.009Z,1629148978.009 [Default:CheckIn:C.Wait] Stopped 2021-08-16T21:22:58.010Z,1629148978.010 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T21:22:58.010Z,1629148978.010 [Default:CheckIn:D] Running Loop=1 2021-08-16T21:22:58.430Z,1629148978.430 [Default:CheckIn:D] Stopped 2021-08-16T21:22:58.431Z,1629148978.431 [Default:CheckIn:E] Running Loop=1 2021-08-16T21:22:58.809Z,1629148978.809 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 183.487126 min 2021-08-16T21:22:58.809Z,1629148978.809 [Default:CheckIn:E] Stopped 2021-08-16T21:22:58.809Z,1629148978.809 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T21:22:58.809Z,1629148978.809 [Default:CheckIn] Stopped 2021-08-16T21:22:58.810Z,1629148978.810 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T21:22:58.810Z,1629148978.810 [Default:CheckIn](INFO): Running loop #33 2021-08-16T21:22:58.810Z,1629148978.810 [Default:CheckIn] Running Loop=33 2021-08-16T21:22:58.810Z,1629148978.810 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T21:22:58.810Z,1629148978.810 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T21:23:00.821Z,1629148980.821 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212258.00,A,4212.99196,N,08344.18978,W,0.039,320.41,160821,,,D*7A 2021-08-16T21:23:00.823Z,1629148980.823 [NAL9602](INFO): GPS fix at 20210816T212258: (42.216533, -83.736496) 2021-08-16T21:23:00.834Z,1629148980.834 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T21:23:00.834Z,1629148980.834 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T21:23:08.481Z,1629148988.481 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0090.lzma 2021-08-16T21:23:09.479Z,1629148989.479 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0090.lzma.bak 2021-08-16T21:23:09.479Z,1629148989.479 [DataOverHttps](INFO): SBD MOMSN=15890269 2021-08-16T21:23:20.226Z,1629149000.226 [NAL9602](INFO): SBD MO Status=2, MOMSN=5466, MT Status=2, MTMSN=0 2021-08-16T21:23:20.226Z,1629149000.226 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:23:26.329Z,1629149006.329 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20210816T183557/Express0091.lzma 2021-08-16T21:23:27.331Z,1629149007.331 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0091.lzma.bak 2021-08-16T21:23:27.331Z,1629149007.331 [DataOverHttps](INFO): SBD MOMSN=15890272 2021-08-16T21:23:29.532Z,1629149009.532 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T21:23:29.537Z,1629149009.537 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T21:23:29.537Z,1629149009.537 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T21:23:41.632Z,1629149021.632 [DVL_micro](ERROR): Failed to parse: :000000000,35.0,+25.6,0000.0,1489.0,000 2021-08-16T21:24:57.222Z,1629149097.222 [NAL9602](INFO): SBD MO Status=0, MOMSN=5466, MT Status=0, MTMSN=0 2021-08-16T21:24:57.222Z,1629149097.222 [NAL9602](INFO): No messages in MT queue 2021-08-16T21:25:27.902Z,1629149127.902 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T21:27:58.616Z,1629149278.616 [DVL_micro](ERROR): Failed to parse:376,-05458,-00013,+00000,I 2021-08-16T21:28:30.165Z,1629149310.165 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T21:28:30.165Z,1629149310.165 [Default:CheckIn:C.Wait] Stopped 2021-08-16T21:28:30.165Z,1629149310.165 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T21:28:30.166Z,1629149310.166 [Default:CheckIn:D] Running Loop=1 2021-08-16T21:28:30.596Z,1629149310.596 [Default:CheckIn:D] Stopped 2021-08-16T21:28:30.596Z,1629149310.596 [Default:CheckIn:E] Running Loop=1 2021-08-16T21:28:30.975Z,1629149310.975 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 189.023210 min 2021-08-16T21:28:30.975Z,1629149310.975 [Default:CheckIn:E] Stopped 2021-08-16T21:28:30.975Z,1629149310.975 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T21:28:30.976Z,1629149310.976 [Default:CheckIn] Stopped 2021-08-16T21:28:30.976Z,1629149310.976 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T21:28:30.976Z,1629149310.976 [Default:CheckIn](INFO): Running loop #34 2021-08-16T21:28:30.976Z,1629149310.976 [Default:CheckIn] Running Loop=34 2021-08-16T21:28:30.976Z,1629149310.976 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T21:28:30.976Z,1629149310.976 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T21:28:32.976Z,1629149312.976 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212831.00,A,4212.99190,N,08344.19697,W,0.039,320.41,160821,,,D*76 2021-08-16T21:28:32.979Z,1629149312.979 [NAL9602](INFO): GPS fix at 20210816T212831: (42.216532, -83.736616) 2021-08-16T21:28:32.989Z,1629149312.989 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T21:28:32.990Z,1629149312.990 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T21:28:40.300Z,1629149320.300 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0093.lzma 2021-08-16T21:28:41.303Z,1629149321.303 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0093.lzma.bak 2021-08-16T21:28:41.303Z,1629149321.303 [DataOverHttps](INFO): SBD MOMSN=15890278 2021-08-16T21:28:49.156Z,1629149329.156 [DVL_micro](ERROR): Failed to parse: :SA,-02.43,-02.39,026.5 2021-08-16T21:28:58.017Z,1629149338.017 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210816T183557/Express0094.lzma 2021-08-16T21:28:59.019Z,1629149339.019 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0094.lzma.bak 2021-08-16T21:28:59.019Z,1629149339.019 [DataOverHttps](INFO): SBD MOMSN=15890281 2021-08-16T21:29:01.285Z,1629149341.285 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T21:29:01.285Z,1629149341.285 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T21:29:01.285Z,1629149341.285 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T21:29:06.543Z,1629149346.543 [NAL9602](INFO): SBD MO Status=2, MOMSN=5467, MT Status=2, MTMSN=0 2021-08-16T21:29:06.543Z,1629149346.543 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:29:35.604Z,1629149375.604 [NAL9602](INFO): SBD MO Status=2, MOMSN=5467, MT Status=2, MTMSN=0 2021-08-16T21:29:35.604Z,1629149375.604 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:29:52.585Z,1629149392.585 [NAL9602](INFO): SBD MO Status=2, MOMSN=5467, MT Status=2, MTMSN=0 2021-08-16T21:29:52.585Z,1629149392.585 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:30:11.967Z,1629149411.967 [NAL9602](INFO): SBD MO Status=2, MOMSN=5467, MT Status=2, MTMSN=0 2021-08-16T21:30:11.967Z,1629149411.967 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:31:36.849Z,1629149496.849 [NAL9602](INFO): SBD MO Status=2, MOMSN=5467, MT Status=2, MTMSN=0 2021-08-16T21:31:36.850Z,1629149496.850 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:33:35.624Z,1629149615.624 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-08-16T21:34:01.957Z,1629149641.957 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T21:34:01.958Z,1629149641.958 [Default:CheckIn:C.Wait] Stopped 2021-08-16T21:34:01.958Z,1629149641.958 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T21:34:01.958Z,1629149641.958 [Default:CheckIn:D] Running Loop=1 2021-08-16T21:34:02.356Z,1629149642.356 [Default:CheckIn:D] Stopped 2021-08-16T21:34:02.356Z,1629149642.356 [Default:CheckIn:E] Running Loop=1 2021-08-16T21:34:02.744Z,1629149642.744 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 194.552555 min 2021-08-16T21:34:02.744Z,1629149642.744 [Default:CheckIn:E] Stopped 2021-08-16T21:34:02.753Z,1629149642.753 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T21:34:02.753Z,1629149642.753 [Default:CheckIn] Stopped 2021-08-16T21:34:02.753Z,1629149642.753 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T21:34:02.753Z,1629149642.753 [Default:CheckIn](INFO): Running loop #35 2021-08-16T21:34:02.753Z,1629149642.753 [Default:CheckIn] Running Loop=35 2021-08-16T21:34:02.754Z,1629149642.754 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T21:34:02.754Z,1629149642.754 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T21:34:04.757Z,1629149644.757 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213402.00,A,4212.99910,N,08344.19274,W,0.078,0.00,160821,,,D*73 2021-08-16T21:34:04.759Z,1629149644.759 [NAL9602](INFO): GPS fix at 20210816T213402: (42.216652, -83.736546) 2021-08-16T21:34:04.788Z,1629149644.788 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T21:34:04.788Z,1629149644.788 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T21:34:12.332Z,1629149652.332 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0096.lzma 2021-08-16T21:34:13.335Z,1629149653.335 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0096.lzma.bak 2021-08-16T21:34:13.335Z,1629149653.335 [DataOverHttps](INFO): SBD MOMSN=15890284 2021-08-16T21:34:24.590Z,1629149664.590 [DVL_micro](ERROR): Failed to parse:99.99,+9999.99,+9999.99,+9999.99 2021-08-16T21:34:33.537Z,1629149673.537 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20210816T183557/Express0097.lzma 2021-08-16T21:34:34.539Z,1629149674.539 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0097.lzma.bak 2021-08-16T21:34:34.539Z,1629149674.539 [DataOverHttps](INFO): SBD MOMSN=15890287 2021-08-16T21:34:36.702Z,1629149676.702 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T21:34:36.734Z,1629149676.734 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T21:34:36.734Z,1629149676.734 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T21:34:36.734Z,1629149676.734 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T21:39:37.360Z,1629149977.360 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T21:39:37.360Z,1629149977.360 [Default:CheckIn:C.Wait] Stopped 2021-08-16T21:39:37.360Z,1629149977.360 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T21:39:37.360Z,1629149977.360 [Default:CheckIn:D] Running Loop=1 2021-08-16T21:39:37.767Z,1629149977.767 [Default:CheckIn:D] Stopped 2021-08-16T21:39:37.767Z,1629149977.767 [Default:CheckIn:E] Running Loop=1 2021-08-16T21:39:38.168Z,1629149978.168 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 200.142741 min 2021-08-16T21:39:38.168Z,1629149978.168 [Default:CheckIn:E] Stopped 2021-08-16T21:39:38.168Z,1629149978.168 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T21:39:38.185Z,1629149978.185 [Default:CheckIn] Stopped 2021-08-16T21:39:38.185Z,1629149978.185 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T21:39:38.185Z,1629149978.185 [Default:CheckIn](INFO): Running loop #36 2021-08-16T21:39:38.185Z,1629149978.185 [Default:CheckIn] Running Loop=36 2021-08-16T21:39:38.185Z,1629149978.185 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T21:39:38.185Z,1629149978.185 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T21:39:40.176Z,1629149980.176 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213938.00,A,4212.99338,N,08344.19094,W,0.058,0.00,160821,,,D*79 2021-08-16T21:39:40.179Z,1629149980.179 [NAL9602](INFO): GPS fix at 20210816T213938: (42.216556, -83.736516) 2021-08-16T21:39:40.188Z,1629149980.188 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T21:39:40.188Z,1629149980.188 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T21:39:47.884Z,1629149987.884 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210816T183557/Courier0099.lzma 2021-08-16T21:39:48.887Z,1629149988.887 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0099.lzma.bak 2021-08-16T21:39:48.887Z,1629149988.887 [DataOverHttps](INFO): SBD MOMSN=15890291 2021-08-16T21:40:09.817Z,1629150009.817 [DataOverHttps](INFO): Sending 135 bytes from file Logs/20210816T183557/Express0100.lzma 2021-08-16T21:40:10.819Z,1629150010.819 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0100.lzma.bak 2021-08-16T21:40:10.819Z,1629150010.819 [DataOverHttps](INFO): SBD MOMSN=15890294 2021-08-16T21:40:10.927Z,1629150010.927 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-08-16T21:40:11.005Z,1629150011.005 [NAL9602](ERROR): received: +CSQ:0 OK67, 2, 0, 0, 0 OK 2021-08-16T21:40:12.976Z,1629150012.976 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T21:40:12.976Z,1629150012.976 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T21:40:12.976Z,1629150012.976 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T21:40:59.853Z,1629150059.853 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T21:40:59.854Z,1629150059.854 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+0.0,1489.0,000 2021-08-16T21:41:14.811Z,1629150074.811 [NAL9602](INFO): SBD MO Status=2, MOMSN=5467, MT Status=2, MTMSN=0 2021-08-16T21:41:14.811Z,1629150074.811 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:41:36.608Z,1629150096.608 [NAL9602](INFO): SBD MO Status=2, MOMSN=5467, MT Status=2, MTMSN=0 2021-08-16T21:41:36.608Z,1629150096.608 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:43:09.132Z,1629150189.132 [NAL9602](INFO): SBD MO Status=2, MOMSN=5467, MT Status=2, MTMSN=0 2021-08-16T21:43:09.132Z,1629150189.132 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:44:39.816Z,1629150279.816 [NAL9602](INFO): SBD MO Status=2, MOMSN=5467, MT Status=2, MTMSN=0 2021-08-16T21:44:39.816Z,1629150279.816 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:44:42.239Z,1629150282.239 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-08-16T21:45:13.007Z,1629150313.007 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T21:45:13.805Z,1629150313.805 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T21:45:13.806Z,1629150313.806 [Default:CheckIn:C.Wait] Stopped 2021-08-16T21:45:13.806Z,1629150313.806 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T21:45:13.806Z,1629150313.806 [Default:CheckIn:D] Running Loop=1 2021-08-16T21:45:14.156Z,1629150314.156 [Default:CheckIn:D] Stopped 2021-08-16T21:45:14.156Z,1629150314.156 [Default:CheckIn:E] Running Loop=1 2021-08-16T21:45:14.580Z,1629150314.580 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 205.749219 min 2021-08-16T21:45:14.580Z,1629150314.580 [Default:CheckIn:E] Stopped 2021-08-16T21:45:14.580Z,1629150314.580 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T21:45:14.580Z,1629150314.580 [Default:CheckIn] Stopped 2021-08-16T21:45:14.580Z,1629150314.580 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T21:45:14.581Z,1629150314.581 [Default:CheckIn](INFO): Running loop #37 2021-08-16T21:45:14.581Z,1629150314.581 [Default:CheckIn] Running Loop=37 2021-08-16T21:45:14.581Z,1629150314.581 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T21:45:14.581Z,1629150314.581 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T21:45:16.589Z,1629150316.589 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214514.00,A,4212.99551,N,08344.18899,W,0.078,156.21,160821,,,D*72 2021-08-16T21:45:16.592Z,1629150316.592 [NAL9602](INFO): GPS fix at 20210816T214514: (42.216592, -83.736483) 2021-08-16T21:45:16.602Z,1629150316.602 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T21:45:16.602Z,1629150316.602 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T21:45:24.081Z,1629150324.081 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0102.lzma 2021-08-16T21:45:25.083Z,1629150325.083 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0102.lzma.bak 2021-08-16T21:45:25.083Z,1629150325.083 [DataOverHttps](INFO): SBD MOMSN=15890297 2021-08-16T21:45:41.865Z,1629150341.865 [DataOverHttps](INFO): Sending 208 bytes from file Logs/20210816T183557/Express0103.lzma 2021-08-16T21:45:42.867Z,1629150342.867 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0103.lzma.bak 2021-08-16T21:45:42.867Z,1629150342.867 [DataOverHttps](INFO): SBD MOMSN=15890300 2021-08-16T21:45:45.272Z,1629150345.272 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T21:45:45.272Z,1629150345.272 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T21:45:45.272Z,1629150345.272 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T21:45:47.300Z,1629150347.300 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-08-16T21:45:47.377Z,1629150347.377 [NAL9602](ERROR): received: +SBDI: 2, 5467, 2, 0, 0, 0 OK 2021-08-16T21:46:14.794Z,1629150374.794 [NAL9602](INFO): SBD MO Status=0, MOMSN=5467, MT Status=0, MTMSN=0 2021-08-16T21:46:14.794Z,1629150374.794 [NAL9602](INFO): No messages in MT queue 2021-08-16T21:46:45.514Z,1629150405.514 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T21:48:24.933Z,1629150504.933 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2021-08-16T21:48:24.940Z,1629150504.940 [BPC1](ERROR): Battery stick #6 (s/n: 00CA) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2021-08-16T21:48:24.941Z,1629150504.941 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6. 2021-08-16T21:48:24.944Z,1629150504.944 [BPC1](INFO): Received data from all battery sticks. 2021-08-16T21:48:47.562Z,1629150527.562 [DVL_micro](ERROR): Failed to parse: :BD,+000,+0000000000000.09,000.00 2021-08-16T21:50:45.986Z,1629150645.986 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T21:50:45.986Z,1629150645.986 [Default:CheckIn:C.Wait] Stopped 2021-08-16T21:50:45.986Z,1629150645.986 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T21:50:45.986Z,1629150645.986 [Default:CheckIn:D] Running Loop=1 2021-08-16T21:50:46.351Z,1629150646.351 [Default:CheckIn:D] Stopped 2021-08-16T21:50:46.351Z,1629150646.351 [Default:CheckIn:E] Running Loop=1 2021-08-16T21:50:46.766Z,1629150646.766 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 211.285807 min 2021-08-16T21:50:46.766Z,1629150646.766 [Default:CheckIn:E] Stopped 2021-08-16T21:50:46.766Z,1629150646.766 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T21:50:46.766Z,1629150646.766 [Default:CheckIn] Stopped 2021-08-16T21:50:46.766Z,1629150646.766 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T21:50:46.766Z,1629150646.766 [Default:CheckIn](INFO): Running loop #38 2021-08-16T21:50:46.766Z,1629150646.766 [Default:CheckIn] Running Loop=38 2021-08-16T21:50:46.767Z,1629150646.767 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T21:50:46.767Z,1629150646.767 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T21:50:48.779Z,1629150648.779 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215046.00,A,4212.99845,N,08344.19181,W,0.019,156.21,160821,,,D*7F 2021-08-16T21:50:48.782Z,1629150648.782 [NAL9602](INFO): GPS fix at 20210816T215046: (42.216641, -83.736530) 2021-08-16T21:50:48.792Z,1629150648.792 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T21:50:48.793Z,1629150648.793 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T21:50:56.113Z,1629150656.113 [DataOverHttps](INFO): Sending 84 bytes from file Logs/20210816T183557/Courier0105.lzma 2021-08-16T21:50:57.115Z,1629150657.115 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0105.lzma.bak 2021-08-16T21:50:57.115Z,1629150657.115 [DataOverHttps](INFO): SBD MOMSN=15890305 2021-08-16T21:51:12.200Z,1629150672.200 [NAL9602](INFO): SBD MO Status=2, MOMSN=5468, MT Status=2, MTMSN=0 2021-08-16T21:51:12.200Z,1629150672.200 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T21:51:13.817Z,1629150673.817 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20210816T183557/Express0106.lzma 2021-08-16T21:51:14.819Z,1629150674.819 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0106.lzma.bak 2021-08-16T21:51:14.819Z,1629150674.819 [DataOverHttps](INFO): SBD MOMSN=15890308 2021-08-16T21:51:17.085Z,1629150677.085 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T21:51:17.085Z,1629150677.085 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T21:51:17.085Z,1629150677.085 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T21:53:24.327Z,1629150804.327 [NAL9602](INFO): SBD MO Status=0, MOMSN=5468, MT Status=0, MTMSN=0 2021-08-16T21:53:24.327Z,1629150804.327 [NAL9602](INFO): No messages in MT queue 2021-08-16T21:53:55.047Z,1629150835.047 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T21:56:17.767Z,1629150977.767 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T21:56:17.768Z,1629150977.768 [Default:CheckIn:C.Wait] Stopped 2021-08-16T21:56:17.768Z,1629150977.768 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T21:56:17.768Z,1629150977.768 [Default:CheckIn:D] Running Loop=1 2021-08-16T21:56:18.146Z,1629150978.146 [Default:CheckIn:D] Stopped 2021-08-16T21:56:18.146Z,1629150978.146 [Default:CheckIn:E] Running Loop=1 2021-08-16T21:56:18.522Z,1629150978.522 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 216.815723 min 2021-08-16T21:56:18.522Z,1629150978.522 [Default:CheckIn:E] Stopped 2021-08-16T21:56:18.522Z,1629150978.522 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T21:56:18.522Z,1629150978.522 [Default:CheckIn] Stopped 2021-08-16T21:56:18.523Z,1629150978.523 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T21:56:18.523Z,1629150978.523 [Default:CheckIn](INFO): Running loop #39 2021-08-16T21:56:18.523Z,1629150978.523 [Default:CheckIn] Running Loop=39 2021-08-16T21:56:18.523Z,1629150978.523 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T21:56:18.523Z,1629150978.523 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T21:56:20.508Z,1629150980.508 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215618.00,A,4212.98909,N,08344.18775,W,0.389,188.40,160821,,,D*78 2021-08-16T21:56:20.511Z,1629150980.511 [NAL9602](INFO): GPS fix at 20210816T215618: (42.216485, -83.736463) 2021-08-16T21:56:20.537Z,1629150980.537 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T21:56:20.537Z,1629150980.537 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T21:56:32.040Z,1629150992.040 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0108.lzma 2021-08-16T21:56:33.043Z,1629150993.043 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0108.lzma.bak 2021-08-16T21:56:33.043Z,1629150993.043 [DataOverHttps](INFO): SBD MOMSN=15890312 2021-08-16T21:56:49.977Z,1629151009.977 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210816T183557/Express0109.lzma 2021-08-16T21:56:50.979Z,1629151010.979 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0109.lzma.bak 2021-08-16T21:56:50.979Z,1629151010.979 [DataOverHttps](INFO): SBD MOMSN=15890315 2021-08-16T21:56:53.222Z,1629151013.222 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T21:56:53.222Z,1629151013.222 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T21:56:53.222Z,1629151013.222 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T21:58:58.404Z,1629151138.404 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T21:58:58.405Z,1629151138.405 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+26.7,0000.0,10 2021-08-16T21:59:08.112Z,1629151148.112 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T21:59:08.112Z,1629151148.112 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+26.7,0000.0,14 2021-08-16T22:00:47.472Z,1629151247.472 [NAL9602](INFO): SBD MO Status=2, MOMSN=5469, MT Status=2, MTMSN=0 2021-08-16T22:00:47.472Z,1629151247.472 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T22:01:04.442Z,1629151264.442 [NAL9602](INFO): SBD MO Status=2, MOMSN=5469, MT Status=2, MTMSN=0 2021-08-16T22:01:04.442Z,1629151264.442 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T22:01:34.741Z,1629151294.741 [NAL9602](INFO): SBD MO Status=2, MOMSN=5469, MT Status=2, MTMSN=0 2021-08-16T22:01:34.741Z,1629151294.741 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-16T22:01:35.144Z,1629151295.144 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-08-16T22:01:53.742Z,1629151313.742 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T22:01:53.742Z,1629151313.742 [Default:CheckIn:C.Wait] Stopped 2021-08-16T22:01:53.742Z,1629151313.742 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T22:01:53.742Z,1629151313.742 [Default:CheckIn:D] Running Loop=1 2021-08-16T22:01:54.160Z,1629151314.160 [Default:CheckIn:D] Stopped 2021-08-16T22:01:54.169Z,1629151314.169 [Default:CheckIn:E] Running Loop=1 2021-08-16T22:01:54.556Z,1629151314.556 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 222.415951 min 2021-08-16T22:01:54.556Z,1629151314.556 [Default:CheckIn:E] Stopped 2021-08-16T22:01:54.557Z,1629151314.557 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T22:01:54.557Z,1629151314.557 [Default:CheckIn] Stopped 2021-08-16T22:01:54.557Z,1629151314.557 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T22:01:54.557Z,1629151314.557 [Default:CheckIn](INFO): Running loop #40 2021-08-16T22:01:54.557Z,1629151314.557 [Default:CheckIn] Running Loop=40 2021-08-16T22:01:54.557Z,1629151314.557 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T22:01:54.557Z,1629151314.557 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T22:01:56.599Z,1629151316.599 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220154.00,A,4212.99045,N,08344.20421,W,0.428,188.40,160821,,,D*74 2021-08-16T22:01:56.618Z,1629151316.618 [NAL9602](INFO): GPS fix at 20210816T220154: (42.216507, -83.736737) 2021-08-16T22:01:56.645Z,1629151316.645 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T22:01:56.645Z,1629151316.645 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T22:02:06.436Z,1629151326.436 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0111.lzma 2021-08-16T22:02:07.439Z,1629151327.439 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0111.lzma.bak 2021-08-16T22:02:07.439Z,1629151327.439 [DataOverHttps](INFO): SBD MOMSN=15890318 2021-08-16T22:02:26.833Z,1629151346.833 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20210816T183557/Express0112.lzma 2021-08-16T22:02:27.835Z,1629151347.835 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0112.lzma.bak 2021-08-16T22:02:27.835Z,1629151347.835 [DataOverHttps](INFO): SBD MOMSN=15890321 2021-08-16T22:02:28.786Z,1629151348.786 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T22:02:30.832Z,1629151350.832 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T22:02:30.841Z,1629151350.841 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T22:02:30.841Z,1629151350.841 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T22:06:50.652Z,1629151610.652 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T22:06:50.652Z,1629151610.652 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0000.0,1489.0,000 2021-08-16T22:07:31.464Z,1629151651.464 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T22:07:31.464Z,1629151651.464 [Default:CheckIn:C.Wait] Stopped 2021-08-16T22:07:31.464Z,1629151651.464 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T22:07:31.464Z,1629151651.464 [Default:CheckIn:D] Running Loop=1 2021-08-16T22:07:31.872Z,1629151651.872 [Default:CheckIn:D] Stopped 2021-08-16T22:07:31.872Z,1629151651.872 [Default:CheckIn:E] Running Loop=1 2021-08-16T22:07:32.272Z,1629151652.272 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 228.044482 min 2021-08-16T22:07:32.272Z,1629151652.272 [Default:CheckIn:E] Stopped 2021-08-16T22:07:32.272Z,1629151652.272 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T22:07:32.272Z,1629151652.272 [Default:CheckIn] Stopped 2021-08-16T22:07:32.273Z,1629151652.273 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T22:07:32.273Z,1629151652.273 [Default:CheckIn](INFO): Running loop #41 2021-08-16T22:07:32.273Z,1629151652.273 [Default:CheckIn] Running Loop=41 2021-08-16T22:07:32.273Z,1629151652.273 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T22:07:32.274Z,1629151652.274 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T22:07:34.286Z,1629151654.286 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220732.00,A,4212.98948,N,08344.18989,W,0.117,188.40,160821,,,A*7F 2021-08-16T22:07:34.288Z,1629151654.288 [NAL9602](INFO): GPS fix at 20210816T220732: (42.216491, -83.736498) 2021-08-16T22:07:34.298Z,1629151654.298 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T22:07:34.298Z,1629151654.298 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T22:07:41.513Z,1629151661.513 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20210816T183557/Courier0114.lzma 2021-08-16T22:07:42.515Z,1629151662.515 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0114.lzma.bak 2021-08-16T22:07:42.515Z,1629151662.515 [DataOverHttps](INFO): SBD MOMSN=15890374 2021-08-16T22:08:02.815Z,1629151682.815 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210816T183557/Express0115.lzma 2021-08-16T22:08:03.968Z,1629151683.968 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0115.lzma.bak 2021-08-16T22:08:03.968Z,1629151683.968 [DataOverHttps](INFO): SBD MOMSN=15890377 2021-08-16T22:08:06.680Z,1629151686.680 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T22:08:06.680Z,1629151686.680 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T22:08:06.680Z,1629151686.680 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T22:10:16.370Z,1629151816.370 [DVL_micro](ERROR): Failed to parse: :WI,-00161,-02754,-00642,+00000,A 2021-08-16T22:10:18.790Z,1629151818.790 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T22:10:18.790Z,1629151818.790 [DVL_micro](ERROR): Failed to parse: :TS,000000035.0,+26.7,0000.0,1489.0,000 2021-08-16T22:12:36.587Z,1629151956.587 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-08-16T22:13:07.300Z,1629151987.300 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T22:13:07.312Z,1629151987.312 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T22:13:07.312Z,1629151987.312 [Default:CheckIn:C.Wait] Stopped 2021-08-16T22:13:07.312Z,1629151987.312 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T22:13:07.312Z,1629151987.312 [Default:CheckIn:D] Running Loop=1 2021-08-16T22:13:07.721Z,1629151987.721 [Default:CheckIn:D] Stopped 2021-08-16T22:13:07.721Z,1629151987.721 [Default:CheckIn:E] Running Loop=1 2021-08-16T22:13:08.108Z,1629151988.108 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 233.641960 min 2021-08-16T22:13:08.108Z,1629151988.108 [Default:CheckIn:E] Stopped 2021-08-16T22:13:08.108Z,1629151988.108 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T22:13:08.108Z,1629151988.108 [Default:CheckIn] Stopped 2021-08-16T22:13:08.108Z,1629151988.108 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T22:13:08.108Z,1629151988.108 [Default:CheckIn](INFO): Running loop #42 2021-08-16T22:13:08.125Z,1629151988.125 [Default:CheckIn] Running Loop=42 2021-08-16T22:13:08.125Z,1629151988.125 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T22:13:08.125Z,1629151988.125 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T22:13:10.120Z,1629151990.120 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221308.00,A,4212.99461,N,08344.16853,W,2.488,316.91,160821,,,A*74 2021-08-16T22:13:10.123Z,1629151990.123 [NAL9602](INFO): GPS fix at 20210816T221308: (42.216577, -83.736142) 2021-08-16T22:13:10.133Z,1629151990.133 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T22:13:10.133Z,1629151990.133 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T22:13:17.043Z,1629151997.043 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20210816T183557/Courier0117.lzma 2021-08-16T22:13:18.035Z,1629151998.035 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0117.lzma.bak 2021-08-16T22:13:18.035Z,1629151998.035 [DataOverHttps](INFO): SBD MOMSN=15890440 2021-08-16T22:13:34.750Z,1629152014.750 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20210816T183557/Express0118.lzma 2021-08-16T22:13:35.748Z,1629152015.748 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0118.lzma.bak 2021-08-16T22:13:35.749Z,1629152015.749 [DataOverHttps](INFO): SBD MOMSN=15890462 2021-08-16T22:13:38.017Z,1629152018.017 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T22:13:38.018Z,1629152018.018 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T22:13:38.018Z,1629152018.018 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T22:13:40.823Z,1629152020.823 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-08-16T22:13:40.905Z,1629152020.905 [NAL9602](ERROR): received: +CSQ:0 OK69, 2, 0, 0, 0 OK 2021-08-16T22:18:12.452Z,1629152292.452 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-08-16T22:18:38.733Z,1629152318.733 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T22:18:38.733Z,1629152318.733 [Default:CheckIn:C.Wait] Stopped 2021-08-16T22:18:38.733Z,1629152318.733 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T22:18:38.734Z,1629152318.734 [Default:CheckIn:D] Running Loop=1 2021-08-16T22:18:39.130Z,1629152319.130 [Default:CheckIn:D] Stopped 2021-08-16T22:18:39.130Z,1629152319.130 [Default:CheckIn:E] Running Loop=1 2021-08-16T22:18:39.540Z,1629152319.540 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 239.165446 min 2021-08-16T22:18:39.540Z,1629152319.540 [Default:CheckIn:E] Stopped 2021-08-16T22:18:39.540Z,1629152319.540 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T22:18:39.540Z,1629152319.540 [Default:CheckIn] Stopped 2021-08-16T22:18:39.540Z,1629152319.540 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T22:18:39.540Z,1629152319.540 [Default:CheckIn](INFO): Running loop #43 2021-08-16T22:18:39.540Z,1629152319.540 [Default:CheckIn] Running Loop=43 2021-08-16T22:18:39.541Z,1629152319.541 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-08-16T22:18:39.541Z,1629152319.541 [Default:CheckIn:Read_GPS] Running Loop=1 2021-08-16T22:18:41.574Z,1629152321.574 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221839.00,A,4212.98568,N,08344.15413,W,1.458,316.91,160821,,,A*71 2021-08-16T22:18:41.577Z,1629152321.577 [NAL9602](INFO): GPS fix at 20210816T221839: (42.216428, -83.735902) 2021-08-16T22:18:41.587Z,1629152321.587 [Default:CheckIn:Read_GPS] Stopped 2021-08-16T22:18:41.587Z,1629152321.587 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-08-16T22:18:48.504Z,1629152328.504 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210816T183557/Courier0120.lzma 2021-08-16T22:18:49.507Z,1629152329.507 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Courier0120.lzma.bak 2021-08-16T22:18:49.507Z,1629152329.507 [DataOverHttps](INFO): SBD MOMSN=15890471 2021-08-16T22:19:06.201Z,1629152346.201 [DataOverHttps](INFO): Sending 206 bytes from file Logs/20210816T183557/Express0121.lzma 2021-08-16T22:19:07.824Z,1629152347.824 [DataOverHttps](INFO): Moved sent file to Logs/20210816T183557/Express0121.lzma.bak 2021-08-16T22:19:07.824Z,1629152347.824 [DataOverHttps](INFO): SBD MOMSN=15890474 2021-08-16T22:19:09.487Z,1629152349.487 [Default:CheckIn:Read_Iridium] Stopped 2021-08-16T22:19:09.487Z,1629152349.487 [Default:CheckIn:C.Wait] Running Loop=1 2021-08-16T22:19:09.487Z,1629152349.487 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-16T22:19:13.454Z,1629152353.454 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-16T22:20:11.707Z,1629152411.707 [DVL_micro](ERROR): only read 3 of 4 data items 2021-08-16T22:20:11.707Z,1629152411.707 [DVL_micro](ERROR): Failed to parse: :BI,+01513,+02830,+0000,I 2021-08-16T22:20:14.534Z,1629152414.534 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2021-08-16T22:20:14.534Z,1629152414.534 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+26.5,0000.,000 2021-08-16T22:20:16.943Z,1629152416.943 [DVL_micro](ERROR): No DVL communication! Re-initializing 2021-08-16T22:20:16.943Z,1629152416.943 [DVL_micro] Communications Fault, FailCount= 1 2021-08-16T22:20:16.943Z,1629152416.943 [DVL_micro](ERROR): Communications Fault 2021-08-16T22:20:17.009Z,1629152417.009 [CBIT](ERROR): Communications Fault in component: DVL_micro 2021-08-16T22:20:17.413Z,1629152417.413 [DVL_micro](INFO): Powering down 2021-08-16T22:20:17.750Z,1629152417.750 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:18.150Z,1629152418.150 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:18.151Z,1629152418.151 [Power24vConverter] Hardware Fault, FailCount= 1 2021-08-16T22:20:18.151Z,1629152418.151 [Power24vConverter](ERROR): Hardware Fault 2021-08-16T22:20:18.218Z,1629152418.218 [CBIT](INFO): Clearing failed state for component DVL_micro 2021-08-16T22:20:18.218Z,1629152418.218 [DVL_micro] No Fault, FailCount= 1 2021-08-16T22:20:18.218Z,1629152418.218 [CBIT](ERROR): Hardware Fault in component: Power24vConverter 2021-08-16T22:20:18.562Z,1629152418.562 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:18.963Z,1629152418.963 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:19.366Z,1629152419.366 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:19.766Z,1629152419.766 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:20.170Z,1629152420.170 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:20.578Z,1629152420.578 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:20.982Z,1629152420.982 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:21.386Z,1629152421.386 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:21.786Z,1629152421.786 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:22.202Z,1629152422.202 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:22.594Z,1629152422.594 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:22.999Z,1629152422.999 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:23.406Z,1629152423.406 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:23.806Z,1629152423.806 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:24.210Z,1629152424.210 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:24.621Z,1629152424.621 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:25.026Z,1629152425.026 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:25.427Z,1629152425.427 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:25.845Z,1629152425.845 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:26.236Z,1629152426.236 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:26.643Z,1629152426.643 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:27.042Z,1629152427.042 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:27.442Z,1629152427.442 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:27.852Z,1629152427.852 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:28.250Z,1629152428.250 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:28.655Z,1629152428.655 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:29.058Z,1629152429.058 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:29.463Z,1629152429.463 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:29.866Z,1629152429.866 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:30.271Z,1629152430.271 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:30.674Z,1629152430.674 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:31.079Z,1629152431.079 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:31.482Z,1629152431.482 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:31.902Z,1629152431.902 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:32.290Z,1629152432.290 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:32.694Z,1629152432.694 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:33.098Z,1629152433.098 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:33.511Z,1629152433.511 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:33.906Z,1629152433.906 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:34.311Z,1629152434.311 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:34.714Z,1629152434.714 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:35.124Z,1629152435.124 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:35.522Z,1629152435.522 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:35.925Z,1629152435.925 [DVL_micro](FAULT): Failed to initialize within timeout. 2021-08-16T22:20:35.926Z,1629152435.926 [DVL_micro] Communications Fault, FailCount= 2 2021-08-16T22:20:35.926Z,1629152435.926 [DVL_micro](ERROR): Communications Fault 2021-08-16T22:20:35.927Z,1629152435.927 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:35.979Z,1629152435.979 [CBIT](ERROR): Communications Fault in component: DVL_micro 2021-08-16T22:20:36.401Z,1629152436.401 [DVL_micro](INFO): Powering down 2021-08-16T22:20:36.402Z,1629152436.402 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:36.744Z,1629152436.744 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:37.138Z,1629152437.138 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:37.201Z,1629152437.201 [CBIT](INFO): Clearing failed state for component DVL_micro 2021-08-16T22:20:37.201Z,1629152437.201 [DVL_micro] No Fault, FailCount= 2 2021-08-16T22:20:37.547Z,1629152437.547 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:37.954Z,1629152437.954 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:38.350Z,1629152438.350 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:38.758Z,1629152438.758 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:39.158Z,1629152439.158 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:39.563Z,1629152439.563 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:39.966Z,1629152439.966 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:40.370Z,1629152440.370 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:40.774Z,1629152440.774 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:41.183Z,1629152441.183 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:41.583Z,1629152441.583 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:41.986Z,1629152441.986 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:42.391Z,1629152442.391 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:42.800Z,1629152442.800 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:43.198Z,1629152443.198 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:43.606Z,1629152443.606 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:44.007Z,1629152444.007 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:44.415Z,1629152444.415 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:44.817Z,1629152444.817 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:45.222Z,1629152445.222 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:45.626Z,1629152445.626 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:46.035Z,1629152446.035 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:46.434Z,1629152446.434 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:46.834Z,1629152446.834 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:47.239Z,1629152447.239 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:47.648Z,1629152447.648 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:48.046Z,1629152448.046 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:48.454Z,1629152448.454 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:48.855Z,1629152448.855 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:49.261Z,1629152449.261 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:49.663Z,1629152449.663 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:50.067Z,1629152450.067 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:50.470Z,1629152450.470 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:50.882Z,1629152450.882 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:51.278Z,1629152451.278 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:51.682Z,1629152451.682 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:52.094Z,1629152452.094 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:52.491Z,1629152452.491 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:52.894Z,1629152452.894 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:53.302Z,1629152453.302 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:53.702Z,1629152453.702 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:54.108Z,1629152454.108 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:54.511Z,1629152454.511 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:54.918Z,1629152454.918 [DVL_micro](FAULT): Failed to initialize within timeout. 2021-08-16T22:20:54.918Z,1629152454.918 [DVL_micro] Communications Fault, FailCount= 3 2021-08-16T22:20:54.918Z,1629152454.918 [DVL_micro](ERROR): Communications Fault 2021-08-16T22:20:54.919Z,1629152454.919 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:54.970Z,1629152454.970 [CBIT](ERROR): Communications Fault in component: DVL_micro 2021-08-16T22:20:54.971Z,1629152454.971 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2021-08-16T22:20:55.393Z,1629152455.393 [DVL_micro](INFO): Powering down 2021-08-16T22:20:55.395Z,1629152455.395 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:55.429Z,1629152455.429 [CommandLine](FAULT): Scheduling is paused 2021-08-16T22:20:55.430Z,1629152455.430 [CBIT](INFO): Critical error at 20210816T222054 2021-08-16T22:20:55.430Z,1629152455.430 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2021-08-16T22:20:55.728Z,1629152455.728 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:56.126Z,1629152456.126 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:56.530Z,1629152456.530 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:56.935Z,1629152456.935 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:57.347Z,1629152457.347 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:57.742Z,1629152457.742 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:58.150Z,1629152458.150 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:58.550Z,1629152458.550 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:58.956Z,1629152458.956 [Power24vConverter](INFO): Powering down. 2021-08-16T22:20:59.359Z,1629152459.359 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:20:59.762Z,1629152459.762 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:00.175Z,1629152460.175 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:00.578Z,1629152460.578 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:00.978Z,1629152460.978 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:01.382Z,1629152461.382 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:01.782Z,1629152461.782 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:02.191Z,1629152462.191 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:02.594Z,1629152462.594 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:02.994Z,1629152462.994 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:03.398Z,1629152463.398 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:03.803Z,1629152463.803 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:04.233Z,1629152464.233 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:04.610Z,1629152464.610 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:05.014Z,1629152465.014 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:05.423Z,1629152465.423 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:05.822Z,1629152465.822 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:06.226Z,1629152466.226 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:06.630Z,1629152466.630 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:07.038Z,1629152467.038 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:07.438Z,1629152467.438 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:07.842Z,1629152467.842 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:08.246Z,1629152468.246 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:08.654Z,1629152468.654 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:09.054Z,1629152469.054 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:09.458Z,1629152469.458 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:09.866Z,1629152469.866 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:10.267Z,1629152470.267 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:10.670Z,1629152470.670 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:11.074Z,1629152471.074 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:11.487Z,1629152471.487 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:11.887Z,1629152471.887 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:12.291Z,1629152472.291 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:12.696Z,1629152472.696 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:13.098Z,1629152473.098 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:13.503Z,1629152473.503 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:13.915Z,1629152473.915 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:14.307Z,1629152474.307 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:14.714Z,1629152474.714 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:15.119Z,1629152475.119 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:15.518Z,1629152475.518 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:15.923Z,1629152475.923 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:16.326Z,1629152476.326 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:16.731Z,1629152476.731 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:17.134Z,1629152477.134 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:17.538Z,1629152477.538 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:17.946Z,1629152477.946 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:18.347Z,1629152478.347 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:18.750Z,1629152478.750 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:19.154Z,1629152479.154 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:19.562Z,1629152479.562 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:19.970Z,1629152479.970 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:20.370Z,1629152480.370 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:20.774Z,1629152480.774 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:21.178Z,1629152481.178 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:21.579Z,1629152481.579 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:21.982Z,1629152481.982 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:22.390Z,1629152482.390 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:22.790Z,1629152482.790 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:23.195Z,1629152483.195 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:23.598Z,1629152483.598 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:24.006Z,1629152484.006 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:24.406Z,1629152484.406 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:24.818Z,1629152484.818 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:25.214Z,1629152485.214 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:25.622Z,1629152485.622 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:26.026Z,1629152486.026 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:26.427Z,1629152486.427 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:26.830Z,1629152486.830 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:27.238Z,1629152487.238 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:27.638Z,1629152487.638 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:28.043Z,1629152488.043 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:28.446Z,1629152488.446 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:28.850Z,1629152488.850 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:29.260Z,1629152489.260 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:29.666Z,1629152489.666 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:30.062Z,1629152490.062 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:30.470Z,1629152490.470 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:30.870Z,1629152490.870 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:31.275Z,1629152491.275 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:31.678Z,1629152491.678 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:32.086Z,1629152492.086 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:32.490Z,1629152492.490 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:32.891Z,1629152492.891 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:33.294Z,1629152493.294 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:33.697Z,1629152493.697 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:34.102Z,1629152494.102 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:34.511Z,1629152494.511 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:34.914Z,1629152494.914 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:35.314Z,1629152495.314 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:35.718Z,1629152495.718 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:36.130Z,1629152496.130 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:36.526Z,1629152496.526 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:36.939Z,1629152496.939 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:37.334Z,1629152497.334 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:37.739Z,1629152497.739 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:38.142Z,1629152498.142 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:38.545Z,1629152498.545 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:38.954Z,1629152498.954 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:39.359Z,1629152499.359 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:39.758Z,1629152499.758 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:40.166Z,1629152500.166 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:40.570Z,1629152500.570 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:40.978Z,1629152500.978 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:41.378Z,1629152501.378 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:41.778Z,1629152501.778 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:42.182Z,1629152502.182 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:42.590Z,1629152502.590 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:42.990Z,1629152502.990 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:43.394Z,1629152503.394 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:43.798Z,1629152503.798 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:44.206Z,1629152504.206 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:44.611Z,1629152504.611 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:45.010Z,1629152505.010 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:45.418Z,1629152505.418 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:45.818Z,1629152505.818 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:46.224Z,1629152506.224 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:46.626Z,1629152506.626 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:47.034Z,1629152507.034 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:47.434Z,1629152507.434 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:47.843Z,1629152507.843 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:48.241Z,1629152508.241 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:48.650Z,1629152508.650 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:49.055Z,1629152509.055 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:49.459Z,1629152509.459 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:49.862Z,1629152509.862 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:50.262Z,1629152510.262 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:50.666Z,1629152510.666 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:51.071Z,1629152511.071 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:51.474Z,1629152511.474 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:51.882Z,1629152511.882 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:52.282Z,1629152512.282 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:52.686Z,1629152512.686 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:53.090Z,1629152513.090 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:53.495Z,1629152513.495 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:53.903Z,1629152513.903 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:54.302Z,1629152514.302 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:54.706Z,1629152514.706 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:55.114Z,1629152515.114 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:55.519Z,1629152515.519 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:55.918Z,1629152515.918 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:56.322Z,1629152516.322 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:56.726Z,1629152516.726 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:57.132Z,1629152517.132 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:57.534Z,1629152517.534 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:57.938Z,1629152517.938 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:58.346Z,1629152518.346 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:58.754Z,1629152518.754 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:59.154Z,1629152519.154 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:21:59.564Z,1629152519.564 [Power24vConverter](INFO): Powering down. 2021-08-16T22:21:59.966Z,1629152519.966 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:00.368Z,1629152520.368 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:00.771Z,1629152520.771 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:01.174Z,1629152521.174 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:01.578Z,1629152521.578 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:01.978Z,1629152521.978 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:02.382Z,1629152522.382 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:02.790Z,1629152522.790 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:03.190Z,1629152523.190 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:03.598Z,1629152523.598 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:03.998Z,1629152523.998 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:04.408Z,1629152524.408 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:04.811Z,1629152524.811 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:05.210Z,1629152525.210 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:05.614Z,1629152525.614 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:06.023Z,1629152526.023 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:06.422Z,1629152526.422 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:06.826Z,1629152526.826 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:07.238Z,1629152527.238 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:07.635Z,1629152527.635 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:08.042Z,1629152528.042 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:08.442Z,1629152528.442 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:08.846Z,1629152528.846 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:09.281Z,1629152529.281 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:09.658Z,1629152529.658 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:10.062Z,1629152530.062 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:10.462Z,1629152530.462 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:10.871Z,1629152530.871 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:11.270Z,1629152531.270 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:11.674Z,1629152531.674 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:12.078Z,1629152532.078 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:12.483Z,1629152532.483 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:12.886Z,1629152532.886 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:13.294Z,1629152533.294 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:13.694Z,1629152533.694 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:14.099Z,1629152534.099 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:14.502Z,1629152534.502 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:14.914Z,1629152534.914 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:15.314Z,1629152535.314 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:15.722Z,1629152535.722 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:16.122Z,1629152536.122 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:16.526Z,1629152536.526 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:16.985Z,1629152536.985 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:17.334Z,1629152537.334 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:17.734Z,1629152537.734 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:18.138Z,1629152538.138 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:18.546Z,1629152538.546 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:18.954Z,1629152538.954 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:19.366Z,1629152539.366 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:19.779Z,1629152539.779 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:20.206Z,1629152540.206 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:20.594Z,1629152540.594 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:21.006Z,1629152541.006 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:21.419Z,1629152541.419 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:21.814Z,1629152541.814 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:22.222Z,1629152542.222 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:22.654Z,1629152542.654 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:23.042Z,1629152543.042 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:23.438Z,1629152543.438 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:23.842Z,1629152543.842 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:24.246Z,1629152544.246 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:24.650Z,1629152544.650 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:25.054Z,1629152545.054 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:25.462Z,1629152545.462 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:25.862Z,1629152545.862 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:26.267Z,1629152546.267 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:26.674Z,1629152546.674 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:27.078Z,1629152547.078 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:27.478Z,1629152547.478 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:27.882Z,1629152547.882 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:28.286Z,1629152548.286 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:28.696Z,1629152548.696 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:29.110Z,1629152549.110 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:29.502Z,1629152549.502 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:29.908Z,1629152549.908 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:30.306Z,1629152550.306 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:30.710Z,1629152550.710 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:31.114Z,1629152551.114 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:31.523Z,1629152551.523 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:31.926Z,1629152551.926 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:32.326Z,1629152552.326 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:32.730Z,1629152552.730 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:33.139Z,1629152553.139 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:33.542Z,1629152553.542 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:33.946Z,1629152553.946 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:34.354Z,1629152554.354 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:34.752Z,1629152554.752 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:35.154Z,1629152555.154 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:35.558Z,1629152555.558 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:35.962Z,1629152555.962 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:36.371Z,1629152556.371 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:36.770Z,1629152556.770 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:37.174Z,1629152557.174 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:37.582Z,1629152557.582 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:37.983Z,1629152557.983 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:38.386Z,1629152558.386 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:38.794Z,1629152558.794 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:39.198Z,1629152559.198 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:39.599Z,1629152559.599 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:40.003Z,1629152560.003 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:40.413Z,1629152560.413 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:40.818Z,1629152560.818 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:41.226Z,1629152561.226 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:41.622Z,1629152561.622 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:42.034Z,1629152562.034 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:42.430Z,1629152562.430 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:42.834Z,1629152562.834 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:43.234Z,1629152563.234 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:43.642Z,1629152563.642 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:44.046Z,1629152564.046 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:44.448Z,1629152564.448 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:44.850Z,1629152564.850 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:45.254Z,1629152565.254 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:45.658Z,1629152565.658 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:46.070Z,1629152566.070 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:46.466Z,1629152566.466 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:46.878Z,1629152566.878 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:47.274Z,1629152567.274 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:47.680Z,1629152567.680 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:48.082Z,1629152568.082 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:48.490Z,1629152568.490 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:48.890Z,1629152568.890 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:49.326Z,1629152569.326 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:49.707Z,1629152569.707 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:50.106Z,1629152570.106 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:50.506Z,1629152570.506 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:50.915Z,1629152570.915 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:51.314Z,1629152571.314 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:51.718Z,1629152571.718 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:52.122Z,1629152572.122 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:52.530Z,1629152572.530 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:52.930Z,1629152572.930 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:53.334Z,1629152573.334 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:53.738Z,1629152573.738 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:54.142Z,1629152574.142 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:54.546Z,1629152574.546 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:54.950Z,1629152574.950 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:55.362Z,1629152575.362 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:55.758Z,1629152575.758 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:56.166Z,1629152576.166 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:56.566Z,1629152576.566 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:56.990Z,1629152576.990 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:57.374Z,1629152577.374 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:57.778Z,1629152577.778 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:58.186Z,1629152578.186 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:58.587Z,1629152578.587 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:58.994Z,1629152578.994 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:22:59.394Z,1629152579.394 [Power24vConverter](INFO): Powering down. 2021-08-16T22:22:59.798Z,1629152579.798 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:00.203Z,1629152580.203 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:00.606Z,1629152580.606 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:01.014Z,1629152581.014 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:01.414Z,1629152581.414 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:01.823Z,1629152581.823 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:02.222Z,1629152582.222 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:02.626Z,1629152582.626 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:03.030Z,1629152583.030 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:03.435Z,1629152583.435 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:03.838Z,1629152583.838 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:04.242Z,1629152584.242 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:04.646Z,1629152584.646 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:05.054Z,1629152585.054 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:05.458Z,1629152585.458 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:05.859Z,1629152585.859 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:06.263Z,1629152586.263 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:06.676Z,1629152586.676 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:07.074Z,1629152587.074 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:07.474Z,1629152587.474 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:07.886Z,1629152587.886 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:08.286Z,1629152588.286 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:08.686Z,1629152588.686 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:09.090Z,1629152589.090 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:09.500Z,1629152589.500 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:09.898Z,1629152589.898 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:10.306Z,1629152590.306 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:10.706Z,1629152590.706 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:11.111Z,1629152591.111 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:11.514Z,1629152591.514 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:11.922Z,1629152591.922 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:12.326Z,1629152592.326 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:12.731Z,1629152592.731 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:13.134Z,1629152593.134 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:13.538Z,1629152593.538 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:13.942Z,1629152593.942 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:14.350Z,1629152594.350 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:14.759Z,1629152594.759 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:15.154Z,1629152595.154 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:15.554Z,1629152595.554 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:15.959Z,1629152595.959 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:16.363Z,1629152596.363 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:16.766Z,1629152596.766 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:17.170Z,1629152597.170 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:17.582Z,1629152597.582 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:17.982Z,1629152597.982 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:18.390Z,1629152598.390 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:18.790Z,1629152598.790 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:19.191Z,1629152599.191 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:19.598Z,1629152599.598 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:19.998Z,1629152599.998 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:20.406Z,1629152600.406 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:20.807Z,1629152600.807 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:21.210Z,1629152601.210 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:21.614Z,1629152601.614 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:22.018Z,1629152602.018 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:22.427Z,1629152602.427 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:22.826Z,1629152602.826 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:23.230Z,1629152603.230 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:23.634Z,1629152603.634 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:24.050Z,1629152604.050 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:24.442Z,1629152604.442 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:24.850Z,1629152604.850 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:25.250Z,1629152605.250 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:25.656Z,1629152605.656 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:26.058Z,1629152606.058 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:26.462Z,1629152606.462 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:26.870Z,1629152606.870 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:27.280Z,1629152607.280 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:27.674Z,1629152607.674 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:28.090Z,1629152608.090 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:28.490Z,1629152608.490 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:28.894Z,1629152608.894 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:29.302Z,1629152609.302 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:29.698Z,1629152609.698 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:30.102Z,1629152610.102 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:30.506Z,1629152610.506 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:30.911Z,1629152610.911 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:31.310Z,1629152611.310 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:31.714Z,1629152611.714 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:32.118Z,1629152612.118 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:32.528Z,1629152612.528 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:32.930Z,1629152612.930 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:33.334Z,1629152613.334 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:33.734Z,1629152613.734 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:34.139Z,1629152614.139 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:34.542Z,1629152614.542 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:34.950Z,1629152614.950 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:35.350Z,1629152615.350 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:35.759Z,1629152615.759 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:36.162Z,1629152616.162 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:36.562Z,1629152616.562 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:36.966Z,1629152616.966 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:37.371Z,1629152617.371 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:37.774Z,1629152617.774 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:38.182Z,1629152618.182 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:38.582Z,1629152618.582 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:38.987Z,1629152618.987 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:39.390Z,1629152619.390 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:39.794Z,1629152619.794 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:40.198Z,1629152620.198 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:40.610Z,1629152620.610 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:41.006Z,1629152621.006 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:41.410Z,1629152621.410 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:41.814Z,1629152621.814 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:42.227Z,1629152622.227 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:42.623Z,1629152622.623 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:43.030Z,1629152623.030 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:43.430Z,1629152623.430 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:43.835Z,1629152623.835 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:44.238Z,1629152624.238 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:44.642Z,1629152624.642 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:45.050Z,1629152625.050 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:45.458Z,1629152625.458 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:45.854Z,1629152625.854 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:46.258Z,1629152626.258 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:46.666Z,1629152626.666 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:47.067Z,1629152627.067 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:47.474Z,1629152627.474 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:47.874Z,1629152627.874 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:48.282Z,1629152628.282 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:48.683Z,1629152628.683 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:49.086Z,1629152629.086 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:49.490Z,1629152629.490 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:49.894Z,1629152629.894 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:50.306Z,1629152630.306 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:50.702Z,1629152630.702 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:51.110Z,1629152631.110 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:51.514Z,1629152631.514 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:51.930Z,1629152631.930 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:52.318Z,1629152632.318 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:52.722Z,1629152632.722 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:53.131Z,1629152633.131 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:53.530Z,1629152633.530 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:53.938Z,1629152633.938 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:54.352Z,1629152634.352 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:54.742Z,1629152634.742 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:55.154Z,1629152635.154 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:55.272Z,1629152635.272 [CBIT](INFO): Clearing failed state for component DVL_micro 2021-08-16T22:23:55.272Z,1629152635.272 [DVL_micro] No Fault, FailCount= 3 2021-08-16T22:23:55.563Z,1629152635.563 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:55.970Z,1629152635.970 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:56.374Z,1629152636.374 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:56.799Z,1629152636.799 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:57.195Z,1629152637.195 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:57.602Z,1629152637.602 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:58.006Z,1629152638.006 [Power24vConverter](FAULT): LCB fault: Software Overcurrent. 2021-08-16T22:23:58.420Z,1629152638.420 [Power24vConverter](INFO): Powering down. 2021-08-16T22:23:59.216Z,1629152639.216 [Power24vConverter](INFO): Powering up. 2021-08-16T22:23:59.235Z,1629152639.235 [CBIT](INFO): Clearing failed state for component Power24vConverter 2021-08-16T22:23:59.235Z,1629152639.235 [Power24vConverter] No Fault, FailCount= 1 2021-08-16T22:24:10.174Z,1629152650.174 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-16T22:24:10.175Z,1629152650.175 [Default:CheckIn:C.Wait] Stopped 2021-08-16T22:24:10.175Z,1629152650.175 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-16T22:24:10.175Z,1629152650.175 [Default:CheckIn:D] Running Loop=1 2021-08-16T22:24:10.550Z,1629152650.550 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2021-08-16T22:24:10.550Z,1629152650.550 [DVL_micro] Data Fault, FailCount= 1 2021-08-16T22:24:10.550Z,1629152650.550 [DVL_micro](ERROR): Data Fault 2021-08-16T22:24:10.560Z,1629152650.560 [Default:CheckIn:D] Stopped 2021-08-16T22:24:10.560Z,1629152650.560 [Default:CheckIn:E] Running Loop=1 2021-08-16T22:24:10.570Z,1629152650.570 [CBIT](ERROR): Data Fault in component: DVL_micro 2021-08-16T22:24:11.033Z,1629152651.033 [DVL_micro](INFO): Powering down 2021-08-16T22:24:11.044Z,1629152651.044 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 244.689290 min 2021-08-16T22:24:11.044Z,1629152651.044 [Default:CheckIn:E] Stopped 2021-08-16T22:24:11.044Z,1629152651.044 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-08-16T22:24:11.044Z,1629152651.044 [Default:CheckIn] Stopped 2021-08-16T22:24:11.044Z,1629152651.044 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-08-16T22:24:11.045Z,1629152651.045 [Default:CheckIn](INFO): Running loop #44 2021-08-16T22:24:11.045Z,1629152651.045 [Default:CheckIn] Running Loop=44 2021-08-16T22:24:11.045Z,1