2024-11-13T15:35:08.968Z,1731512108.968 [CommandExec](IMPORTANT): got command restart logs 2024-11-13T15:37:21.652Z,1731512241.652 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T15:37:21.652Z,1731512241.652 [Default:CheckIn:C.Wait] Stopped 2024-11-13T15:37:21.652Z,1731512241.652 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T15:37:21.652Z,1731512241.652 [Default:CheckIn:D] Running Loop=1 2024-11-13T15:37:22.066Z,1731512242.066 [Default:CheckIn:D] Stopped 2024-11-13T15:37:22.066Z,1731512242.066 [Default:CheckIn:E] Running Loop=1 2024-11-13T15:37:22.497Z,1731512242.497 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 7.805066 min 2024-11-13T15:37:22.497Z,1731512242.497 [Default:CheckIn:E] Stopped 2024-11-13T15:37:22.497Z,1731512242.497 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T15:37:22.497Z,1731512242.497 [Default:CheckIn] Stopped 2024-11-13T15:37:22.497Z,1731512242.497 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T15:37:22.498Z,1731512242.498 [Default:CheckIn](INFO): Running loop #2 2024-11-13T15:37:22.498Z,1731512242.498 [Default:CheckIn] Running Loop=2 2024-11-13T15:37:22.498Z,1731512242.498 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T15:37:22.498Z,1731512242.498 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T15:37:24.474Z,1731512244.474 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,153723.00,A,3647.86683,N,12151.04114,W,0.505,278.10,131124,,,D*73 2024-11-13T15:37:24.476Z,1731512244.476 [NAL9602](INFO): GPS fix at 20241113T153723: (36.797781, -121.850686) 2024-11-13T15:37:24.487Z,1731512244.487 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T15:37:24.487Z,1731512244.487 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T15:37:31.742Z,1731512251.742 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241112T201328/Courier0102.lzma 2024-11-13T15:37:32.745Z,1731512252.745 [DataOverHttps](INFO): Moved sent file to Logs/20241112T201328/Courier0102.lzma.bak 2024-11-13T15:37:32.745Z,1731512252.745 [DataOverHttps](INFO): SBD MOMSN=23393248 2024-11-13T15:37:48.799Z,1731512268.799 [DataOverHttps](INFO): Sending 269 bytes from file Logs/20241113T153508/Courier0000.lzma 2024-11-13T15:37:49.800Z,1731512269.800 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0000.lzma.bak 2024-11-13T15:37:49.801Z,1731512269.801 [DataOverHttps](INFO): SBD MOMSN=23393251 2024-11-13T15:38:05.739Z,1731512285.739 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20241112T201328/Express0103.lzma 2024-11-13T15:38:06.741Z,1731512286.741 [DataOverHttps](INFO): Moved sent file to Logs/20241112T201328/Express0103.lzma.bak 2024-11-13T15:38:06.741Z,1731512286.741 [DataOverHttps](INFO): SBD MOMSN=23393255 2024-11-13T15:38:08.135Z,1731512288.135 [NAL9602](INFO): SBD MO Status=2, MOMSN=60000, MT Status=2, MTMSN=0 2024-11-13T15:38:08.135Z,1731512288.135 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-13T15:38:24.370Z,1731512304.370 [NAL9602](INFO): SBD MO Status=2, MOMSN=60000, MT Status=2, MTMSN=0 2024-11-13T15:38:24.370Z,1731512304.370 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-13T15:38:25.627Z,1731512305.627 [DataOverHttps](INFO): Sending 396 bytes from file Logs/20241113T153508/Express0001.lzma 2024-11-13T15:38:26.629Z,1731512306.629 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0001.lzma.bak 2024-11-13T15:38:26.629Z,1731512306.629 [DataOverHttps](INFO): SBD MOMSN=23393258 2024-11-13T15:38:49.406Z,1731512329.406 [NAL9602](INFO): SBD MO Status=2, MOMSN=60000, MT Status=2, MTMSN=0 2024-11-13T15:38:49.406Z,1731512329.406 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-13T15:39:29.211Z,1731512369.211 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T15:40:00.336Z,1731512400.336 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T15:40:31.459Z,1731512431.459 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T15:41:02.583Z,1731512462.583 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T15:41:14.033Z,1731512474.033 [NAL9602](INFO): SBD MO Status=2, MOMSN=60000, MT Status=2, MTMSN=0 2024-11-13T15:41:14.034Z,1731512474.034 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-13T15:41:22.651Z,1731512482.651 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20241113T153508/Express0004.lzma 2024-11-13T15:41:23.653Z,1731512483.653 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0004.lzma.bak 2024-11-13T15:41:23.653Z,1731512483.653 [DataOverHttps](INFO): SBD MOMSN=23393264 2024-11-13T15:41:24.990Z,1731512484.990 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T15:41:24.999Z,1731512484.999 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T15:41:24.999Z,1731512484.999 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T15:42:26.400Z,1731512546.400 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-11-13T15:42:57.096Z,1731512577.096 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T15:46:25.573Z,1731512785.573 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T15:46:25.574Z,1731512785.574 [Default:CheckIn:C.Wait] Stopped 2024-11-13T15:46:25.574Z,1731512785.574 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T15:46:25.574Z,1731512785.574 [Default:CheckIn:D] Running Loop=1 2024-11-13T15:46:25.986Z,1731512785.986 [Default:CheckIn:D] Stopped 2024-11-13T15:46:25.986Z,1731512785.986 [Default:CheckIn:E] Running Loop=1 2024-11-13T15:46:26.381Z,1731512786.381 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 16.870408 min 2024-11-13T15:46:26.381Z,1731512786.381 [Default:CheckIn:E] Stopped 2024-11-13T15:46:26.381Z,1731512786.381 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T15:46:26.381Z,1731512786.381 [Default:CheckIn] Stopped 2024-11-13T15:46:26.382Z,1731512786.382 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T15:46:26.382Z,1731512786.382 [Default:CheckIn](INFO): Running loop #3 2024-11-13T15:46:26.382Z,1731512786.382 [Default:CheckIn] Running Loop=3 2024-11-13T15:46:26.382Z,1731512786.382 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T15:46:26.382Z,1731512786.382 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T15:46:28.390Z,1731512788.390 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,154627.00,A,3648.43063,N,12149.61779,W,8.708,81.08,131124,,,D*42 2024-11-13T15:46:28.392Z,1731512788.392 [NAL9602](INFO): GPS fix at 20241113T154627: (36.807177, -121.826963) 2024-11-13T15:46:28.403Z,1731512788.403 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T15:46:28.403Z,1731512788.403 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T15:46:49.802Z,1731512809.802 [NAL9602](INFO): SBD MO Status=2, MOMSN=60000, MT Status=2, MTMSN=0 2024-11-13T15:46:49.802Z,1731512809.802 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-13T15:47:10.397Z,1731512830.397 [NAL9602](INFO): SBD MO Status=1, MOMSN=60000, MT Status=0, MTMSN=0 2024-11-13T15:47:10.398Z,1731512830.398 [NAL9602](INFO): No messages in MT queue 2024-11-13T15:47:30.911Z,1731512850.911 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T15:47:41.102Z,1731512861.102 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T15:47:52.338Z,1731512872.338 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0006.lzma 2024-11-13T15:47:53.340Z,1731512873.340 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0006.lzma.bak 2024-11-13T15:47:53.341Z,1731512873.341 [DataOverHttps](INFO): SBD MOMSN=23393269 2024-11-13T15:48:09.307Z,1731512889.307 [DataOverHttps](INFO): Sending 249 bytes from file Logs/20241113T153508/Express0007.lzma 2024-11-13T15:48:10.308Z,1731512890.308 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0007.lzma.bak 2024-11-13T15:48:10.309Z,1731512890.309 [DataOverHttps](INFO): SBD MOMSN=23393272 2024-11-13T15:48:11.434Z,1731512891.434 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T15:48:11.439Z,1731512891.439 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T15:48:11.439Z,1731512891.439 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T15:53:12.157Z,1731513192.157 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T15:53:12.157Z,1731513192.157 [Default:CheckIn:C.Wait] Stopped 2024-11-13T15:53:12.157Z,1731513192.157 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T15:53:12.158Z,1731513192.158 [Default:CheckIn:D] Running Loop=1 2024-11-13T15:53:12.553Z,1731513192.553 [Default:CheckIn:D] Stopped 2024-11-13T15:53:12.553Z,1731513192.553 [Default:CheckIn:E] Running Loop=1 2024-11-13T15:53:12.962Z,1731513192.962 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 23.646523 min 2024-11-13T15:53:12.962Z,1731513192.962 [Default:CheckIn:E] Stopped 2024-11-13T15:53:12.962Z,1731513192.962 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T15:53:12.962Z,1731513192.962 [Default:CheckIn] Stopped 2024-11-13T15:53:12.962Z,1731513192.962 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T15:53:12.962Z,1731513192.962 [Default:CheckIn](INFO): Running loop #4 2024-11-13T15:53:12.962Z,1731513192.962 [Default:CheckIn] Running Loop=4 2024-11-13T15:53:12.963Z,1731513192.963 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T15:53:12.963Z,1731513192.963 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T15:53:14.971Z,1731513194.971 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155314.00,A,3648.39571,N,12149.65953,W,0.972,283.39,131124,,,A*73 2024-11-13T15:53:14.973Z,1731513194.973 [NAL9602](INFO): GPS fix at 20241113T155314: (36.806595, -121.827659) 2024-11-13T15:53:14.984Z,1731513194.984 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T15:53:14.984Z,1731513194.984 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T15:53:22.242Z,1731513202.242 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0009.lzma 2024-11-13T15:53:23.244Z,1731513203.244 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0009.lzma.bak 2024-11-13T15:53:23.245Z,1731513203.245 [DataOverHttps](INFO): SBD MOMSN=23393276 2024-11-13T15:53:41.062Z,1731513221.062 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20241113T153508/Express0010.lzma 2024-11-13T15:53:42.065Z,1731513222.065 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0010.lzma.bak 2024-11-13T15:53:42.065Z,1731513222.065 [DataOverHttps](INFO): SBD MOMSN=23393279 2024-11-13T15:53:43.260Z,1731513223.260 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T15:53:43.260Z,1731513223.260 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T15:53:43.260Z,1731513223.260 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T15:53:49.313Z,1731513229.313 [NAL9602](INFO): SBD MO Status=2, MOMSN=60001, MT Status=2, MTMSN=0 2024-11-13T15:53:49.313Z,1731513229.313 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-13T15:54:02.241Z,1731513242.241 [NAL9602](INFO): SBD MO Status=1, MOMSN=60001, MT Status=0, MTMSN=0 2024-11-13T15:54:02.242Z,1731513242.242 [NAL9602](INFO): No messages in MT queue 2024-11-13T15:54:32.968Z,1731513272.968 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T15:58:44.065Z,1731513524.065 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T15:58:44.066Z,1731513524.066 [Default:CheckIn:C.Wait] Stopped 2024-11-13T15:58:44.066Z,1731513524.066 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T15:58:44.066Z,1731513524.066 [Default:CheckIn:D] Running Loop=1 2024-11-13T15:58:44.457Z,1731513524.457 [Default:CheckIn:D] Stopped 2024-11-13T15:58:44.457Z,1731513524.457 [Default:CheckIn:E] Running Loop=1 2024-11-13T15:58:44.866Z,1731513524.866 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 29.178261 min 2024-11-13T15:58:44.866Z,1731513524.866 [Default:CheckIn:E] Stopped 2024-11-13T15:58:44.866Z,1731513524.866 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T15:58:44.867Z,1731513524.867 [Default:CheckIn] Stopped 2024-11-13T15:58:44.867Z,1731513524.867 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T15:58:44.867Z,1731513524.867 [Default:CheckIn](INFO): Running loop #5 2024-11-13T15:58:44.867Z,1731513524.867 [Default:CheckIn] Running Loop=5 2024-11-13T15:58:44.867Z,1731513524.867 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T15:58:44.867Z,1731513524.867 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T15:58:46.889Z,1731513526.889 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155846.00,A,3648.41446,N,12149.73545,W,1.983,328.91,131124,,,A*74 2024-11-13T15:58:46.901Z,1731513526.901 [NAL9602](INFO): GPS fix at 20241113T155846: (36.806908, -121.828924) 2024-11-13T15:58:46.911Z,1731513526.911 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T15:58:46.912Z,1731513526.912 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T15:58:56.802Z,1731513536.802 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241113T153508/Courier0012.lzma 2024-11-13T15:58:57.805Z,1731513537.805 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0012.lzma.bak 2024-11-13T15:58:57.805Z,1731513537.805 [DataOverHttps](INFO): SBD MOMSN=23393284 2024-11-13T15:59:12.485Z,1731513552.485 [NAL9602](INFO): SBD MO Status=1, MOMSN=60002, MT Status=0, MTMSN=0 2024-11-13T15:59:12.485Z,1731513552.485 [NAL9602](INFO): No messages in MT queue 2024-11-13T15:59:13.698Z,1731513553.698 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20241113T153508/Express0013.lzma 2024-11-13T15:59:14.700Z,1731513554.700 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0013.lzma.bak 2024-11-13T15:59:14.701Z,1731513554.701 [DataOverHttps](INFO): SBD MOMSN=23393287 2024-11-13T15:59:15.786Z,1731513555.786 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T15:59:15.786Z,1731513555.786 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T15:59:15.786Z,1731513555.786 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T15:59:43.200Z,1731513583.200 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T16:02:51.531Z,1731513771.531 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:03:22.655Z,1731513802.655 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:03:53.779Z,1731513833.779 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:04:16.373Z,1731513856.373 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T16:04:16.373Z,1731513856.373 [Default:CheckIn:C.Wait] Stopped 2024-11-13T16:04:16.373Z,1731513856.373 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T16:04:16.373Z,1731513856.373 [Default:CheckIn:D] Running Loop=1 2024-11-13T16:04:16.782Z,1731513856.782 [Default:CheckIn:D] Stopped 2024-11-13T16:04:16.782Z,1731513856.782 [Default:CheckIn:E] Running Loop=1 2024-11-13T16:04:17.195Z,1731513857.195 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 34.717004 min 2024-11-13T16:04:17.195Z,1731513857.195 [Default:CheckIn:E] Stopped 2024-11-13T16:04:17.196Z,1731513857.196 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T16:04:17.196Z,1731513857.196 [Default:CheckIn] Stopped 2024-11-13T16:04:17.196Z,1731513857.196 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T16:04:17.196Z,1731513857.196 [Default:CheckIn](INFO): Running loop #6 2024-11-13T16:04:17.196Z,1731513857.196 [Default:CheckIn] Running Loop=6 2024-11-13T16:04:17.196Z,1731513857.196 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T16:04:17.196Z,1731513857.196 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T16:04:19.194Z,1731513859.194 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160418.00,A,3648.44831,N,12149.41487,W,4.393,82.05,131124,,,D*47 2024-11-13T16:04:19.196Z,1731513859.196 [NAL9602](INFO): GPS fix at 20241113T160418: (36.807472, -121.823581) 2024-11-13T16:04:19.234Z,1731513859.234 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T16:04:19.234Z,1731513859.234 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T16:04:24.903Z,1731513864.903 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:04:39.397Z,1731513879.397 [NAL9602](INFO): SBD MO Status=1, MOMSN=60003, MT Status=0, MTMSN=0 2024-11-13T16:04:39.397Z,1731513879.397 [NAL9602](INFO): No messages in MT queue 2024-11-13T16:04:46.542Z,1731513886.542 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.602463 2024-11-13T16:05:02.133Z,1731513902.133 [NAL9602](INFO): SBD MO Status=1, MOMSN=60004, MT Status=0, MTMSN=0 2024-11-13T16:05:02.191Z,1731513902.191 [NAL9602](INFO): Sent 74 bytes from file Logs/20241113T153508/Courier0015.lzma 2024-11-13T16:05:02.191Z,1731513902.191 [NAL9602](INFO): Packets left to send: 0 2024-11-13T16:05:12.739Z,1731513912.739 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003297 2024-11-13T16:05:13.502Z,1731513913.502 [NAL9602](INFO): SBD MO Status=1, MOMSN=60005, MT Status=0, MTMSN=0 2024-11-13T16:05:13.559Z,1731513913.559 [NAL9602](INFO): Sent 145 bytes from file Logs/20241113T153508/Express0016.lzma 2024-11-13T16:05:13.559Z,1731513913.559 [NAL9602](INFO): Packets left to send: 0 2024-11-13T16:05:13.926Z,1731513913.926 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T16:05:13.926Z,1731513913.926 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T16:05:13.926Z,1731513913.926 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T16:05:44.202Z,1731513944.202 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T16:08:47.551Z,1731514127.551 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:10:14.605Z,1731514214.605 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T16:10:14.605Z,1731514214.605 [Default:CheckIn:C.Wait] Stopped 2024-11-13T16:10:14.605Z,1731514214.605 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T16:10:14.605Z,1731514214.605 [Default:CheckIn:D] Running Loop=1 2024-11-13T16:10:15.015Z,1731514215.015 [Default:CheckIn:D] Stopped 2024-11-13T16:10:15.015Z,1731514215.015 [Default:CheckIn:E] Running Loop=1 2024-11-13T16:10:15.432Z,1731514215.432 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 40.687557 min 2024-11-13T16:10:15.432Z,1731514215.432 [Default:CheckIn:E] Stopped 2024-11-13T16:10:15.432Z,1731514215.432 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T16:10:15.432Z,1731514215.432 [Default:CheckIn] Stopped 2024-11-13T16:10:15.432Z,1731514215.432 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T16:10:15.433Z,1731514215.433 [Default:CheckIn](INFO): Running loop #7 2024-11-13T16:10:15.433Z,1731514215.433 [Default:CheckIn] Running Loop=7 2024-11-13T16:10:15.433Z,1731514215.433 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T16:10:15.433Z,1731514215.433 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T16:10:17.457Z,1731514217.457 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161016.00,A,3648.40274,N,12148.94495,W,4.276,96.38,131124,,,D*48 2024-11-13T16:10:17.460Z,1731514217.460 [NAL9602](INFO): GPS fix at 20241113T161016: (36.806712, -121.815749) 2024-11-13T16:10:17.470Z,1731514217.470 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T16:10:17.470Z,1731514217.470 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T16:10:30.761Z,1731514230.761 [NAL9602](INFO): SBD MO Status=0, MOMSN=60006, MT Status=0, MTMSN=0 2024-11-13T16:10:30.761Z,1731514230.761 [NAL9602](INFO): No messages in MT queue 2024-11-13T16:10:48.923Z,1731514248.923 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:11:01.461Z,1731514261.461 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T16:11:20.047Z,1731514280.047 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:11:51.171Z,1731514311.171 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:12:22.307Z,1731514342.307 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:12:53.431Z,1731514373.431 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:12:57.447Z,1731514377.447 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.763535 2024-11-13T16:13:17.705Z,1731514397.705 [NAL9602](INFO): SBD MO Status=1, MOMSN=60007, MT Status=0, MTMSN=0 2024-11-13T16:13:17.755Z,1731514397.755 [NAL9602](INFO): Sent 71 bytes from file Logs/20241113T153508/Courier0018.lzma 2024-11-13T16:13:17.755Z,1731514397.755 [NAL9602](INFO): Packets left to send: 0 2024-11-13T16:13:25.412Z,1731514405.412 [NAL9602](INFO): SBD MO Status=1, MOMSN=60008, MT Status=0, MTMSN=0 2024-11-13T16:13:25.459Z,1731514405.459 [NAL9602](INFO): Sent 144 bytes from file Logs/20241113T153508/Express0019.lzma 2024-11-13T16:13:25.459Z,1731514405.459 [NAL9602](INFO): Packets left to send: 0 2024-11-13T16:13:28.571Z,1731514408.571 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:13:33.494Z,1731514413.494 [NAL9602](INFO): SBD MO Status=0, MOMSN=60009, MT Status=0, MTMSN=0 2024-11-13T16:13:33.583Z,1731514413.583 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T16:13:33.583Z,1731514413.583 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T16:13:33.583Z,1731514413.583 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T16:13:59.695Z,1731514439.695 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:14:04.195Z,1731514444.195 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T16:14:30.835Z,1731514470.835 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:15:01.979Z,1731514501.979 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-11-13T16:15:32.639Z,1731514532.639 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003271 2024-11-13T16:18:34.149Z,1731514714.149 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T16:18:34.149Z,1731514714.149 [Default:CheckIn:C.Wait] Stopped 2024-11-13T16:18:34.150Z,1731514714.150 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T16:18:34.150Z,1731514714.150 [Default:CheckIn:D] Running Loop=1 2024-11-13T16:18:34.557Z,1731514714.557 [Default:CheckIn:D] Stopped 2024-11-13T16:18:34.558Z,1731514714.558 [Default:CheckIn:E] Running Loop=1 2024-11-13T16:18:34.954Z,1731514714.954 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 49.013265 min 2024-11-13T16:18:34.954Z,1731514714.954 [Default:CheckIn:E] Stopped 2024-11-13T16:18:34.954Z,1731514714.954 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T16:18:34.954Z,1731514714.954 [Default:CheckIn] Stopped 2024-11-13T16:18:34.954Z,1731514714.954 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T16:18:34.954Z,1731514714.954 [Default:CheckIn](INFO): Running loop #8 2024-11-13T16:18:34.954Z,1731514714.954 [Default:CheckIn] Running Loop=8 2024-11-13T16:18:34.955Z,1731514714.955 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T16:18:34.955Z,1731514714.955 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T16:18:36.966Z,1731514716.966 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161836.00,A,3648.32705,N,12148.26570,W,4.413,102.80,131124,,,D*7D 2024-11-13T16:18:36.968Z,1731514716.968 [NAL9602](INFO): GPS fix at 20241113T161836: (36.805451, -121.804428) 2024-11-13T16:18:36.979Z,1731514716.979 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T16:18:36.979Z,1731514716.979 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T16:18:45.014Z,1731514725.014 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0021.lzma 2024-11-13T16:18:46.016Z,1731514726.016 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0021.lzma.bak 2024-11-13T16:18:46.017Z,1731514726.017 [DataOverHttps](INFO): SBD MOMSN=23393305 2024-11-13T16:18:52.354Z,1731514732.354 [NAL9602](INFO): SBD MO Status=0, MOMSN=60010, MT Status=0, MTMSN=0 2024-11-13T16:18:52.354Z,1731514732.354 [NAL9602](INFO): No messages in MT queue 2024-11-13T16:19:04.838Z,1731514744.838 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20241113T153508/Express0022.lzma 2024-11-13T16:19:05.840Z,1731514745.840 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0022.lzma.bak 2024-11-13T16:19:05.841Z,1731514745.841 [DataOverHttps](INFO): SBD MOMSN=23393308 2024-11-13T16:19:06.929Z,1731514746.929 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T16:19:06.930Z,1731514746.930 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T16:19:06.930Z,1731514746.930 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T16:19:23.070Z,1731514763.070 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T16:24:07.502Z,1731515047.502 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T16:24:07.502Z,1731515047.502 [Default:CheckIn:C.Wait] Stopped 2024-11-13T16:24:07.502Z,1731515047.502 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T16:24:07.503Z,1731515047.503 [Default:CheckIn:D] Running Loop=1 2024-11-13T16:24:07.907Z,1731515047.907 [Default:CheckIn:D] Stopped 2024-11-13T16:24:07.907Z,1731515047.907 [Default:CheckIn:E] Running Loop=1 2024-11-13T16:24:08.319Z,1731515048.319 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 54.569096 min 2024-11-13T16:24:08.319Z,1731515048.319 [Default:CheckIn:E] Stopped 2024-11-13T16:24:08.320Z,1731515048.320 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T16:24:08.320Z,1731515048.320 [Default:CheckIn] Stopped 2024-11-13T16:24:08.320Z,1731515048.320 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T16:24:08.320Z,1731515048.320 [Default:CheckIn](INFO): Running loop #9 2024-11-13T16:24:08.320Z,1731515048.320 [Default:CheckIn] Running Loop=9 2024-11-13T16:24:08.320Z,1731515048.320 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T16:24:08.320Z,1731515048.320 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T16:24:10.317Z,1731515050.317 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162409.00,A,3648.31201,N,12147.93952,W,2.955,105.28,131124,,,D*7D 2024-11-13T16:24:10.319Z,1731515050.319 [NAL9602](INFO): GPS fix at 20241113T162409: (36.805200, -121.798992) 2024-11-13T16:24:10.330Z,1731515050.330 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T16:24:10.330Z,1731515050.330 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T16:24:17.671Z,1731515057.671 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0024.lzma 2024-11-13T16:24:18.673Z,1731515058.673 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0024.lzma.bak 2024-11-13T16:24:18.673Z,1731515058.673 [DataOverHttps](INFO): SBD MOMSN=23393312 2024-11-13T16:24:30.581Z,1731515070.581 [NAL9602](INFO): SBD MO Status=0, MOMSN=60011, MT Status=0, MTMSN=0 2024-11-13T16:24:30.581Z,1731515070.581 [NAL9602](INFO): No messages in MT queue 2024-11-13T16:24:37.092Z,1731515077.092 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20241113T153508/Express0025.lzma 2024-11-13T16:24:38.092Z,1731515078.092 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0025.lzma.bak 2024-11-13T16:24:38.093Z,1731515078.093 [DataOverHttps](INFO): SBD MOMSN=23393315 2024-11-13T16:24:39.474Z,1731515079.474 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T16:24:39.474Z,1731515079.474 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T16:24:39.491Z,1731515079.491 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T16:25:01.279Z,1731515101.279 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T16:27:17.042Z,1731515237.042 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T16:27:29.949Z,1731515249.949 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T16:27:42.877Z,1731515262.877 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T16:27:54.997Z,1731515274.997 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T16:28:08.733Z,1731515288.733 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T16:28:21.677Z,1731515301.677 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T16:28:34.202Z,1731515314.202 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T16:29:40.114Z,1731515380.114 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T16:29:40.114Z,1731515380.114 [Default:CheckIn:C.Wait] Stopped 2024-11-13T16:29:40.114Z,1731515380.114 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T16:29:40.115Z,1731515380.115 [Default:CheckIn:D] Running Loop=1 2024-11-13T16:29:40.522Z,1731515380.522 [Default:CheckIn:D] Stopped 2024-11-13T16:29:40.522Z,1731515380.522 [Default:CheckIn:E] Running Loop=1 2024-11-13T16:29:40.990Z,1731515380.990 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 60.112667 min 2024-11-13T16:29:40.990Z,1731515380.990 [Default:CheckIn:E] Stopped 2024-11-13T16:29:40.990Z,1731515380.990 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T16:29:40.990Z,1731515380.990 [Default:CheckIn] Stopped 2024-11-13T16:29:40.990Z,1731515380.990 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T16:29:40.990Z,1731515380.990 [Default:CheckIn](INFO): Running loop #10 2024-11-13T16:29:40.990Z,1731515380.990 [Default:CheckIn] Running Loop=10 2024-11-13T16:29:40.990Z,1731515380.990 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T16:29:40.991Z,1731515380.991 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T16:29:42.930Z,1731515382.930 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162942.00,A,3648.31699,N,12147.54568,W,2.741,80.13,131124,,,D*4B 2024-11-13T16:29:42.932Z,1731515382.932 [NAL9602](INFO): GPS fix at 20241113T162942: (36.805283, -121.792428) 2024-11-13T16:29:42.943Z,1731515382.943 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T16:29:42.943Z,1731515382.943 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T16:29:49.962Z,1731515389.962 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0027.lzma 2024-11-13T16:29:50.964Z,1731515390.964 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0027.lzma.bak 2024-11-13T16:29:50.965Z,1731515390.965 [DataOverHttps](INFO): SBD MOMSN=23393319 2024-11-13T16:30:05.165Z,1731515405.165 [NAL9602](INFO): SBD MO Status=2, MOMSN=60012, MT Status=2, MTMSN=0 2024-11-13T16:30:05.165Z,1731515405.165 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-13T16:30:06.827Z,1731515406.827 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20241113T153508/Express0028.lzma 2024-11-13T16:30:07.829Z,1731515407.829 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0028.lzma.bak 2024-11-13T16:30:07.829Z,1731515407.829 [DataOverHttps](INFO): SBD MOMSN=23393322 2024-11-13T16:30:09.214Z,1731515409.214 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T16:30:09.214Z,1731515409.214 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T16:30:09.214Z,1731515409.214 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T16:30:25.353Z,1731515425.353 [NAL9602](INFO): SBD MO Status=0, MOMSN=60012, MT Status=0, MTMSN=0 2024-11-13T16:30:25.354Z,1731515425.354 [NAL9602](INFO): No messages in MT queue 2024-11-13T16:30:56.058Z,1731515456.058 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T16:31:17.870Z,1731515477.870 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T16:31:32.009Z,1731515492.009 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T16:31:44.540Z,1731515504.540 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T16:31:57.865Z,1731515517.865 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T16:32:11.200Z,1731515531.200 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T16:32:24.933Z,1731515544.933 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T16:32:38.266Z,1731515558.266 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T16:32:51.597Z,1731515571.597 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T16:33:04.929Z,1731515584.929 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T16:33:18.261Z,1731515598.261 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T16:33:33.217Z,1731515613.217 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 5. 2024-11-13T16:33:33.219Z,1731515613.219 [BPC1](INFO): Received data from all battery sticks. 2024-11-13T16:35:09.829Z,1731515709.829 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T16:35:09.830Z,1731515709.830 [Default:CheckIn:C.Wait] Stopped 2024-11-13T16:35:09.830Z,1731515709.830 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T16:35:09.830Z,1731515709.830 [Default:CheckIn:D] Running Loop=1 2024-11-13T16:35:10.271Z,1731515710.271 [Default:CheckIn:D] Stopped 2024-11-13T16:35:10.271Z,1731515710.271 [Default:CheckIn:E] Running Loop=1 2024-11-13T16:35:10.647Z,1731515710.647 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 65.608407 min 2024-11-13T16:35:10.647Z,1731515710.647 [Default:CheckIn:E] Stopped 2024-11-13T16:35:10.647Z,1731515710.647 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T16:35:10.647Z,1731515710.647 [Default:CheckIn] Stopped 2024-11-13T16:35:10.647Z,1731515710.647 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T16:35:10.647Z,1731515710.647 [Default:CheckIn](INFO): Running loop #11 2024-11-13T16:35:10.647Z,1731515710.647 [Default:CheckIn] Running Loop=11 2024-11-13T16:35:10.647Z,1731515710.647 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T16:35:10.648Z,1731515710.648 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T16:35:12.653Z,1731515712.653 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,163511.00,A,3648.50417,N,12147.22730,W,4.063,51.74,131124,,,D*41 2024-11-13T16:35:12.656Z,1731515712.656 [NAL9602](INFO): GPS fix at 20241113T163511: (36.808403, -121.787122) 2024-11-13T16:35:12.667Z,1731515712.667 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T16:35:12.667Z,1731515712.667 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T16:35:20.263Z,1731515720.263 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20241113T153508/Courier0030.lzma 2024-11-13T16:35:21.265Z,1731515721.265 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0030.lzma.bak 2024-11-13T16:35:21.265Z,1731515721.265 [DataOverHttps](INFO): SBD MOMSN=23393326 2024-11-13T16:35:34.061Z,1731515734.061 [NAL9602](INFO): SBD MO Status=2, MOMSN=60013, MT Status=2, MTMSN=0 2024-11-13T16:35:34.061Z,1731515734.061 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-13T16:35:37.199Z,1731515737.199 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20241113T153508/Express0031.lzma 2024-11-13T16:35:38.201Z,1731515738.201 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0031.lzma.bak 2024-11-13T16:35:38.202Z,1731515738.202 [DataOverHttps](INFO): SBD MOMSN=23393329 2024-11-13T16:35:39.327Z,1731515739.327 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T16:35:39.327Z,1731515739.327 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T16:35:39.327Z,1731515739.327 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T16:36:18.500Z,1731515778.500 [NAL9602](INFO): SBD MO Status=0, MOMSN=60013, MT Status=0, MTMSN=0 2024-11-13T16:36:18.501Z,1731515778.501 [NAL9602](INFO): No messages in MT queue 2024-11-13T16:36:49.211Z,1731515809.211 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T16:40:39.946Z,1731516039.946 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T16:40:39.946Z,1731516039.946 [Default:CheckIn:C.Wait] Stopped 2024-11-13T16:40:39.946Z,1731516039.946 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T16:40:39.946Z,1731516039.946 [Default:CheckIn:D] Running Loop=1 2024-11-13T16:40:40.351Z,1731516040.351 [Default:CheckIn:D] Stopped 2024-11-13T16:40:40.351Z,1731516040.351 [Default:CheckIn:E] Running Loop=1 2024-11-13T16:40:40.741Z,1731516040.741 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 71.109814 min 2024-11-13T16:40:40.741Z,1731516040.741 [Default:CheckIn:E] Stopped 2024-11-13T16:40:40.741Z,1731516040.741 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T16:40:40.741Z,1731516040.741 [Default:CheckIn] Stopped 2024-11-13T16:40:40.741Z,1731516040.741 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T16:40:40.741Z,1731516040.741 [Default:CheckIn](INFO): Running loop #12 2024-11-13T16:40:40.741Z,1731516040.741 [Default:CheckIn] Running Loop=12 2024-11-13T16:40:40.742Z,1731516040.742 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T16:40:40.742Z,1731516040.742 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T16:40:42.757Z,1731516042.757 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164042.00,A,3648.41894,N,12147.12363,W,2.410,186.65,131124,,,D*7E 2024-11-13T16:40:42.760Z,1731516042.760 [NAL9602](INFO): GPS fix at 20241113T164042: (36.806982, -121.785394) 2024-11-13T16:40:42.771Z,1731516042.771 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T16:40:42.771Z,1731516042.771 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T16:40:52.814Z,1731516052.814 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0033.lzma 2024-11-13T16:40:53.817Z,1731516053.817 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0033.lzma.bak 2024-11-13T16:40:53.817Z,1731516053.817 [DataOverHttps](INFO): SBD MOMSN=23393333 2024-11-13T16:41:10.883Z,1731516070.883 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20241113T153508/Express0034.lzma 2024-11-13T16:41:11.885Z,1731516071.885 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0034.lzma.bak 2024-11-13T16:41:11.885Z,1731516071.885 [DataOverHttps](INFO): SBD MOMSN=23393336 2024-11-13T16:41:13.106Z,1731516073.106 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T16:41:13.106Z,1731516073.106 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T16:41:13.107Z,1731516073.107 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T16:41:22.784Z,1731516082.784 [NAL9602](INFO): SBD MO Status=0, MOMSN=60014, MT Status=0, MTMSN=0 2024-11-13T16:41:22.784Z,1731516082.784 [NAL9602](INFO): No messages in MT queue 2024-11-13T16:41:53.482Z,1731516113.482 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T16:46:13.847Z,1731516373.847 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T16:46:13.847Z,1731516373.847 [Default:CheckIn:C.Wait] Stopped 2024-11-13T16:46:13.847Z,1731516373.847 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T16:46:13.848Z,1731516373.848 [Default:CheckIn:D] Running Loop=1 2024-11-13T16:46:14.237Z,1731516374.237 [Default:CheckIn:D] Stopped 2024-11-13T16:46:14.237Z,1731516374.237 [Default:CheckIn:E] Running Loop=1 2024-11-13T16:46:14.651Z,1731516374.651 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 76.674593 min 2024-11-13T16:46:14.651Z,1731516374.651 [Default:CheckIn:E] Stopped 2024-11-13T16:46:14.651Z,1731516374.651 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T16:46:14.651Z,1731516374.651 [Default:CheckIn] Stopped 2024-11-13T16:46:14.651Z,1731516374.651 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T16:46:14.651Z,1731516374.651 [Default:CheckIn](INFO): Running loop #13 2024-11-13T16:46:14.652Z,1731516374.652 [Default:CheckIn] Running Loop=13 2024-11-13T16:46:14.652Z,1731516374.652 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T16:46:14.652Z,1731516374.652 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T16:46:16.654Z,1731516376.654 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164615.00,A,3648.13198,N,12147.19425,W,0.914,196.74,131124,,,D*7C 2024-11-13T16:46:16.656Z,1731516376.656 [NAL9602](INFO): GPS fix at 20241113T164615: (36.802200, -121.786571) 2024-11-13T16:46:16.667Z,1731516376.667 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T16:46:16.667Z,1731516376.667 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T16:46:26.983Z,1731516386.983 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0036.lzma 2024-11-13T16:46:27.985Z,1731516387.985 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0036.lzma.bak 2024-11-13T16:46:27.985Z,1731516387.985 [DataOverHttps](INFO): SBD MOMSN=23393340 2024-11-13T16:46:39.761Z,1731516399.761 [NAL9602](INFO): SBD MO Status=0, MOMSN=60015, MT Status=0, MTMSN=0 2024-11-13T16:46:39.761Z,1731516399.761 [NAL9602](INFO): No messages in MT queue 2024-11-13T16:46:43.690Z,1731516403.690 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20241113T153508/Express0037.lzma 2024-11-13T16:46:44.693Z,1731516404.693 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0037.lzma.bak 2024-11-13T16:46:44.693Z,1731516404.693 [DataOverHttps](INFO): SBD MOMSN=23393343 2024-11-13T16:46:45.830Z,1731516405.830 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T16:46:45.830Z,1731516405.830 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T16:46:45.830Z,1731516405.830 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T16:47:10.552Z,1731516430.552 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T16:51:46.374Z,1731516706.374 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T16:51:46.374Z,1731516706.374 [Default:CheckIn:C.Wait] Stopped 2024-11-13T16:51:46.374Z,1731516706.374 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T16:51:46.375Z,1731516706.375 [Default:CheckIn:D] Running Loop=1 2024-11-13T16:51:46.782Z,1731516706.782 [Default:CheckIn:D] Stopped 2024-11-13T16:51:46.782Z,1731516706.782 [Default:CheckIn:E] Running Loop=1 2024-11-13T16:51:47.196Z,1731516707.196 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 82.217008 min 2024-11-13T16:51:47.196Z,1731516707.196 [Default:CheckIn:E] Stopped 2024-11-13T16:51:47.196Z,1731516707.196 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T16:51:47.196Z,1731516707.196 [Default:CheckIn] Stopped 2024-11-13T16:51:47.196Z,1731516707.196 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T16:51:47.196Z,1731516707.196 [Default:CheckIn](INFO): Running loop #14 2024-11-13T16:51:47.196Z,1731516707.196 [Default:CheckIn] Running Loop=14 2024-11-13T16:51:47.196Z,1731516707.196 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T16:51:47.196Z,1731516707.196 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T16:51:49.194Z,1731516709.194 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165148.00,A,3648.13379,N,12147.20991,W,0.078,277.49,131124,,,D*76 2024-11-13T16:51:49.196Z,1731516709.196 [NAL9602](INFO): GPS fix at 20241113T165148: (36.802230, -121.786832) 2024-11-13T16:51:49.207Z,1731516709.207 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T16:51:49.207Z,1731516709.207 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T16:51:56.990Z,1731516716.990 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20241113T153508/Courier0039.lzma 2024-11-13T16:51:57.993Z,1731516717.993 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0039.lzma.bak 2024-11-13T16:51:57.993Z,1731516717.993 [DataOverHttps](INFO): SBD MOMSN=23393347 2024-11-13T16:52:13.847Z,1731516733.847 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20241113T153508/Express0040.lzma 2024-11-13T16:52:14.849Z,1731516734.849 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0040.lzma.bak 2024-11-13T16:52:14.849Z,1731516734.849 [DataOverHttps](INFO): SBD MOMSN=23393350 2024-11-13T16:52:16.279Z,1731516736.279 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T16:52:16.279Z,1731516736.279 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T16:52:16.279Z,1731516736.279 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T16:53:15.329Z,1731516795.329 [NAL9602](INFO): SBD MO Status=2, MOMSN=60016, MT Status=2, MTMSN=0 2024-11-13T16:53:15.329Z,1731516795.329 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-13T16:54:15.934Z,1731516855.934 [NAL9602](INFO): SBD MO Status=2, MOMSN=60016, MT Status=2, MTMSN=0 2024-11-13T16:54:15.934Z,1731516855.934 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-13T16:54:26.118Z,1731516866.118 [NAL9602](INFO): SBD MO Status=0, MOMSN=60016, MT Status=0, MTMSN=0 2024-11-13T16:54:26.118Z,1731516866.118 [NAL9602](INFO): No messages in MT queue 2024-11-13T16:54:56.856Z,1731516896.856 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T16:57:16.757Z,1731517036.757 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T16:57:16.757Z,1731517036.757 [Default:CheckIn:C.Wait] Stopped 2024-11-13T16:57:16.757Z,1731517036.757 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T16:57:16.758Z,1731517036.758 [Default:CheckIn:D] Running Loop=1 2024-11-13T16:57:17.168Z,1731517037.168 [Default:CheckIn:D] Stopped 2024-11-13T16:57:17.168Z,1731517037.168 [Default:CheckIn:E] Running Loop=1 2024-11-13T16:57:17.567Z,1731517037.567 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 87.723438 min 2024-11-13T16:57:17.567Z,1731517037.567 [Default:CheckIn:E] Stopped 2024-11-13T16:57:17.567Z,1731517037.567 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T16:57:17.567Z,1731517037.567 [Default:CheckIn] Stopped 2024-11-13T16:57:17.568Z,1731517037.568 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T16:57:17.568Z,1731517037.568 [Default:CheckIn](INFO): Running loop #15 2024-11-13T16:57:17.568Z,1731517037.568 [Default:CheckIn] Running Loop=15 2024-11-13T16:57:17.568Z,1731517037.568 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T16:57:17.568Z,1731517037.568 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T16:57:19.587Z,1731517039.587 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165718.00,A,3648.13847,N,12147.20714,W,0.039,26.32,131124,,,D*4F 2024-11-13T16:57:19.589Z,1731517039.589 [NAL9602](INFO): GPS fix at 20241113T165718: (36.802308, -121.786786) 2024-11-13T16:57:19.600Z,1731517039.600 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T16:57:19.600Z,1731517039.600 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T16:57:27.142Z,1731517047.142 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0042.lzma 2024-11-13T16:57:28.145Z,1731517048.145 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0042.lzma.bak 2024-11-13T16:57:28.145Z,1731517048.145 [DataOverHttps](INFO): SBD MOMSN=23393354 2024-11-13T16:57:29.273Z,1731517049.273 [NAL9602](INFO): SBD MO Status=0, MOMSN=60017, MT Status=0, MTMSN=0 2024-11-13T16:57:29.273Z,1731517049.273 [NAL9602](INFO): No messages in MT queue 2024-11-13T16:57:44.110Z,1731517064.110 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20241113T153508/Express0043.lzma 2024-11-13T16:57:45.113Z,1731517065.113 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0043.lzma.bak 2024-11-13T16:57:45.113Z,1731517065.113 [DataOverHttps](INFO): SBD MOMSN=23393358 2024-11-13T16:57:46.258Z,1731517066.258 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T16:57:46.258Z,1731517066.258 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T16:57:46.259Z,1731517066.259 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T16:57:59.988Z,1731517079.988 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T17:02:46.731Z,1731517366.731 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T17:02:46.731Z,1731517366.731 [Default:CheckIn:C.Wait] Stopped 2024-11-13T17:02:46.731Z,1731517366.731 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T17:02:46.732Z,1731517366.732 [Default:CheckIn:D] Running Loop=1 2024-11-13T17:02:47.104Z,1731517367.104 [Default:CheckIn:D] Stopped 2024-11-13T17:02:47.104Z,1731517367.104 [Default:CheckIn:E] Running Loop=1 2024-11-13T17:02:47.562Z,1731517367.562 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 93.222363 min 2024-11-13T17:02:47.562Z,1731517367.562 [Default:CheckIn:E] Stopped 2024-11-13T17:02:47.562Z,1731517367.562 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T17:02:47.562Z,1731517367.562 [Default:CheckIn] Stopped 2024-11-13T17:02:47.562Z,1731517367.562 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T17:02:47.563Z,1731517367.563 [Default:CheckIn](INFO): Running loop #16 2024-11-13T17:02:47.563Z,1731517367.563 [Default:CheckIn] Running Loop=16 2024-11-13T17:02:47.563Z,1731517367.563 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T17:02:47.563Z,1731517367.563 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T17:02:49.517Z,1731517369.517 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170248.00,A,3648.14016,N,12147.21014,W,0.058,331.89,131124,,,D*74 2024-11-13T17:02:49.520Z,1731517369.520 [NAL9602](INFO): GPS fix at 20241113T170248: (36.802336, -121.786836) 2024-11-13T17:02:49.563Z,1731517369.563 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T17:02:49.564Z,1731517369.564 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T17:02:59.718Z,1731517379.718 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20241113T153508/Courier0045.lzma 2024-11-13T17:03:00.721Z,1731517380.721 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0045.lzma.bak 2024-11-13T17:03:00.721Z,1731517380.721 [DataOverHttps](INFO): SBD MOMSN=23393361 2024-11-13T17:03:03.315Z,1731517383.315 [NAL9602](INFO): SBD MO Status=0, MOMSN=60018, MT Status=0, MTMSN=0 2024-11-13T17:03:03.315Z,1731517383.315 [NAL9602](INFO): No messages in MT queue 2024-11-13T17:03:16.547Z,1731517396.547 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20241113T153508/Express0046.lzma 2024-11-13T17:03:17.549Z,1731517397.549 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0046.lzma.bak 2024-11-13T17:03:17.549Z,1731517397.549 [DataOverHttps](INFO): SBD MOMSN=23393364 2024-11-13T17:03:18.674Z,1731517398.674 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T17:03:18.674Z,1731517398.674 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T17:03:18.674Z,1731517398.674 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T17:03:34.011Z,1731517414.011 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T17:08:19.430Z,1731517699.430 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T17:08:19.430Z,1731517699.430 [Default:CheckIn:C.Wait] Stopped 2024-11-13T17:08:19.430Z,1731517699.430 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T17:08:19.455Z,1731517699.455 [Default:CheckIn:D] Running Loop=1 2024-11-13T17:08:19.843Z,1731517699.843 [Default:CheckIn:D] Stopped 2024-11-13T17:08:19.843Z,1731517699.843 [Default:CheckIn:E] Running Loop=1 2024-11-13T17:08:20.252Z,1731517700.252 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 98.768018 min 2024-11-13T17:08:20.252Z,1731517700.252 [Default:CheckIn:E] Stopped 2024-11-13T17:08:20.252Z,1731517700.252 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T17:08:20.252Z,1731517700.252 [Default:CheckIn] Stopped 2024-11-13T17:08:20.252Z,1731517700.252 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T17:08:20.252Z,1731517700.252 [Default:CheckIn](INFO): Running loop #17 2024-11-13T17:08:20.252Z,1731517700.252 [Default:CheckIn] Running Loop=17 2024-11-13T17:08:20.253Z,1731517700.253 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T17:08:20.253Z,1731517700.253 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T17:08:22.250Z,1731517702.250 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170821.00,A,3648.14563,N,12147.25219,W,0.058,297.14,131124,,,D*74 2024-11-13T17:08:22.252Z,1731517702.252 [NAL9602](INFO): GPS fix at 20241113T170821: (36.802427, -121.787537) 2024-11-13T17:08:22.271Z,1731517702.271 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T17:08:22.271Z,1731517702.271 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T17:08:30.498Z,1731517710.498 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0048.lzma 2024-11-13T17:08:31.500Z,1731517711.500 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0048.lzma.bak 2024-11-13T17:08:31.501Z,1731517711.501 [DataOverHttps](INFO): SBD MOMSN=23393368 2024-11-13T17:08:35.462Z,1731517715.462 [NAL9602](INFO): SBD MO Status=0, MOMSN=60019, MT Status=0, MTMSN=0 2024-11-13T17:08:35.462Z,1731517715.462 [NAL9602](INFO): No messages in MT queue 2024-11-13T17:08:47.567Z,1731517727.567 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20241113T153508/Express0049.lzma 2024-11-13T17:08:48.569Z,1731517728.569 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0049.lzma.bak 2024-11-13T17:08:48.569Z,1731517728.569 [DataOverHttps](INFO): SBD MOMSN=23393371 2024-11-13T17:08:49.696Z,1731517729.696 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T17:08:49.696Z,1731517729.696 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T17:08:49.696Z,1731517729.696 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T17:09:06.208Z,1731517746.208 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T17:13:50.257Z,1731518030.257 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T17:13:50.257Z,1731518030.257 [Default:CheckIn:C.Wait] Stopped 2024-11-13T17:13:50.258Z,1731518030.258 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T17:13:50.258Z,1731518030.258 [Default:CheckIn:D] Running Loop=1 2024-11-13T17:13:50.662Z,1731518030.662 [Default:CheckIn:D] Stopped 2024-11-13T17:13:50.662Z,1731518030.662 [Default:CheckIn:E] Running Loop=1 2024-11-13T17:13:51.080Z,1731518031.080 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 104.281673 min 2024-11-13T17:13:51.080Z,1731518031.080 [Default:CheckIn:E] Stopped 2024-11-13T17:13:51.080Z,1731518031.080 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T17:13:51.080Z,1731518031.080 [Default:CheckIn] Stopped 2024-11-13T17:13:51.080Z,1731518031.080 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T17:13:51.080Z,1731518031.080 [Default:CheckIn](INFO): Running loop #18 2024-11-13T17:13:51.080Z,1731518031.080 [Default:CheckIn] Running Loop=18 2024-11-13T17:13:51.080Z,1731518031.080 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T17:13:51.080Z,1731518031.080 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T17:13:53.078Z,1731518033.078 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171352.00,A,3648.17456,N,12147.27845,W,0.019,276.94,131124,,,D*7D 2024-11-13T17:13:53.080Z,1731518033.080 [NAL9602](INFO): GPS fix at 20241113T171352: (36.802909, -121.787974) 2024-11-13T17:13:53.114Z,1731518033.114 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T17:13:53.115Z,1731518033.115 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T17:14:00.266Z,1731518040.266 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20241113T153508/Courier0051.lzma 2024-11-13T17:14:01.268Z,1731518041.268 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0051.lzma.bak 2024-11-13T17:14:01.269Z,1731518041.269 [DataOverHttps](INFO): SBD MOMSN=23393384 2024-11-13T17:14:09.642Z,1731518049.642 [NAL9602](INFO): SBD MO Status=0, MOMSN=60020, MT Status=0, MTMSN=0 2024-11-13T17:14:09.642Z,1731518049.642 [NAL9602](INFO): No messages in MT queue 2024-11-13T17:14:17.051Z,1731518057.051 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20241113T153508/Express0052.lzma 2024-11-13T17:14:18.053Z,1731518058.053 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0052.lzma.bak 2024-11-13T17:14:18.053Z,1731518058.053 [DataOverHttps](INFO): SBD MOMSN=23393387 2024-11-13T17:14:19.359Z,1731518059.359 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T17:14:19.359Z,1731518059.359 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T17:14:19.359Z,1731518059.359 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T17:14:40.400Z,1731518080.400 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T17:19:20.078Z,1731518360.078 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T17:19:20.078Z,1731518360.078 [Default:CheckIn:C.Wait] Stopped 2024-11-13T17:19:20.078Z,1731518360.078 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T17:19:20.078Z,1731518360.078 [Default:CheckIn:D] Running Loop=1 2024-11-13T17:19:20.478Z,1731518360.478 [Default:CheckIn:D] Stopped 2024-11-13T17:19:20.478Z,1731518360.478 [Default:CheckIn:E] Running Loop=1 2024-11-13T17:19:20.886Z,1731518360.886 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 109.778605 min 2024-11-13T17:19:20.886Z,1731518360.886 [Default:CheckIn:E] Stopped 2024-11-13T17:19:20.886Z,1731518360.886 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T17:19:20.886Z,1731518360.886 [Default:CheckIn] Stopped 2024-11-13T17:19:20.887Z,1731518360.887 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T17:19:20.887Z,1731518360.887 [Default:CheckIn](INFO): Running loop #19 2024-11-13T17:19:20.887Z,1731518360.887 [Default:CheckIn] Running Loop=19 2024-11-13T17:19:20.887Z,1731518360.887 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T17:19:20.887Z,1731518360.887 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T17:19:22.894Z,1731518362.894 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171922.00,A,3648.17332,N,12147.28148,W,0.117,276.94,131124,,,D*71 2024-11-13T17:19:22.896Z,1731518362.896 [NAL9602](INFO): GPS fix at 20241113T171922: (36.802889, -121.788025) 2024-11-13T17:19:22.927Z,1731518362.927 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T17:19:22.927Z,1731518362.927 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T17:19:30.594Z,1731518370.594 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0054.lzma 2024-11-13T17:19:31.597Z,1731518371.597 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0054.lzma.bak 2024-11-13T17:19:31.597Z,1731518371.597 [DataOverHttps](INFO): SBD MOMSN=23393391 2024-11-13T17:19:40.273Z,1731518380.273 [NAL9602](INFO): SBD MO Status=0, MOMSN=60021, MT Status=0, MTMSN=0 2024-11-13T17:19:40.273Z,1731518380.273 [NAL9602](INFO): No messages in MT queue 2024-11-13T17:19:47.502Z,1731518387.502 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20241113T153508/Express0055.lzma 2024-11-13T17:19:48.505Z,1731518388.505 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0055.lzma.bak 2024-11-13T17:19:48.505Z,1731518388.505 [DataOverHttps](INFO): SBD MOMSN=23393394 2024-11-13T17:19:49.970Z,1731518389.970 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T17:19:49.970Z,1731518389.970 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T17:19:49.970Z,1731518389.970 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T17:20:10.973Z,1731518410.973 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T17:24:50.630Z,1731518690.630 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T17:24:50.630Z,1731518690.630 [Default:CheckIn:C.Wait] Stopped 2024-11-13T17:24:50.630Z,1731518690.630 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T17:24:50.630Z,1731518690.630 [Default:CheckIn:D] Running Loop=1 2024-11-13T17:24:51.034Z,1731518691.034 [Default:CheckIn:D] Stopped 2024-11-13T17:24:51.034Z,1731518691.034 [Default:CheckIn:E] Running Loop=1 2024-11-13T17:24:51.437Z,1731518691.437 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 115.287866 min 2024-11-13T17:24:51.438Z,1731518691.438 [Default:CheckIn:E] Stopped 2024-11-13T17:24:51.438Z,1731518691.438 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T17:24:51.438Z,1731518691.438 [Default:CheckIn] Stopped 2024-11-13T17:24:51.438Z,1731518691.438 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T17:24:51.438Z,1731518691.438 [Default:CheckIn](INFO): Running loop #20 2024-11-13T17:24:51.438Z,1731518691.438 [Default:CheckIn] Running Loop=20 2024-11-13T17:24:51.438Z,1731518691.438 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T17:24:51.438Z,1731518691.438 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T17:24:53.450Z,1731518693.450 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172452.00,A,3648.17359,N,12147.27849,W,0.136,276.94,131124,,,D*71 2024-11-13T17:24:53.452Z,1731518693.452 [NAL9602](INFO): GPS fix at 20241113T172452: (36.802893, -121.787975) 2024-11-13T17:24:53.496Z,1731518693.496 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T17:24:53.496Z,1731518693.496 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T17:25:00.882Z,1731518700.882 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20241113T153508/Courier0057.lzma 2024-11-13T17:25:01.885Z,1731518701.885 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0057.lzma.bak 2024-11-13T17:25:01.885Z,1731518701.885 [DataOverHttps](INFO): SBD MOMSN=23393398 2024-11-13T17:25:17.795Z,1731518717.795 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20241113T153508/Express0058.lzma 2024-11-13T17:25:18.797Z,1731518718.797 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0058.lzma.bak 2024-11-13T17:25:18.797Z,1731518718.797 [DataOverHttps](INFO): SBD MOMSN=23393401 2024-11-13T17:25:20.208Z,1731518720.208 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T17:25:20.208Z,1731518720.208 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T17:25:20.208Z,1731518720.208 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T17:26:58.890Z,1731518818.890 [NAL9602](INFO): SBD MO Status=0, MOMSN=60022, MT Status=0, MTMSN=0 2024-11-13T17:26:58.890Z,1731518818.890 [NAL9602](INFO): No messages in MT queue 2024-11-13T17:27:29.574Z,1731518849.574 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T17:30:20.892Z,1731519020.892 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T17:30:20.892Z,1731519020.892 [Default:CheckIn:C.Wait] Stopped 2024-11-13T17:30:20.892Z,1731519020.892 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T17:30:20.892Z,1731519020.892 [Default:CheckIn:D] Running Loop=1 2024-11-13T17:30:21.294Z,1731519021.294 [Default:CheckIn:D] Stopped 2024-11-13T17:30:21.294Z,1731519021.294 [Default:CheckIn:E] Running Loop=1 2024-11-13T17:30:21.690Z,1731519021.690 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 120.792204 min 2024-11-13T17:30:21.690Z,1731519021.690 [Default:CheckIn:E] Stopped 2024-11-13T17:30:21.690Z,1731519021.690 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T17:30:21.690Z,1731519021.690 [Default:CheckIn] Stopped 2024-11-13T17:30:21.690Z,1731519021.690 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T17:30:21.690Z,1731519021.690 [Default:CheckIn](INFO): Running loop #21 2024-11-13T17:30:21.690Z,1731519021.690 [Default:CheckIn] Running Loop=21 2024-11-13T17:30:21.690Z,1731519021.690 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T17:30:21.707Z,1731519021.707 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T17:30:23.701Z,1731519023.701 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173022.00,A,3648.17425,N,12147.27795,W,0.058,276.94,131124,,,A*7D 2024-11-13T17:30:23.704Z,1731519023.704 [NAL9602](INFO): GPS fix at 20241113T173022: (36.802904, -121.787966) 2024-11-13T17:30:23.723Z,1731519023.723 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T17:30:23.723Z,1731519023.723 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T17:30:31.658Z,1731519031.658 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0060.lzma 2024-11-13T17:30:32.661Z,1731519032.661 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0060.lzma.bak 2024-11-13T17:30:32.662Z,1731519032.662 [DataOverHttps](INFO): SBD MOMSN=23393406 2024-11-13T17:30:35.822Z,1731519035.822 [NAL9602](INFO): SBD MO Status=0, MOMSN=60023, MT Status=0, MTMSN=0 2024-11-13T17:30:35.822Z,1731519035.822 [NAL9602](INFO): No messages in MT queue 2024-11-13T17:30:48.871Z,1731519048.871 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20241113T153508/Express0061.lzma 2024-11-13T17:30:49.873Z,1731519049.873 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0061.lzma.bak 2024-11-13T17:30:49.873Z,1731519049.873 [DataOverHttps](INFO): SBD MOMSN=23393409 2024-11-13T17:30:51.201Z,1731519051.201 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T17:30:51.201Z,1731519051.201 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T17:30:51.201Z,1731519051.201 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T17:31:06.563Z,1731519066.563 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T17:34:39.889Z,1731519279.889 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T17:34:52.413Z,1731519292.413 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T17:35:05.745Z,1731519305.745 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T17:35:18.674Z,1731519318.674 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T17:35:31.197Z,1731519331.197 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T17:35:44.531Z,1731519344.531 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T17:35:51.818Z,1731519351.818 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T17:35:51.818Z,1731519351.818 [Default:CheckIn:C.Wait] Stopped 2024-11-13T17:35:51.818Z,1731519351.818 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T17:35:51.819Z,1731519351.819 [Default:CheckIn:D] Running Loop=1 2024-11-13T17:35:52.222Z,1731519352.222 [Default:CheckIn:D] Stopped 2024-11-13T17:35:52.222Z,1731519352.222 [Default:CheckIn:E] Running Loop=1 2024-11-13T17:35:52.631Z,1731519352.631 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 126.307666 min 2024-11-13T17:35:52.631Z,1731519352.631 [Default:CheckIn:E] Stopped 2024-11-13T17:35:52.631Z,1731519352.631 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T17:35:52.631Z,1731519352.631 [Default:CheckIn] Stopped 2024-11-13T17:35:52.631Z,1731519352.631 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T17:35:52.632Z,1731519352.632 [Default:CheckIn](INFO): Running loop #22 2024-11-13T17:35:52.632Z,1731519352.632 [Default:CheckIn] Running Loop=22 2024-11-13T17:35:52.632Z,1731519352.632 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T17:35:52.632Z,1731519352.632 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T17:35:54.638Z,1731519354.638 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173553.00,A,3648.17597,N,12147.27377,W,0.058,20.54,131124,,,A*43 2024-11-13T17:35:54.648Z,1731519354.648 [NAL9602](INFO): GPS fix at 20241113T173553: (36.802933, -121.787896) 2024-11-13T17:35:54.659Z,1731519354.659 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T17:35:54.659Z,1731519354.659 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T17:35:57.054Z,1731519357.054 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-13T17:36:01.850Z,1731519361.850 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0063.lzma 2024-11-13T17:36:02.853Z,1731519362.853 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0063.lzma.bak 2024-11-13T17:36:02.853Z,1731519362.853 [DataOverHttps](INFO): SBD MOMSN=23393415 2024-11-13T17:36:11.621Z,1731519371.621 [NAL9602](INFO): SBD MO Status=0, MOMSN=60024, MT Status=0, MTMSN=0 2024-11-13T17:36:11.621Z,1731519371.621 [NAL9602](INFO): No messages in MT queue 2024-11-13T17:36:19.847Z,1731519379.847 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20241113T153508/Express0064.lzma 2024-11-13T17:36:20.849Z,1731519380.849 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0064.lzma.bak 2024-11-13T17:36:20.849Z,1731519380.849 [DataOverHttps](INFO): SBD MOMSN=23393418 2024-11-13T17:36:22.138Z,1731519382.138 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T17:36:22.138Z,1731519382.138 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T17:36:22.138Z,1731519382.138 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T17:36:26.184Z,1731519386.184 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-11-13T17:36:26.184Z,1731519386.184 [DropWeight] Hardware Fault, FailCount= 1 2024-11-13T17:36:26.184Z,1731519386.184 [DropWeight](ERROR): Hardware Fault 2024-11-13T17:36:26.289Z,1731519386.289 [CommandExec](FAULT): Scheduling is paused 2024-11-13T17:36:26.290Z,1731519386.290 [CBIT](INFO): Critical error at 20241113T173626 2024-11-13T17:36:26.310Z,1731519386.310 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-11-13T17:36:26.315Z,1731519386.315 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-11-13T17:36:26.688Z,1731519386.688 [CBIT](INFO): Critical error at 20241113T173626 2024-11-13T17:36:42.030Z,1731519402.030 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T17:38:32.645Z,1731519512.645 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T17:38:38.301Z,1731519518.301 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T17:38:52.040Z,1731519532.040 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T17:39:05.774Z,1731519545.774 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T17:39:19.915Z,1731519559.915 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T17:39:33.649Z,1731519573.649 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T17:39:46.981Z,1731519586.981 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T17:40:00.315Z,1731519600.315 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T17:40:13.645Z,1731519613.645 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T17:40:27.381Z,1731519627.381 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T17:40:40.715Z,1731519640.715 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T17:40:54.045Z,1731519654.045 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-11-13T17:40:54.071Z,1731519654.071 [BPC1](INFO): Calculating totals. Valid battery stick count: 48. Valid reserve battery stick count: 5. 2024-11-13T17:40:54.074Z,1731519654.074 [BPC1](INFO): Received data from all battery sticks. 2024-11-13T17:41:22.745Z,1731519682.745 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T17:41:22.745Z,1731519682.745 [Default:CheckIn:C.Wait] Stopped 2024-11-13T17:41:22.745Z,1731519682.745 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T17:41:22.746Z,1731519682.746 [Default:CheckIn:D] Running Loop=1 2024-11-13T17:41:23.155Z,1731519683.155 [Default:CheckIn:D] Stopped 2024-11-13T17:41:23.156Z,1731519683.156 [Default:CheckIn:E] Running Loop=1 2024-11-13T17:41:23.555Z,1731519683.555 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 131.823234 min 2024-11-13T17:41:23.555Z,1731519683.555 [Default:CheckIn:E] Stopped 2024-11-13T17:41:23.555Z,1731519683.555 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T17:41:23.555Z,1731519683.555 [Default:CheckIn] Stopped 2024-11-13T17:41:23.555Z,1731519683.555 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T17:41:23.556Z,1731519683.556 [Default:CheckIn](INFO): Running loop #23 2024-11-13T17:41:23.556Z,1731519683.556 [Default:CheckIn] Running Loop=23 2024-11-13T17:41:23.556Z,1731519683.556 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T17:41:23.556Z,1731519683.556 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T17:41:25.565Z,1731519685.565 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174124.00,A,3648.17036,N,12147.27305,W,0.058,130.98,131124,,,A*7B 2024-11-13T17:41:25.578Z,1731519685.578 [NAL9602](INFO): GPS fix at 20241113T174124: (36.802839, -121.787884) 2024-11-13T17:41:25.589Z,1731519685.589 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T17:41:25.589Z,1731519685.589 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T17:41:33.523Z,1731519693.523 [DataOverHttps](INFO): Sending 193 bytes from file Logs/20241113T153508/Courier0066.lzma 2024-11-13T17:41:34.525Z,1731519694.525 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0066.lzma.bak 2024-11-13T17:41:34.525Z,1731519694.525 [DataOverHttps](INFO): SBD MOMSN=23393424 2024-11-13T17:41:50.323Z,1731519710.323 [DataOverHttps](INFO): Sending 159 bytes from file Logs/20241113T153508/Express0067.lzma 2024-11-13T17:41:51.325Z,1731519711.325 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0067.lzma.bak 2024-11-13T17:41:51.325Z,1731519711.325 [DataOverHttps](INFO): SBD MOMSN=23393429 2024-11-13T17:41:52.655Z,1731519712.655 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T17:41:52.655Z,1731519712.655 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T17:41:52.655Z,1731519712.655 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T17:42:01.522Z,1731519721.522 [NAL9602](INFO): SBD MO Status=0, MOMSN=60025, MT Status=0, MTMSN=0 2024-11-13T17:42:01.522Z,1731519721.522 [NAL9602](INFO): No messages in MT queue 2024-11-13T17:42:32.223Z,1731519752.223 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T17:46:53.228Z,1731520013.228 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T17:46:53.228Z,1731520013.228 [Default:CheckIn:C.Wait] Stopped 2024-11-13T17:46:53.228Z,1731520013.228 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T17:46:53.229Z,1731520013.229 [Default:CheckIn:D] Running Loop=1 2024-11-13T17:46:53.629Z,1731520013.629 [Default:CheckIn:D] Stopped 2024-11-13T17:46:53.629Z,1731520013.629 [Default:CheckIn:E] Running Loop=1 2024-11-13T17:46:54.025Z,1731520014.025 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 137.331136 min 2024-11-13T17:46:54.025Z,1731520014.025 [Default:CheckIn:E] Stopped 2024-11-13T17:46:54.025Z,1731520014.025 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T17:46:54.025Z,1731520014.025 [Default:CheckIn] Stopped 2024-11-13T17:46:54.025Z,1731520014.025 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T17:46:54.025Z,1731520014.025 [Default:CheckIn](INFO): Running loop #24 2024-11-13T17:46:54.025Z,1731520014.025 [Default:CheckIn] Running Loop=24 2024-11-13T17:46:54.025Z,1731520014.025 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T17:46:54.026Z,1731520014.026 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T17:46:56.037Z,1731520016.037 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174655.00,A,3648.17159,N,12147.27862,W,0.369,321.18,131124,,,A*73 2024-11-13T17:46:56.040Z,1731520016.040 [NAL9602](INFO): GPS fix at 20241113T174655: (36.802860, -121.787977) 2024-11-13T17:46:56.055Z,1731520016.055 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T17:46:56.056Z,1731520016.056 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T17:47:03.670Z,1731520023.670 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0069.lzma 2024-11-13T17:47:04.673Z,1731520024.673 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0069.lzma.bak 2024-11-13T17:47:04.673Z,1731520024.673 [DataOverHttps](INFO): SBD MOMSN=23393434 2024-11-13T17:47:20.606Z,1731520040.606 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20241113T153508/Express0070.lzma 2024-11-13T17:47:21.609Z,1731520041.609 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0070.lzma.bak 2024-11-13T17:47:21.609Z,1731520041.609 [DataOverHttps](INFO): SBD MOMSN=23393437 2024-11-13T17:47:22.714Z,1731520042.714 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T17:47:22.714Z,1731520042.714 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T17:47:22.714Z,1731520042.714 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T17:48:26.129Z,1731520106.129 [NAL9602](INFO): SBD MO Status=2, MOMSN=60026, MT Status=2, MTMSN=0 2024-11-13T17:48:26.129Z,1731520106.129 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-13T17:49:09.361Z,1731520149.361 [NAL9602](INFO): SBD MO Status=2, MOMSN=60026, MT Status=2, MTMSN=0 2024-11-13T17:49:09.361Z,1731520149.361 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-13T17:51:26.357Z,1731520286.357 [CBIT](INFO): Clearing failed state for component DropWeight 2024-11-13T17:51:26.357Z,1731520286.357 [DropWeight] No Fault, FailCount= 1 2024-11-13T17:51:58.236Z,1731520318.236 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-11-13T17:52:23.320Z,1731520343.320 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T17:52:23.320Z,1731520343.320 [Default:CheckIn:C.Wait] Stopped 2024-11-13T17:52:23.321Z,1731520343.321 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T17:52:23.321Z,1731520343.321 [Default:CheckIn:D] Running Loop=1 2024-11-13T17:52:23.702Z,1731520343.702 [Default:CheckIn:D] Stopped 2024-11-13T17:52:23.702Z,1731520343.702 [Default:CheckIn:E] Running Loop=1 2024-11-13T17:52:24.107Z,1731520344.107 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 142.832340 min 2024-11-13T17:52:24.107Z,1731520344.107 [Default:CheckIn:E] Stopped 2024-11-13T17:52:24.107Z,1731520344.107 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T17:52:24.108Z,1731520344.108 [Default:CheckIn] Stopped 2024-11-13T17:52:24.108Z,1731520344.108 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T17:52:24.108Z,1731520344.108 [Default:CheckIn](INFO): Running loop #25 2024-11-13T17:52:24.108Z,1731520344.108 [Default:CheckIn] Running Loop=25 2024-11-13T17:52:24.108Z,1731520344.108 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T17:52:24.108Z,1731520344.108 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T17:52:28.942Z,1731520348.942 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175228.00,A,3648.16473,N,12147.28107,W,1.769,344.62,131124,,,A*7E 2024-11-13T17:52:28.944Z,1731520348.944 [NAL9602](INFO): GPS fix at 20241113T175228: (36.802746, -121.788018) 2024-11-13T17:52:28.975Z,1731520348.975 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T17:52:28.975Z,1731520348.975 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T17:52:34.562Z,1731520354.562 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241113T153508/Courier0072.lzma 2024-11-13T17:52:35.565Z,1731520355.565 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0072.lzma.bak 2024-11-13T17:52:35.565Z,1731520355.565 [DataOverHttps](INFO): SBD MOMSN=23393440 2024-11-13T17:52:54.075Z,1731520374.075 [DataOverHttps](INFO): Sending 208 bytes from file Logs/20241113T153508/Express0073.lzma 2024-11-13T17:52:55.077Z,1731520375.077 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0073.lzma.bak 2024-11-13T17:52:55.077Z,1731520375.077 [DataOverHttps](INFO): SBD MOMSN=23393443 2024-11-13T17:52:56.462Z,1731520376.462 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T17:52:56.462Z,1731520376.462 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T17:52:56.462Z,1731520376.462 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T17:53:01.708Z,1731520381.708 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T17:57:57.052Z,1731520677.052 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-13T17:57:57.052Z,1731520677.052 [Default:CheckIn:C.Wait] Stopped 2024-11-13T17:57:57.053Z,1731520677.053 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T17:57:57.053Z,1731520677.053 [Default:CheckIn:D] Running Loop=1 2024-11-13T17:57:57.462Z,1731520677.462 [Default:CheckIn:D] Stopped 2024-11-13T17:57:57.462Z,1731520677.462 [Default:CheckIn:E] Running Loop=1 2024-11-13T17:57:57.866Z,1731520677.866 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 148.395003 min 2024-11-13T17:57:57.866Z,1731520677.866 [Default:CheckIn:E] Stopped 2024-11-13T17:57:57.866Z,1731520677.866 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-13T17:57:57.866Z,1731520677.866 [Default:CheckIn] Stopped 2024-11-13T17:57:57.866Z,1731520677.866 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T17:57:57.866Z,1731520677.866 [Default:CheckIn](INFO): Running loop #26 2024-11-13T17:57:57.866Z,1731520677.866 [Default:CheckIn] Running Loop=26 2024-11-13T17:57:57.867Z,1731520677.867 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-13T17:57:57.867Z,1731520677.867 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-13T17:58:30.587Z,1731520710.587 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-11-13T17:58:30.671Z,1731520710.671 [NAL9602](ERROR): received: +CSQ:0 OK026, 2, 0, 0, 0 OK 2024-11-13T18:02:58.043Z,1731520978.043 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-11-13T17:57:57.9Z 2024-11-13T18:02:58.043Z,1731520978.043 [Default:CheckIn:Read_GPS] Stopped 2024-11-13T18:02:58.043Z,1731520978.043 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-13T18:03:02.476Z,1731520982.476 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-11-13T18:03:06.182Z,1731520986.182 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241113T153508/Courier0075.lzma 2024-11-13T18:03:07.185Z,1731520987.185 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Courier0075.lzma.bak 2024-11-13T18:03:07.185Z,1731520987.185 [DataOverHttps](INFO): SBD MOMSN=23393635 2024-11-13T18:03:23.054Z,1731521003.054 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20241113T153508/Express0076.lzma 2024-11-13T18:03:24.057Z,1731521004.057 [DataOverHttps](INFO): Moved sent file to Logs/20241113T153508/Express0076.lzma.bak 2024-11-13T18:03:24.057Z,1731521004.057 [DataOverHttps](INFO): SBD MOMSN=23393644 2024-11-13T18:03:25.166Z,1731521005.166 [Default:CheckIn:Read_Iridium] Stopped 2024-11-13T18:03:25.166Z,1731521005.166 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-13T18:03:25.166Z,1731521005.166 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-13T18:03:33.180Z,1731521013.180 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-13T18:03:35.943Z,1731521015.943 [CommandExec](IMPORTANT): got command failComponent 2024-11-13T18:03:35.943Z,1731521015.943 [CommandExec](IMPORTANT): Failed components: 2024-11-13T18:03:35.944Z,1731521015.944 [CommandExec](IMPORTANT): No failed Components. 2024-11-13T18:03:39.588Z,1731521019.588 [CommandExec](IMPORTANT): got command quit 2024-11-13T18:03:40.815Z,1731521020.815 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-13T18:03:40.815Z,1731521020.815 [CommandExec](INFO): Uninitializing the command executive. 2024-11-13T18:03:40.815Z,1731521020.815 [CommandExec](INFO): Uninitializing the command scheduler. 2024-11-13T18:03:40.815Z,1731521020.815 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:40.966Z,1731521020.966 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-11-13T18:03:40.967Z,1731521020.967 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-11-13T18:03:40.967Z,1731521020.967 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:40.968Z,1731521020.968 [NavChartDb](INFO): Join timeout helper Thread ID is 6426 2024-11-13T18:03:41.035Z,1731521021.035 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-13T18:03:41.035Z,1731521021.035 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:41.051Z,1731521021.051 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-11-13T18:03:41.051Z,1731521021.051 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:41.052Z,1731521021.052 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6427 2024-11-13T18:03:41.375Z,1731521021.375 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-13T18:03:41.375Z,1731521021.375 [WetLabsBB2FL](INFO): Powering down 2024-11-13T18:03:41.376Z,1731521021.376 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:41.379Z,1731521021.379 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-11-13T18:03:41.379Z,1731521021.379 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:41.379Z,1731521021.379 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6428 2024-11-13T18:03:41.559Z,1731521021.559 [CTD_Seabird](INFO): Powering down 2024-11-13T18:03:41.571Z,1731521021.571 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-13T18:03:41.572Z,1731521021.572 [CTD_Seabird](INFO): Powering down 2024-11-13T18:03:41.583Z,1731521021.583 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:41.599Z,1731521021.599 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-11-13T18:03:41.599Z,1731521021.599 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:41.599Z,1731521021.599 [Radio_Surface](INFO): Join timeout helper Thread ID is 6429 2024-11-13T18:03:41.972Z,1731521021.972 [Radio_Surface](INFO): Powering down 2024-11-13T18:03:41.973Z,1731521021.973 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-13T18:03:41.973Z,1731521021.973 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:41.987Z,1731521021.987 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-11-13T18:03:41.987Z,1731521021.987 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:41.987Z,1731521021.987 [Onboard](INFO): Join timeout helper Thread ID is 6430 2024-11-13T18:03:42.555Z,1731521022.555 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-11-13T18:03:43.395Z,1731521023.395 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-13T18:03:43.395Z,1731521023.395 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:43.416Z,1731521023.416 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-11-13T18:03:43.416Z,1731521023.416 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:43.416Z,1731521023.416 [DataOverHttps](INFO): Join timeout helper Thread ID is 6431 2024-11-13T18:03:43.559Z,1731521023.559 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-13T18:03:43.559Z,1731521023.559 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:43.567Z,1731521023.567 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-11-13T18:03:43.567Z,1731521023.567 [logger ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:43.568Z,1731521023.568 [logger](INFO): Join timeout helper Thread ID is 6432 2024-11-13T18:03:43.576Z,1731521023.576 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-13T18:03:43.576Z,1731521023.576 [logger ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:43.587Z,1731521023.587 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-11-13T18:03:43.587Z,1731521023.587 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:43.588Z,1731521023.588 [CommandLine](INFO): Join timeout helper Thread ID is 6433 2024-11-13T18:03:43.591Z,1731521023.591 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-13T18:03:43.591Z,1731521023.591 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:43.607Z,1731521023.607 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-11-13T18:03:43.607Z,1731521023.607 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:43.608Z,1731521023.608 [CommandExec](INFO): Join timeout helper Thread ID is 6434 2024-11-13T18:03:43.609Z,1731521023.609 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-11-13T18:03:43.609Z,1731521023.609 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:43.609Z,1731521023.609 [controlThread](INFO): Join timeout helper Thread ID is 6435 2024-11-13T18:03:43.667Z,1731521023.667 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-13T18:03:43.667Z,1731521023.667 [controlThread](DEBUG): Uninitializing ControlThread 2024-11-13T18:03:43.668Z,1731521023.668 [AHRS_M2](INFO): Powering down 2024-11-13T18:03:43.739Z,1731521023.739 [NAL9602](INFO): Powering down 2024-11-13T18:03:43.741Z,1731521023.741 [Sonardyne_Nano](INFO): Powering down 2024-11-13T18:03:43.860Z,1731521023.860 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-11-13T18:03:43.861Z,1731521023.861 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-11-13T18:03:43.861Z,1731521023.861 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-11-13T18:03:43.862Z,1731521023.862 [MissionManager](INFO): Uninitializing Mission Default 2024-11-13T18:03:43.862Z,1731521023.862 [Default] Stopped 2024-11-13T18:03:43.862Z,1731521023.862 [Default](DEBUG): Aggregate::uninitialize Default 2024-11-13T18:03:43.862Z,1731521023.862 [Default:B.GoToSurface] Stopped 2024-11-13T18:03:43.862Z,1731521023.862 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-11-13T18:03:43.862Z,1731521023.862 [Default:CheckIn] Stopped 2024-11-13T18:03:43.863Z,1731521023.863 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-13T18:03:43.863Z,1731521023.863 [Default:CheckIn:C.Wait] Stopped 2024-11-13T18:03:43.863Z,1731521023.863 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-13T18:03:43.865Z,1731521023.865 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-11-13T18:03:43.866Z,1731521023.866 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-11-13T18:03:43.866Z,1731521023.866 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-11-13T18:03:43.866Z,1731521023.866 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-11-13T18:03:43.867Z,1731521023.867 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-11-13T18:03:43.867Z,1731521023.867 [BuoyancyServo](INFO): Powering down 2024-11-13T18:03:43.879Z,1731521023.879 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-11-13T18:03:43.879Z,1731521023.879 [ElevatorServo](INFO): Powering down 2024-11-13T18:03:43.880Z,1731521023.880 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-11-13T18:03:43.880Z,1731521023.880 [MassServo](INFO): Powering down 2024-11-13T18:03:43.881Z,1731521023.881 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-11-13T18:03:43.881Z,1731521023.881 [RudderServo](INFO): Powering down 2024-11-13T18:03:43.881Z,1731521023.881 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-11-13T18:03:43.882Z,1731521023.882 [ThrusterHE](INFO): Powering down 2024-11-13T18:03:43.882Z,1731521023.882 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-11-13T18:03:43.883Z,1731521023.883 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-11-13T18:03:43.883Z,1731521023.883 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-11-13T18:03:43.883Z,1731521023.883 [CBIT](DEBUG): Powering off loads. 2024-11-13T18:03:43.894Z,1731521023.894 [CBIT](DEBUG): Disabling WDT. 2024-11-13T18:03:43.906Z,1731521023.906 [CBIT](DEBUG): Opening all GF detection circuits. 2024-11-13T18:03:43.907Z,1731521023.907 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:43.973Z,1731521023.973 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:43.976Z,1731521023.976 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:43.982Z,1731521023.982 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:44.056Z,1731521024.056 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:44.060Z,1731521024.060 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:44.103Z,1731521024.103 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-13T18:03:44.207Z,1731521024.207 [logger ThreadHandler](INFO): Thread cancelled.