2021-07-29T17:46:36.483Z,1627580796.483 [CommandLine](IMPORTANT): got command restart logs 2021-07-29T17:46:37.750Z,1627580797.750 [DataOverHttps](INFO): Moved sent file to Logs/20210729T162753/Express0025.lzma.bak 2021-07-29T17:46:37.750Z,1627580797.750 [DataOverHttps](INFO): SBD MOMSN=15774356 2021-07-29T17:46:57.379Z,1627580817.379 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-29T17:46:57.898Z,1627580817.898 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210729T162753/Courier0027.lzma 2021-07-29T17:46:58.900Z,1627580818.900 [DataOverHttps](INFO): Moved sent file to Logs/20210729T162753/Courier0027.lzma.bak 2021-07-29T17:46:58.900Z,1627580818.900 [DataOverHttps](INFO): SBD MOMSN=15774382 2021-07-29T17:47:14.554Z,1627580834.554 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20210729T162753/Express0028.lzma 2021-07-29T17:47:15.556Z,1627580835.556 [DataOverHttps](INFO): Moved sent file to Logs/20210729T162753/Express0028.lzma.bak 2021-07-29T17:47:15.557Z,1627580835.557 [DataOverHttps](INFO): SBD MOMSN=15774384 2021-07-29T17:47:16.798Z,1627580836.798 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T17:47:16.798Z,1627580836.798 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T17:47:16.799Z,1627580836.799 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T17:48:42.853Z,1627580922.853 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T17:48:56.235Z,1627580936.235 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T17:48:59.711Z,1627580939.711 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.263187 2021-07-29T17:49:09.936Z,1627580949.936 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T17:49:13.307Z,1627580953.307 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002933 2021-07-29T17:49:22.898Z,1627580962.898 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T17:49:36.167Z,1627580976.167 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T17:49:49.500Z,1627580989.500 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T17:50:03.238Z,1627581003.238 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T17:50:17.259Z,1627581017.259 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T17:50:30.493Z,1627581030.493 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T17:50:44.227Z,1627581044.227 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T17:50:57.558Z,1627581057.558 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T17:52:17.526Z,1627581137.526 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-29T17:52:17.527Z,1627581137.527 [Default:CheckIn:C.Wait] Stopped 2021-07-29T17:52:17.527Z,1627581137.527 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T17:52:17.527Z,1627581137.527 [Default:CheckIn:D] Running Loop=1 2021-07-29T17:52:17.944Z,1627581137.944 [Default:CheckIn:D] Stopped 2021-07-29T17:52:17.944Z,1627581137.944 [Default:CheckIn:E] Running Loop=1 2021-07-29T17:52:18.422Z,1627581138.422 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.227454 min 2021-07-29T17:52:18.422Z,1627581138.422 [Default:CheckIn:E] Stopped 2021-07-29T17:52:18.422Z,1627581138.422 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-29T17:52:18.423Z,1627581138.423 [Default:CheckIn] Stopped 2021-07-29T17:52:18.423Z,1627581138.423 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T17:52:18.423Z,1627581138.423 [Default:CheckIn](INFO): Running loop #7 2021-07-29T17:52:18.423Z,1627581138.423 [Default:CheckIn] Running Loop=7 2021-07-29T17:52:18.423Z,1627581138.423 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-29T17:52:18.423Z,1627581138.423 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-29T17:52:20.330Z,1627581140.330 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175219.00,A,3647.82129,N,12150.55022,W,28.438,76.88,290721,,,D*7A 2021-07-29T17:52:20.349Z,1627581140.349 [NAL9602](INFO): GPS fix at 20210729T175219: (36.797021, -121.842504) 2021-07-29T17:52:20.368Z,1627581140.368 [Default:CheckIn:Read_GPS] Stopped 2021-07-29T17:52:20.368Z,1627581140.368 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-29T17:52:27.651Z,1627581147.651 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20210729T174636/Courier0003.lzma 2021-07-29T17:52:28.652Z,1627581148.652 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Courier0003.lzma.bak 2021-07-29T17:52:28.652Z,1627581148.652 [DataOverHttps](INFO): SBD MOMSN=15774396 2021-07-29T17:52:44.723Z,1627581164.723 [DataOverHttps](INFO): Sending 450 bytes from file Logs/20210729T174636/Express0004.lzma 2021-07-29T17:52:45.725Z,1627581165.725 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Express0004.lzma.bak 2021-07-29T17:52:45.725Z,1627581165.725 [DataOverHttps](INFO): SBD MOMSN=15774400 2021-07-29T17:52:47.146Z,1627581167.146 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T17:52:47.146Z,1627581167.146 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T17:52:47.146Z,1627581167.146 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T17:53:16.197Z,1627581196.197 [NAL9602](INFO): SBD MO Status=2, MOMSN=5729, MT Status=2, MTMSN=0 2021-07-29T17:53:16.198Z,1627581196.198 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-07-29T17:53:39.633Z,1627581219.633 [BPC1](ERROR): Battery stick #59 (s/n: 024A) reported OVER_TEMP_ALARM. Status code: 0x1717. 2021-07-29T17:53:39.634Z,1627581219.634 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 5. 2021-07-29T17:53:39.636Z,1627581219.636 [BPC1](INFO): Received data from all battery sticks. 2021-07-29T17:54:12.357Z,1627581252.357 [NAL9602](INFO): SBD MO Status=2, MOMSN=5729, MT Status=2, MTMSN=0 2021-07-29T17:54:12.358Z,1627581252.358 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-07-29T17:54:21.249Z,1627581261.249 [NAL9602](INFO): SBD MO Status=0, MOMSN=5729, MT Status=0, MTMSN=0 2021-07-29T17:54:21.249Z,1627581261.249 [NAL9602](INFO): No messages in MT queue 2021-07-29T17:54:51.951Z,1627581291.951 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-29T17:57:47.703Z,1627581467.703 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-29T17:57:47.703Z,1627581467.703 [Default:CheckIn:C.Wait] Stopped 2021-07-29T17:57:47.703Z,1627581467.703 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T17:57:47.704Z,1627581467.704 [Default:CheckIn:D] Running Loop=1 2021-07-29T17:57:48.122Z,1627581468.122 [Default:CheckIn:D] Stopped 2021-07-29T17:57:48.122Z,1627581468.122 [Default:CheckIn:E] Running Loop=1 2021-07-29T17:57:48.510Z,1627581468.510 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.730420 min 2021-07-29T17:57:48.510Z,1627581468.510 [Default:CheckIn:E] Stopped 2021-07-29T17:57:48.510Z,1627581468.510 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-29T17:57:48.510Z,1627581468.510 [Default:CheckIn] Stopped 2021-07-29T17:57:48.510Z,1627581468.510 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T17:57:48.510Z,1627581468.510 [Default:CheckIn](INFO): Running loop #8 2021-07-29T17:57:48.510Z,1627581468.510 [Default:CheckIn] Running Loop=8 2021-07-29T17:57:48.511Z,1627581468.511 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-29T17:57:48.511Z,1627581468.511 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-29T17:57:50.525Z,1627581470.526 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175749.00,A,3648.40370,N,12147.38587,W,14.404,54.93,290721,,,D*78 2021-07-29T17:57:50.528Z,1627581470.528 [NAL9602](INFO): GPS fix at 20210729T175749: (36.806728, -121.789765) 2021-07-29T17:57:50.539Z,1627581470.539 [Default:CheckIn:Read_GPS] Stopped 2021-07-29T17:57:50.539Z,1627581470.539 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-29T17:57:57.490Z,1627581477.490 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20210729T174636/Courier0006.lzma 2021-07-29T17:57:58.492Z,1627581478.492 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Courier0006.lzma.bak 2021-07-29T17:57:58.492Z,1627581478.492 [DataOverHttps](INFO): SBD MOMSN=15774435 2021-07-29T17:58:04.693Z,1627581484.693 [NAL9602](INFO): SBD MO Status=0, MOMSN=5730, MT Status=0, MTMSN=0 2021-07-29T17:58:04.694Z,1627581484.694 [NAL9602](INFO): No messages in MT queue 2021-07-29T17:58:20.282Z,1627581500.282 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20210729T174636/Express0007.lzma 2021-07-29T17:58:21.284Z,1627581501.284 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Express0007.lzma.bak 2021-07-29T17:58:21.285Z,1627581501.285 [DataOverHttps](INFO): SBD MOMSN=15774438 2021-07-29T17:58:22.584Z,1627581502.584 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T17:58:22.585Z,1627581502.585 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T17:58:22.585Z,1627581502.585 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T17:58:35.497Z,1627581515.497 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-29T18:03:23.252Z,1627581803.252 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-29T18:03:23.252Z,1627581803.252 [Default:CheckIn:C.Wait] Stopped 2021-07-29T18:03:23.252Z,1627581803.252 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T18:03:23.252Z,1627581803.252 [Default:CheckIn:D] Running Loop=1 2021-07-29T18:03:23.642Z,1627581803.642 [Default:CheckIn:D] Stopped 2021-07-29T18:03:23.642Z,1627581803.642 [Default:CheckIn:E] Running Loop=1 2021-07-29T18:03:24.050Z,1627581804.050 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 47.322416 min 2021-07-29T18:03:24.050Z,1627581804.050 [Default:CheckIn:E] Stopped 2021-07-29T18:03:24.050Z,1627581804.050 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-29T18:03:24.050Z,1627581804.050 [Default:CheckIn] Stopped 2021-07-29T18:03:24.051Z,1627581804.051 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T18:03:24.051Z,1627581804.051 [Default:CheckIn](INFO): Running loop #9 2021-07-29T18:03:24.051Z,1627581804.051 [Default:CheckIn] Running Loop=9 2021-07-29T18:03:24.051Z,1627581804.051 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-29T18:03:24.051Z,1627581804.051 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-29T18:03:26.066Z,1627581806.066 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180325.00,A,3648.31236,N,12147.14689,W,0.058,279.62,290721,,,D*71 2021-07-29T18:03:26.068Z,1627581806.068 [NAL9602](INFO): GPS fix at 20210729T180325: (36.805206, -121.785781) 2021-07-29T18:03:26.080Z,1627581806.080 [Default:CheckIn:Read_GPS] Stopped 2021-07-29T18:03:26.080Z,1627581806.080 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-29T18:03:33.778Z,1627581813.778 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20210729T174636/Courier0009.lzma 2021-07-29T18:03:34.780Z,1627581814.780 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Courier0009.lzma.bak 2021-07-29T18:03:34.780Z,1627581814.780 [DataOverHttps](INFO): SBD MOMSN=15774449 2021-07-29T18:03:40.201Z,1627581820.201 [NAL9602](INFO): SBD MO Status=0, MOMSN=5731, MT Status=0, MTMSN=0 2021-07-29T18:03:40.201Z,1627581820.201 [NAL9602](INFO): No messages in MT queue 2021-07-29T18:03:50.578Z,1627581830.578 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20210729T174636/Express0010.lzma 2021-07-29T18:03:51.580Z,1627581831.580 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Express0010.lzma.bak 2021-07-29T18:03:51.581Z,1627581831.581 [DataOverHttps](INFO): SBD MOMSN=15774452 2021-07-29T18:03:52.734Z,1627581832.734 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T18:03:52.734Z,1627581832.734 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T18:03:52.734Z,1627581832.734 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T18:04:10.928Z,1627581850.928 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-29T18:06:08.906Z,1627581968.906 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:06:22.285Z,1627581982.285 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:06:35.616Z,1627581995.616 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:06:49.420Z,1627582009.420 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:07:02.750Z,1627582022.750 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:07:16.086Z,1627582036.086 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:07:29.363Z,1627582049.363 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:07:43.084Z,1627582063.084 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:07:56.416Z,1627582076.416 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:08:09.748Z,1627582089.748 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:08:23.099Z,1627582103.099 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:08:53.394Z,1627582133.394 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-29T18:08:53.394Z,1627582133.394 [Default:CheckIn:C.Wait] Stopped 2021-07-29T18:08:53.394Z,1627582133.394 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T18:08:53.395Z,1627582133.395 [Default:CheckIn:D] Running Loop=1 2021-07-29T18:08:53.803Z,1627582133.803 [Default:CheckIn:D] Stopped 2021-07-29T18:08:53.803Z,1627582133.803 [Default:CheckIn:E] Running Loop=1 2021-07-29T18:08:54.221Z,1627582134.221 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.825106 min 2021-07-29T18:08:54.221Z,1627582134.221 [Default:CheckIn:E] Stopped 2021-07-29T18:08:54.222Z,1627582134.222 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-29T18:08:54.222Z,1627582134.222 [Default:CheckIn] Stopped 2021-07-29T18:08:54.222Z,1627582134.222 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T18:08:54.222Z,1627582134.222 [Default:CheckIn](INFO): Running loop #10 2021-07-29T18:08:54.222Z,1627582134.222 [Default:CheckIn] Running Loop=10 2021-07-29T18:08:54.222Z,1627582134.222 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-29T18:08:54.223Z,1627582134.223 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-29T18:08:56.218Z,1627582136.218 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180855.00,A,3648.31191,N,12147.14554,W,0.097,279.62,290721,,,D*73 2021-07-29T18:08:56.220Z,1627582136.220 [NAL9602](INFO): GPS fix at 20210729T180855: (36.805199, -121.785759) 2021-07-29T18:08:56.258Z,1627582136.258 [Default:CheckIn:Read_GPS] Stopped 2021-07-29T18:08:56.258Z,1627582136.258 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-29T18:09:03.890Z,1627582143.890 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210729T174636/Courier0012.lzma 2021-07-29T18:09:04.892Z,1627582144.892 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Courier0012.lzma.bak 2021-07-29T18:09:04.892Z,1627582144.892 [DataOverHttps](INFO): SBD MOMSN=15774487 2021-07-29T18:09:10.353Z,1627582150.353 [NAL9602](INFO): SBD MO Status=0, MOMSN=5732, MT Status=0, MTMSN=0 2021-07-29T18:09:10.354Z,1627582150.354 [NAL9602](INFO): No messages in MT queue 2021-07-29T18:09:20.854Z,1627582160.854 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20210729T174636/Express0013.lzma 2021-07-29T18:09:21.856Z,1627582161.856 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Express0013.lzma.bak 2021-07-29T18:09:21.856Z,1627582161.856 [DataOverHttps](INFO): SBD MOMSN=15774490 2021-07-29T18:09:23.302Z,1627582163.302 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T18:09:23.302Z,1627582163.302 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T18:09:23.302Z,1627582163.302 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T18:09:41.063Z,1627582181.063 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-29T18:11:06.305Z,1627582266.305 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 5. 2021-07-29T18:11:06.328Z,1627582266.328 [BPC1](INFO): Received data from all battery sticks. 2021-07-29T18:14:23.986Z,1627582463.986 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-29T18:14:23.986Z,1627582463.986 [Default:CheckIn:C.Wait] Stopped 2021-07-29T18:14:23.986Z,1627582463.986 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T18:14:23.986Z,1627582463.986 [Default:CheckIn:D] Running Loop=1 2021-07-29T18:14:24.398Z,1627582464.398 [Default:CheckIn:D] Stopped 2021-07-29T18:14:24.398Z,1627582464.398 [Default:CheckIn:E] Running Loop=1 2021-07-29T18:14:24.791Z,1627582464.791 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 58.335018 min 2021-07-29T18:14:24.791Z,1627582464.791 [Default:CheckIn:E] Stopped 2021-07-29T18:14:24.791Z,1627582464.791 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-29T18:14:24.791Z,1627582464.791 [Default:CheckIn] Stopped 2021-07-29T18:14:24.791Z,1627582464.791 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T18:14:24.791Z,1627582464.791 [Default:CheckIn](INFO): Running loop #11 2021-07-29T18:14:24.791Z,1627582464.791 [Default:CheckIn] Running Loop=11 2021-07-29T18:14:24.791Z,1627582464.791 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-29T18:14:24.792Z,1627582464.792 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-29T18:14:26.811Z,1627582466.811 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181426.00,A,3648.31245,N,12147.14482,W,0.019,279.62,290721,,,D*7C 2021-07-29T18:14:26.814Z,1627582466.814 [NAL9602](INFO): GPS fix at 20210729T181426: (36.805208, -121.785747) 2021-07-29T18:14:26.852Z,1627582466.852 [Default:CheckIn:Read_GPS] Stopped 2021-07-29T18:14:26.852Z,1627582466.852 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-29T18:14:33.782Z,1627582473.782 [DataOverHttps](INFO): Sending 86 bytes from file Logs/20210729T174636/Courier0015.lzma 2021-07-29T18:14:34.784Z,1627582474.784 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Courier0015.lzma.bak 2021-07-29T18:14:34.784Z,1627582474.784 [DataOverHttps](INFO): SBD MOMSN=15774502 2021-07-29T18:14:45.389Z,1627582485.389 [NAL9602](INFO): SBD MO Status=0, MOMSN=5733, MT Status=0, MTMSN=0 2021-07-29T18:14:45.390Z,1627582485.390 [NAL9602](INFO): No messages in MT queue 2021-07-29T18:14:50.526Z,1627582490.526 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20210729T174636/Express0016.lzma 2021-07-29T18:14:51.528Z,1627582491.528 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Express0016.lzma.bak 2021-07-29T18:14:51.528Z,1627582491.528 [DataOverHttps](INFO): SBD MOMSN=15774505 2021-07-29T18:14:52.683Z,1627582492.683 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T18:14:52.683Z,1627582492.683 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T18:14:52.683Z,1627582492.683 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T18:15:16.095Z,1627582516.095 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-29T18:19:53.350Z,1627582793.350 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-29T18:19:53.350Z,1627582793.350 [Default:CheckIn:C.Wait] Stopped 2021-07-29T18:19:53.350Z,1627582793.350 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T18:19:53.350Z,1627582793.350 [Default:CheckIn:D] Running Loop=1 2021-07-29T18:19:53.759Z,1627582793.759 [Default:CheckIn:D] Stopped 2021-07-29T18:19:53.759Z,1627582793.759 [Default:CheckIn:E] Running Loop=1 2021-07-29T18:19:54.151Z,1627582794.151 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.824377 min 2021-07-29T18:19:54.151Z,1627582794.151 [Default:CheckIn:E] Stopped 2021-07-29T18:19:54.151Z,1627582794.151 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-29T18:19:54.151Z,1627582794.151 [Default:CheckIn] Stopped 2021-07-29T18:19:54.151Z,1627582794.151 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T18:19:54.151Z,1627582794.151 [Default:CheckIn](INFO): Running loop #12 2021-07-29T18:19:54.151Z,1627582794.151 [Default:CheckIn] Running Loop=12 2021-07-29T18:19:54.151Z,1627582794.151 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-29T18:19:54.152Z,1627582794.152 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-29T18:19:56.166Z,1627582796.166 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181955.00,A,3648.31361,N,12147.14668,W,0.039,279.51,290721,,,D*76 2021-07-29T18:19:56.168Z,1627582796.168 [NAL9602](INFO): GPS fix at 20210729T181955: (36.805227, -121.785778) 2021-07-29T18:19:56.179Z,1627582796.179 [Default:CheckIn:Read_GPS] Stopped 2021-07-29T18:19:56.179Z,1627582796.179 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-29T18:20:03.474Z,1627582803.474 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210729T174636/Courier0018.lzma 2021-07-29T18:20:04.479Z,1627582804.479 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Courier0018.lzma.bak 2021-07-29T18:20:04.479Z,1627582804.479 [DataOverHttps](INFO): SBD MOMSN=15774538 2021-07-29T18:20:09.930Z,1627582809.930 [NAL9602](INFO): SBD MO Status=0, MOMSN=5734, MT Status=0, MTMSN=0 2021-07-29T18:20:09.930Z,1627582809.930 [NAL9602](INFO): No messages in MT queue 2021-07-29T18:20:26.410Z,1627582826.410 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20210729T174636/Express0019.lzma 2021-07-29T18:20:27.412Z,1627582827.412 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Express0019.lzma.bak 2021-07-29T18:20:27.413Z,1627582827.413 [DataOverHttps](INFO): SBD MOMSN=15774541 2021-07-29T18:20:28.619Z,1627582828.619 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T18:20:28.619Z,1627582828.619 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T18:20:28.619Z,1627582828.619 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T18:20:40.724Z,1627582840.724 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-29T18:23:34.914Z,1627583014.914 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:23:48.240Z,1627583028.240 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:24:01.572Z,1627583041.572 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:24:14.911Z,1627583054.911 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:24:28.256Z,1627583068.256 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:24:41.588Z,1627583081.588 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:24:54.921Z,1627583094.921 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:25:08.253Z,1627583108.253 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:25:21.586Z,1627583121.586 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:25:29.344Z,1627583129.344 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-29T18:25:29.344Z,1627583129.344 [Default:CheckIn:C.Wait] Stopped 2021-07-29T18:25:29.344Z,1627583129.344 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T18:25:29.345Z,1627583129.345 [Default:CheckIn:D] Running Loop=1 2021-07-29T18:25:29.688Z,1627583129.688 [Default:CheckIn:D] Stopped 2021-07-29T18:25:29.688Z,1627583129.688 [Default:CheckIn:E] Running Loop=1 2021-07-29T18:25:30.079Z,1627583130.079 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 69.423185 min 2021-07-29T18:25:30.079Z,1627583130.079 [Default:CheckIn:E] Stopped 2021-07-29T18:25:30.079Z,1627583130.079 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-29T18:25:30.079Z,1627583130.079 [Default:CheckIn] Stopped 2021-07-29T18:25:30.079Z,1627583130.079 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T18:25:30.079Z,1627583130.079 [Default:CheckIn](INFO): Running loop #13 2021-07-29T18:25:30.080Z,1627583130.080 [Default:CheckIn] Running Loop=13 2021-07-29T18:25:30.080Z,1627583130.080 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-29T18:25:30.080Z,1627583130.080 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-29T18:25:32.094Z,1627583132.094 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182531.00,A,3648.15004,N,12147.22205,W,0.408,197.58,290721,,,D*7B 2021-07-29T18:25:32.096Z,1627583132.096 [NAL9602](INFO): GPS fix at 20210729T182531: (36.802501, -121.787034) 2021-07-29T18:25:32.107Z,1627583132.107 [Default:CheckIn:Read_GPS] Stopped 2021-07-29T18:25:32.107Z,1627583132.107 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-29T18:25:34.936Z,1627583134.936 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:25:39.262Z,1627583139.262 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20210729T174636/Courier0021.lzma 2021-07-29T18:25:40.265Z,1627583140.265 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Courier0021.lzma.bak 2021-07-29T18:25:40.265Z,1627583140.265 [DataOverHttps](INFO): SBD MOMSN=15774553 2021-07-29T18:25:48.272Z,1627583148.272 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:25:56.518Z,1627583156.518 [DataOverHttps](INFO): Sending 156 bytes from file Logs/20210729T174636/Express0022.lzma 2021-07-29T18:25:57.520Z,1627583157.520 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Express0022.lzma.bak 2021-07-29T18:25:57.520Z,1627583157.520 [DataOverHttps](INFO): SBD MOMSN=15774556 2021-07-29T18:25:59.196Z,1627583159.196 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T18:25:59.196Z,1627583159.196 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T18:25:59.197Z,1627583159.197 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T18:26:19.783Z,1627583179.783 [NAL9602](INFO): SBD MO Status=0, MOMSN=5735, MT Status=0, MTMSN=0 2021-07-29T18:26:19.783Z,1627583179.783 [NAL9602](INFO): No messages in MT queue 2021-07-29T18:26:50.487Z,1627583210.487 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-29T18:27:49.472Z,1627583269.472 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:28:29.899Z,1627583309.899 [BPC1](INFO): Calculating totals. Valid battery stick count: 52. Valid reserve battery stick count: 5. 2021-07-29T18:28:29.902Z,1627583309.902 [BPC1](INFO): Received data from all battery sticks. 2021-07-29T18:30:59.836Z,1627583459.836 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-29T18:30:59.836Z,1627583459.836 [Default:CheckIn:C.Wait] Stopped 2021-07-29T18:30:59.836Z,1627583459.836 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T18:30:59.836Z,1627583459.836 [Default:CheckIn:D] Running Loop=1 2021-07-29T18:31:00.250Z,1627583460.250 [Default:CheckIn:D] Stopped 2021-07-29T18:31:00.250Z,1627583460.250 [Default:CheckIn:E] Running Loop=1 2021-07-29T18:31:00.637Z,1627583460.637 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 74.932560 min 2021-07-29T18:31:00.638Z,1627583460.638 [Default:CheckIn:E] Stopped 2021-07-29T18:31:00.638Z,1627583460.638 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-29T18:31:00.638Z,1627583460.638 [Default:CheckIn] Stopped 2021-07-29T18:31:00.638Z,1627583460.638 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T18:31:00.638Z,1627583460.638 [Default:CheckIn](INFO): Running loop #14 2021-07-29T18:31:00.638Z,1627583460.638 [Default:CheckIn] Running Loop=14 2021-07-29T18:31:00.638Z,1627583460.638 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-29T18:31:00.639Z,1627583460.639 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-29T18:31:02.658Z,1627583462.658 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183101.00,A,3648.14106,N,12147.23249,W,1.302,213.86,290721,,,A*73 2021-07-29T18:31:02.660Z,1627583462.660 [NAL9602](INFO): GPS fix at 20210729T183101: (36.802351, -121.787208) 2021-07-29T18:31:02.671Z,1627583462.671 [Default:CheckIn:Read_GPS] Stopped 2021-07-29T18:31:02.671Z,1627583462.671 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-29T18:31:09.806Z,1627583469.806 [DataOverHttps](INFO): Sending 86 bytes from file Logs/20210729T174636/Courier0024.lzma 2021-07-29T18:31:10.808Z,1627583470.808 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Courier0024.lzma.bak 2021-07-29T18:31:10.808Z,1627583470.808 [DataOverHttps](INFO): SBD MOMSN=15774590 2021-07-29T18:31:26.517Z,1627583486.517 [NAL9602](INFO): SBD MO Status=2, MOMSN=5736, MT Status=2, MTMSN=0 2021-07-29T18:31:26.517Z,1627583486.517 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-07-29T18:31:26.930Z,1627583486.930 [DataOverHttps](INFO): Sending 209 bytes from file Logs/20210729T174636/Express0025.lzma 2021-07-29T18:31:27.932Z,1627583487.932 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Express0025.lzma.bak 2021-07-29T18:31:27.932Z,1627583487.932 [DataOverHttps](INFO): SBD MOMSN=15774593 2021-07-29T18:31:29.363Z,1627583489.363 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T18:31:29.363Z,1627583489.363 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T18:31:29.363Z,1627583489.363 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T18:32:14.705Z,1627583534.705 [NAL9602](INFO): SBD MO Status=0, MOMSN=5736, MT Status=0, MTMSN=0 2021-07-29T18:32:14.706Z,1627583534.706 [NAL9602](INFO): No messages in MT queue 2021-07-29T18:32:45.408Z,1627583565.408 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-29T18:36:30.099Z,1627583790.099 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-29T18:36:30.100Z,1627583790.100 [Default:CheckIn:C.Wait] Stopped 2021-07-29T18:36:30.100Z,1627583790.100 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T18:36:30.100Z,1627583790.100 [Default:CheckIn:D] Running Loop=1 2021-07-29T18:36:30.516Z,1627583790.516 [Default:CheckIn:D] Stopped 2021-07-29T18:36:30.516Z,1627583790.516 [Default:CheckIn:E] Running Loop=1 2021-07-29T18:36:30.902Z,1627583790.902 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 80.436995 min 2021-07-29T18:36:30.902Z,1627583790.902 [Default:CheckIn:E] Stopped 2021-07-29T18:36:30.902Z,1627583790.902 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-29T18:36:30.902Z,1627583790.902 [Default:CheckIn] Stopped 2021-07-29T18:36:30.903Z,1627583790.903 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T18:36:30.903Z,1627583790.903 [Default:CheckIn](INFO): Running loop #15 2021-07-29T18:36:30.903Z,1627583790.903 [Default:CheckIn] Running Loop=15 2021-07-29T18:36:30.903Z,1627583790.903 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-29T18:36:30.903Z,1627583790.903 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-29T18:36:32.918Z,1627583792.918 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183632.00,A,3648.17964,N,12147.27830,W,0.447,273.35,290721,,,D*77 2021-07-29T18:36:32.920Z,1627583792.920 [NAL9602](INFO): GPS fix at 20210729T183632: (36.802994, -121.787972) 2021-07-29T18:36:32.931Z,1627583792.931 [Default:CheckIn:Read_GPS] Stopped 2021-07-29T18:36:32.931Z,1627583792.931 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-29T18:36:40.570Z,1627583800.570 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210729T174636/Courier0027.lzma 2021-07-29T18:36:41.572Z,1627583801.572 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Courier0027.lzma.bak 2021-07-29T18:36:41.572Z,1627583801.572 [DataOverHttps](INFO): SBD MOMSN=15774604 2021-07-29T18:36:57.262Z,1627583817.262 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20210729T174636/Express0028.lzma 2021-07-29T18:36:58.265Z,1627583818.265 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Express0028.lzma.bak 2021-07-29T18:36:58.265Z,1627583818.265 [DataOverHttps](INFO): SBD MOMSN=15774607 2021-07-29T18:36:58.369Z,1627583818.369 [NAL9602](INFO): SBD MO Status=0, MOMSN=5737, MT Status=0, MTMSN=0 2021-07-29T18:36:58.369Z,1627583818.369 [NAL9602](INFO): No messages in MT queue 2021-07-29T18:36:59.614Z,1627583819.614 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T18:36:59.614Z,1627583819.614 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T18:36:59.614Z,1627583819.614 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T18:37:29.068Z,1627583849.068 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-29T18:40:59.309Z,1627584059.309 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:41:12.560Z,1627584072.560 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:41:25.892Z,1627584085.892 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:41:39.693Z,1627584099.693 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:41:53.024Z,1627584113.024 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:42:00.246Z,1627584120.246 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-29T18:42:00.246Z,1627584120.246 [Default:CheckIn:C.Wait] Stopped 2021-07-29T18:42:00.246Z,1627584120.246 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T18:42:00.246Z,1627584120.246 [Default:CheckIn:D] Running Loop=1 2021-07-29T18:42:00.648Z,1627584120.648 [Default:CheckIn:D] Stopped 2021-07-29T18:42:00.648Z,1627584120.648 [Default:CheckIn:E] Running Loop=1 2021-07-29T18:42:01.062Z,1627584121.062 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 85.939185 min 2021-07-29T18:42:01.062Z,1627584121.062 [Default:CheckIn:E] Stopped 2021-07-29T18:42:01.062Z,1627584121.062 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-29T18:42:01.062Z,1627584121.062 [Default:CheckIn] Stopped 2021-07-29T18:42:01.062Z,1627584121.062 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T18:42:01.063Z,1627584121.063 [Default:CheckIn](INFO): Running loop #16 2021-07-29T18:42:01.063Z,1627584121.063 [Default:CheckIn] Running Loop=16 2021-07-29T18:42:01.063Z,1627584121.063 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-29T18:42:01.063Z,1627584121.063 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-29T18:42:03.070Z,1627584123.070 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184202.00,A,3648.16584,N,12147.28157,W,0.836,301.26,290721,,,D*7F 2021-07-29T18:42:03.075Z,1627584123.075 [NAL9602](INFO): GPS fix at 20210729T184202: (36.802764, -121.788026) 2021-07-29T18:42:03.105Z,1627584123.105 [Default:CheckIn:Read_GPS] Stopped 2021-07-29T18:42:03.105Z,1627584123.105 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-29T18:42:06.506Z,1627584126.506 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:42:13.582Z,1627584133.582 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210729T174636/Courier0030.lzma 2021-07-29T18:42:14.584Z,1627584134.584 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Courier0030.lzma.bak 2021-07-29T18:42:14.585Z,1627584134.585 [DataOverHttps](INFO): SBD MOMSN=15774645 2021-07-29T18:42:19.704Z,1627584139.704 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:42:33.887Z,1627584153.887 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:42:35.195Z,1627584155.195 [DataOverHttps](INFO): Sending 219 bytes from file Logs/20210729T174636/Express0031.lzma 2021-07-29T18:42:36.196Z,1627584156.196 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Express0031.lzma.bak 2021-07-29T18:42:36.196Z,1627584156.196 [DataOverHttps](INFO): SBD MOMSN=15774648 2021-07-29T18:42:37.528Z,1627584157.528 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T18:42:37.528Z,1627584157.528 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T18:42:37.528Z,1627584157.528 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T18:42:47.647Z,1627584167.647 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:43:00.956Z,1627584180.956 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:43:14.697Z,1627584194.697 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:45:57.110Z,1627584357.110 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 5. 2021-07-29T18:45:57.129Z,1627584357.129 [BPC1](INFO): Received data from all battery sticks. 2021-07-29T18:47:05.472Z,1627584425.472 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-07-29T18:47:36.171Z,1627584456.171 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-29T18:47:38.206Z,1627584458.206 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-29T18:47:38.206Z,1627584458.206 [Default:CheckIn:C.Wait] Stopped 2021-07-29T18:47:38.206Z,1627584458.206 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T18:47:38.206Z,1627584458.206 [Default:CheckIn:D] Running Loop=1 2021-07-29T18:47:38.617Z,1627584458.617 [Default:CheckIn:D] Stopped 2021-07-29T18:47:38.617Z,1627584458.617 [Default:CheckIn:E] Running Loop=1 2021-07-29T18:47:39.006Z,1627584459.006 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 91.571997 min 2021-07-29T18:47:39.006Z,1627584459.006 [Default:CheckIn:E] Stopped 2021-07-29T18:47:39.006Z,1627584459.006 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-29T18:47:39.006Z,1627584459.006 [Default:CheckIn] Stopped 2021-07-29T18:47:39.006Z,1627584459.006 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T18:47:39.007Z,1627584459.007 [Default:CheckIn](INFO): Running loop #17 2021-07-29T18:47:39.007Z,1627584459.007 [Default:CheckIn] Running Loop=17 2021-07-29T18:47:39.007Z,1627584459.007 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-29T18:47:39.007Z,1627584459.007 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-29T18:47:41.017Z,1627584461.017 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184740.00,A,3648.16547,N,12147.28340,W,0.758,232.64,290721,,,D*77 2021-07-29T18:47:41.020Z,1627584461.020 [NAL9602](INFO): GPS fix at 20210729T184740: (36.802758, -121.788057) 2021-07-29T18:47:41.030Z,1627584461.030 [Default:CheckIn:Read_GPS] Stopped 2021-07-29T18:47:41.030Z,1627584461.030 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-29T18:47:48.454Z,1627584468.454 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20210729T174636/Courier0033.lzma 2021-07-29T18:47:49.952Z,1627584469.952 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Courier0033.lzma.bak 2021-07-29T18:47:49.952Z,1627584469.952 [DataOverHttps](INFO): SBD MOMSN=15774658 2021-07-29T18:48:05.278Z,1627584485.278 [DataOverHttps](INFO): Sending 271 bytes from file Logs/20210729T174636/Express0034.lzma 2021-07-29T18:48:06.280Z,1627584486.280 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Express0034.lzma.bak 2021-07-29T18:48:06.281Z,1627584486.281 [DataOverHttps](INFO): SBD MOMSN=15774661 2021-07-29T18:48:07.707Z,1627584487.707 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T18:48:07.707Z,1627584487.707 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T18:48:07.707Z,1627584487.707 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T18:48:11.796Z,1627584491.796 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-07-29T18:48:11.871Z,1627584491.871 [NAL9602](ERROR): received: +CSQ:0 OK37, 0, 0, 0, 0 OK 2021-07-29T18:48:47.333Z,1627584527.333 [NAL9602](INFO): SBD MO Status=2, MOMSN=5738, MT Status=2, MTMSN=0 2021-07-29T18:48:47.334Z,1627584527.334 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-07-29T18:52:43.748Z,1627584763.748 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-07-29T18:53:08.401Z,1627584788.401 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-29T18:53:08.401Z,1627584788.401 [Default:CheckIn:C.Wait] Stopped 2021-07-29T18:53:08.401Z,1627584788.401 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T18:53:08.402Z,1627584788.402 [Default:CheckIn:D] Running Loop=1 2021-07-29T18:53:08.806Z,1627584788.806 [Default:CheckIn:D] Stopped 2021-07-29T18:53:08.806Z,1627584788.806 [Default:CheckIn:E] Running Loop=1 2021-07-29T18:53:09.218Z,1627584789.218 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 97.075146 min 2021-07-29T18:53:09.218Z,1627584789.218 [Default:CheckIn:E] Stopped 2021-07-29T18:53:09.219Z,1627584789.219 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-29T18:53:09.219Z,1627584789.219 [Default:CheckIn] Stopped 2021-07-29T18:53:09.219Z,1627584789.219 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T18:53:09.219Z,1627584789.219 [Default:CheckIn](INFO): Running loop #18 2021-07-29T18:53:09.219Z,1627584789.219 [Default:CheckIn] Running Loop=18 2021-07-29T18:53:09.219Z,1627584789.219 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-29T18:53:09.220Z,1627584789.220 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-29T18:53:11.222Z,1627584791.222 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185310.00,A,3648.17096,N,12147.28311,W,0.972,228.94,290721,,,A*7C 2021-07-29T18:53:11.224Z,1627584791.224 [NAL9602](INFO): GPS fix at 20210729T185310: (36.802849, -121.788052) 2021-07-29T18:53:11.253Z,1627584791.253 [Default:CheckIn:Read_GPS] Stopped 2021-07-29T18:53:11.253Z,1627584791.253 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-29T18:53:18.422Z,1627584798.422 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210729T174636/Courier0036.lzma 2021-07-29T18:53:19.425Z,1627584799.425 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Courier0036.lzma.bak 2021-07-29T18:53:19.425Z,1627584799.425 [DataOverHttps](INFO): SBD MOMSN=15774692 2021-07-29T18:53:35.055Z,1627584815.055 [DataOverHttps](INFO): Sending 328 bytes from file Logs/20210729T174636/Express0037.lzma 2021-07-29T18:53:36.056Z,1627584816.056 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Express0037.lzma.bak 2021-07-29T18:53:36.056Z,1627584816.056 [DataOverHttps](INFO): SBD MOMSN=15774695 2021-07-29T18:53:37.491Z,1627584817.491 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T18:53:37.491Z,1627584817.491 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T18:53:37.491Z,1627584817.491 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T18:53:43.571Z,1627584823.571 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-29T18:58:25.570Z,1627585105.570 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:58:38.106Z,1627585118.106 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-29T18:58:38.106Z,1627585118.106 [Default:CheckIn:C.Wait] Stopped 2021-07-29T18:58:38.106Z,1627585118.106 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T18:58:38.107Z,1627585118.107 [Default:CheckIn:D] Running Loop=1 2021-07-29T18:58:38.503Z,1627585118.503 [Default:CheckIn:D] Stopped 2021-07-29T18:58:38.503Z,1627585118.503 [Default:CheckIn:E] Running Loop=1 2021-07-29T18:58:38.970Z,1627585118.970 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 102.570109 min 2021-07-29T18:58:38.970Z,1627585118.970 [Default:CheckIn:E] Stopped 2021-07-29T18:58:38.970Z,1627585118.970 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-29T18:58:38.970Z,1627585118.970 [Default:CheckIn] Stopped 2021-07-29T18:58:38.970Z,1627585118.970 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T18:58:38.971Z,1627585118.971 [Default:CheckIn](INFO): Running loop #19 2021-07-29T18:58:38.971Z,1627585118.971 [Default:CheckIn] Running Loop=19 2021-07-29T18:58:38.971Z,1627585118.971 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-29T18:58:38.971Z,1627585118.971 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-29T18:58:39.364Z,1627585119.364 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:58:40.922Z,1627585120.922 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185840.00,A,3648.17526,N,12147.28240,W,0.505,183.38,290721,,,A*71 2021-07-29T18:58:40.924Z,1627585120.924 [NAL9602](INFO): GPS fix at 20210729T185840: (36.802921, -121.788040) 2021-07-29T18:58:40.956Z,1627585120.956 [Default:CheckIn:Read_GPS] Stopped 2021-07-29T18:58:40.956Z,1627585120.956 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-29T18:58:48.350Z,1627585128.350 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210729T174636/Courier0039.lzma 2021-07-29T18:58:49.352Z,1627585129.352 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Courier0039.lzma.bak 2021-07-29T18:58:49.353Z,1627585129.353 [DataOverHttps](INFO): SBD MOMSN=15774706 2021-07-29T18:58:52.227Z,1627585132.227 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:59:05.226Z,1627585145.226 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20210729T174636/Express0040.lzma 2021-07-29T18:59:05.561Z,1627585145.561 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:59:06.228Z,1627585146.228 [DataOverHttps](INFO): Moved sent file to Logs/20210729T174636/Express0040.lzma.bak 2021-07-29T18:59:06.229Z,1627585146.229 [DataOverHttps](INFO): SBD MOMSN=15774731 2021-07-29T18:59:07.607Z,1627585147.607 [Default:CheckIn:Read_Iridium] Stopped 2021-07-29T18:59:07.607Z,1627585147.607 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-29T18:59:07.607Z,1627585147.607 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-29T18:59:11.620Z,1627585151.620 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-07-29T18:59:11.695Z,1627585151.695 [NAL9602](ERROR): received: +CSQ:0 OK38, 2, 0, 0, 0 OK 2021-07-29T18:59:18.892Z,1627585158.892 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:59:32.223Z,1627585172.223 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:59:45.160Z,1627585185.160 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T18:59:58.889Z,1627585198.889 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T19:00:12.220Z,1627585212.220 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T19:00:25.552Z,1627585225.552 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T19:00:38.885Z,1627585238.885 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T19:00:51.814Z,1627585251.814 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-07-29T19:01:07.579Z,1627585267.579 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2021-07-29T19:01:22.522Z,1627585282.522 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2021-07-29T19:01:37.471Z,1627585297.471 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2021-07-29T19:01:52.418Z,1627585312.418 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2021-07-29T19:02:06.172Z,1627585326.172 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2021-07-29T19:02:06.172Z,1627585326.172 [DropWeight] Hardware Fault, FailCount= 1 2021-07-29T19:02:06.172Z,1627585326.172 [DropWeight](ERROR): Hardware Fault 2021-07-29T19:02:06.245Z,1627585326.245 [CommandLine](FAULT): Scheduling is paused 2021-07-29T19:02:06.245Z,1627585326.245 [CBIT](INFO): Critical error at 20210729T190206 2021-07-29T19:02:06.256Z,1627585326.256 [CBIT](ERROR): Hardware Fault in component: DropWeight 2021-07-29T19:02:06.256Z,1627585326.256 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2021-07-29T19:02:06.643Z,1627585326.643 [CBIT](INFO): Critical error at 20210729T190206 2021-07-29T19:02:07.775Z,1627585327.775 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2021-07-29T19:02:23.122Z,1627585343.122 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2021-07-29T19:02:38.070Z,1627585358.070 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2021-07-29T19:02:47.619Z,1627585367.619 [CommandLine](IMPORTANT): got command quit 2021-07-29T19:02:48.623Z,1627585368.623 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-29T19:02:48.623Z,1627585368.623 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:48.650Z,1627585368.650 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2021-07-29T19:02:48.651Z,1627585368.651 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:48.651Z,1627585368.651 [CommandLine](INFO): Join timeout helper Thread ID is 1244 2021-07-29T19:02:48.659Z,1627585368.659 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2021-07-29T19:02:48.659Z,1627585368.659 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:48.659Z,1627585368.659 [NavChartDb](INFO): Join timeout helper Thread ID is 1245 2021-07-29T19:02:48.723Z,1627585368.723 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-29T19:02:48.723Z,1627585368.723 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:48.727Z,1627585368.727 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2021-07-29T19:02:48.727Z,1627585368.727 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:48.727Z,1627585368.727 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1246 2021-07-29T19:02:49.127Z,1627585369.127 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-29T19:02:49.127Z,1627585369.127 [WetLabsBB2FL](INFO): Powering down 2021-07-29T19:02:49.128Z,1627585369.128 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:49.139Z,1627585369.139 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2021-07-29T19:02:49.140Z,1627585369.140 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:49.140Z,1627585369.140 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1247 2021-07-29T19:02:49.415Z,1627585369.415 [CTD_Seabird](INFO): Powering down 2021-07-29T19:02:49.427Z,1627585369.427 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-29T19:02:49.427Z,1627585369.427 [CTD_Seabird](INFO): Powering down 2021-07-29T19:02:49.443Z,1627585369.443 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:49.463Z,1627585369.463 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2021-07-29T19:02:49.463Z,1627585369.463 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:49.463Z,1627585369.463 [Radio_Surface](INFO): Join timeout helper Thread ID is 1248 2021-07-29T19:02:49.515Z,1627585369.515 [Radio_Surface](INFO): Powering down 2021-07-29T19:02:49.516Z,1627585369.516 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-29T19:02:49.516Z,1627585369.516 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:49.523Z,1627585369.523 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2021-07-29T19:02:49.531Z,1627585369.531 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:49.531Z,1627585369.531 [Onboard](INFO): Join timeout helper Thread ID is 1249 2021-07-29T19:02:52.495Z,1627585372.495 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-29T19:02:52.495Z,1627585372.495 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:52.515Z,1627585372.515 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2021-07-29T19:02:52.515Z,1627585372.515 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:52.516Z,1627585372.516 [DataOverHttps](INFO): Join timeout helper Thread ID is 1250 2021-07-29T19:02:52.911Z,1627585372.911 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-29T19:02:52.913Z,1627585372.913 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:52.915Z,1627585372.915 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2021-07-29T19:02:52.915Z,1627585372.915 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:52.916Z,1627585372.916 [BackseatComponent](INFO): Join timeout helper Thread ID is 1251 2021-07-29T19:02:53.099Z,1627585373.099 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-29T19:02:53.099Z,1627585373.099 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:53.100Z,1627585373.100 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2021-07-29T19:02:53.100Z,1627585373.100 [logger ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:53.101Z,1627585373.101 [logger](INFO): Join timeout helper Thread ID is 1252 2021-07-29T19:02:53.122Z,1627585373.122 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-29T19:02:53.122Z,1627585373.122 [logger ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:53.123Z,1627585373.123 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2021-07-29T19:02:53.123Z,1627585373.123 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:53.124Z,1627585373.124 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2021-07-29T19:02:53.124Z,1627585373.124 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:53.124Z,1627585373.124 [controlThread](INFO): Join timeout helper Thread ID is 1253 2021-07-29T19:02:53.407Z,1627585373.407 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-29T19:02:53.407Z,1627585373.407 [controlThread](DEBUG): Uninitializing ControlThread 2021-07-29T19:02:53.407Z,1627585373.407 [AHRS_M2](INFO): Powering down 2021-07-29T19:02:53.480Z,1627585373.480 [NAL9602](INFO): Powering down 2021-07-29T19:02:53.482Z,1627585373.482 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2021-07-29T19:02:53.483Z,1627585373.483 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2021-07-29T19:02:53.483Z,1627585373.483 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2021-07-29T19:02:53.484Z,1627585373.484 [MissionManager](INFO): Uninitializing Mission Default 2021-07-29T19:02:53.484Z,1627585373.484 [Default] Stopped 2021-07-29T19:02:53.484Z,1627585373.484 [Default](DEBUG): Aggregate::uninitialize Default 2021-07-29T19:02:53.484Z,1627585373.484 [Default:B.GoToSurface] Stopped 2021-07-29T19:02:53.484Z,1627585373.484 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-07-29T19:02:53.484Z,1627585373.484 [Default:CheckIn] Stopped 2021-07-29T19:02:53.485Z,1627585373.485 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-29T19:02:53.485Z,1627585373.485 [Default:CheckIn:C.Wait] Stopped 2021-07-29T19:02:53.485Z,1627585373.485 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-29T19:02:53.488Z,1627585373.488 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2021-07-29T19:02:53.488Z,1627585373.488 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2021-07-29T19:02:53.489Z,1627585373.489 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2021-07-29T19:02:53.489Z,1627585373.489 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2021-07-29T19:02:53.489Z,1627585373.489 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-07-29T19:02:53.489Z,1627585373.489 [BuoyancyServo](INFO): Powering down 2021-07-29T19:02:53.503Z,1627585373.503 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2021-07-29T19:02:53.503Z,1627585373.503 [ElevatorServo](INFO): Powering down 2021-07-29T19:02:53.504Z,1627585373.504 [MassServo](DEBUG): Uninitialize Mass Servo. 2021-07-29T19:02:53.504Z,1627585373.504 [MassServo](INFO): Powering down 2021-07-29T19:02:53.505Z,1627585373.505 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-07-29T19:02:53.505Z,1627585373.505 [RudderServo](INFO): Powering down 2021-07-29T19:02:53.506Z,1627585373.506 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2021-07-29T19:02:53.506Z,1627585373.506 [ThrusterHE](INFO): Powering down 2021-07-29T19:02:53.507Z,1627585373.507 [SBIT](DEBUG): Uninitialize SBIT Component. 2021-07-29T19:02:53.507Z,1627585373.507 [IBIT](DEBUG): Uninitialize IBIT Component. 2021-07-29T19:02:53.507Z,1627585373.507 [CBIT](DEBUG): Uninitialize CBIT Component. 2021-07-29T19:02:53.508Z,1627585373.508 [CBIT](DEBUG): Powering off loads. 2021-07-29T19:02:53.518Z,1627585373.518 [CBIT](DEBUG): Disabling WDT. 2021-07-29T19:02:53.530Z,1627585373.530 [CBIT](DEBUG): Opening all GF detection circuits. 2021-07-29T19:02:53.531Z,1627585373.531 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:53.589Z,1627585373.589 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:53.592Z,1627585373.592 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:53.599Z,1627585373.599 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:53.644Z,1627585373.644 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:53.677Z,1627585373.677 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:53.682Z,1627585373.682 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:53.714Z,1627585373.714 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-07-29T19:02:53.795Z,1627585373.795 [logger ThreadHandler](INFO): Thread cancelled.