2020-06-04T15:36:46.520Z,1591285006.520 [CommandLine](IMPORTANT): got command restart logs 2020-06-04T15:38:59.017Z,1591285139.017 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2020-06-04T15:40:28.256Z,1591285228.256 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-06-04T15:40:28.256Z,1591285228.256 [Default:CheckIn:C.Wait] Stopped 2020-06-04T15:40:28.256Z,1591285228.256 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-06-04T15:40:28.257Z,1591285228.257 [Default:CheckIn:D] Running Loop=1 2020-06-04T15:40:28.667Z,1591285228.667 [Default:CheckIn:D] Stopped 2020-06-04T15:40:28.667Z,1591285228.667 [Default:CheckIn:E] Running Loop=1 2020-06-04T15:40:29.102Z,1591285229.102 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 24.753792 min 2020-06-04T15:40:29.102Z,1591285229.102 [Default:CheckIn:E] Stopped 2020-06-04T15:40:29.102Z,1591285229.102 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-06-04T15:40:29.102Z,1591285229.102 [Default:CheckIn] Stopped 2020-06-04T15:40:29.102Z,1591285229.102 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-06-04T15:40:29.102Z,1591285229.102 [Default:CheckIn](INFO): Running loop #5 2020-06-04T15:40:29.102Z,1591285229.102 [Default:CheckIn] Running Loop=5 2020-06-04T15:40:29.103Z,1591285229.103 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-06-04T15:40:29.103Z,1591285229.103 [Default:CheckIn:Read_GPS] Running Loop=1 2020-06-04T15:40:31.056Z,1591285231.056 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,154020.00,A,4133.14041,N,07042.51548,W,0.233,198.73,040620,,,A*71 2020-06-04T15:40:31.059Z,1591285231.059 [NAL9602](INFO): GPS fix at 20200604T154020: (41.552340, -70.708591) 2020-06-04T15:40:31.083Z,1591285231.083 [Default:CheckIn:Read_GPS] Stopped 2020-06-04T15:40:31.083Z,1591285231.083 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-06-04T15:40:35.427Z,1591285235.427 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200603T234555/Courier0070.lzma 2020-06-04T15:40:36.429Z,1591285236.429 [DataOverHttps](INFO): Moved sent file to Logs/20200603T234555/Courier0070.lzma.bak 2020-06-04T15:40:36.429Z,1591285236.429 [DataOverHttps](INFO): SBD MOMSN=23048 2020-06-04T15:40:45.468Z,1591285245.468 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20200604T153646/Courier0000.lzma 2020-06-04T15:40:46.469Z,1591285246.469 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Courier0000.lzma.bak 2020-06-04T15:40:46.469Z,1591285246.469 [DataOverHttps](INFO): SBD MOMSN=23050 2020-06-04T15:41:05.395Z,1591285265.395 [NAL9602](INFO): SBD MO Status=2, MOMSN=11367, MT Status=2, MTMSN=0 2020-06-04T15:41:05.395Z,1591285265.395 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2020-06-04T15:41:12.575Z,1591285272.575 [DataOverHttps](INFO): Sending 96 bytes from file Logs/20200603T234555/Express0071.lzma 2020-06-04T15:41:13.577Z,1591285273.577 [DataOverHttps](INFO): Moved sent file to Logs/20200603T234555/Express0071.lzma.bak 2020-06-04T15:41:13.577Z,1591285273.577 [DataOverHttps](INFO): SBD MOMSN=23054 2020-06-04T15:41:22.627Z,1591285282.627 [DataOverHttps](INFO): Sending 327 bytes from file Logs/20200604T153646/Express0001.lzma 2020-06-04T15:41:22.835Z,1591285282.835 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T15:41:23.629Z,1591285283.629 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Express0001.lzma.bak 2020-06-04T15:41:23.629Z,1591285283.629 [DataOverHttps](INFO): SBD MOMSN=23057 2020-06-04T15:41:32.667Z,1591285292.667 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20200604T153646/Express0004.lzma 2020-06-04T15:41:33.669Z,1591285293.669 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Express0004.lzma.bak 2020-06-04T15:41:33.669Z,1591285293.669 [DataOverHttps](INFO): SBD MOMSN=23061 2020-06-04T15:41:34.930Z,1591285294.930 [Default:CheckIn:Read_Iridium] Stopped 2020-06-04T15:41:34.931Z,1591285294.931 [Default:CheckIn:C.Wait] Running Loop=1 2020-06-04T15:41:34.931Z,1591285294.931 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-06-04T15:41:35.692Z,1591285295.692 [NAL9602](INFO): SBD MO Status=2, MOMSN=11367, MT Status=2, MTMSN=0 2020-06-04T15:41:35.692Z,1591285295.692 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2020-06-04T15:42:37.103Z,1591285357.103 [NAL9602](INFO): SBD MO Status=0, MOMSN=11367, MT Status=0, MTMSN=0 2020-06-04T15:42:37.103Z,1591285357.103 [NAL9602](INFO): No messages in MT queue 2020-06-04T15:43:07.823Z,1591285387.823 [NAL9602](INFO): Not Powering down - fast GPS 2020-06-04T15:44:50.470Z,1591285490.470 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T15:45:30.838Z,1591285530.838 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T15:46:10.837Z,1591285570.837 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-06-04T15:46:14.493Z,1591285574.493 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2020-06-04T15:46:35.498Z,1591285595.498 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-06-04T15:46:35.498Z,1591285595.498 [Default:CheckIn:C.Wait] Stopped 2020-06-04T15:46:35.499Z,1591285595.499 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-06-04T15:46:35.500Z,1591285595.500 [Default:CheckIn:D] Running Loop=1 2020-06-04T15:46:35.917Z,1591285595.917 [Default:CheckIn:D] Stopped 2020-06-04T15:46:35.917Z,1591285595.917 [Default:CheckIn:E] Running Loop=1 2020-06-04T15:46:36.308Z,1591285596.308 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 30.874624 min 2020-06-04T15:46:36.308Z,1591285596.308 [Default:CheckIn:E] Stopped 2020-06-04T15:46:36.308Z,1591285596.308 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-06-04T15:46:36.308Z,1591285596.308 [Default:CheckIn] Stopped 2020-06-04T15:46:36.308Z,1591285596.308 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-06-04T15:46:36.308Z,1591285596.308 [Default:CheckIn](INFO): Running loop #6 2020-06-04T15:46:36.308Z,1591285596.308 [Default:CheckIn] Running Loop=6 2020-06-04T15:46:36.308Z,1591285596.308 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-06-04T15:46:36.308Z,1591285596.308 [Default:CheckIn:Read_GPS] Running Loop=1 2020-06-04T15:46:38.291Z,1591285598.291 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,154627.00,A,4133.03587,N,07042.42466,W,9.855,165.73,040620,,,D*72 2020-06-04T15:46:38.293Z,1591285598.293 [NAL9602](INFO): GPS fix at 20200604T154627: (41.550598, -70.707078) 2020-06-04T15:46:38.338Z,1591285598.338 [Default:CheckIn:Read_GPS] Stopped 2020-06-04T15:46:38.338Z,1591285598.338 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-06-04T15:46:41.911Z,1591285601.911 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20200604T153646/Courier0006.lzma 2020-06-04T15:46:42.913Z,1591285602.913 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Courier0006.lzma.bak 2020-06-04T15:46:42.913Z,1591285602.913 [DataOverHttps](INFO): SBD MOMSN=23066 2020-06-04T15:46:51.951Z,1591285611.951 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20200604T153646/Express0007.lzma 2020-06-04T15:46:52.864Z,1591285612.864 [NAL9602](INFO): SBD MO Status=0, MOMSN=11368, MT Status=0, MTMSN=0 2020-06-04T15:46:52.864Z,1591285612.864 [NAL9602](INFO): No messages in MT queue 2020-06-04T15:46:52.953Z,1591285612.953 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Express0007.lzma.bak 2020-06-04T15:46:52.953Z,1591285612.953 [DataOverHttps](INFO): SBD MOMSN=23069 2020-06-04T15:46:54.535Z,1591285614.535 [Default:CheckIn:Read_Iridium] Stopped 2020-06-04T15:46:54.535Z,1591285614.535 [Default:CheckIn:C.Wait] Running Loop=1 2020-06-04T15:46:54.535Z,1591285614.536 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-06-04T15:47:09.850Z,1591285629.850 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2020-06-04T15:47:23.565Z,1591285643.565 [NAL9602](INFO): Not Powering down - fast GPS 2020-06-04T15:48:25.852Z,1591285705.852 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2020-06-04T15:49:05.838Z,1591285745.838 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T15:49:30.484Z,1591285770.484 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T15:50:54.084Z,1591285854.084 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2020-06-04T15:50:54.494Z,1591285854.494 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2020-06-04T15:51:55.097Z,1591285915.097 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-06-04T15:51:55.097Z,1591285915.097 [Default:CheckIn:C.Wait] Stopped 2020-06-04T15:51:55.097Z,1591285915.097 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-06-04T15:51:55.097Z,1591285915.097 [Default:CheckIn:D] Running Loop=1 2020-06-04T15:51:55.492Z,1591285915.492 [Default:CheckIn:D] Stopped 2020-06-04T15:51:55.492Z,1591285915.492 [Default:CheckIn:E] Running Loop=1 2020-06-04T15:51:55.913Z,1591285915.913 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.200867 min 2020-06-04T15:51:55.913Z,1591285915.913 [Default:CheckIn:E] Stopped 2020-06-04T15:51:55.913Z,1591285915.913 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-06-04T15:51:55.913Z,1591285915.913 [Default:CheckIn] Stopped 2020-06-04T15:51:55.913Z,1591285915.913 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-06-04T15:51:55.913Z,1591285915.913 [Default:CheckIn](INFO): Running loop #7 2020-06-04T15:51:55.913Z,1591285915.913 [Default:CheckIn] Running Loop=7 2020-06-04T15:51:55.913Z,1591285915.913 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-06-04T15:51:55.913Z,1591285915.913 [Default:CheckIn:Read_GPS] Running Loop=1 2020-06-04T15:51:57.906Z,1591285917.906 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155146.00,A,4131.93136,N,07041.93395,W,11.955,156.61,040620,,,D*49 2020-06-04T15:51:57.908Z,1591285917.908 [NAL9602](INFO): GPS fix at 20200604T155146: (41.532189, -70.698899) 2020-06-04T15:51:57.973Z,1591285917.973 [Default:CheckIn:Read_GPS] Stopped 2020-06-04T15:51:57.973Z,1591285917.973 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-06-04T15:52:02.255Z,1591285922.255 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20200604T153646/Courier0009.lzma 2020-06-04T15:52:03.257Z,1591285923.257 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Courier0009.lzma.bak 2020-06-04T15:52:03.257Z,1591285923.257 [DataOverHttps](INFO): SBD MOMSN=23074 2020-06-04T15:52:12.295Z,1591285932.295 [DataOverHttps](INFO): Sending 136 bytes from file Logs/20200604T153646/Express0010.lzma 2020-06-04T15:52:13.297Z,1591285933.297 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Express0010.lzma.bak 2020-06-04T15:52:13.297Z,1591285933.297 [DataOverHttps](INFO): SBD MOMSN=23077 2020-06-04T15:52:14.527Z,1591285934.527 [Default:CheckIn:Read_Iridium] Stopped 2020-06-04T15:52:14.527Z,1591285934.527 [Default:CheckIn:C.Wait] Running Loop=1 2020-06-04T15:52:14.527Z,1591285934.527 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-06-04T15:52:26.561Z,1591285946.561 [NAL9602](INFO): SBD MO Status=0, MOMSN=11369, MT Status=0, MTMSN=0 2020-06-04T15:52:26.561Z,1591285946.561 [NAL9602](INFO): No messages in MT queue 2020-06-04T15:52:57.274Z,1591285977.274 [NAL9602](INFO): Not Powering down - fast GPS 2020-06-04T15:54:14.866Z,1591286054.866 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T15:55:51.845Z,1591286151.845 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T15:56:31.854Z,1591286191.854 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T15:56:54.031Z,1591286214.031 [RDI_PathfinderUp](ERROR): only read 0 of 4 data items 2020-06-04T15:57:15.070Z,1591286235.070 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-06-04T15:57:15.070Z,1591286235.070 [Default:CheckIn:C.Wait] Stopped 2020-06-04T15:57:15.070Z,1591286235.070 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-06-04T15:57:15.070Z,1591286235.070 [Default:CheckIn:D] Running Loop=1 2020-06-04T15:57:15.451Z,1591286235.451 [Default:CheckIn:D] Stopped 2020-06-04T15:57:15.451Z,1591286235.451 [Default:CheckIn:E] Running Loop=1 2020-06-04T15:57:15.900Z,1591286235.900 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.533529 min 2020-06-04T15:57:15.900Z,1591286235.900 [Default:CheckIn:E] Stopped 2020-06-04T15:57:15.901Z,1591286235.901 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-06-04T15:57:15.901Z,1591286235.901 [Default:CheckIn] Stopped 2020-06-04T15:57:15.901Z,1591286235.901 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-06-04T15:57:15.901Z,1591286235.901 [Default:CheckIn](INFO): Running loop #8 2020-06-04T15:57:15.901Z,1591286235.901 [Default:CheckIn] Running Loop=8 2020-06-04T15:57:15.901Z,1591286235.901 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-06-04T15:57:15.901Z,1591286235.901 [Default:CheckIn:Read_GPS] Running Loop=1 2020-06-04T15:57:17.850Z,1591286237.850 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155706.00,A,4131.15483,N,07041.03434,W,9.350,91.96,040620,,,D*4F 2020-06-04T15:57:17.853Z,1591286237.853 [NAL9602](INFO): GPS fix at 20200604T155706: (41.519247, -70.683906) 2020-06-04T15:57:17.947Z,1591286237.947 [Default:CheckIn:Read_GPS] Stopped 2020-06-04T15:57:17.947Z,1591286237.947 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-06-04T15:57:21.587Z,1591286241.587 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20200604T153646/Courier0012.lzma 2020-06-04T15:57:22.589Z,1591286242.589 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Courier0012.lzma.bak 2020-06-04T15:57:22.589Z,1591286242.589 [DataOverHttps](INFO): SBD MOMSN=23083 2020-06-04T15:57:31.627Z,1591286251.627 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20200604T153646/Express0013.lzma 2020-06-04T15:57:32.630Z,1591286252.630 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Express0013.lzma.bak 2020-06-04T15:57:32.631Z,1591286252.631 [DataOverHttps](INFO): SBD MOMSN=23086 2020-06-04T15:57:34.068Z,1591286254.068 [Default:CheckIn:Read_Iridium] Stopped 2020-06-04T15:57:34.068Z,1591286254.068 [Default:CheckIn:C.Wait] Running Loop=1 2020-06-04T15:57:34.068Z,1591286254.068 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-06-04T15:57:37.667Z,1591286257.667 [NAL9602](INFO): SBD MO Status=0, MOMSN=11370, MT Status=0, MTMSN=0 2020-06-04T15:57:37.667Z,1591286257.667 [NAL9602](INFO): No messages in MT queue 2020-06-04T15:58:08.345Z,1591286288.345 [NAL9602](INFO): Not Powering down - fast GPS 2020-06-04T15:59:51.798Z,1591286391.798 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T16:00:41.532Z,1591286441.532 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2020-06-04T16:00:41.534Z,1591286441.534 [BPC1](INFO): Received data from all battery sticks. 2020-06-04T16:02:34.616Z,1591286554.616 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-06-04T16:02:34.616Z,1591286554.616 [Default:CheckIn:C.Wait] Stopped 2020-06-04T16:02:34.616Z,1591286554.616 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-06-04T16:02:34.616Z,1591286554.616 [Default:CheckIn:D] Running Loop=1 2020-06-04T16:02:35.026Z,1591286555.026 [Default:CheckIn:D] Stopped 2020-06-04T16:02:35.026Z,1591286555.026 [Default:CheckIn:E] Running Loop=1 2020-06-04T16:02:35.427Z,1591286555.427 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 46.859778 min 2020-06-04T16:02:35.427Z,1591286555.427 [Default:CheckIn:E] Stopped 2020-06-04T16:02:35.427Z,1591286555.427 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-06-04T16:02:35.427Z,1591286555.427 [Default:CheckIn] Stopped 2020-06-04T16:02:35.428Z,1591286555.428 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-06-04T16:02:35.428Z,1591286555.428 [Default:CheckIn](INFO): Running loop #9 2020-06-04T16:02:35.428Z,1591286555.428 [Default:CheckIn] Running Loop=9 2020-06-04T16:02:35.428Z,1591286555.428 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-06-04T16:02:35.428Z,1591286555.428 [Default:CheckIn:Read_GPS] Running Loop=1 2020-06-04T16:02:37.409Z,1591286557.409 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160226.00,A,4131.46065,N,07040.31740,W,0.272,171.01,040620,,,A*78 2020-06-04T16:02:37.412Z,1591286557.412 [NAL9602](INFO): GPS fix at 20200604T160226: (41.524344, -70.671957) 2020-06-04T16:02:37.453Z,1591286557.453 [Default:CheckIn:Read_GPS] Stopped 2020-06-04T16:02:37.453Z,1591286557.453 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-06-04T16:02:41.887Z,1591286561.887 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20200604T153646/Courier0015.lzma 2020-06-04T16:02:42.896Z,1591286562.896 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Courier0015.lzma.bak 2020-06-04T16:02:42.896Z,1591286562.896 [DataOverHttps](INFO): SBD MOMSN=23091 2020-06-04T16:02:51.931Z,1591286571.931 [DataOverHttps](INFO): Sending 137 bytes from file Logs/20200604T153646/Express0016.lzma 2020-06-04T16:02:52.933Z,1591286572.933 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Express0016.lzma.bak 2020-06-04T16:02:52.933Z,1591286572.933 [DataOverHttps](INFO): SBD MOMSN=23094 2020-06-04T16:02:54.407Z,1591286574.407 [Default:CheckIn:Read_Iridium] Stopped 2020-06-04T16:02:54.407Z,1591286574.407 [Default:CheckIn:C.Wait] Running Loop=1 2020-06-04T16:02:54.407Z,1591286574.407 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-06-04T16:02:56.872Z,1591286576.872 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2020-06-04T16:03:17.411Z,1591286597.411 [NAL9602](INFO): SBD MO Status=2, MOMSN=11371, MT Status=2, MTMSN=0 2020-06-04T16:03:17.411Z,1591286597.411 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2020-06-04T16:03:31.201Z,1591286611.201 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2020-06-04T16:03:36.813Z,1591286616.813 [NAL9602](INFO): SBD MO Status=0, MOMSN=11371, MT Status=0, MTMSN=0 2020-06-04T16:03:36.813Z,1591286616.813 [NAL9602](INFO): No messages in MT queue 2020-06-04T16:04:07.502Z,1591286647.502 [NAL9602](INFO): Not Powering down - fast GPS 2020-06-04T16:04:39.851Z,1591286679.851 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-06-04T16:05:31.560Z,1591286731.560 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T16:05:55.835Z,1591286755.835 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2020-06-04T16:05:59.841Z,1591286759.841 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T16:07:40.462Z,1591286860.462 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2020-06-04T16:07:54.997Z,1591286874.997 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-06-04T16:07:54.997Z,1591286874.997 [Default:CheckIn:C.Wait] Stopped 2020-06-04T16:07:54.997Z,1591286874.997 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-06-04T16:07:54.998Z,1591286874.998 [Default:CheckIn:D] Running Loop=1 2020-06-04T16:07:55.394Z,1591286875.394 [Default:CheckIn:D] Stopped 2020-06-04T16:07:55.394Z,1591286875.394 [Default:CheckIn:E] Running Loop=1 2020-06-04T16:07:55.854Z,1591286875.854 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.199243 min 2020-06-04T16:07:55.854Z,1591286875.854 [Default:CheckIn:E] Stopped 2020-06-04T16:07:55.854Z,1591286875.854 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-06-04T16:07:55.854Z,1591286875.854 [Default:CheckIn] Stopped 2020-06-04T16:07:55.854Z,1591286875.854 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-06-04T16:07:55.855Z,1591286875.855 [Default:CheckIn](INFO): Running loop #10 2020-06-04T16:07:55.855Z,1591286875.855 [Default:CheckIn] Running Loop=10 2020-06-04T16:07:55.855Z,1591286875.855 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-06-04T16:07:55.855Z,1591286875.855 [Default:CheckIn:Read_GPS] Running Loop=1 2020-06-04T16:07:57.809Z,1591286877.809 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160746.00,A,4131.45522,N,07040.31093,W,0.078,109.91,040620,,,D*7C 2020-06-04T16:07:57.811Z,1591286877.811 [NAL9602](INFO): GPS fix at 20200604T160746: (41.524254, -70.671849) 2020-06-04T16:07:57.932Z,1591286877.932 [Default:CheckIn:Read_GPS] Stopped 2020-06-04T16:07:57.932Z,1591286877.932 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-06-04T16:08:02.207Z,1591286882.207 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20200604T153646/Courier0018.lzma 2020-06-04T16:08:03.210Z,1591286883.210 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Courier0018.lzma.bak 2020-06-04T16:08:03.210Z,1591286883.210 [DataOverHttps](INFO): SBD MOMSN=23098 2020-06-04T16:08:13.251Z,1591286893.251 [DataOverHttps](INFO): Sending 121 bytes from file Logs/20200604T153646/Express0019.lzma 2020-06-04T16:08:14.253Z,1591286894.253 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Express0019.lzma.bak 2020-06-04T16:08:14.253Z,1591286894.253 [DataOverHttps](INFO): SBD MOMSN=23101 2020-06-04T16:08:16.013Z,1591286896.013 [Default:CheckIn:Read_Iridium] Stopped 2020-06-04T16:08:16.013Z,1591286896.013 [Default:CheckIn:C.Wait] Running Loop=1 2020-06-04T16:08:16.014Z,1591286896.014 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-06-04T16:08:19.210Z,1591286899.210 [NAL9602](INFO): SBD MO Status=0, MOMSN=11372, MT Status=0, MTMSN=0 2020-06-04T16:08:19.211Z,1591286899.211 [NAL9602](INFO): No messages in MT queue 2020-06-04T16:08:49.902Z,1591286929.902 [NAL9602](INFO): Not Powering down - fast GPS 2020-06-04T16:10:41.467Z,1591287041.467 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2020-06-04T16:12:05.881Z,1591287125.881 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T16:13:16.624Z,1591287196.624 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-06-04T16:13:16.624Z,1591287196.624 [Default:CheckIn:C.Wait] Stopped 2020-06-04T16:13:16.624Z,1591287196.624 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-06-04T16:13:16.624Z,1591287196.624 [Default:CheckIn:D] Running Loop=1 2020-06-04T16:13:17.008Z,1591287197.008 [Default:CheckIn:D] Stopped 2020-06-04T16:13:17.008Z,1591287197.008 [Default:CheckIn:E] Running Loop=1 2020-06-04T16:13:17.398Z,1591287197.398 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 57.559473 min 2020-06-04T16:13:17.398Z,1591287197.398 [Default:CheckIn:E] Stopped 2020-06-04T16:13:17.398Z,1591287197.398 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-06-04T16:13:17.398Z,1591287197.398 [Default:CheckIn] Stopped 2020-06-04T16:13:17.398Z,1591287197.398 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-06-04T16:13:17.398Z,1591287197.398 [Default:CheckIn](INFO): Running loop #11 2020-06-04T16:13:17.398Z,1591287197.398 [Default:CheckIn] Running Loop=11 2020-06-04T16:13:17.399Z,1591287197.399 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-06-04T16:13:17.399Z,1591287197.399 [Default:CheckIn:Read_GPS] Running Loop=1 2020-06-04T16:13:19.387Z,1591287199.387 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161308.00,A,4131.45719,N,07040.31113,W,0.039,109.91,040620,,,D*75 2020-06-04T16:13:19.389Z,1591287199.389 [NAL9602](INFO): GPS fix at 20200604T161308: (41.524287, -70.671852) 2020-06-04T16:13:19.469Z,1591287199.469 [Default:CheckIn:Read_GPS] Stopped 2020-06-04T16:13:19.469Z,1591287199.469 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-06-04T16:13:23.535Z,1591287203.535 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20200604T153646/Courier0021.lzma 2020-06-04T16:13:24.537Z,1591287204.537 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Courier0021.lzma.bak 2020-06-04T16:13:24.537Z,1591287204.537 [DataOverHttps](INFO): SBD MOMSN=23105 2020-06-04T16:13:34.335Z,1591287214.335 [NAL9602](INFO): SBD MO Status=0, MOMSN=11373, MT Status=0, MTMSN=0 2020-06-04T16:13:34.335Z,1591287214.335 [NAL9602](INFO): No messages in MT queue 2020-06-04T16:13:34.591Z,1591287214.591 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20200604T153646/Express0022.lzma 2020-06-04T16:13:35.593Z,1591287215.593 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Express0022.lzma.bak 2020-06-04T16:13:35.593Z,1591287215.593 [DataOverHttps](INFO): SBD MOMSN=23108 2020-06-04T16:13:36.837Z,1591287216.837 [Default:CheckIn:Read_Iridium] Stopped 2020-06-04T16:13:36.837Z,1591287216.837 [Default:CheckIn:C.Wait] Running Loop=1 2020-06-04T16:13:36.837Z,1591287216.837 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-06-04T16:13:44.488Z,1591287224.488 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2020-06-04T16:14:01.850Z,1591287241.850 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2020-06-04T16:14:05.037Z,1591287245.037 [NAL9602](INFO): Not Powering down - fast GPS 2020-06-04T16:14:24.480Z,1591287264.480 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2020-06-04T16:15:59.033Z,1591287359.033 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2020-06-04T16:16:03.034Z,1591287363.034 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2020-06-04T16:16:22.851Z,1591287382.851 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-06-04T16:16:24.854Z,1591287384.854 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T16:17:58.171Z,1591287478.171 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-06-04T16:18:37.364Z,1591287517.364 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-06-04T16:18:37.364Z,1591287517.364 [Default:CheckIn:C.Wait] Stopped 2020-06-04T16:18:37.364Z,1591287517.364 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-06-04T16:18:37.365Z,1591287517.365 [Default:CheckIn:D] Running Loop=1 2020-06-04T16:18:37.805Z,1591287517.805 [Default:CheckIn:D] Stopped 2020-06-04T16:18:37.805Z,1591287517.805 [Default:CheckIn:E] Running Loop=1 2020-06-04T16:18:38.206Z,1591287518.206 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 62.906087 min 2020-06-04T16:18:38.206Z,1591287518.206 [Default:CheckIn:E] Stopped 2020-06-04T16:18:38.206Z,1591287518.206 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-06-04T16:18:38.206Z,1591287518.206 [Default:CheckIn] Stopped 2020-06-04T16:18:38.206Z,1591287518.206 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-06-04T16:18:38.207Z,1591287518.207 [Default:CheckIn](INFO): Running loop #12 2020-06-04T16:18:38.207Z,1591287518.207 [Default:CheckIn] Running Loop=12 2020-06-04T16:18:38.207Z,1591287518.207 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-06-04T16:18:38.207Z,1591287518.207 [Default:CheckIn:Read_GPS] Running Loop=1 2020-06-04T16:18:40.183Z,1591287520.183 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161829.00,A,4131.45831,N,07040.30862,W,0.039,69.25,040620,,,D*4E 2020-06-04T16:18:40.185Z,1591287520.185 [NAL9602](INFO): GPS fix at 20200604T161829: (41.524305, -70.671810) 2020-06-04T16:18:40.238Z,1591287520.238 [Default:CheckIn:Read_GPS] Stopped 2020-06-04T16:18:40.238Z,1591287520.238 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-06-04T16:18:43.851Z,1591287523.851 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20200604T153646/Courier0024.lzma 2020-06-04T16:18:44.853Z,1591287524.853 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Courier0024.lzma.bak 2020-06-04T16:18:44.853Z,1591287524.853 [DataOverHttps](INFO): SBD MOMSN=23112 2020-06-04T16:18:53.899Z,1591287533.899 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20200604T153646/Express0025.lzma 2020-06-04T16:18:54.901Z,1591287534.901 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Express0025.lzma.bak 2020-06-04T16:18:54.901Z,1591287534.901 [DataOverHttps](INFO): SBD MOMSN=23115 2020-06-04T16:18:56.362Z,1591287536.362 [Default:CheckIn:Read_Iridium] Stopped 2020-06-04T16:18:56.362Z,1591287536.362 [Default:CheckIn:C.Wait] Running Loop=1 2020-06-04T16:18:56.362Z,1591287536.362 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-06-04T16:18:59.186Z,1591287539.186 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-06-04T16:19:01.988Z,1591287541.988 [NAL9602](INFO): SBD MO Status=0, MOMSN=11374, MT Status=0, MTMSN=0 2020-06-04T16:19:01.988Z,1591287541.988 [NAL9602](INFO): No messages in MT queue 2020-06-04T16:19:19.072Z,1591287559.072 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T16:19:32.681Z,1591287572.681 [NAL9602](INFO): Not Powering down - fast GPS 2020-06-04T16:23:06.864Z,1591287786.864 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2020-06-04T16:23:56.949Z,1591287836.949 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-06-04T16:23:56.949Z,1591287836.949 [Default:CheckIn:C.Wait] Stopped 2020-06-04T16:23:56.949Z,1591287836.949 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-06-04T16:23:56.949Z,1591287836.949 [Default:CheckIn:D] Running Loop=1 2020-06-04T16:23:57.326Z,1591287837.326 [Default:CheckIn:D] Stopped 2020-06-04T16:23:57.326Z,1591287837.326 [Default:CheckIn:E] Running Loop=1 2020-06-04T16:23:57.736Z,1591287837.736 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 68.231437 min 2020-06-04T16:23:57.737Z,1591287837.737 [Default:CheckIn:E] Stopped 2020-06-04T16:23:57.737Z,1591287837.737 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-06-04T16:23:57.737Z,1591287837.737 [Default:CheckIn] Stopped 2020-06-04T16:23:57.738Z,1591287837.738 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-06-04T16:23:57.738Z,1591287837.738 [Default:CheckIn](INFO): Running loop #13 2020-06-04T16:23:57.738Z,1591287837.738 [Default:CheckIn] Running Loop=13 2020-06-04T16:23:57.739Z,1591287837.739 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-06-04T16:23:57.739Z,1591287837.739 [Default:CheckIn:Read_GPS] Running Loop=1 2020-06-04T16:23:59.721Z,1591287839.721 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162348.00,A,4131.47257,N,07040.28512,W,0.194,121.62,040620,,,D*72 2020-06-04T16:23:59.724Z,1591287839.724 [NAL9602](INFO): GPS fix at 20200604T162348: (41.524543, -70.671419) 2020-06-04T16:23:59.776Z,1591287839.776 [Default:CheckIn:Read_GPS] Stopped 2020-06-04T16:23:59.776Z,1591287839.776 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-06-04T16:24:04.155Z,1591287844.155 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20200604T153646/Courier0027.lzma 2020-06-04T16:24:05.157Z,1591287845.157 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Courier0027.lzma.bak 2020-06-04T16:24:05.157Z,1591287845.157 [DataOverHttps](INFO): SBD MOMSN=23119 2020-06-04T16:24:14.195Z,1591287854.195 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20200604T153646/Express0028.lzma 2020-06-04T16:24:15.197Z,1591287855.197 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Express0028.lzma.bak 2020-06-04T16:24:15.197Z,1591287855.197 [DataOverHttps](INFO): SBD MOMSN=23122 2020-06-04T16:24:16.734Z,1591287856.734 [Default:CheckIn:Read_Iridium] Stopped 2020-06-04T16:24:16.734Z,1591287856.734 [Default:CheckIn:C.Wait] Running Loop=1 2020-06-04T16:24:16.734Z,1591287856.734 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-06-04T16:24:40.560Z,1591287880.560 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T16:25:04.836Z,1591287904.836 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2020-06-04T16:26:30.015Z,1591287990.015 [NAL9602](INFO): SBD MO Status=0, MOMSN=11375, MT Status=0, MTMSN=0 2020-06-04T16:26:30.015Z,1591287990.015 [NAL9602](INFO): No messages in MT queue 2020-06-04T16:27:00.717Z,1591288020.717 [NAL9602](INFO): Not Powering down - fast GPS 2020-06-04T16:29:17.303Z,1591288157.303 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-06-04T16:29:17.303Z,1591288157.303 [Default:CheckIn:C.Wait] Stopped 2020-06-04T16:29:17.303Z,1591288157.303 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-06-04T16:29:17.304Z,1591288157.304 [Default:CheckIn:D] Running Loop=1 2020-06-04T16:29:17.714Z,1591288157.714 [Default:CheckIn:D] Stopped 2020-06-04T16:29:17.715Z,1591288157.715 [Default:CheckIn:E] Running Loop=1 2020-06-04T16:29:18.134Z,1591288158.134 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.571248 min 2020-06-04T16:29:18.134Z,1591288158.134 [Default:CheckIn:E] Stopped 2020-06-04T16:29:18.134Z,1591288158.134 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-06-04T16:29:18.135Z,1591288158.135 [Default:CheckIn] Stopped 2020-06-04T16:29:18.135Z,1591288158.135 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-06-04T16:29:18.135Z,1591288158.135 [Default:CheckIn](INFO): Running loop #14 2020-06-04T16:29:18.135Z,1591288158.135 [Default:CheckIn] Running Loop=14 2020-06-04T16:29:18.135Z,1591288158.135 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-06-04T16:29:18.135Z,1591288158.135 [Default:CheckIn:Read_GPS] Running Loop=1 2020-06-04T16:29:20.102Z,1591288160.102 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162909.00,A,4131.46456,N,07040.27797,W,0.136,121.62,040620,,,D*73 2020-06-04T16:29:20.104Z,1591288160.104 [NAL9602](INFO): GPS fix at 20200604T162909: (41.524409, -70.671300) 2020-06-04T16:29:20.145Z,1591288160.145 [Default:CheckIn:Read_GPS] Stopped 2020-06-04T16:29:20.146Z,1591288160.146 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-06-04T16:29:24.458Z,1591288164.458 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20200604T153646/Courier0030.lzma 2020-06-04T16:29:25.457Z,1591288165.457 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Courier0030.lzma.bak 2020-06-04T16:29:25.457Z,1591288165.457 [DataOverHttps](INFO): SBD MOMSN=23126 2020-06-04T16:29:34.495Z,1591288174.495 [DataOverHttps](INFO): Sending 121 bytes from file Logs/20200604T153646/Express0031.lzma 2020-06-04T16:29:35.511Z,1591288175.511 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Express0031.lzma.bak 2020-06-04T16:29:35.511Z,1591288175.511 [DataOverHttps](INFO): SBD MOMSN=23129 2020-06-04T16:29:35.889Z,1591288175.889 [RDI_Pathfinder](ERROR): only read 0 of 4 data items 2020-06-04T16:29:37.150Z,1591288177.150 [Default:CheckIn:Read_Iridium] Stopped 2020-06-04T16:29:37.150Z,1591288177.150 [Default:CheckIn:C.Wait] Running Loop=1 2020-06-04T16:29:37.150Z,1591288177.150 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-06-04T16:30:01.719Z,1591288201.719 [NAL9602](INFO): SBD MO Status=0, MOMSN=11376, MT Status=0, MTMSN=0 2020-06-04T16:30:01.719Z,1591288201.719 [NAL9602](INFO): No messages in MT queue 2020-06-04T16:30:11.459Z,1591288211.459 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2020-06-04T16:30:32.438Z,1591288232.438 [NAL9602](INFO): Not Powering down - fast GPS 2020-06-04T16:30:55.880Z,1591288255.880 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T16:31:50.455Z,1591288310.455 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-06-04T16:34:37.682Z,1591288477.682 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-06-04T16:34:37.682Z,1591288477.682 [Default:CheckIn:C.Wait] Stopped 2020-06-04T16:34:37.682Z,1591288477.682 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-06-04T16:34:37.682Z,1591288477.682 [Default:CheckIn:D] Running Loop=1 2020-06-04T16:34:38.102Z,1591288478.102 [Default:CheckIn:D] Stopped 2020-06-04T16:34:38.102Z,1591288478.102 [Default:CheckIn:E] Running Loop=1 2020-06-04T16:34:38.496Z,1591288478.496 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 78.911035 min 2020-06-04T16:34:38.496Z,1591288478.496 [Default:CheckIn:E] Stopped 2020-06-04T16:34:38.496Z,1591288478.496 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-06-04T16:34:38.496Z,1591288478.496 [Default:CheckIn] Stopped 2020-06-04T16:34:38.496Z,1591288478.496 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-06-04T16:34:38.496Z,1591288478.496 [Default:CheckIn](INFO): Running loop #15 2020-06-04T16:34:38.497Z,1591288478.497 [Default:CheckIn] Running Loop=15 2020-06-04T16:34:38.497Z,1591288478.497 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-06-04T16:34:38.497Z,1591288478.497 [Default:CheckIn:Read_GPS] Running Loop=1 2020-06-04T16:34:40.482Z,1591288480.482 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,163429.00,A,4131.47105,N,07040.28422,W,0.039,146.43,040620,,,D*71 2020-06-04T16:34:40.484Z,1591288480.484 [NAL9602](INFO): GPS fix at 20200604T163429: (41.524518, -70.671404) 2020-06-04T16:34:40.546Z,1591288480.546 [Default:CheckIn:Read_GPS] Stopped 2020-06-04T16:34:40.547Z,1591288480.547 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-06-04T16:34:44.777Z,1591288484.777 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20200604T153646/Courier0033.lzma 2020-06-04T16:34:45.780Z,1591288485.780 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Courier0033.lzma.bak 2020-06-04T16:34:45.781Z,1591288485.781 [DataOverHttps](INFO): SBD MOMSN=23133 2020-06-04T16:34:54.819Z,1591288494.819 [DataOverHttps](INFO): Sending 121 bytes from file Logs/20200604T153646/Express0034.lzma 2020-06-04T16:34:55.821Z,1591288495.821 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Express0034.lzma.bak 2020-06-04T16:34:55.821Z,1591288495.821 [DataOverHttps](INFO): SBD MOMSN=23137 2020-06-04T16:34:57.093Z,1591288497.093 [Default:CheckIn:Read_Iridium] Stopped 2020-06-04T16:34:57.093Z,1591288497.093 [Default:CheckIn:C.Wait] Running Loop=1 2020-06-04T16:34:57.093Z,1591288497.093 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-06-04T16:35:29.026Z,1591288529.026 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2020-06-04T16:35:37.926Z,1591288537.926 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2020-06-04T16:35:38.276Z,1591288538.276 [NAL9602](INFO): SBD MO Status=2, MOMSN=11377, MT Status=2, MTMSN=0 2020-06-04T16:35:38.276Z,1591288538.276 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2020-06-04T16:36:18.253Z,1591288578.253 [NAL9602](INFO): SBD MO Status=0, MOMSN=11377, MT Status=0, MTMSN=0 2020-06-04T16:36:18.253Z,1591288578.253 [NAL9602](INFO): No messages in MT queue 2020-06-04T16:36:48.967Z,1591288608.967 [NAL9602](INFO): Not Powering down - fast GPS 2020-06-04T16:36:51.836Z,1591288611.836 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T16:37:27.794Z,1591288647.794 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2020-06-04T16:37:31.830Z,1591288651.830 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T16:38:49.006Z,1591288729.006 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2020-06-04T16:39:57.650Z,1591288797.650 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-06-04T16:39:57.650Z,1591288797.650 [Default:CheckIn:C.Wait] Stopped 2020-06-04T16:39:57.650Z,1591288797.650 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-06-04T16:39:57.650Z,1591288797.650 [Default:CheckIn:D] Running Loop=1 2020-06-04T16:39:58.087Z,1591288798.087 [Default:CheckIn:D] Stopped 2020-06-04T16:39:58.087Z,1591288798.087 [Default:CheckIn:E] Running Loop=1 2020-06-04T16:39:58.464Z,1591288798.464 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.243856 min 2020-06-04T16:39:58.464Z,1591288798.464 [Default:CheckIn:E] Stopped 2020-06-04T16:39:58.464Z,1591288798.464 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-06-04T16:39:58.464Z,1591288798.464 [Default:CheckIn] Stopped 2020-06-04T16:39:58.464Z,1591288798.464 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-06-04T16:39:58.464Z,1591288798.464 [Default:CheckIn](INFO): Running loop #16 2020-06-04T16:39:58.464Z,1591288798.464 [Default:CheckIn] Running Loop=16 2020-06-04T16:39:58.464Z,1591288798.464 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-06-04T16:39:58.465Z,1591288798.465 [Default:CheckIn:Read_GPS] Running Loop=1 2020-06-04T16:40:00.456Z,1591288800.456 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,163949.00,A,4131.47691,N,07040.28010,W,0.700,324.95,040620,,,A*70 2020-06-04T16:40:00.458Z,1591288800.458 [NAL9602](INFO): GPS fix at 20200604T163949: (41.524615, -70.671335) 2020-06-04T16:40:00.509Z,1591288800.509 [Default:CheckIn:Read_GPS] Stopped 2020-06-04T16:40:00.510Z,1591288800.510 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-06-04T16:40:02.888Z,1591288802.888 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2020-06-04T16:40:02.888Z,1591288802.888 [RDI_Pathfinder] Communications Fault, FailCount= 1 2020-06-04T16:40:02.889Z,1591288802.889 [RDI_Pathfinder](ERROR): Communications Fault 2020-06-04T16:40:02.937Z,1591288802.937 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2020-06-04T16:40:03.368Z,1591288803.368 [RDI_Pathfinder](INFO): Powering down 2020-06-04T16:40:04.083Z,1591288804.083 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20200604T153646/Courier0036.lzma 2020-06-04T16:40:04.176Z,1591288804.176 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2020-06-04T16:40:04.176Z,1591288804.176 [RDI_Pathfinder] No Fault, FailCount= 1 2020-06-04T16:40:05.085Z,1591288805.085 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Courier0036.lzma.bak 2020-06-04T16:40:05.085Z,1591288805.085 [DataOverHttps](INFO): SBD MOMSN=23141 2020-06-04T16:40:13.789Z,1591288813.789 [Micromodem](FAULT): Failed to receive CAREV within timeout 2020-06-04T16:40:13.789Z,1591288813.789 [Micromodem] Hardware Fault, FailCount= 1 2020-06-04T16:40:13.789Z,1591288813.789 [Micromodem](ERROR): Hardware Fault 2020-06-04T16:40:13.869Z,1591288813.869 [CBIT](ERROR): Hardware Fault in component: Micromodem 2020-06-04T16:40:14.131Z,1591288814.131 [DataOverHttps](INFO): Sending 121 bytes from file Logs/20200604T153646/Express0037.lzma 2020-06-04T16:40:14.193Z,1591288814.193 [Micromodem](INFO): Powering down 2020-06-04T16:40:15.060Z,1591288815.060 [CBIT](INFO): Clearing failed state for component Micromodem 2020-06-04T16:40:15.060Z,1591288815.060 [Micromodem] No Fault, FailCount= 1 2020-06-04T16:40:15.133Z,1591288815.133 [DataOverHttps](INFO): Moved sent file to Logs/20200604T153646/Express0037.lzma.bak 2020-06-04T16:40:15.133Z,1591288815.133 [DataOverHttps](INFO): SBD MOMSN=23144 2020-06-04T16:40:16.647Z,1591288816.647 [Default:CheckIn:Read_Iridium] Stopped 2020-06-04T16:40:16.647Z,1591288816.647 [Default:CheckIn:C.Wait] Running Loop=1 2020-06-04T16:40:16.647Z,1591288816.647 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-06-04T16:40:17.825Z,1591288817.825 [Micromodem](INFO): Powering up 2020-06-04T16:40:17.825Z,1591288817.825 [Micromodem](DEBUG): Initializing Micromodem. 2020-06-04T16:40:22.667Z,1591288822.667 [Micromodem](INFO): Nmea out: $CCCFG,ALL,0*33 2020-06-04T16:40:26.732Z,1591288826.732 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2020-06-04T16:40:26.732Z,1591288826.732 [RDI_Pathfinder] Communications Fault, FailCount= 2 2020-06-04T16:40:26.732Z,1591288826.732 [RDI_Pathfinder](ERROR): Communications Fault 2020-06-04T16:40:26.780Z,1591288826.780 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2020-06-04T16:40:27.216Z,1591288827.216 [RDI_Pathfinder](INFO): Powering down 2020-06-04T16:40:27.980Z,1591288827.980 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2020-06-04T16:40:27.980Z,1591288827.980 [RDI_Pathfinder] No Fault, FailCount= 2 2020-06-04T16:40:28.729Z,1591288828.729 [Micromodem](INFO): Nmea in: $CATMG,2020-06-04T16:40:28.202955Z,RTC,RTC*52 2020-06-04T16:40:28.730Z,1591288828.730 [Micromodem](ERROR): CFG response from modem unexpected: $CATMG,2020-06-04T16:40:28.202955Z,RTC,RTC*52 2020-06-04T16:40:33.985Z,1591288833.985 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-06-04T16:40:34.383Z,1591288834.383 [Micromodem](INFO): Nmea in: $CACFG,ALL,0*31 2020-06-04T16:40:34.383Z,1591288834.383 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31 2020-06-04T16:40:34.811Z,1591288834.811 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33 2020-06-04T16:40:34.812Z,1591288834.812 [Micromodem](INFO): Nmea out: $CCCFG,nav.dt.txtrig_gpio4,1*64 2020-06-04T16:40:35.204Z,1591288835.204 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.txtrig_gpio4,1*66 2020-06-04T16:40:35.204Z,1591288835.204 [Micromodem](INFO): Nmea out: $CCCFG,pwramp.txlevel,0*2F 2020-06-04T16:40:35.595Z,1591288835.595 [Micromodem](INFO): Nmea in: $CACFG,pwramp.txlevel,0*2D 2020-06-04T16:40:35.596Z,1591288835.596 [Micromodem](INFO): Nmea out: $CCCFG,DTO,30*1E 2020-06-04T16:40:35.999Z,1591288835.999 [Micromodem](INFO): Nmea in: $CACFG,DTO,30*1C 2020-06-04T16:40:35.000Z,1591288836.000 [Micromodem](INFO): Nmea out: $CCCFG,FC0,14500*47 2020-06-04T16:40:36.413Z,1591288836.413 [Micromodem](INFO): Nmea in: $CACFG,FC0,14500*45 2020-06-04T16:40:36.413Z,1591288836.413 [Micromodem](INFO): Nmea out: $CCCFG,BW0,4000*63 2020-06-04T16:40:36.832Z,1591288836.832 [Micromodem](INFO): Nmea in: $CACFG,BW0,4000*61 2020-06-04T16:40:36.832Z,1591288836.832 [Micromodem](INFO): Nmea out: $CCCFG,BND,0*3A 2020-06-04T16:40:37.217Z,1591288837.217 [Micromodem](INFO): Nmea in: $CACFG,BND,0*38 2020-06-04T16:40:37.218Z,1591288837.218 [Micromodem](INFO): Nmea out: $CCCLK,2020,06,04,16,40,38*4E 2020-06-04T16:40:38.424Z,1591288838.424 [Micromodem](INFO): Nmea in: $CACLK,2020,6,4,16,40,38*4C 2020-06-04T16:40:38.425Z,1591288838.425 [Micromodem](INFO): Nmea in: $CATMS,0,2020-06-04T16:40:39Z*7D 2020-06-04T16:40:38.426Z,1591288838.426 [Micromodem](INFO): Nmea in: $CATMG,2020-06-04T16:40:39.027153Z,USER_CMD,RTC*18 2020-06-04T16:40:53.830Z,1591288853.830 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2020-06-04T16:41:05.126Z,1591288865.126 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2020-06-04T16:42:52.607Z,1591288972.607 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2020-06-04T16:42:52.607Z,1591288972.607 [RDI_Pathfinder] Communications Fault, FailCount= 1 2020-06-04T16:42:52.607Z,1591288972.607 [RDI_Pathfinder](ERROR): Communications Fault 2020-06-04T16:42:52.647Z,1591288972.647 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2020-06-04T16:42:53.056Z,1591288973.056 [RDI_Pathfinder](INFO): Powering down 2020-06-04T16:42:53.884Z,1591288973.884 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2020-06-04T16:42:53.885Z,1591288973.885 [RDI_Pathfinder] No Fault, FailCount= 1 2020-06-04T16:44:40.653Z,1591289080.653 [CommandLine](IMPORTANT): got command quit 2020-06-04T16:44:41.659Z,1591289081.659 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2020-06-04T16:44:41.660Z,1591289081.660 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2020-06-04T16:44:41.660Z,1591289081.660 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:41.811Z,1591289081.811 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2020-06-04T16:44:41.812Z,1591289081.812 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:41.814Z,1591289081.814 [CommandLine](INFO): Join timeout helper Thread ID is 7431 2020-06-04T16:44:41.815Z,1591289081.815 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2020-06-04T16:44:41.816Z,1591289081.816 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:41.817Z,1591289081.817 [NavChartDb](INFO): Join timeout helper Thread ID is 7432 2020-06-04T16:44:41.851Z,1591289081.851 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2020-06-04T16:44:41.852Z,1591289081.852 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:41.855Z,1591289081.855 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler 2020-06-04T16:44:41.855Z,1591289081.855 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:41.856Z,1591289081.856 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 7433 2020-06-04T16:44:41.979Z,1591289081.979 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread. 2020-06-04T16:44:41.980Z,1591289081.980 [WetLabsSeaOWL_UV_A](INFO): Powering down 2020-06-04T16:44:41.980Z,1591289081.980 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:41.995Z,1591289081.995 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2020-06-04T16:44:41.995Z,1591289081.995 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:41.996Z,1591289081.996 [Radio_Surface](INFO): Join timeout helper Thread ID is 7434 2020-06-04T16:44:42.283Z,1591289082.283 [Radio_Surface](INFO): Powering down 2020-06-04T16:44:42.284Z,1591289082.284 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2020-06-04T16:44:42.285Z,1591289082.285 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:42.291Z,1591289082.291 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2020-06-04T16:44:42.291Z,1591289082.291 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:42.292Z,1591289082.292 [DataOverHttps](INFO): Join timeout helper Thread ID is 7435 2020-06-04T16:44:43.220Z,1591289083.220 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2020-06-04T16:44:43.220Z,1591289083.220 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:43.244Z,1591289083.244 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2020-06-04T16:44:43.244Z,1591289083.244 [logger ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:43.245Z,1591289083.245 [logger](INFO): Join timeout helper Thread ID is 7436 2020-06-04T16:44:43.258Z,1591289083.258 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2020-06-04T16:44:43.258Z,1591289083.258 [logger ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:43.268Z,1591289083.268 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2020-06-04T16:44:43.268Z,1591289083.268 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:43.268Z,1591289083.268 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2020-06-04T16:44:43.268Z,1591289083.268 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:43.269Z,1591289083.269 [controlThread](INFO): Join timeout helper Thread ID is 7437 2020-06-04T16:44:43.297Z,1591289083.297 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2020-06-04T16:44:43.298Z,1591289083.298 [controlThread](DEBUG): Uninitializing ControlThread 2020-06-04T16:44:43.298Z,1591289083.298 [AHRS_M2](INFO): Powering down 2020-06-04T16:44:43.368Z,1591289083.368 [DUSBL_Hydroid](INFO): Powering down 2020-06-04T16:44:43.460Z,1591289083.460 [Micromodem](INFO): Powering down 2020-06-04T16:44:43.556Z,1591289083.556 [NAL9602](INFO): Powering down 2020-06-04T16:44:43.627Z,1591289083.627 [RDI_Pathfinder](INFO): Powering down 2020-06-04T16:44:43.699Z,1591289083.699 [RDI_PathfinderUp](INFO): Powering down 2020-06-04T16:44:43.701Z,1591289083.701 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2020-06-04T16:44:43.702Z,1591289083.702 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2020-06-04T16:44:43.702Z,1591289083.702 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2020-06-04T16:44:43.703Z,1591289083.703 [MissionManager](INFO): Uninitializing Mission Default 2020-06-04T16:44:43.703Z,1591289083.703 [Default] Stopped 2020-06-04T16:44:43.703Z,1591289083.703 [Default](DEBUG): Aggregate::uninitialize Default 2020-06-04T16:44:43.703Z,1591289083.703 [Default:B.GoToSurface] Stopped 2020-06-04T16:44:43.703Z,1591289083.703 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-06-04T16:44:43.703Z,1591289083.703 [Default:CheckIn] Stopped 2020-06-04T16:44:43.704Z,1591289083.704 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-06-04T16:44:43.704Z,1591289083.704 [Default:CheckIn:C.Wait] Stopped 2020-06-04T16:44:43.704Z,1591289083.704 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-06-04T16:44:43.706Z,1591289083.706 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2020-06-04T16:44:43.706Z,1591289083.706 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2020-06-04T16:44:43.707Z,1591289083.707 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2020-06-04T16:44:43.707Z,1591289083.707 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2020-06-04T16:44:43.707Z,1591289083.707 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2020-06-04T16:44:43.707Z,1591289083.707 [BuoyancyServo](INFO): Powering down 2020-06-04T16:44:43.719Z,1591289083.719 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2020-06-04T16:44:43.720Z,1591289083.720 [ElevatorServo](INFO): Powering down 2020-06-04T16:44:43.720Z,1591289083.720 [MassServo](DEBUG): Uninitialize Mass Servo. 2020-06-04T16:44:43.720Z,1591289083.720 [MassServo](INFO): Powering down 2020-06-04T16:44:43.721Z,1591289083.721 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-06-04T16:44:43.721Z,1591289083.721 [RudderServo](INFO): Powering down 2020-06-04T16:44:43.722Z,1591289083.722 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2020-06-04T16:44:43.722Z,1591289083.722 [ThrusterServo](INFO): Powering down 2020-06-04T16:44:43.723Z,1591289083.723 [SBIT](DEBUG): Uninitialize SBIT Component. 2020-06-04T16:44:43.723Z,1591289083.723 [IBIT](DEBUG): Uninitialize IBIT Component. 2020-06-04T16:44:43.724Z,1591289083.724 [CBIT](DEBUG): Uninitialize CBIT Component. 2020-06-04T16:44:43.724Z,1591289083.724 [CBIT](DEBUG): Powering off loads. 2020-06-04T16:44:43.735Z,1591289083.735 [CBIT](DEBUG): Disabling WDT. 2020-06-04T16:44:43.747Z,1591289083.747 [CBIT](DEBUG): Opening all GF detection circuits. 2020-06-04T16:44:43.748Z,1591289083.748 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:43.794Z,1591289083.794 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:43.806Z,1591289083.806 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:43.856Z,1591289083.856 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:43.918Z,1591289083.918 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-06-04T16:44:43.985Z,1591289083.985 [logger ThreadHandler](INFO): Thread cancelled.