2024-12-12T18:55:13.942Z,1734029713.942 [CommandExec](IMPORTANT): got command restart logs 2024-12-12T18:57:09.092Z,1734029829.092 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-12-12T18:57:40.216Z,1734029860.216 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-12-12T18:58:11.348Z,1734029891.348 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-12-12T18:58:42.488Z,1734029922.488 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-12-12T18:59:20.872Z,1734029960.872 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T18:59:20.872Z,1734029960.872 [Default:CheckIn:C.Wait] Stopped 2024-12-12T18:59:20.872Z,1734029960.872 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T18:59:20.872Z,1734029960.872 [Default:CheckIn:D] Running Loop=1 2024-12-12T18:59:21.284Z,1734029961.284 [Default:CheckIn:D] Stopped 2024-12-12T18:59:21.284Z,1734029961.284 [Default:CheckIn:E] Running Loop=1 2024-12-12T18:59:21.674Z,1734029961.674 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.242798 min 2024-12-12T18:59:21.674Z,1734029961.674 [Default:CheckIn:E] Stopped 2024-12-12T18:59:21.674Z,1734029961.674 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T18:59:21.674Z,1734029961.674 [Default:CheckIn] Stopped 2024-12-12T18:59:21.675Z,1734029961.675 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T18:59:21.675Z,1734029961.675 [Default:CheckIn](INFO): Running loop #3 2024-12-12T18:59:21.675Z,1734029961.675 [Default:CheckIn] Running Loop=3 2024-12-12T18:59:21.675Z,1734029961.675 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T18:59:21.675Z,1734029961.675 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T18:59:23.691Z,1734029963.691 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185929.00,A,3648.22049,N,12149.38263,W,22.646,84.24,121224,,,D*78 2024-12-12T18:59:23.693Z,1734029963.693 [NAL9602](INFO): GPS fix at 20241212T185929: (36.803675, -121.823044) 2024-12-12T18:59:23.708Z,1734029963.708 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T18:59:23.708Z,1734029963.708 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T18:59:37.058Z,1734029977.058 [NAL9602](INFO): SBD MO Status=0, MOMSN=60940, MT Status=0, MTMSN=0 2024-12-12T18:59:37.058Z,1734029977.058 [NAL9602](INFO): No messages in MT queue 2024-12-12T18:59:39.223Z,1734029979.223 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241212T143000/Courier0039.lzma 2024-12-12T18:59:40.226Z,1734029980.226 [DataOverHttps](INFO): Moved sent file to Logs/20241212T143000/Courier0039.lzma.bak 2024-12-12T18:59:40.226Z,1734029980.226 [DataOverHttps](INFO): SBD MOMSN=23674374 2024-12-12T19:00:07.760Z,1734030007.760 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-12T19:00:45.468Z,1734030045.468 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20241212T185513/Courier0000.lzma 2024-12-12T19:00:46.470Z,1734030046.470 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0000.lzma.bak 2024-12-12T19:00:46.470Z,1734030046.470 [DataOverHttps](INFO): SBD MOMSN=23674377 2024-12-12T19:01:34.495Z,1734030094.495 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20241212T143000/Express0040.lzma 2024-12-12T19:01:49.554Z,1734030109.554 [DataOverHttps](INFO): Moved sent file to Logs/20241212T143000/Express0040.lzma.bak 2024-12-12T19:01:49.554Z,1734030109.554 [DataOverHttps](INFO): SBD MOMSN=23674384 2024-12-12T19:03:13.292Z,1734030193.292 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-12-12T19:03:36.856Z,1734030216.856 [DataOverHttps](INFO): Sending 397 bytes from file Logs/20241212T185513/Express0001.lzma 2024-12-12T19:03:37.858Z,1734030217.858 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0001.lzma.bak 2024-12-12T19:03:37.858Z,1734030217.858 [DataOverHttps](INFO): SBD MOMSN=23674392 2024-12-12T19:03:53.595Z,1734030233.595 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20241212T185513/Express0004.lzma 2024-12-12T19:03:54.598Z,1734030234.598 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0004.lzma.bak 2024-12-12T19:03:54.598Z,1734030234.598 [DataOverHttps](INFO): SBD MOMSN=23674396 2024-12-12T19:03:56.155Z,1734030236.155 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T19:03:56.155Z,1734030236.155 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T19:03:56.155Z,1734030236.155 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T19:08:56.756Z,1734030536.756 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T19:08:56.756Z,1734030536.756 [Default:CheckIn:C.Wait] Stopped 2024-12-12T19:08:56.756Z,1734030536.756 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T19:08:56.757Z,1734030536.757 [Default:CheckIn:D] Running Loop=1 2024-12-12T19:08:57.148Z,1734030537.148 [Default:CheckIn:D] Stopped 2024-12-12T19:08:57.149Z,1734030537.149 [Default:CheckIn:E] Running Loop=1 2024-12-12T19:08:57.551Z,1734030537.551 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 30.840531 min 2024-12-12T19:08:57.551Z,1734030537.551 [Default:CheckIn:E] Stopped 2024-12-12T19:08:57.551Z,1734030537.551 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T19:08:57.551Z,1734030537.551 [Default:CheckIn] Stopped 2024-12-12T19:08:57.551Z,1734030537.551 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T19:08:57.552Z,1734030537.552 [Default:CheckIn](INFO): Running loop #4 2024-12-12T19:08:57.552Z,1734030537.552 [Default:CheckIn] Running Loop=4 2024-12-12T19:08:57.552Z,1734030537.552 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T19:08:57.552Z,1734030537.552 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T19:08:59.567Z,1734030539.567 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190905.00,A,3648.26640,N,12147.13591,W,4.315,189.30,121224,,,D*7A 2024-12-12T19:08:59.579Z,1734030539.579 [NAL9602](INFO): GPS fix at 20241212T190905: (36.804440, -121.785599) 2024-12-12T19:08:59.590Z,1734030539.590 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T19:08:59.590Z,1734030539.590 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T19:09:06.899Z,1734030546.899 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241212T185513/Courier0006.lzma 2024-12-12T19:09:07.902Z,1734030547.902 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0006.lzma.bak 2024-12-12T19:09:07.902Z,1734030547.902 [DataOverHttps](INFO): SBD MOMSN=23674479 2024-12-12T19:09:14.511Z,1734030554.511 [NAL9602](INFO): SBD MO Status=0, MOMSN=60941, MT Status=0, MTMSN=0 2024-12-12T19:09:14.511Z,1734030554.511 [NAL9602](INFO): No messages in MT queue 2024-12-12T19:09:24.376Z,1734030564.376 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20241212T185513/Express0007.lzma 2024-12-12T19:09:25.378Z,1734030565.378 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0007.lzma.bak 2024-12-12T19:09:25.378Z,1734030565.378 [DataOverHttps](INFO): SBD MOMSN=23674483 2024-12-12T19:09:26.649Z,1734030566.649 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T19:09:26.649Z,1734030566.649 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T19:09:26.649Z,1734030566.649 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T19:09:45.218Z,1734030585.218 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-12T19:14:27.214Z,1734030867.214 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T19:14:27.214Z,1734030867.214 [Default:CheckIn:C.Wait] Stopped 2024-12-12T19:14:27.214Z,1734030867.214 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T19:14:27.214Z,1734030867.214 [Default:CheckIn:D] Running Loop=1 2024-12-12T19:14:27.624Z,1734030867.624 [Default:CheckIn:D] Stopped 2024-12-12T19:14:27.625Z,1734030867.625 [Default:CheckIn:E] Running Loop=1 2024-12-12T19:14:28.041Z,1734030868.041 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.348466 min 2024-12-12T19:14:28.041Z,1734030868.041 [Default:CheckIn:E] Stopped 2024-12-12T19:14:28.041Z,1734030868.041 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T19:14:28.041Z,1734030868.041 [Default:CheckIn] Stopped 2024-12-12T19:14:28.042Z,1734030868.042 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T19:14:28.042Z,1734030868.042 [Default:CheckIn](INFO): Running loop #5 2024-12-12T19:14:28.042Z,1734030868.042 [Default:CheckIn] Running Loop=5 2024-12-12T19:14:28.042Z,1734030868.042 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T19:14:28.042Z,1734030868.042 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T19:14:30.035Z,1734030870.035 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191435.00,A,3648.13800,N,12147.20668,W,0.097,253.94,121224,,,D*7B 2024-12-12T19:14:30.037Z,1734030870.037 [NAL9602](INFO): GPS fix at 20241212T191435: (36.802300, -121.786778) 2024-12-12T19:14:30.080Z,1734030870.080 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T19:14:30.080Z,1734030870.080 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T19:14:37.363Z,1734030877.363 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20241212T185513/Courier0009.lzma 2024-12-12T19:14:38.366Z,1734030878.366 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0009.lzma.bak 2024-12-12T19:14:38.366Z,1734030878.366 [DataOverHttps](INFO): SBD MOMSN=23674491 2024-12-12T19:14:46.655Z,1734030886.655 [NAL9602](INFO): SBD MO Status=0, MOMSN=60942, MT Status=0, MTMSN=0 2024-12-12T19:14:46.655Z,1734030886.655 [NAL9602](INFO): No messages in MT queue 2024-12-12T19:14:56.888Z,1734030896.888 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20241212T185513/Express0010.lzma 2024-12-12T19:14:57.890Z,1734030897.890 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0010.lzma.bak 2024-12-12T19:14:57.890Z,1734030897.890 [DataOverHttps](INFO): SBD MOMSN=23674528 2024-12-12T19:14:59.191Z,1734030899.191 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T19:14:59.191Z,1734030899.191 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T19:14:59.192Z,1734030899.192 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T19:15:17.341Z,1734030917.341 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-12T19:19:59.753Z,1734031199.753 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T19:19:59.753Z,1734031199.753 [Default:CheckIn:C.Wait] Stopped 2024-12-12T19:19:59.753Z,1734031199.753 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T19:19:59.753Z,1734031199.753 [Default:CheckIn:D] Running Loop=1 2024-12-12T19:20:00.169Z,1734031200.169 [Default:CheckIn:D] Stopped 2024-12-12T19:20:00.169Z,1734031200.169 [Default:CheckIn:E] Running Loop=1 2024-12-12T19:20:00.559Z,1734031200.559 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.890873 min 2024-12-12T19:20:00.559Z,1734031200.559 [Default:CheckIn:E] Stopped 2024-12-12T19:20:00.560Z,1734031200.560 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T19:20:00.560Z,1734031200.560 [Default:CheckIn] Stopped 2024-12-12T19:20:00.560Z,1734031200.560 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T19:20:00.560Z,1734031200.560 [Default:CheckIn](INFO): Running loop #6 2024-12-12T19:20:00.560Z,1734031200.560 [Default:CheckIn] Running Loop=6 2024-12-12T19:20:00.560Z,1734031200.560 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T19:20:00.560Z,1734031200.560 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T19:20:02.571Z,1734031202.571 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192008.00,A,3648.13907,N,12147.21027,W,0.000,331.04,121224,,,D*7A 2024-12-12T19:20:02.573Z,1734031202.573 [NAL9602](INFO): GPS fix at 20241212T192008: (36.802318, -121.786838) 2024-12-12T19:20:02.584Z,1734031202.584 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T19:20:02.584Z,1734031202.584 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T19:20:09.467Z,1734031209.467 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20241212T185513/Courier0012.lzma 2024-12-12T19:20:10.470Z,1734031210.470 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0012.lzma.bak 2024-12-12T19:20:10.470Z,1734031210.470 [DataOverHttps](INFO): SBD MOMSN=23674532 2024-12-12T19:20:13.986Z,1734031213.986 [NAL9602](INFO): SBD MO Status=0, MOMSN=60943, MT Status=0, MTMSN=0 2024-12-12T19:20:13.987Z,1734031213.987 [NAL9602](INFO): No messages in MT queue 2024-12-12T19:20:33.164Z,1734031233.164 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20241212T185513/Express0013.lzma 2024-12-12T19:20:34.166Z,1734031234.166 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0013.lzma.bak 2024-12-12T19:20:34.166Z,1734031234.166 [DataOverHttps](INFO): SBD MOMSN=23674535 2024-12-12T19:20:35.491Z,1734031235.491 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T19:20:35.491Z,1734031235.491 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T19:20:35.492Z,1734031235.492 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T19:20:44.764Z,1734031244.764 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-12T19:25:36.275Z,1734031536.275 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T19:25:36.275Z,1734031536.275 [Default:CheckIn:C.Wait] Stopped 2024-12-12T19:25:36.276Z,1734031536.276 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T19:25:36.276Z,1734031536.276 [Default:CheckIn:D] Running Loop=1 2024-12-12T19:25:36.666Z,1734031536.666 [Default:CheckIn:D] Stopped 2024-12-12T19:25:36.666Z,1734031536.666 [Default:CheckIn:E] Running Loop=1 2024-12-12T19:25:37.075Z,1734031537.075 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 47.499158 min 2024-12-12T19:25:37.076Z,1734031537.076 [Default:CheckIn:E] Stopped 2024-12-12T19:25:37.076Z,1734031537.076 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T19:25:37.076Z,1734031537.076 [Default:CheckIn] Stopped 2024-12-12T19:25:37.076Z,1734031537.076 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T19:25:37.076Z,1734031537.076 [Default:CheckIn](INFO): Running loop #7 2024-12-12T19:25:37.076Z,1734031537.076 [Default:CheckIn] Running Loop=7 2024-12-12T19:25:37.076Z,1734031537.076 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T19:25:37.077Z,1734031537.077 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T19:25:39.091Z,1734031539.091 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192544.00,A,3648.17021,N,12147.28045,W,0.836,330.40,121224,,,D*7F 2024-12-12T19:25:39.093Z,1734031539.093 [NAL9602](INFO): GPS fix at 20241212T192544: (36.802837, -121.788008) 2024-12-12T19:25:39.104Z,1734031539.104 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T19:25:39.104Z,1734031539.104 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T19:25:46.955Z,1734031546.955 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20241212T185513/Courier0015.lzma 2024-12-12T19:25:47.958Z,1734031547.958 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0015.lzma.bak 2024-12-12T19:25:47.958Z,1734031547.958 [DataOverHttps](INFO): SBD MOMSN=23674571 2024-12-12T19:25:51.234Z,1734031551.234 [NAL9602](INFO): SBD MO Status=0, MOMSN=60944, MT Status=0, MTMSN=0 2024-12-12T19:25:51.235Z,1734031551.235 [NAL9602](INFO): No messages in MT queue 2024-12-12T19:26:13.816Z,1734031573.816 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20241212T185513/Express0016.lzma 2024-12-12T19:26:14.818Z,1734031574.818 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0016.lzma.bak 2024-12-12T19:26:14.818Z,1734031574.818 [DataOverHttps](INFO): SBD MOMSN=23674574 2024-12-12T19:26:16.353Z,1734031576.353 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T19:26:16.353Z,1734031576.353 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T19:26:16.353Z,1734031576.353 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T19:26:21.993Z,1734031581.993 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-12T19:31:16.935Z,1734031876.935 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T19:31:16.935Z,1734031876.935 [Default:CheckIn:C.Wait] Stopped 2024-12-12T19:31:16.935Z,1734031876.935 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T19:31:16.935Z,1734031876.935 [Default:CheckIn:D] Running Loop=1 2024-12-12T19:31:17.327Z,1734031877.327 [Default:CheckIn:D] Stopped 2024-12-12T19:31:17.328Z,1734031877.328 [Default:CheckIn:E] Running Loop=1 2024-12-12T19:31:17.736Z,1734031877.736 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 53.176851 min 2024-12-12T19:31:17.736Z,1734031877.736 [Default:CheckIn:E] Stopped 2024-12-12T19:31:17.736Z,1734031877.736 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T19:31:17.736Z,1734031877.736 [Default:CheckIn] Stopped 2024-12-12T19:31:17.737Z,1734031877.737 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T19:31:17.737Z,1734031877.737 [Default:CheckIn](INFO): Running loop #8 2024-12-12T19:31:17.737Z,1734031877.737 [Default:CheckIn] Running Loop=8 2024-12-12T19:31:17.737Z,1734031877.737 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T19:31:17.737Z,1734031877.737 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T19:31:19.743Z,1734031879.743 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193125.00,A,3648.17348,N,12147.27665,W,0.214,212.20,121224,,,A*72 2024-12-12T19:31:19.745Z,1734031879.745 [NAL9602](INFO): GPS fix at 20241212T193125: (36.802891, -121.787944) 2024-12-12T19:31:19.756Z,1734031879.756 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T19:31:19.756Z,1734031879.756 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T19:31:26.727Z,1734031886.727 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241212T185513/Courier0018.lzma 2024-12-12T19:31:27.730Z,1734031887.730 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0018.lzma.bak 2024-12-12T19:31:27.730Z,1734031887.730 [DataOverHttps](INFO): SBD MOMSN=23674578 2024-12-12T19:31:41.962Z,1734031901.962 [NAL9602](INFO): SBD MO Status=2, MOMSN=60945, MT Status=2, MTMSN=0 2024-12-12T19:31:41.963Z,1734031901.963 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-12T19:31:43.739Z,1734031903.739 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20241212T185513/Express0019.lzma 2024-12-12T19:31:44.742Z,1734031904.742 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0019.lzma.bak 2024-12-12T19:31:44.742Z,1734031904.742 [DataOverHttps](INFO): SBD MOMSN=23674581 2024-12-12T19:31:46.020Z,1734031906.020 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T19:31:46.020Z,1734031906.020 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T19:31:46.020Z,1734031906.020 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T19:31:55.306Z,1734031915.306 [NAL9602](INFO): SBD MO Status=2, MOMSN=60945, MT Status=2, MTMSN=0 2024-12-12T19:31:55.306Z,1734031915.306 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-12T19:35:07.630Z,1734032107.630 [NAL9602](INFO): SBD MO Status=0, MOMSN=60945, MT Status=0, MTMSN=0 2024-12-12T19:35:07.631Z,1734032107.631 [NAL9602](INFO): No messages in MT queue 2024-12-12T19:35:38.333Z,1734032138.333 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-12T19:36:46.631Z,1734032206.631 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T19:36:46.631Z,1734032206.631 [Default:CheckIn:C.Wait] Stopped 2024-12-12T19:36:46.631Z,1734032206.631 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T19:36:46.632Z,1734032206.632 [Default:CheckIn:D] Running Loop=1 2024-12-12T19:36:47.019Z,1734032207.019 [Default:CheckIn:D] Stopped 2024-12-12T19:36:47.019Z,1734032207.019 [Default:CheckIn:E] Running Loop=1 2024-12-12T19:36:47.423Z,1734032207.423 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 58.671712 min 2024-12-12T19:36:47.424Z,1734032207.424 [Default:CheckIn:E] Stopped 2024-12-12T19:36:47.424Z,1734032207.424 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T19:36:47.424Z,1734032207.424 [Default:CheckIn] Stopped 2024-12-12T19:36:47.424Z,1734032207.424 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T19:36:47.424Z,1734032207.424 [Default:CheckIn](INFO): Running loop #9 2024-12-12T19:36:47.424Z,1734032207.424 [Default:CheckIn] Running Loop=9 2024-12-12T19:36:47.424Z,1734032207.424 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T19:36:47.425Z,1734032207.425 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T19:36:49.440Z,1734032209.440 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193655.00,A,3648.17261,N,12147.27948,W,0.156,212.20,121224,,,A*7D 2024-12-12T19:36:49.443Z,1734032209.443 [NAL9602](INFO): GPS fix at 20241212T193655: (36.802877, -121.787991) 2024-12-12T19:36:49.461Z,1734032209.461 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T19:36:49.461Z,1734032209.461 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T19:36:57.250Z,1734032217.250 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241212T185513/Courier0021.lzma 2024-12-12T19:36:58.250Z,1734032218.250 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0021.lzma.bak 2024-12-12T19:36:58.250Z,1734032218.250 [DataOverHttps](INFO): SBD MOMSN=23674626 2024-12-12T19:37:02.766Z,1734032222.766 [NAL9602](INFO): SBD MO Status=0, MOMSN=60946, MT Status=0, MTMSN=0 2024-12-12T19:37:02.767Z,1734032222.767 [NAL9602](INFO): No messages in MT queue 2024-12-12T19:37:14.800Z,1734032234.800 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20241212T185513/Express0022.lzma 2024-12-12T19:37:15.802Z,1734032235.802 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0022.lzma.bak 2024-12-12T19:37:15.802Z,1734032235.802 [DataOverHttps](INFO): SBD MOMSN=23674629 2024-12-12T19:37:17.325Z,1734032237.325 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T19:37:17.325Z,1734032237.325 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T19:37:17.325Z,1734032237.325 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T19:37:33.473Z,1734032253.473 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-12T19:42:17.916Z,1734032537.916 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T19:42:17.916Z,1734032537.916 [Default:CheckIn:C.Wait] Stopped 2024-12-12T19:42:17.916Z,1734032537.916 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T19:42:17.917Z,1734032537.917 [Default:CheckIn:D] Running Loop=1 2024-12-12T19:42:18.325Z,1734032538.325 [Default:CheckIn:D] Stopped 2024-12-12T19:42:18.325Z,1734032538.325 [Default:CheckIn:E] Running Loop=1 2024-12-12T19:42:18.719Z,1734032538.719 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 64.193477 min 2024-12-12T19:42:18.720Z,1734032538.720 [Default:CheckIn:E] Stopped 2024-12-12T19:42:18.720Z,1734032538.720 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T19:42:18.720Z,1734032538.720 [Default:CheckIn] Stopped 2024-12-12T19:42:18.720Z,1734032538.720 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T19:42:18.720Z,1734032538.720 [Default:CheckIn](INFO): Running loop #10 2024-12-12T19:42:18.720Z,1734032538.720 [Default:CheckIn] Running Loop=10 2024-12-12T19:42:18.721Z,1734032538.721 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T19:42:18.721Z,1734032538.721 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T19:42:20.727Z,1734032540.727 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194226.00,A,3648.17386,N,12147.27630,W,0.078,212.20,121224,,,A*7F 2024-12-12T19:42:20.729Z,1734032540.729 [NAL9602](INFO): GPS fix at 20241212T194226: (36.802898, -121.787938) 2024-12-12T19:42:20.745Z,1734032540.745 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T19:42:20.745Z,1734032540.745 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T19:42:28.448Z,1734032548.448 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241212T185513/Courier0024.lzma 2024-12-12T19:42:29.450Z,1734032549.450 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0024.lzma.bak 2024-12-12T19:42:29.450Z,1734032549.450 [DataOverHttps](INFO): SBD MOMSN=23674634 2024-12-12T19:42:48.900Z,1734032568.900 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20241212T185513/Express0025.lzma 2024-12-12T19:42:49.902Z,1734032569.902 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0025.lzma.bak 2024-12-12T19:42:49.902Z,1734032569.902 [DataOverHttps](INFO): SBD MOMSN=23674637 2024-12-12T19:42:51.561Z,1734032571.561 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T19:42:51.561Z,1734032571.561 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T19:42:51.561Z,1734032571.561 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T19:44:24.814Z,1734032664.814 [NAL9602](INFO): SBD MO Status=0, MOMSN=60947, MT Status=0, MTMSN=0 2024-12-12T19:44:24.815Z,1734032664.815 [NAL9602](INFO): No messages in MT queue 2024-12-12T19:44:55.601Z,1734032695.601 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-12T19:47:52.171Z,1734032872.171 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T19:47:52.172Z,1734032872.172 [Default:CheckIn:C.Wait] Stopped 2024-12-12T19:47:52.172Z,1734032872.172 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T19:47:52.172Z,1734032872.172 [Default:CheckIn:D] Running Loop=1 2024-12-12T19:47:52.587Z,1734032872.587 [Default:CheckIn:D] Stopped 2024-12-12T19:47:52.587Z,1734032872.587 [Default:CheckIn:E] Running Loop=1 2024-12-12T19:47:52.981Z,1734032872.981 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 69.764510 min 2024-12-12T19:47:52.981Z,1734032872.981 [Default:CheckIn:E] Stopped 2024-12-12T19:47:52.981Z,1734032872.981 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T19:47:52.981Z,1734032872.981 [Default:CheckIn] Stopped 2024-12-12T19:47:52.981Z,1734032872.981 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T19:47:52.982Z,1734032872.982 [Default:CheckIn](INFO): Running loop #11 2024-12-12T19:47:52.982Z,1734032872.982 [Default:CheckIn] Running Loop=11 2024-12-12T19:47:52.982Z,1734032872.982 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T19:47:52.982Z,1734032872.982 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T19:47:54.995Z,1734032874.995 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194800.00,A,3648.17195,N,12147.27801,W,0.039,7.55,121224,,,A*7C 2024-12-12T19:47:54.997Z,1734032874.997 [NAL9602](INFO): GPS fix at 20241212T194800: (36.802866, -121.787967) 2024-12-12T19:47:55.008Z,1734032875.008 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T19:47:55.008Z,1734032875.008 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T19:48:02.823Z,1734032882.823 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241212T185513/Courier0027.lzma 2024-12-12T19:48:03.826Z,1734032883.826 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0027.lzma.bak 2024-12-12T19:48:03.826Z,1734032883.826 [DataOverHttps](INFO): SBD MOMSN=23674694 2024-12-12T19:48:18.489Z,1734032898.489 [NAL9602](INFO): SBD MO Status=2, MOMSN=60948, MT Status=2, MTMSN=0 2024-12-12T19:48:18.489Z,1734032898.489 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-12T19:48:22.500Z,1734032902.500 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20241212T185513/Express0028.lzma 2024-12-12T19:48:23.502Z,1734032903.502 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0028.lzma.bak 2024-12-12T19:48:23.502Z,1734032903.502 [DataOverHttps](INFO): SBD MOMSN=23674697 2024-12-12T19:48:24.962Z,1734032904.962 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T19:48:24.963Z,1734032904.963 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T19:48:24.963Z,1734032904.963 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T19:48:48.803Z,1734032928.803 [NAL9602](INFO): SBD MO Status=2, MOMSN=60948, MT Status=2, MTMSN=0 2024-12-12T19:48:48.804Z,1734032928.804 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-12T19:51:01.371Z,1734033061.371 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-12T19:51:14.298Z,1734033074.298 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-12T19:51:27.227Z,1734033087.227 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-12T19:51:39.750Z,1734033099.750 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-12T19:51:53.090Z,1734033113.090 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-12T19:52:06.011Z,1734033126.011 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-12T19:52:18.940Z,1734033138.940 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-12T19:52:58.145Z,1734033178.145 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-12-12T19:53:25.685Z,1734033205.685 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T19:53:25.685Z,1734033205.685 [Default:CheckIn:C.Wait] Stopped 2024-12-12T19:53:25.685Z,1734033205.685 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T19:53:25.685Z,1734033205.685 [Default:CheckIn:D] Running Loop=1 2024-12-12T19:53:26.036Z,1734033206.036 [Default:CheckIn:D] Stopped 2024-12-12T19:53:26.036Z,1734033206.036 [Default:CheckIn:E] Running Loop=1 2024-12-12T19:53:26.449Z,1734033206.449 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 75.321997 min 2024-12-12T19:53:26.449Z,1734033206.449 [Default:CheckIn:E] Stopped 2024-12-12T19:53:26.449Z,1734033206.449 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T19:53:26.449Z,1734033206.449 [Default:CheckIn] Stopped 2024-12-12T19:53:26.449Z,1734033206.449 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T19:53:26.449Z,1734033206.449 [Default:CheckIn](INFO): Running loop #12 2024-12-12T19:53:26.449Z,1734033206.449 [Default:CheckIn] Running Loop=12 2024-12-12T19:53:26.449Z,1734033206.449 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T19:53:26.449Z,1734033206.449 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T19:53:28.447Z,1734033208.447 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195334.00,A,3648.17949,N,12147.26825,W,0.019,333.98,121224,,,A*78 2024-12-12T19:53:28.457Z,1734033208.457 [NAL9602](INFO): GPS fix at 20241212T195334: (36.802991, -121.787804) 2024-12-12T19:53:28.468Z,1734033208.468 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T19:53:28.468Z,1734033208.468 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T19:53:35.779Z,1734033215.779 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241212T185513/Courier0030.lzma 2024-12-12T19:53:36.782Z,1734033216.782 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0030.lzma.bak 2024-12-12T19:53:36.782Z,1734033216.782 [DataOverHttps](INFO): SBD MOMSN=23674712 2024-12-12T19:53:52.700Z,1734033232.700 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20241212T185513/Express0031.lzma 2024-12-12T19:53:54.706Z,1734033234.706 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0031.lzma.bak 2024-12-12T19:53:54.706Z,1734033234.706 [DataOverHttps](INFO): SBD MOMSN=23674715 2024-12-12T19:53:55.985Z,1734033235.985 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T19:53:55.985Z,1734033235.985 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T19:53:55.985Z,1734033235.985 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T19:54:00.361Z,1734033240.361 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-12-12T19:54:00.361Z,1734033240.361 [DropWeight] Hardware Fault, FailCount= 1 2024-12-12T19:54:00.361Z,1734033240.361 [DropWeight](ERROR): Hardware Fault 2024-12-12T19:54:00.399Z,1734033240.399 [CommandExec](FAULT): Scheduling is paused for 3 commands 2024-12-12T19:54:00.399Z,1734033240.399 [CBIT](INFO): Critical error at 20241212T195400 2024-12-12T19:54:00.400Z,1734033240.400 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-12-12T19:54:00.403Z,1734033240.403 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-12-12T19:54:00.403Z,1734033240.403 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-12-12T19:54:00.773Z,1734033240.773 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-12T19:54:00.832Z,1734033240.832 [CBIT](INFO): Critical error at 20241212T195400 2024-12-12T19:54:52.470Z,1734033292.470 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-12-12T19:55:06.207Z,1734033306.207 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-12-12T19:55:19.942Z,1734033319.942 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-12-12T19:55:33.274Z,1734033333.274 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-12-12T19:55:47.010Z,1734033347.010 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-12-12T19:56:00.343Z,1734033360.343 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-12-12T19:56:13.674Z,1734033373.674 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-12-12T19:56:27.006Z,1734033387.006 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-12-12T19:56:40.744Z,1734033400.744 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-12-12T19:56:54.890Z,1734033414.890 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-12-12T19:57:08.222Z,1734033428.222 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-12-12T19:57:21.158Z,1734033441.158 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 5. 2024-12-12T19:57:21.160Z,1734033441.160 [BPC1](INFO): Received data from all battery sticks. 2024-12-12T19:58:56.513Z,1734033536.513 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T19:58:56.513Z,1734033536.513 [Default:CheckIn:C.Wait] Stopped 2024-12-12T19:58:56.513Z,1734033536.513 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T19:58:56.513Z,1734033536.513 [Default:CheckIn:D] Running Loop=1 2024-12-12T19:58:56.915Z,1734033536.915 [Default:CheckIn:D] Stopped 2024-12-12T19:58:56.915Z,1734033536.915 [Default:CheckIn:E] Running Loop=1 2024-12-12T19:58:57.321Z,1734033537.321 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 80.836637 min 2024-12-12T19:58:57.321Z,1734033537.321 [Default:CheckIn:E] Stopped 2024-12-12T19:58:57.321Z,1734033537.321 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T19:58:57.321Z,1734033537.321 [Default:CheckIn] Stopped 2024-12-12T19:58:57.321Z,1734033537.321 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T19:58:57.322Z,1734033537.322 [Default:CheckIn](INFO): Running loop #13 2024-12-12T19:58:57.322Z,1734033537.322 [Default:CheckIn] Running Loop=13 2024-12-12T19:58:57.322Z,1734033537.322 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T19:58:57.322Z,1734033537.322 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T19:58:59.330Z,1734033539.330 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195905.00,A,3648.18138,N,12147.26880,W,0.136,357.81,121224,,,A*78 2024-12-12T19:58:59.346Z,1734033539.346 [NAL9602](INFO): GPS fix at 20241212T195905: (36.803023, -121.787813) 2024-12-12T19:58:59.358Z,1734033539.358 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T19:58:59.358Z,1734033539.358 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T19:59:06.920Z,1734033546.920 [DataOverHttps](INFO): Sending 296 bytes from file Logs/20241212T185513/Courier0033.lzma 2024-12-12T19:59:07.923Z,1734033547.923 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0033.lzma.bak 2024-12-12T19:59:07.923Z,1734033547.923 [DataOverHttps](INFO): SBD MOMSN=23674791 2024-12-12T19:59:23.692Z,1734033563.692 [DataOverHttps](INFO): Sending 167 bytes from file Logs/20241212T185513/Express0034.lzma 2024-12-12T19:59:24.694Z,1734033564.694 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0034.lzma.bak 2024-12-12T19:59:24.694Z,1734033564.694 [DataOverHttps](INFO): SBD MOMSN=23674796 2024-12-12T19:59:26.008Z,1734033566.008 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T19:59:26.008Z,1734033566.008 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T19:59:26.008Z,1734033566.008 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T19:59:30.029Z,1734033570.029 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-12-12T19:59:30.104Z,1734033570.104 [NAL9602](ERROR): received: +CSQ:0 OK948, 2, 0, 0, 0 OK 2024-12-12T20:02:16.490Z,1734033736.490 [NAL9602](INFO): SBD MO Status=0, MOMSN=60948, MT Status=0, MTMSN=0 2024-12-12T20:02:16.490Z,1734033736.490 [NAL9602](INFO): No messages in MT queue 2024-12-12T20:02:47.186Z,1734033767.186 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-12T20:04:26.583Z,1734033866.583 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T20:04:26.583Z,1734033866.583 [Default:CheckIn:C.Wait] Stopped 2024-12-12T20:04:26.583Z,1734033866.583 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T20:04:26.583Z,1734033866.583 [Default:CheckIn:D] Running Loop=1 2024-12-12T20:04:26.987Z,1734033866.987 [Default:CheckIn:D] Stopped 2024-12-12T20:04:26.987Z,1734033866.987 [Default:CheckIn:E] Running Loop=1 2024-12-12T20:04:27.393Z,1734033867.393 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 86.337842 min 2024-12-12T20:04:27.393Z,1734033867.393 [Default:CheckIn:E] Stopped 2024-12-12T20:04:27.393Z,1734033867.393 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T20:04:27.393Z,1734033867.393 [Default:CheckIn] Stopped 2024-12-12T20:04:27.393Z,1734033867.393 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T20:04:27.393Z,1734033867.393 [Default:CheckIn](INFO): Running loop #14 2024-12-12T20:04:27.393Z,1734033867.393 [Default:CheckIn] Running Loop=14 2024-12-12T20:04:27.393Z,1734033867.393 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T20:04:27.394Z,1734033867.394 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T20:04:29.402Z,1734033869.402 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200435.00,A,3648.17730,N,12147.26954,W,0.272,357.81,121224,,,A*73 2024-12-12T20:04:29.405Z,1734033869.405 [NAL9602](INFO): GPS fix at 20241212T200435: (36.802955, -121.787826) 2024-12-12T20:04:29.416Z,1734033869.416 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T20:04:29.416Z,1734033869.416 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T20:04:37.155Z,1734033877.155 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241212T185513/Courier0036.lzma 2024-12-12T20:04:38.158Z,1734033878.158 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0036.lzma.bak 2024-12-12T20:04:38.158Z,1734033878.158 [DataOverHttps](INFO): SBD MOMSN=23674801 2024-12-12T20:04:50.877Z,1734033890.877 [NAL9602](INFO): SBD MO Status=2, MOMSN=60949, MT Status=2, MTMSN=0 2024-12-12T20:04:50.877Z,1734033890.877 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-12T20:04:57.892Z,1734033897.892 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20241212T185513/Express0037.lzma 2024-12-12T20:04:58.894Z,1734033898.894 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0037.lzma.bak 2024-12-12T20:04:58.894Z,1734033898.894 [DataOverHttps](INFO): SBD MOMSN=23674804 2024-12-12T20:05:00.197Z,1734033900.197 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T20:05:00.197Z,1734033900.197 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T20:05:00.197Z,1734033900.197 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T20:05:19.158Z,1734033919.158 [NAL9602](INFO): SBD MO Status=0, MOMSN=60949, MT Status=0, MTMSN=0 2024-12-12T20:05:19.158Z,1734033919.158 [NAL9602](INFO): No messages in MT queue 2024-12-12T20:05:49.868Z,1734033949.868 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-12T20:09:00.585Z,1734034140.585 [CBIT](INFO): Clearing failed state for component DropWeight 2024-12-12T20:09:00.585Z,1734034140.585 [DropWeight] No Fault, FailCount= 1 2024-12-12T20:10:00.764Z,1734034200.764 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T20:10:00.764Z,1734034200.764 [Default:CheckIn:C.Wait] Stopped 2024-12-12T20:10:00.765Z,1734034200.765 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T20:10:00.765Z,1734034200.765 [Default:CheckIn:D] Running Loop=1 2024-12-12T20:10:01.163Z,1734034201.163 [Default:CheckIn:D] Stopped 2024-12-12T20:10:01.163Z,1734034201.163 [Default:CheckIn:E] Running Loop=1 2024-12-12T20:10:01.568Z,1734034201.568 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 91.907446 min 2024-12-12T20:10:01.568Z,1734034201.568 [Default:CheckIn:E] Stopped 2024-12-12T20:10:01.568Z,1734034201.568 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T20:10:01.569Z,1734034201.569 [Default:CheckIn] Stopped 2024-12-12T20:10:01.569Z,1734034201.569 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T20:10:01.569Z,1734034201.569 [Default:CheckIn](INFO): Running loop #15 2024-12-12T20:10:01.569Z,1734034201.569 [Default:CheckIn] Running Loop=15 2024-12-12T20:10:01.569Z,1734034201.569 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T20:10:01.569Z,1734034201.569 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T20:10:03.583Z,1734034203.583 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201009.00,A,3648.16610,N,12147.28131,W,1.924,21.26,121224,,,A*48 2024-12-12T20:10:03.585Z,1734034203.585 [NAL9602](INFO): GPS fix at 20241212T201009: (36.802768, -121.788022) 2024-12-12T20:10:03.596Z,1734034203.596 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T20:10:03.596Z,1734034203.596 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T20:10:10.575Z,1734034210.575 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241212T185513/Courier0039.lzma 2024-12-12T20:10:12.324Z,1734034212.324 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0039.lzma.bak 2024-12-12T20:10:12.324Z,1734034212.324 [DataOverHttps](INFO): SBD MOMSN=23674839 2024-12-12T20:10:29.967Z,1734034229.967 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20241212T185513/Express0040.lzma 2024-12-12T20:10:30.966Z,1734034230.966 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0040.lzma.bak 2024-12-12T20:10:30.966Z,1734034230.966 [DataOverHttps](INFO): SBD MOMSN=23674842 2024-12-12T20:10:32.325Z,1734034232.325 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T20:10:32.325Z,1734034232.325 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T20:10:32.325Z,1734034232.325 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T20:15:05.841Z,1734034505.841 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-12-12T20:15:32.927Z,1734034532.927 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T20:15:32.928Z,1734034532.928 [Default:CheckIn:C.Wait] Stopped 2024-12-12T20:15:32.928Z,1734034532.928 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T20:15:32.928Z,1734034532.928 [Default:CheckIn:D] Running Loop=1 2024-12-12T20:15:33.319Z,1734034533.319 [Default:CheckIn:D] Stopped 2024-12-12T20:15:33.319Z,1734034533.319 [Default:CheckIn:E] Running Loop=1 2024-12-12T20:15:33.727Z,1734034533.727 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 97.443368 min 2024-12-12T20:15:33.728Z,1734034533.728 [Default:CheckIn:E] Stopped 2024-12-12T20:15:33.728Z,1734034533.728 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T20:15:33.728Z,1734034533.728 [Default:CheckIn] Stopped 2024-12-12T20:15:33.728Z,1734034533.728 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T20:15:33.728Z,1734034533.728 [Default:CheckIn](INFO): Running loop #16 2024-12-12T20:15:33.728Z,1734034533.728 [Default:CheckIn] Running Loop=16 2024-12-12T20:15:33.728Z,1734034533.728 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T20:15:33.729Z,1734034533.729 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T20:15:35.739Z,1734034535.739 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201541.00,A,3648.15912,N,12147.28688,W,1.866,60.01,121224,,,A*4D 2024-12-12T20:15:35.749Z,1734034535.749 [NAL9602](INFO): GPS fix at 20241212T201541: (36.802652, -121.788115) 2024-12-12T20:15:35.761Z,1734034535.761 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T20:15:35.761Z,1734034535.761 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T20:15:42.975Z,1734034542.975 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241212T185513/Courier0042.lzma 2024-12-12T20:15:43.978Z,1734034543.978 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0042.lzma.bak 2024-12-12T20:15:43.978Z,1734034543.978 [DataOverHttps](INFO): SBD MOMSN=23674845 2024-12-12T20:15:59.736Z,1734034559.736 [DataOverHttps](INFO): Sending 208 bytes from file Logs/20241212T185513/Express0043.lzma 2024-12-12T20:16:00.738Z,1734034560.738 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0043.lzma.bak 2024-12-12T20:16:00.738Z,1734034560.738 [DataOverHttps](INFO): SBD MOMSN=23674848 2024-12-12T20:16:02.012Z,1734034562.012 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T20:16:02.012Z,1734034562.012 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T20:16:02.012Z,1734034562.012 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T20:16:08.058Z,1734034568.058 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-12T20:21:02.699Z,1734034862.699 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T20:21:02.699Z,1734034862.699 [Default:CheckIn:C.Wait] Stopped 2024-12-12T20:21:02.699Z,1734034862.699 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T20:21:02.699Z,1734034862.699 [Default:CheckIn:D] Running Loop=1 2024-12-12T20:21:03.103Z,1734034863.103 [Default:CheckIn:D] Stopped 2024-12-12T20:21:03.103Z,1734034863.103 [Default:CheckIn:E] Running Loop=1 2024-12-12T20:21:03.509Z,1734034863.509 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 102.939779 min 2024-12-12T20:21:03.509Z,1734034863.509 [Default:CheckIn:E] Stopped 2024-12-12T20:21:03.509Z,1734034863.509 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T20:21:03.509Z,1734034863.509 [Default:CheckIn] Stopped 2024-12-12T20:21:03.509Z,1734034863.509 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T20:21:03.510Z,1734034863.510 [Default:CheckIn](INFO): Running loop #17 2024-12-12T20:21:03.510Z,1734034863.510 [Default:CheckIn] Running Loop=17 2024-12-12T20:21:03.510Z,1734034863.510 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T20:21:03.510Z,1734034863.510 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T20:21:05.519Z,1734034865.519 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202111.00,A,3648.16582,N,12147.29753,W,3.091,2.86,121224,,,A*76 2024-12-12T20:21:05.521Z,1734034865.521 [NAL9602](INFO): GPS fix at 20241212T202111: (36.802764, -121.788292) 2024-12-12T20:21:05.533Z,1734034865.533 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T20:21:05.533Z,1734034865.533 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T20:21:12.927Z,1734034872.927 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241212T185513/Courier0045.lzma 2024-12-12T20:21:13.930Z,1734034873.930 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0045.lzma.bak 2024-12-12T20:21:13.930Z,1734034873.930 [DataOverHttps](INFO): SBD MOMSN=23674897 2024-12-12T20:21:29.860Z,1734034889.860 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20241212T185513/Express0046.lzma 2024-12-12T20:21:30.862Z,1734034890.862 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0046.lzma.bak 2024-12-12T20:21:30.862Z,1734034890.862 [DataOverHttps](INFO): SBD MOMSN=23674900 2024-12-12T20:21:32.205Z,1734034892.205 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T20:21:32.206Z,1734034892.206 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T20:21:32.206Z,1734034892.206 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T20:21:36.217Z,1734034896.217 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-12-12T20:21:36.292Z,1734034896.292 [NAL9602](ERROR): received: +CSQ:0 OK949, 0, 0, 0, 0 OK 2024-12-12T20:26:07.741Z,1734035167.741 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-12-12T20:26:32.823Z,1734035192.823 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-12T20:26:32.823Z,1734035192.823 [Default:CheckIn:C.Wait] Stopped 2024-12-12T20:26:32.823Z,1734035192.823 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T20:26:32.824Z,1734035192.824 [Default:CheckIn:D] Running Loop=1 2024-12-12T20:26:33.217Z,1734035193.217 [Default:CheckIn:D] Stopped 2024-12-12T20:26:33.217Z,1734035193.217 [Default:CheckIn:E] Running Loop=1 2024-12-12T20:26:33.619Z,1734035193.619 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 108.441675 min 2024-12-12T20:26:33.619Z,1734035193.619 [Default:CheckIn:E] Stopped 2024-12-12T20:26:33.619Z,1734035193.619 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-12T20:26:33.619Z,1734035193.619 [Default:CheckIn] Stopped 2024-12-12T20:26:33.619Z,1734035193.619 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T20:26:33.620Z,1734035193.620 [Default:CheckIn](INFO): Running loop #18 2024-12-12T20:26:33.620Z,1734035193.620 [Default:CheckIn] Running Loop=18 2024-12-12T20:26:33.620Z,1734035193.620 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-12T20:26:33.620Z,1734035193.620 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-12T20:26:35.631Z,1734035195.631 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202641.00,A,3648.15722,N,12147.28120,W,1.050,80.20,121224,,,A*45 2024-12-12T20:26:35.633Z,1734035195.633 [NAL9602](INFO): GPS fix at 20241212T202641: (36.802620, -121.788020) 2024-12-12T20:26:35.644Z,1734035195.644 [Default:CheckIn:Read_GPS] Stopped 2024-12-12T20:26:35.644Z,1734035195.644 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-12T20:26:45.223Z,1734035205.223 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241212T185513/Courier0048.lzma 2024-12-12T20:26:46.226Z,1734035206.226 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Courier0048.lzma.bak 2024-12-12T20:26:46.226Z,1734035206.226 [DataOverHttps](INFO): SBD MOMSN=23674931 2024-12-12T20:27:03.460Z,1734035223.460 [DataOverHttps](INFO): Sending 217 bytes from file Logs/20241212T185513/Express0049.lzma 2024-12-12T20:27:04.462Z,1734035224.462 [DataOverHttps](INFO): Moved sent file to Logs/20241212T185513/Express0049.lzma.bak 2024-12-12T20:27:04.462Z,1734035224.462 [DataOverHttps](INFO): SBD MOMSN=23674934 2024-12-12T20:27:05.975Z,1734035225.975 [Default:CheckIn:Read_Iridium] Stopped 2024-12-12T20:27:05.992Z,1734035225.992 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-12T20:27:05.992Z,1734035225.992 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-12T20:27:07.977Z,1734035227.977 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-12T20:28:53.821Z,1734035333.821 [CommandExec](IMPORTANT): got command quit 2024-12-12T20:28:54.824Z,1734035334.824 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-12T20:28:54.824Z,1734035334.824 [CommandExec](INFO): Uninitializing the command executive. 2024-12-12T20:28:54.824Z,1734035334.824 [CommandExec](INFO): Uninitializing the command scheduler. 2024-12-12T20:28:54.824Z,1734035334.824 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:54.916Z,1734035334.916 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-12-12T20:28:54.916Z,1734035334.916 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-12-12T20:28:54.916Z,1734035334.916 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:54.917Z,1734035334.917 [NavChartDb](INFO): Join timeout helper Thread ID is 9491 2024-12-12T20:28:55.236Z,1734035335.236 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-12T20:28:55.236Z,1734035335.236 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:55.244Z,1734035335.244 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-12-12T20:28:55.244Z,1734035335.244 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:55.244Z,1734035335.244 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 9492 2024-12-12T20:28:55.584Z,1734035335.584 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-12T20:28:55.584Z,1734035335.584 [WetLabsBB2FL](INFO): Powering down 2024-12-12T20:28:55.585Z,1734035335.585 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:55.604Z,1734035335.604 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-12-12T20:28:55.604Z,1734035335.604 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:55.604Z,1734035335.604 [CTD_Seabird](INFO): Join timeout helper Thread ID is 9493 2024-12-12T20:28:56.072Z,1734035336.072 [CTD_Seabird](INFO): Powering down 2024-12-12T20:28:56.084Z,1734035336.084 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-12T20:28:56.084Z,1734035336.084 [CTD_Seabird](INFO): Powering down 2024-12-12T20:28:56.096Z,1734035336.096 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:56.096Z,1734035336.096 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-12-12T20:28:56.096Z,1734035336.096 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:56.097Z,1734035336.097 [Radio_Surface](INFO): Join timeout helper Thread ID is 9494 2024-12-12T20:28:56.424Z,1734035336.424 [Radio_Surface](INFO): Powering down 2024-12-12T20:28:56.425Z,1734035336.425 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-12T20:28:56.425Z,1734035336.425 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:56.432Z,1734035336.432 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-12-12T20:28:56.432Z,1734035336.432 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:56.432Z,1734035336.432 [Onboard](INFO): Join timeout helper Thread ID is 9495 2024-12-12T20:28:57.320Z,1734035337.320 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-12-12T20:28:58.172Z,1734035338.172 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-12T20:28:58.172Z,1734035338.172 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.182Z,1734035338.182 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-12-12T20:28:58.183Z,1734035338.183 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.183Z,1734035338.183 [DataOverHttps](INFO): Join timeout helper Thread ID is 9496 2024-12-12T20:28:58.324Z,1734035338.324 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-12T20:28:58.324Z,1734035338.324 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.329Z,1734035338.329 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-12-12T20:28:58.329Z,1734035338.329 [logger ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.329Z,1734035338.329 [logger](INFO): Join timeout helper Thread ID is 9497 2024-12-12T20:28:58.351Z,1734035338.351 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-12T20:28:58.352Z,1734035338.352 [logger ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.368Z,1734035338.368 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-12-12T20:28:58.369Z,1734035338.369 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.369Z,1734035338.369 [CommandLine](INFO): Join timeout helper Thread ID is 9498 2024-12-12T20:28:58.460Z,1734035338.460 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-12T20:28:58.460Z,1734035338.460 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.468Z,1734035338.468 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-12-12T20:28:58.469Z,1734035338.469 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.469Z,1734035338.469 [CommandExec](INFO): Join timeout helper Thread ID is 9499 2024-12-12T20:28:58.470Z,1734035338.470 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-12-12T20:28:58.471Z,1734035338.471 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.471Z,1734035338.471 [controlThread](INFO): Join timeout helper Thread ID is 9500 2024-12-12T20:28:58.656Z,1734035338.656 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-12T20:28:58.656Z,1734035338.656 [controlThread](DEBUG): Uninitializing ControlThread 2024-12-12T20:28:58.657Z,1734035338.657 [AHRS_M2](INFO): Powering down 2024-12-12T20:28:58.729Z,1734035338.729 [NAL9602](INFO): Powering down 2024-12-12T20:28:58.731Z,1734035338.731 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-12-12T20:28:58.731Z,1734035338.731 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-12-12T20:28:58.732Z,1734035338.732 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-12-12T20:28:58.733Z,1734035338.733 [MissionManager](INFO): Uninitializing Mission Default 2024-12-12T20:28:58.733Z,1734035338.733 [Default] Stopped 2024-12-12T20:28:58.733Z,1734035338.733 [Default](DEBUG): Aggregate::uninitialize Default 2024-12-12T20:28:58.733Z,1734035338.733 [Default:B.GoToSurface] Stopped 2024-12-12T20:28:58.733Z,1734035338.733 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-12-12T20:28:58.733Z,1734035338.733 [Default:CheckIn] Stopped 2024-12-12T20:28:58.733Z,1734035338.733 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-12T20:28:58.733Z,1734035338.733 [Default:CheckIn:C.Wait] Stopped 2024-12-12T20:28:58.733Z,1734035338.733 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-12T20:28:58.736Z,1734035338.736 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-12-12T20:28:58.737Z,1734035338.737 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-12-12T20:28:58.737Z,1734035338.737 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-12-12T20:28:58.737Z,1734035338.737 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-12-12T20:28:58.737Z,1734035338.737 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-12-12T20:28:58.737Z,1734035338.737 [BuoyancyServo](INFO): Powering down 2024-12-12T20:28:58.752Z,1734035338.752 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-12-12T20:28:58.752Z,1734035338.752 [ElevatorServo](INFO): Powering down 2024-12-12T20:28:58.753Z,1734035338.753 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-12-12T20:28:58.753Z,1734035338.753 [MassServo](INFO): Powering down 2024-12-12T20:28:58.754Z,1734035338.754 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-12-12T20:28:58.754Z,1734035338.754 [RudderServo](INFO): Powering down 2024-12-12T20:28:58.755Z,1734035338.755 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-12-12T20:28:58.755Z,1734035338.755 [ThrusterHE](INFO): Powering down 2024-12-12T20:28:58.756Z,1734035338.756 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-12-12T20:28:58.756Z,1734035338.756 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-12-12T20:28:58.756Z,1734035338.756 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-12-12T20:28:58.756Z,1734035338.756 [CBIT](DEBUG): Powering off loads. 2024-12-12T20:28:58.768Z,1734035338.768 [CBIT](DEBUG): Disabling WDT. 2024-12-12T20:28:58.780Z,1734035338.780 [CBIT](DEBUG): Opening all GF detection circuits. 2024-12-12T20:28:58.781Z,1734035338.781 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.834Z,1734035338.834 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.839Z,1734035338.839 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.845Z,1734035338.845 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.918Z,1734035338.918 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.923Z,1734035338.923 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:58.965Z,1734035338.965 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-12-12T20:28:59.074Z,1734035339.074 [logger ThreadHandler](INFO): Thread cancelled.