2024-06-12T20:57:56.829Z,1718225876.829 [CommandExec](IMPORTANT): got command restart logs
2024-06-12T20:58:43.550Z,1718225923.550 [NAL9602](INFO): SBD MO Status=0, MOMSN=52750, MT Status=0, MTMSN=0
2024-06-12T20:58:43.550Z,1718225923.550 [NAL9602](INFO): No messages in MT queue
2024-06-12T20:59:14.258Z,1718225954.258 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T21:02:12.435Z,1718226132.435 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T21:02:12.435Z,1718226132.435 [Default:CheckIn:C.Wait] Stopped
2024-06-12T21:02:12.435Z,1718226132.435 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T21:02:12.436Z,1718226132.436 [Default:CheckIn:D] Running Loop=1
2024-06-12T21:02:12.835Z,1718226132.835 [Default:CheckIn:D] Stopped
2024-06-12T21:02:12.835Z,1718226132.835 [Default:CheckIn:E] Running Loop=1
2024-06-12T21:02:13.240Z,1718226133.240 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  41.515361 min 
2024-06-12T21:02:13.240Z,1718226133.240 [Default:CheckIn:E] Stopped
2024-06-12T21:02:13.240Z,1718226133.240 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T21:02:13.240Z,1718226133.240 [Default:CheckIn] Stopped
2024-06-12T21:02:13.240Z,1718226133.240 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T21:02:13.240Z,1718226133.240 [Default:CheckIn](INFO): Running loop #8
2024-06-12T21:02:13.240Z,1718226133.240 [Default:CheckIn] Running Loop=8
2024-06-12T21:02:13.240Z,1718226133.240 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T21:02:13.240Z,1718226133.240 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T21:02:15.267Z,1718226135.267 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210222.00,A,3647.97666,N,12149.53148,W,19.769,79.48,120624,,,A*76
2024-06-12T21:02:15.299Z,1718226135.299 [NAL9602](INFO): GPS fix at 20240612T210222: (36.799611, -121.825525)
2024-06-12T21:02:15.313Z,1718226135.313 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T21:02:15.313Z,1718226135.313 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T21:02:36.254Z,1718226156.254 [NAL9602](INFO): SBD MO Status=0, MOMSN=52751, MT Status=0, MTMSN=0
2024-06-12T21:02:36.254Z,1718226156.254 [NAL9602](INFO): No messages in MT queue
2024-06-12T21:02:56.292Z,1718226176.292 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-06-12T21:03:06.961Z,1718226186.961 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T21:03:27.420Z,1718226207.420 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-06-12T21:03:58.552Z,1718226238.552 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-06-12T21:04:29.688Z,1718226269.688 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-06-12T21:04:44.748Z,1718226284.749 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.239517
2024-06-12T21:05:00.130Z,1718226300.130 [NAL9602](INFO): SBD MO Status=1, MOMSN=52752, MT Status=0, MTMSN=0
2024-06-12T21:05:00.180Z,1718226300.180 [NAL9602](INFO): Sent 39 bytes from file Logs/20240612T123000/Courier0057.lzma
2024-06-12T21:05:00.180Z,1718226300.180 [NAL9602](INFO): Packets left to send: 0
2024-06-12T21:05:10.307Z,1718226310.307 [NAL9602](INFO): SBD MO Status=1, MOMSN=52753, MT Status=0, MTMSN=0
2024-06-12T21:05:10.385Z,1718226310.385 [NAL9602](INFO): Sent 269 bytes from file Logs/20240612T205756/Courier0000.lzma
2024-06-12T21:05:10.385Z,1718226310.385 [NAL9602](INFO): Packets left to send: 0
2024-06-12T21:05:15.872Z,1718226315.872 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-06-12T21:05:20.818Z,1718226320.818 [NAL9602](INFO): SBD MO Status=1, MOMSN=52754, MT Status=0, MTMSN=0
2024-06-12T21:05:20.884Z,1718226320.884 [NAL9602](INFO): Sent 115 bytes from file Logs/20240612T123000/Express0058.lzma
2024-06-12T21:05:20.884Z,1718226320.884 [NAL9602](INFO): Packets left to send: 0
2024-06-12T21:05:28.947Z,1718226328.947 [NAL9602](INFO): SBD MO Status=1, MOMSN=52755, MT Status=0, MTMSN=0
2024-06-12T21:05:29.004Z,1718226329.004 [NAL9602](INFO): Sent 332 bytes from file Logs/20240612T205756/Express0001.lzma
2024-06-12T21:05:29.004Z,1718226329.004 [NAL9602](INFO): Packets left to send: 1
2024-06-12T21:05:36.218Z,1718226336.218 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004353
2024-06-12T21:05:36.318Z,1718226336.318 [NAL9602](INFO): SBD MO Status=1, MOMSN=52756, MT Status=0, MTMSN=0
2024-06-12T21:05:36.368Z,1718226336.368 [NAL9602](INFO): Sent 126 bytes from file Logs/20240612T205756/Express0001.lzma
2024-06-12T21:05:36.368Z,1718226336.368 [NAL9602](INFO): Packets left to send: 0
2024-06-12T21:05:43.600Z,1718226343.600 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20240612T205756/Express0004.lzma
2024-06-12T21:05:45.073Z,1718226345.073 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0004.lzma.bak
2024-06-12T21:05:45.073Z,1718226345.073 [DataOverHttps](INFO): SBD MOMSN=21202140
2024-06-12T21:05:46.028Z,1718226346.028 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T21:05:46.029Z,1718226346.029 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T21:05:46.029Z,1718226346.029 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T21:06:07.017Z,1718226367.017 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T21:10:46.604Z,1718226646.604 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T21:10:46.604Z,1718226646.604 [Default:CheckIn:C.Wait] Stopped
2024-06-12T21:10:46.604Z,1718226646.604 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T21:10:46.604Z,1718226646.604 [Default:CheckIn:D] Running Loop=1
2024-06-12T21:10:47.009Z,1718226647.009 [Default:CheckIn:D] Stopped
2024-06-12T21:10:47.009Z,1718226647.009 [Default:CheckIn:E] Running Loop=1
2024-06-12T21:10:47.426Z,1718226647.426 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  50.084916 min 
2024-06-12T21:10:47.426Z,1718226647.426 [Default:CheckIn:E] Stopped
2024-06-12T21:10:47.426Z,1718226647.426 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T21:10:47.426Z,1718226647.426 [Default:CheckIn] Stopped
2024-06-12T21:10:47.427Z,1718226647.427 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T21:10:47.427Z,1718226647.427 [Default:CheckIn](INFO): Running loop #9
2024-06-12T21:10:47.427Z,1718226647.427 [Default:CheckIn] Running Loop=9
2024-06-12T21:10:47.427Z,1718226647.427 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T21:10:47.427Z,1718226647.427 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T21:10:49.414Z,1718226649.414 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211057.00,A,3648.28828,N,12147.13959,W,4.257,190.92,120624,,,A*7F
2024-06-12T21:10:49.417Z,1718226649.417 [NAL9602](INFO): GPS fix at 20240612T211057: (36.804805, -121.785660)
2024-06-12T21:10:49.428Z,1718226649.428 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T21:10:49.428Z,1718226649.428 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T21:10:56.607Z,1718226656.607 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240612T205756/Courier0006.lzma
2024-06-12T21:10:57.610Z,1718226657.610 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0006.lzma.bak
2024-06-12T21:10:57.610Z,1718226657.610 [DataOverHttps](INFO): SBD MOMSN=21202159
2024-06-12T21:11:13.604Z,1718226673.604 [DataOverHttps](INFO): Sending 163 bytes from file Logs/20240612T205756/Express0007.lzma
2024-06-12T21:11:14.606Z,1718226674.606 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0007.lzma.bak
2024-06-12T21:11:14.606Z,1718226674.606 [DataOverHttps](INFO): SBD MOMSN=21202162
2024-06-12T21:11:15.674Z,1718226675.674 [NAL9602](INFO): SBD MO Status=2, MOMSN=52757, MT Status=2, MTMSN=0
2024-06-12T21:11:15.674Z,1718226675.674 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-06-12T21:11:16.123Z,1718226676.123 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T21:11:16.123Z,1718226676.123 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T21:11:16.123Z,1718226676.123 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T21:11:36.686Z,1718226696.686 [NAL9602](INFO): SBD MO Status=2, MOMSN=52757, MT Status=2, MTMSN=0
2024-06-12T21:11:36.686Z,1718226696.686 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-06-12T21:12:12.243Z,1718226732.243 [NAL9602](INFO): SBD MO Status=2, MOMSN=52757, MT Status=2, MTMSN=0
2024-06-12T21:12:12.243Z,1718226732.243 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-06-12T21:12:30.418Z,1718226750.418 [NAL9602](INFO): SBD MO Status=0, MOMSN=52757, MT Status=0, MTMSN=0
2024-06-12T21:12:30.419Z,1718226750.419 [NAL9602](INFO): No messages in MT queue
2024-06-12T21:13:01.121Z,1718226781.121 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T21:16:16.662Z,1718226976.662 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T21:16:16.663Z,1718226976.663 [Default:CheckIn:C.Wait] Stopped
2024-06-12T21:16:16.663Z,1718226976.663 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T21:16:16.663Z,1718226976.663 [Default:CheckIn:D] Running Loop=1
2024-06-12T21:16:17.068Z,1718226977.068 [Default:CheckIn:D] Stopped
2024-06-12T21:16:17.068Z,1718226977.068 [Default:CheckIn:E] Running Loop=1
2024-06-12T21:16:17.479Z,1718226977.479 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  55.585905 min 
2024-06-12T21:16:17.479Z,1718226977.479 [Default:CheckIn:E] Stopped
2024-06-12T21:16:17.479Z,1718226977.479 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T21:16:17.479Z,1718226977.479 [Default:CheckIn] Stopped
2024-06-12T21:16:17.479Z,1718226977.479 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T21:16:17.480Z,1718226977.480 [Default:CheckIn](INFO): Running loop #10
2024-06-12T21:16:17.480Z,1718226977.480 [Default:CheckIn] Running Loop=10
2024-06-12T21:16:17.480Z,1718226977.480 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T21:16:17.480Z,1718226977.480 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T21:16:19.482Z,1718226979.482 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211627.00,A,3648.15038,N,12147.22156,W,0.039,235.88,120624,,,A*75
2024-06-12T21:16:19.484Z,1718226979.484 [NAL9602](INFO): GPS fix at 20240612T211627: (36.802506, -121.787026)
2024-06-12T21:16:19.495Z,1718226979.495 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T21:16:19.495Z,1718226979.495 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T21:16:27.471Z,1718226987.471 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240612T205756/Courier0009.lzma
2024-06-12T21:16:28.475Z,1718226988.475 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0009.lzma.bak
2024-06-12T21:16:28.475Z,1718226988.475 [DataOverHttps](INFO): SBD MOMSN=21202222
2024-06-12T21:16:44.584Z,1718227004.584 [DataOverHttps](INFO): Sending 160 bytes from file Logs/20240612T205756/Express0010.lzma
2024-06-12T21:16:45.586Z,1718227005.586 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0010.lzma.bak
2024-06-12T21:16:45.586Z,1718227005.586 [DataOverHttps](INFO): SBD MOMSN=21202225
2024-06-12T21:16:46.975Z,1718227006.975 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T21:16:46.975Z,1718227006.975 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T21:16:46.975Z,1718227006.975 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T21:17:04.326Z,1718227024.326 [NAL9602](INFO): SBD MO Status=0, MOMSN=52758, MT Status=0, MTMSN=0
2024-06-12T21:17:04.326Z,1718227024.326 [NAL9602](INFO): No messages in MT queue
2024-06-12T21:17:35.029Z,1718227055.029 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T21:21:47.551Z,1718227307.551 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T21:21:47.551Z,1718227307.551 [Default:CheckIn:C.Wait] Stopped
2024-06-12T21:21:47.551Z,1718227307.551 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T21:21:47.551Z,1718227307.551 [Default:CheckIn:D] Running Loop=1
2024-06-12T21:21:47.947Z,1718227307.947 [Default:CheckIn:D] Stopped
2024-06-12T21:21:47.947Z,1718227307.947 [Default:CheckIn:E] Running Loop=1
2024-06-12T21:21:48.347Z,1718227308.347 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  61.100562 min 
2024-06-12T21:21:48.347Z,1718227308.347 [Default:CheckIn:E] Stopped
2024-06-12T21:21:48.347Z,1718227308.347 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T21:21:48.347Z,1718227308.347 [Default:CheckIn] Stopped
2024-06-12T21:21:48.347Z,1718227308.347 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T21:21:48.347Z,1718227308.347 [Default:CheckIn](INFO): Running loop #11
2024-06-12T21:21:48.347Z,1718227308.347 [Default:CheckIn] Running Loop=11
2024-06-12T21:21:48.348Z,1718227308.348 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T21:21:48.348Z,1718227308.348 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T21:21:50.367Z,1718227310.367 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212158.00,A,3648.14995,N,12147.22212,W,0.039,235.88,120624,,,A*75
2024-06-12T21:21:50.369Z,1718227310.369 [NAL9602](INFO): GPS fix at 20240612T212158: (36.802499, -121.787035)
2024-06-12T21:21:50.380Z,1718227310.380 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T21:21:50.380Z,1718227310.380 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T21:21:58.359Z,1718227318.359 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240612T205756/Courier0012.lzma
2024-06-12T21:21:59.362Z,1718227319.362 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0012.lzma.bak
2024-06-12T21:21:59.362Z,1718227319.362 [DataOverHttps](INFO): SBD MOMSN=21202237
2024-06-12T21:22:15.444Z,1718227335.444 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20240612T205756/Express0013.lzma
2024-06-12T21:22:16.446Z,1718227336.446 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0013.lzma.bak
2024-06-12T21:22:16.446Z,1718227336.446 [DataOverHttps](INFO): SBD MOMSN=21202240
2024-06-12T21:22:17.853Z,1718227337.853 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T21:22:17.853Z,1718227337.853 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T21:22:17.853Z,1718227337.853 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T21:25:18.839Z,1718227518.839 [NAL9602](INFO): SBD MO Status=2, MOMSN=52759, MT Status=2, MTMSN=0
2024-06-12T21:25:18.839Z,1718227518.839 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-06-12T21:26:44.487Z,1718227604.487 [NAL9602](INFO): SBD MO Status=0, MOMSN=52759, MT Status=0, MTMSN=0
2024-06-12T21:26:44.487Z,1718227604.487 [NAL9602](INFO): No messages in MT queue
2024-06-12T21:27:15.188Z,1718227635.188 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T21:27:18.432Z,1718227638.432 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T21:27:18.432Z,1718227638.432 [Default:CheckIn:C.Wait] Stopped
2024-06-12T21:27:18.432Z,1718227638.432 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T21:27:18.432Z,1718227638.432 [Default:CheckIn:D] Running Loop=1
2024-06-12T21:27:18.880Z,1718227638.880 [Default:CheckIn:D] Stopped
2024-06-12T21:27:18.881Z,1718227638.881 [Default:CheckIn:E] Running Loop=1
2024-06-12T21:27:19.255Z,1718227639.255 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  66.616117 min 
2024-06-12T21:27:19.256Z,1718227639.256 [Default:CheckIn:E] Stopped
2024-06-12T21:27:19.256Z,1718227639.256 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T21:27:19.257Z,1718227639.257 [Default:CheckIn] Stopped
2024-06-12T21:27:19.257Z,1718227639.257 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T21:27:19.258Z,1718227639.258 [Default:CheckIn](INFO): Running loop #12
2024-06-12T21:27:19.259Z,1718227639.259 [Default:CheckIn] Running Loop=12
2024-06-12T21:27:19.259Z,1718227639.259 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T21:27:19.260Z,1718227639.260 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T21:27:21.250Z,1718227641.250 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212729.00,A,3648.15018,N,12147.22409,W,0.097,235.88,120624,,,A*70
2024-06-12T21:27:21.252Z,1718227641.252 [NAL9602](INFO): GPS fix at 20240612T212729: (36.802503, -121.787068)
2024-06-12T21:27:21.268Z,1718227641.268 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T21:27:21.268Z,1718227641.268 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T21:27:28.215Z,1718227648.215 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240612T205756/Courier0015.lzma
2024-06-12T21:27:29.947Z,1718227649.947 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0015.lzma.bak
2024-06-12T21:27:29.947Z,1718227649.947 [DataOverHttps](INFO): SBD MOMSN=21202296
2024-06-12T21:27:41.450Z,1718227661.450 [NAL9602](INFO): SBD MO Status=0, MOMSN=52760, MT Status=0, MTMSN=0
2024-06-12T21:27:41.451Z,1718227661.451 [NAL9602](INFO): No messages in MT queue
2024-06-12T21:27:45.160Z,1718227665.160 [DataOverHttps](INFO): Sending 163 bytes from file Logs/20240612T205756/Express0016.lzma
2024-06-12T21:27:46.162Z,1718227666.162 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0016.lzma.bak
2024-06-12T21:27:46.162Z,1718227666.162 [DataOverHttps](INFO): SBD MOMSN=21202299
2024-06-12T21:27:47.521Z,1718227667.521 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T21:27:47.521Z,1718227667.521 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T21:27:47.521Z,1718227667.521 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T21:28:12.157Z,1718227692.157 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T21:32:48.120Z,1718227968.120 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T21:32:48.120Z,1718227968.120 [Default:CheckIn:C.Wait] Stopped
2024-06-12T21:32:48.120Z,1718227968.120 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T21:32:48.120Z,1718227968.120 [Default:CheckIn:D] Running Loop=1
2024-06-12T21:32:48.531Z,1718227968.531 [Default:CheckIn:D] Stopped
2024-06-12T21:32:48.531Z,1718227968.531 [Default:CheckIn:E] Running Loop=1
2024-06-12T21:32:48.928Z,1718227968.928 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  72.110295 min 
2024-06-12T21:32:48.928Z,1718227968.928 [Default:CheckIn:E] Stopped
2024-06-12T21:32:48.928Z,1718227968.928 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T21:32:48.928Z,1718227968.928 [Default:CheckIn] Stopped
2024-06-12T21:32:48.929Z,1718227968.929 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T21:32:48.929Z,1718227968.929 [Default:CheckIn](INFO): Running loop #13
2024-06-12T21:32:48.929Z,1718227968.929 [Default:CheckIn] Running Loop=13
2024-06-12T21:32:48.929Z,1718227968.929 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T21:32:48.929Z,1718227968.929 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T21:32:50.935Z,1718227970.935 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213259.00,A,3648.18665,N,12147.27881,W,0.097,294.56,120624,,,A*73
2024-06-12T21:32:50.937Z,1718227970.937 [NAL9602](INFO): GPS fix at 20240612T213259: (36.803111, -121.787980)
2024-06-12T21:32:50.948Z,1718227970.948 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T21:32:50.948Z,1718227970.948 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T21:32:58.735Z,1718227978.735 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240612T205756/Courier0018.lzma
2024-06-12T21:32:59.825Z,1718227979.825 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0018.lzma.bak
2024-06-12T21:32:59.826Z,1718227979.826 [DataOverHttps](INFO): SBD MOMSN=21202309
2024-06-12T21:33:15.624Z,1718227995.624 [DataOverHttps](INFO): Sending 156 bytes from file Logs/20240612T205756/Express0019.lzma
2024-06-12T21:33:16.626Z,1718227996.626 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0019.lzma.bak
2024-06-12T21:33:16.626Z,1718227996.626 [DataOverHttps](INFO): SBD MOMSN=21202312
2024-06-12T21:33:18.016Z,1718227998.016 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T21:33:18.016Z,1718227998.016 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T21:33:18.016Z,1718227998.016 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T21:34:00.022Z,1718228040.022 [NAL9602](INFO): SBD MO Status=0, MOMSN=52761, MT Status=0, MTMSN=0
2024-06-12T21:34:00.022Z,1718228040.022 [NAL9602](INFO): No messages in MT queue
2024-06-12T21:34:30.725Z,1718228070.725 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T21:38:18.591Z,1718228298.591 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T21:38:18.592Z,1718228298.592 [Default:CheckIn:C.Wait] Stopped
2024-06-12T21:38:18.592Z,1718228298.592 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T21:38:18.592Z,1718228298.592 [Default:CheckIn:D] Running Loop=1
2024-06-12T21:38:18.997Z,1718228298.997 [Default:CheckIn:D] Stopped
2024-06-12T21:38:18.997Z,1718228298.997 [Default:CheckIn:E] Running Loop=1
2024-06-12T21:38:19.430Z,1718228299.430 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  77.618050 min 
2024-06-12T21:38:19.430Z,1718228299.430 [Default:CheckIn:E] Stopped
2024-06-12T21:38:19.430Z,1718228299.430 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T21:38:19.430Z,1718228299.430 [Default:CheckIn] Stopped
2024-06-12T21:38:19.430Z,1718228299.430 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T21:38:19.430Z,1718228299.430 [Default:CheckIn](INFO): Running loop #14
2024-06-12T21:38:19.430Z,1718228299.430 [Default:CheckIn] Running Loop=14
2024-06-12T21:38:19.430Z,1718228299.430 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T21:38:19.430Z,1718228299.430 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T21:38:21.411Z,1718228301.411 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213829.00,A,3648.19263,N,12147.28144,W,0.428,294.56,120624,,,A*72
2024-06-12T21:38:21.413Z,1718228301.413 [NAL9602](INFO): GPS fix at 20240612T213829: (36.803210, -121.788024)
2024-06-12T21:38:21.440Z,1718228301.440 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T21:38:21.440Z,1718228301.440 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T21:38:29.347Z,1718228309.347 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240612T205756/Courier0021.lzma
2024-06-12T21:38:30.350Z,1718228310.350 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0021.lzma.bak
2024-06-12T21:38:30.350Z,1718228310.350 [DataOverHttps](INFO): SBD MOMSN=21202363
2024-06-12T21:38:46.488Z,1718228326.488 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20240612T205756/Express0022.lzma
2024-06-12T21:38:47.490Z,1718228327.490 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0022.lzma.bak
2024-06-12T21:38:47.490Z,1718228327.490 [DataOverHttps](INFO): SBD MOMSN=21202366
2024-06-12T21:38:48.912Z,1718228328.912 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T21:38:48.912Z,1718228328.912 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T21:38:48.913Z,1718228328.913 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T21:39:31.297Z,1718228371.297 [NAL9602](INFO): SBD MO Status=2, MOMSN=52762, MT Status=2, MTMSN=0
2024-06-12T21:39:31.298Z,1718228371.298 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-06-12T21:42:58.958Z,1718228578.958 [NAL9602](INFO): SBD MO Status=0, MOMSN=52762, MT Status=0, MTMSN=0
2024-06-12T21:42:58.958Z,1718228578.958 [NAL9602](INFO): No messages in MT queue
2024-06-12T21:43:29.710Z,1718228609.710 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T21:43:49.495Z,1718228629.495 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T21:43:49.496Z,1718228629.496 [Default:CheckIn:C.Wait] Stopped
2024-06-12T21:43:49.496Z,1718228629.496 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T21:43:49.496Z,1718228629.496 [Default:CheckIn:D] Running Loop=1
2024-06-12T21:43:49.903Z,1718228629.903 [Default:CheckIn:D] Stopped
2024-06-12T21:43:49.903Z,1718228629.903 [Default:CheckIn:E] Running Loop=1
2024-06-12T21:43:50.303Z,1718228630.303 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  83.133154 min 
2024-06-12T21:43:50.303Z,1718228630.303 [Default:CheckIn:E] Stopped
2024-06-12T21:43:50.303Z,1718228630.303 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T21:43:50.328Z,1718228630.328 [Default:CheckIn] Stopped
2024-06-12T21:43:50.328Z,1718228630.328 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T21:43:50.328Z,1718228630.328 [Default:CheckIn](INFO): Running loop #15
2024-06-12T21:43:50.328Z,1718228630.328 [Default:CheckIn] Running Loop=15
2024-06-12T21:43:50.328Z,1718228630.328 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T21:43:50.328Z,1718228630.328 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T21:43:52.311Z,1718228632.311 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214400.00,A,3648.19299,N,12147.28595,W,0.019,294.56,120624,,,A*79
2024-06-12T21:43:52.314Z,1718228632.314 [NAL9602](INFO): GPS fix at 20240612T214400: (36.803216, -121.788099)
2024-06-12T21:43:52.325Z,1718228632.325 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T21:43:52.325Z,1718228632.325 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T21:43:59.695Z,1718228639.695 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240612T205756/Courier0024.lzma
2024-06-12T21:44:00.698Z,1718228640.698 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0024.lzma.bak
2024-06-12T21:44:00.698Z,1718228640.698 [DataOverHttps](INFO): SBD MOMSN=21202391
2024-06-12T21:44:05.238Z,1718228645.238 [NAL9602](INFO): SBD MO Status=0, MOMSN=52763, MT Status=0, MTMSN=0
2024-06-12T21:44:05.238Z,1718228645.238 [NAL9602](INFO): No messages in MT queue
2024-06-12T21:44:16.612Z,1718228656.612 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20240612T205756/Express0025.lzma
2024-06-12T21:44:17.610Z,1718228657.610 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0025.lzma.bak
2024-06-12T21:44:17.610Z,1718228657.610 [DataOverHttps](INFO): SBD MOMSN=21202397
2024-06-12T21:44:18.995Z,1718228658.995 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T21:44:18.995Z,1718228658.995 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T21:44:18.995Z,1718228658.995 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T21:44:26.247Z,1718228666.247 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T21:44:35.945Z,1718228675.945 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T21:44:39.575Z,1718228679.575 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T21:44:52.906Z,1718228692.906 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T21:45:05.433Z,1718228705.433 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T21:45:18.360Z,1718228718.360 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T21:45:31.286Z,1718228731.286 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T21:45:44.215Z,1718228744.215 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T21:48:23.804Z,1718228903.804 [BPC1](INFO): Calculating totals. Valid battery stick count: 40. Valid reserve battery stick count: 6.
2024-06-12T21:48:23.806Z,1718228903.806 [BPC1](INFO): Received data from all battery sticks.
2024-06-12T21:49:19.563Z,1718228959.563 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T21:49:19.563Z,1718228959.563 [Default:CheckIn:C.Wait] Stopped
2024-06-12T21:49:19.564Z,1718228959.564 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T21:49:19.564Z,1718228959.564 [Default:CheckIn:D] Running Loop=1
2024-06-12T21:49:19.972Z,1718228959.972 [Default:CheckIn:D] Stopped
2024-06-12T21:49:19.972Z,1718228959.972 [Default:CheckIn:E] Running Loop=1
2024-06-12T21:49:20.389Z,1718228960.389 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  88.634310 min 
2024-06-12T21:49:20.389Z,1718228960.389 [Default:CheckIn:E] Stopped
2024-06-12T21:49:20.389Z,1718228960.389 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T21:49:20.389Z,1718228960.389 [Default:CheckIn] Stopped
2024-06-12T21:49:20.389Z,1718228960.389 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T21:49:20.389Z,1718228960.389 [Default:CheckIn](INFO): Running loop #16
2024-06-12T21:49:20.389Z,1718228960.389 [Default:CheckIn] Running Loop=16
2024-06-12T21:49:20.389Z,1718228960.389 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T21:49:20.390Z,1718228960.390 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T21:49:22.383Z,1718228962.383 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214930.00,A,3648.19500,N,12147.28717,W,0.350,294.56,120624,,,A*76
2024-06-12T21:49:22.385Z,1718228962.385 [NAL9602](INFO): GPS fix at 20240612T214930: (36.803250, -121.788119)
2024-06-12T21:49:22.397Z,1718228962.397 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T21:49:22.397Z,1718228962.397 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T21:49:29.829Z,1718228969.829 [DataOverHttps](INFO): Sending 204 bytes from file Logs/20240612T205756/Courier0027.lzma
2024-06-12T21:49:30.830Z,1718228970.830 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0027.lzma.bak
2024-06-12T21:49:30.830Z,1718228970.830 [DataOverHttps](INFO): SBD MOMSN=21202469
2024-06-12T21:49:46.716Z,1718228986.716 [DataOverHttps](INFO): Sending 170 bytes from file Logs/20240612T205756/Express0028.lzma
2024-06-12T21:49:47.718Z,1718228987.718 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0028.lzma.bak
2024-06-12T21:49:47.718Z,1718228987.718 [DataOverHttps](INFO): SBD MOMSN=21202472
2024-06-12T21:49:49.072Z,1718228989.072 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T21:49:49.072Z,1718228989.072 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T21:49:49.072Z,1718228989.072 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T21:51:17.118Z,1718229077.118 [NAL9602](INFO): SBD MO Status=0, MOMSN=52764, MT Status=0, MTMSN=0
2024-06-12T21:51:17.118Z,1718229077.118 [NAL9602](INFO): No messages in MT queue
2024-06-12T21:51:47.821Z,1718229107.821 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T21:54:49.631Z,1718229289.631 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T21:54:49.631Z,1718229289.631 [Default:CheckIn:C.Wait] Stopped
2024-06-12T21:54:49.631Z,1718229289.631 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T21:54:49.632Z,1718229289.632 [Default:CheckIn:D] Running Loop=1
2024-06-12T21:54:50.037Z,1718229290.037 [Default:CheckIn:D] Stopped
2024-06-12T21:54:50.037Z,1718229290.037 [Default:CheckIn:E] Running Loop=1
2024-06-12T21:54:50.435Z,1718229290.435 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  94.135400 min 
2024-06-12T21:54:50.448Z,1718229290.448 [Default:CheckIn:E] Stopped
2024-06-12T21:54:50.448Z,1718229290.448 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T21:54:50.448Z,1718229290.448 [Default:CheckIn] Stopped
2024-06-12T21:54:50.448Z,1718229290.448 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T21:54:50.448Z,1718229290.448 [Default:CheckIn](INFO): Running loop #17
2024-06-12T21:54:50.448Z,1718229290.448 [Default:CheckIn] Running Loop=17
2024-06-12T21:54:50.448Z,1718229290.448 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T21:54:50.449Z,1718229290.449 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T21:54:52.451Z,1718229292.451 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215500.00,A,3648.17375,N,12147.28111,W,0.350,159.98,120624,,,A*72
2024-06-12T21:54:52.453Z,1718229292.453 [NAL9602](INFO): GPS fix at 20240612T215500: (36.802896, -121.788019)
2024-06-12T21:54:52.484Z,1718229292.484 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T21:54:52.484Z,1718229292.484 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T21:54:59.452Z,1718229299.452 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240612T205756/Courier0030.lzma
2024-06-12T21:55:00.454Z,1718229300.454 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0030.lzma.bak
2024-06-12T21:55:00.454Z,1718229300.454 [DataOverHttps](INFO): SBD MOMSN=21202482
2024-06-12T21:55:07.402Z,1718229307.402 [NAL9602](INFO): SBD MO Status=0, MOMSN=52765, MT Status=0, MTMSN=0
2024-06-12T21:55:07.402Z,1718229307.402 [NAL9602](INFO): No messages in MT queue
2024-06-12T21:55:16.348Z,1718229316.348 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20240612T205756/Express0031.lzma
2024-06-12T21:55:17.350Z,1718229317.350 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0031.lzma.bak
2024-06-12T21:55:17.350Z,1718229317.350 [DataOverHttps](INFO): SBD MOMSN=21202485
2024-06-12T21:55:18.727Z,1718229318.727 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T21:55:18.727Z,1718229318.727 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T21:55:18.727Z,1718229318.727 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T21:55:38.099Z,1718229338.099 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T22:00:19.300Z,1718229619.300 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T22:00:19.300Z,1718229619.300 [Default:CheckIn:C.Wait] Stopped
2024-06-12T22:00:19.300Z,1718229619.300 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T22:00:19.301Z,1718229619.301 [Default:CheckIn:D] Running Loop=1
2024-06-12T22:00:19.712Z,1718229619.712 [Default:CheckIn:D] Stopped
2024-06-12T22:00:19.712Z,1718229619.712 [Default:CheckIn:E] Running Loop=1
2024-06-12T22:00:20.119Z,1718229620.119 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  99.629972 min 
2024-06-12T22:00:20.119Z,1718229620.119 [Default:CheckIn:E] Stopped
2024-06-12T22:00:20.119Z,1718229620.119 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T22:00:20.119Z,1718229620.119 [Default:CheckIn] Stopped
2024-06-12T22:00:20.119Z,1718229620.119 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T22:00:20.119Z,1718229620.119 [Default:CheckIn](INFO): Running loop #18
2024-06-12T22:00:20.119Z,1718229620.119 [Default:CheckIn] Running Loop=18
2024-06-12T22:00:20.120Z,1718229620.120 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T22:00:20.120Z,1718229620.120 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T22:00:22.123Z,1718229622.123 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220030.00,A,3648.18055,N,12147.27958,W,0.564,159.98,120624,,,A*77
2024-06-12T22:00:22.125Z,1718229622.125 [NAL9602](INFO): GPS fix at 20240612T220030: (36.803009, -121.787993)
2024-06-12T22:00:22.156Z,1718229622.156 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T22:00:22.156Z,1718229622.156 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T22:00:29.995Z,1718229629.995 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240612T205756/Courier0033.lzma
2024-06-12T22:00:31.114Z,1718229631.114 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0033.lzma.bak
2024-06-12T22:00:31.114Z,1718229631.114 [DataOverHttps](INFO): SBD MOMSN=21202540
2024-06-12T22:00:47.108Z,1718229647.108 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240612T205756/Express0034.lzma
2024-06-12T22:00:48.110Z,1718229648.110 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0034.lzma.bak
2024-06-12T22:00:48.110Z,1718229648.110 [DataOverHttps](INFO): SBD MOMSN=21202543
2024-06-12T22:00:49.604Z,1718229649.604 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T22:00:49.604Z,1718229649.604 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T22:00:49.604Z,1718229649.604 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T22:01:08.582Z,1718229668.582 [NAL9602](INFO): SBD MO Status=0, MOMSN=52766, MT Status=0, MTMSN=0
2024-06-12T22:01:08.583Z,1718229668.583 [NAL9602](INFO): No messages in MT queue
2024-06-12T22:01:39.284Z,1718229699.284 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T22:05:50.184Z,1718229950.184 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T22:05:50.184Z,1718229950.184 [Default:CheckIn:C.Wait] Stopped
2024-06-12T22:05:50.184Z,1718229950.184 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T22:05:50.185Z,1718229950.185 [Default:CheckIn:D] Running Loop=1
2024-06-12T22:05:50.601Z,1718229950.601 [Default:CheckIn:D] Stopped
2024-06-12T22:05:50.601Z,1718229950.601 [Default:CheckIn:E] Running Loop=1
2024-06-12T22:05:50.987Z,1718229950.987 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  105.144792 min 
2024-06-12T22:05:50.987Z,1718229950.987 [Default:CheckIn:E] Stopped
2024-06-12T22:05:50.987Z,1718229950.987 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T22:05:50.988Z,1718229950.988 [Default:CheckIn] Stopped
2024-06-12T22:05:50.988Z,1718229950.988 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T22:05:50.988Z,1718229950.988 [Default:CheckIn](INFO): Running loop #19
2024-06-12T22:05:50.988Z,1718229950.988 [Default:CheckIn] Running Loop=19
2024-06-12T22:05:50.988Z,1718229950.988 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T22:05:50.988Z,1718229950.988 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T22:05:52.999Z,1718229952.999 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220601.00,A,3648.17476,N,12147.28074,W,0.078,159.98,120624,,,A*79
2024-06-12T22:05:53.001Z,1718229953.001 [NAL9602](INFO): GPS fix at 20240612T220601: (36.802913, -121.788012)
2024-06-12T22:05:53.012Z,1718229953.012 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T22:05:53.012Z,1718229953.012 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T22:06:00.845Z,1718229960.845 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240612T205756/Courier0036.lzma
2024-06-12T22:06:01.846Z,1718229961.846 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0036.lzma.bak
2024-06-12T22:06:01.846Z,1718229961.846 [DataOverHttps](INFO): SBD MOMSN=21202553
2024-06-12T22:06:07.947Z,1718229967.947 [NAL9602](INFO): SBD MO Status=0, MOMSN=52767, MT Status=0, MTMSN=0
2024-06-12T22:06:07.947Z,1718229967.947 [NAL9602](INFO): No messages in MT queue
2024-06-12T22:06:17.788Z,1718229977.788 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20240612T205756/Express0037.lzma
2024-06-12T22:06:18.791Z,1718229978.791 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0037.lzma.bak
2024-06-12T22:06:18.793Z,1718229978.793 [DataOverHttps](INFO): SBD MOMSN=21202557
2024-06-12T22:06:20.483Z,1718229980.483 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T22:06:20.483Z,1718229980.483 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T22:06:20.484Z,1718229980.484 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T22:06:38.649Z,1718229998.649 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T22:11:21.052Z,1718230281.052 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T22:11:21.053Z,1718230281.053 [Default:CheckIn:C.Wait] Stopped
2024-06-12T22:11:21.053Z,1718230281.053 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T22:11:21.053Z,1718230281.053 [Default:CheckIn:D] Running Loop=1
2024-06-12T22:11:21.467Z,1718230281.467 [Default:CheckIn:D] Stopped
2024-06-12T22:11:21.467Z,1718230281.467 [Default:CheckIn:E] Running Loop=1
2024-06-12T22:11:21.860Z,1718230281.860 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  110.659220 min 
2024-06-12T22:11:21.860Z,1718230281.860 [Default:CheckIn:E] Stopped
2024-06-12T22:11:21.860Z,1718230281.860 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T22:11:21.860Z,1718230281.860 [Default:CheckIn] Stopped
2024-06-12T22:11:21.860Z,1718230281.860 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T22:11:21.860Z,1718230281.860 [Default:CheckIn](INFO): Running loop #20
2024-06-12T22:11:21.860Z,1718230281.860 [Default:CheckIn] Running Loop=20
2024-06-12T22:11:21.861Z,1718230281.861 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T22:11:21.861Z,1718230281.861 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T22:11:23.875Z,1718230283.875 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221132.00,A,3648.17857,N,12147.28073,W,0.175,188.20,120624,,,A*74
2024-06-12T22:11:23.877Z,1718230283.877 [NAL9602](INFO): GPS fix at 20240612T221132: (36.802976, -121.788012)
2024-06-12T22:11:23.888Z,1718230283.888 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T22:11:23.888Z,1718230283.888 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T22:11:31.293Z,1718230291.293 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240612T205756/Courier0039.lzma
2024-06-12T22:11:32.290Z,1718230292.290 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0039.lzma.bak
2024-06-12T22:11:32.290Z,1718230292.290 [DataOverHttps](INFO): SBD MOMSN=21202611
2024-06-12T22:11:34.802Z,1718230294.802 [NAL9602](INFO): SBD MO Status=0, MOMSN=52768, MT Status=0, MTMSN=0
2024-06-12T22:11:34.802Z,1718230294.802 [NAL9602](INFO): No messages in MT queue
2024-06-12T22:11:48.145Z,1718230308.145 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240612T205756/Express0040.lzma
2024-06-12T22:11:49.146Z,1718230309.146 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0040.lzma.bak
2024-06-12T22:11:49.146Z,1718230309.146 [DataOverHttps](INFO): SBD MOMSN=21202614
2024-06-12T22:11:50.571Z,1718230310.571 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T22:11:50.571Z,1718230310.571 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T22:11:50.592Z,1718230310.592 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T22:12:05.505Z,1718230325.505 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T22:16:51.144Z,1718230611.144 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T22:16:51.144Z,1718230611.144 [Default:CheckIn:C.Wait] Stopped
2024-06-12T22:16:51.144Z,1718230611.144 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T22:16:51.145Z,1718230611.145 [Default:CheckIn:D] Running Loop=1
2024-06-12T22:16:51.554Z,1718230611.554 [Default:CheckIn:D] Stopped
2024-06-12T22:16:51.554Z,1718230611.554 [Default:CheckIn:E] Running Loop=1
2024-06-12T22:16:51.947Z,1718230611.947 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  116.160677 min 
2024-06-12T22:16:51.947Z,1718230611.947 [Default:CheckIn:E] Stopped
2024-06-12T22:16:51.947Z,1718230611.947 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T22:16:51.947Z,1718230611.947 [Default:CheckIn] Stopped
2024-06-12T22:16:51.947Z,1718230611.947 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T22:16:51.947Z,1718230611.947 [Default:CheckIn](INFO): Running loop #21
2024-06-12T22:16:51.947Z,1718230611.947 [Default:CheckIn] Running Loop=21
2024-06-12T22:16:51.948Z,1718230611.948 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T22:16:51.948Z,1718230611.948 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T22:16:53.959Z,1718230613.959 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221702.00,A,3648.17851,N,12147.27921,W,0.214,188.20,120624,,,A*72
2024-06-12T22:16:53.962Z,1718230613.962 [NAL9602](INFO): GPS fix at 20240612T221702: (36.802975, -121.787987)
2024-06-12T22:16:53.973Z,1718230613.973 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T22:16:53.973Z,1718230613.973 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T22:17:01.903Z,1718230621.903 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240612T205756/Courier0042.lzma
2024-06-12T22:17:02.906Z,1718230622.906 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0042.lzma.bak
2024-06-12T22:17:02.906Z,1718230622.906 [DataOverHttps](INFO): SBD MOMSN=21202627
2024-06-12T22:17:19.852Z,1718230639.852 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240612T205756/Express0043.lzma
2024-06-12T22:17:20.854Z,1718230640.854 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0043.lzma.bak
2024-06-12T22:17:20.854Z,1718230640.854 [DataOverHttps](INFO): SBD MOMSN=21202635
2024-06-12T22:17:22.264Z,1718230642.264 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T22:17:22.264Z,1718230642.264 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T22:17:22.264Z,1718230642.264 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T22:19:18.211Z,1718230758.211 [NAL9602](INFO): SBD MO Status=2, MOMSN=52769, MT Status=2, MTMSN=0
2024-06-12T22:19:18.211Z,1718230758.211 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-06-12T22:19:35.582Z,1718230775.582 [NAL9602](INFO): SBD MO Status=2, MOMSN=52769, MT Status=2, MTMSN=0
2024-06-12T22:19:35.582Z,1718230775.582 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-06-12T22:19:43.663Z,1718230783.663 [NAL9602](INFO): SBD MO Status=0, MOMSN=52769, MT Status=0, MTMSN=0
2024-06-12T22:19:43.663Z,1718230783.663 [NAL9602](INFO): No messages in MT queue
2024-06-12T22:20:14.360Z,1718230814.360 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T22:22:22.852Z,1718230942.852 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T22:22:22.852Z,1718230942.852 [Default:CheckIn:C.Wait] Stopped
2024-06-12T22:22:22.852Z,1718230942.852 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T22:22:22.853Z,1718230942.853 [Default:CheckIn:D] Running Loop=1
2024-06-12T22:22:23.267Z,1718230943.267 [Default:CheckIn:D] Stopped
2024-06-12T22:22:23.267Z,1718230943.267 [Default:CheckIn:E] Running Loop=1
2024-06-12T22:22:23.655Z,1718230943.655 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  121.689217 min 
2024-06-12T22:22:23.655Z,1718230943.655 [Default:CheckIn:E] Stopped
2024-06-12T22:22:23.655Z,1718230943.655 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T22:22:23.656Z,1718230943.656 [Default:CheckIn] Stopped
2024-06-12T22:22:23.656Z,1718230943.656 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T22:22:23.656Z,1718230943.656 [Default:CheckIn](INFO): Running loop #22
2024-06-12T22:22:23.656Z,1718230943.656 [Default:CheckIn] Running Loop=22
2024-06-12T22:22:23.656Z,1718230943.656 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T22:22:23.656Z,1718230943.656 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T22:22:25.662Z,1718230945.662 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222234.00,A,3648.18129,N,12147.27440,W,0.078,188.20,120624,,,A*7A
2024-06-12T22:22:25.665Z,1718230945.665 [NAL9602](INFO): GPS fix at 20240612T222234: (36.803021, -121.787907)
2024-06-12T22:22:25.676Z,1718230945.676 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T22:22:25.676Z,1718230945.676 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T22:22:32.591Z,1718230952.591 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240612T205756/Courier0045.lzma
2024-06-12T22:22:33.594Z,1718230953.594 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0045.lzma.bak
2024-06-12T22:22:33.594Z,1718230953.594 [DataOverHttps](INFO): SBD MOMSN=21202696
2024-06-12T22:22:47.474Z,1718230967.474 [NAL9602](INFO): SBD MO Status=0, MOMSN=52770, MT Status=0, MTMSN=0
2024-06-12T22:22:47.475Z,1718230967.475 [NAL9602](INFO): No messages in MT queue
2024-06-12T22:22:49.648Z,1718230969.648 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20240612T205756/Express0046.lzma
2024-06-12T22:22:50.650Z,1718230970.650 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0046.lzma.bak
2024-06-12T22:22:50.650Z,1718230970.650 [DataOverHttps](INFO): SBD MOMSN=21202699
2024-06-12T22:22:52.339Z,1718230972.339 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T22:22:52.339Z,1718230972.339 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T22:22:52.339Z,1718230972.339 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T22:23:18.181Z,1718230998.181 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T22:27:52.907Z,1718231272.907 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T22:27:52.907Z,1718231272.907 [Default:CheckIn:C.Wait] Stopped
2024-06-12T22:27:52.907Z,1718231272.907 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T22:27:52.907Z,1718231272.907 [Default:CheckIn:D] Running Loop=1
2024-06-12T22:27:53.322Z,1718231273.322 [Default:CheckIn:D] Stopped
2024-06-12T22:27:53.322Z,1718231273.322 [Default:CheckIn:E] Running Loop=1
2024-06-12T22:27:53.720Z,1718231273.720 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  127.190145 min 
2024-06-12T22:27:53.720Z,1718231273.720 [Default:CheckIn:E] Stopped
2024-06-12T22:27:53.720Z,1718231273.720 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T22:27:53.720Z,1718231273.720 [Default:CheckIn] Stopped
2024-06-12T22:27:53.720Z,1718231273.720 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T22:27:53.721Z,1718231273.721 [Default:CheckIn](INFO): Running loop #23
2024-06-12T22:27:53.721Z,1718231273.721 [Default:CheckIn] Running Loop=23
2024-06-12T22:27:53.721Z,1718231273.721 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T22:27:53.721Z,1718231273.721 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T22:27:55.727Z,1718231275.727 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222804.00,A,3648.18019,N,12147.27875,W,0.058,188.20,120624,,,A*79
2024-06-12T22:27:55.729Z,1718231275.729 [NAL9602](INFO): GPS fix at 20240612T222804: (36.803003, -121.787979)
2024-06-12T22:27:55.744Z,1718231275.744 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T22:27:55.744Z,1718231275.744 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T22:28:03.027Z,1718231283.027 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240612T205756/Courier0048.lzma
2024-06-12T22:28:04.030Z,1718231284.030 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0048.lzma.bak
2024-06-12T22:28:04.030Z,1718231284.030 [DataOverHttps](INFO): SBD MOMSN=21202725
2024-06-12T22:28:20.036Z,1718231300.036 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20240612T205756/Express0049.lzma
2024-06-12T22:28:21.041Z,1718231301.041 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0049.lzma.bak
2024-06-12T22:28:21.041Z,1718231301.041 [DataOverHttps](INFO): SBD MOMSN=21202765
2024-06-12T22:28:22.404Z,1718231302.404 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T22:28:22.404Z,1718231302.404 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T22:28:22.404Z,1718231302.404 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T22:28:47.447Z,1718231327.447 [NAL9602](INFO): SBD MO Status=2, MOMSN=52771, MT Status=2, MTMSN=0
2024-06-12T22:28:47.447Z,1718231327.447 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-06-12T22:29:22.183Z,1718231362.183 [NAL9602](INFO): SBD MO Status=2, MOMSN=52771, MT Status=2, MTMSN=0
2024-06-12T22:29:22.183Z,1718231362.183 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-06-12T22:29:56.926Z,1718231396.926 [NAL9602](INFO): SBD MO Status=2, MOMSN=52771, MT Status=2, MTMSN=0
2024-06-12T22:29:56.927Z,1718231396.927 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-06-12T22:30:14.710Z,1718231414.710 [NAL9602](INFO): SBD MO Status=0, MOMSN=52771, MT Status=0, MTMSN=0
2024-06-12T22:30:14.710Z,1718231414.710 [NAL9602](INFO): No messages in MT queue
2024-06-12T22:30:45.404Z,1718231445.404 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T22:33:06.399Z,1718231586.399 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2024-06-12T22:33:06.399Z,1718231586.399 [DropWeight] Hardware Fault, FailCount= 1
2024-06-12T22:33:06.399Z,1718231586.399 [DropWeight](ERROR): Hardware Fault
2024-06-12T22:33:06.418Z,1718231586.418 [CommandExec](FAULT): Scheduling is paused
2024-06-12T22:33:06.418Z,1718231586.418 [CBIT](INFO): Critical error at 20240612T223306
2024-06-12T22:33:06.421Z,1718231586.421 [CBIT](ERROR): Hardware Fault in component: DropWeight
2024-06-12T22:33:06.421Z,1718231586.421 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2024-06-12T22:33:06.828Z,1718231586.828 [CBIT](INFO): Critical error at 20240612T223306
2024-06-12T22:33:22.978Z,1718231602.978 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T22:33:22.978Z,1718231602.978 [Default:CheckIn:C.Wait] Stopped
2024-06-12T22:33:22.978Z,1718231602.978 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T22:33:22.979Z,1718231602.979 [Default:CheckIn:D] Running Loop=1
2024-06-12T22:33:23.385Z,1718231603.385 [Default:CheckIn:D] Stopped
2024-06-12T22:33:23.385Z,1718231603.385 [Default:CheckIn:E] Running Loop=1
2024-06-12T22:33:23.865Z,1718231603.865 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  132.691187 min 
2024-06-12T22:33:23.865Z,1718231603.865 [Default:CheckIn:E] Stopped
2024-06-12T22:33:23.865Z,1718231603.865 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T22:33:23.865Z,1718231603.865 [Default:CheckIn] Stopped
2024-06-12T22:33:23.865Z,1718231603.865 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T22:33:23.866Z,1718231603.866 [Default:CheckIn](INFO): Running loop #24
2024-06-12T22:33:23.866Z,1718231603.866 [Default:CheckIn] Running Loop=24
2024-06-12T22:33:23.866Z,1718231603.866 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T22:33:23.866Z,1718231603.866 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T22:33:25.798Z,1718231605.798 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223334.00,A,3648.17959,N,12147.28007,W,0.058,0.00,120624,,,A*73
2024-06-12T22:33:25.801Z,1718231605.801 [NAL9602](INFO): GPS fix at 20240612T223334: (36.802993, -121.788001)
2024-06-12T22:33:25.812Z,1718231605.812 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T22:33:25.812Z,1718231605.812 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T22:33:32.800Z,1718231612.800 [DataOverHttps](INFO): Sending 181 bytes from file Logs/20240612T205756/Courier0051.lzma
2024-06-12T22:33:33.802Z,1718231613.802 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0051.lzma.bak
2024-06-12T22:33:33.802Z,1718231613.802 [DataOverHttps](INFO): SBD MOMSN=21202783
2024-06-12T22:33:49.720Z,1718231629.720 [DataOverHttps](INFO): Sending 156 bytes from file Logs/20240612T205756/Express0052.lzma
2024-06-12T22:33:50.722Z,1718231630.722 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0052.lzma.bak
2024-06-12T22:33:50.722Z,1718231630.722 [DataOverHttps](INFO): SBD MOMSN=21202791
2024-06-12T22:33:52.080Z,1718231632.080 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T22:33:52.080Z,1718231632.080 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T22:33:52.080Z,1718231632.080 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T22:36:22.762Z,1718231782.762 [NAL9602](INFO): SBD MO Status=2, MOMSN=52772, MT Status=2, MTMSN=0
2024-06-12T22:36:22.762Z,1718231782.762 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-06-12T22:37:57.697Z,1718231877.697 [NAL9602](INFO): SBD MO Status=2, MOMSN=52772, MT Status=2, MTMSN=0
2024-06-12T22:37:57.698Z,1718231877.698 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-06-12T22:38:40.930Z,1718231920.930 [NAL9602](INFO): SBD MO Status=2, MOMSN=52772, MT Status=2, MTMSN=0
2024-06-12T22:38:40.930Z,1718231920.930 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-06-12T22:38:41.328Z,1718231921.328 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-06-12T22:38:52.655Z,1718231932.655 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T22:38:52.655Z,1718231932.655 [Default:CheckIn:C.Wait] Stopped
2024-06-12T22:38:52.655Z,1718231932.655 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T22:38:52.655Z,1718231932.655 [Default:CheckIn:D] Running Loop=1
2024-06-12T22:38:53.060Z,1718231933.060 [Default:CheckIn:D] Stopped
2024-06-12T22:38:53.060Z,1718231933.060 [Default:CheckIn:E] Running Loop=1
2024-06-12T22:38:53.475Z,1718231933.475 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  138.185775 min 
2024-06-12T22:38:53.475Z,1718231933.475 [Default:CheckIn:E] Stopped
2024-06-12T22:38:53.475Z,1718231933.475 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T22:38:53.476Z,1718231933.476 [Default:CheckIn] Stopped
2024-06-12T22:38:53.476Z,1718231933.476 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T22:38:53.476Z,1718231933.476 [Default:CheckIn](INFO): Running loop #25
2024-06-12T22:38:53.476Z,1718231933.476 [Default:CheckIn] Running Loop=25
2024-06-12T22:38:53.476Z,1718231933.476 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T22:38:53.476Z,1718231933.476 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T22:38:55.471Z,1718231935.471 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223903.00,A,3648.16682,N,12147.27750,W,1.011,278.77,120624,,,A*7E
2024-06-12T22:38:55.473Z,1718231935.473 [NAL9602](INFO): GPS fix at 20240612T223903: (36.802780, -121.787958)
2024-06-12T22:38:55.511Z,1718231935.511 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T22:38:55.511Z,1718231935.511 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T22:39:03.939Z,1718231943.939 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240612T205756/Courier0054.lzma
2024-06-12T22:39:04.942Z,1718231944.942 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0054.lzma.bak
2024-06-12T22:39:04.943Z,1718231944.943 [DataOverHttps](INFO): SBD MOMSN=21202851
2024-06-12T22:39:20.884Z,1718231960.884 [DataOverHttps](INFO): Sending 242 bytes from file Logs/20240612T205756/Express0055.lzma
2024-06-12T22:39:21.886Z,1718231961.886 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0055.lzma.bak
2024-06-12T22:39:21.886Z,1718231961.886 [DataOverHttps](INFO): SBD MOMSN=21202860
2024-06-12T22:39:23.372Z,1718231963.372 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T22:39:23.372Z,1718231963.372 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T22:39:23.372Z,1718231963.372 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T22:39:27.389Z,1718231967.389 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T22:44:23.951Z,1718232263.951 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T22:44:23.952Z,1718232263.952 [Default:CheckIn:C.Wait] Stopped
2024-06-12T22:44:23.952Z,1718232263.952 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T22:44:23.952Z,1718232263.952 [Default:CheckIn:D] Running Loop=1
2024-06-12T22:44:24.344Z,1718232264.344 [Default:CheckIn:D] Stopped
2024-06-12T22:44:24.344Z,1718232264.344 [Default:CheckIn:E] Running Loop=1
2024-06-12T22:44:24.747Z,1718232264.747 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  143.707178 min 
2024-06-12T22:44:24.747Z,1718232264.747 [Default:CheckIn:E] Stopped
2024-06-12T22:44:24.747Z,1718232264.747 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T22:44:24.747Z,1718232264.747 [Default:CheckIn] Stopped
2024-06-12T22:44:24.747Z,1718232264.747 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T22:44:24.748Z,1718232264.748 [Default:CheckIn](INFO): Running loop #26
2024-06-12T22:44:24.748Z,1718232264.748 [Default:CheckIn] Running Loop=26
2024-06-12T22:44:24.748Z,1718232264.748 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T22:44:24.748Z,1718232264.748 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T22:48:06.613Z,1718232486.613 [CBIT](INFO): Clearing failed state for component DropWeight
2024-06-12T22:48:06.613Z,1718232486.613 [DropWeight] No Fault, FailCount= 1
2024-06-12T22:49:24.964Z,1718232564.964 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-06-12T22:44:24.7Z
2024-06-12T22:49:24.965Z,1718232564.965 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T22:49:24.965Z,1718232564.965 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T22:49:29.373Z,1718232569.373 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-06-12T22:49:30.578Z,1718232570.578 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T22:49:32.735Z,1718232572.735 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240612T205756/Courier0057.lzma
2024-06-12T22:49:33.738Z,1718232573.738 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0057.lzma.bak
2024-06-12T22:49:33.738Z,1718232573.738 [DataOverHttps](INFO): SBD MOMSN=21202920
2024-06-12T22:49:43.102Z,1718232583.102 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T22:49:49.792Z,1718232589.792 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20240612T205756/Express0058.lzma
2024-06-12T22:49:50.794Z,1718232590.794 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0058.lzma.bak
2024-06-12T22:49:50.794Z,1718232590.794 [DataOverHttps](INFO): SBD MOMSN=21202925
2024-06-12T22:49:52.435Z,1718232592.435 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T22:49:52.435Z,1718232592.435 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T22:49:52.435Z,1718232592.435 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T22:49:56.030Z,1718232596.030 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T22:50:00.077Z,1718232600.077 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T22:50:09.362Z,1718232609.362 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T22:50:22.294Z,1718232622.294 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T22:50:34.815Z,1718232634.815 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T22:50:48.150Z,1718232648.150 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-06-12T22:53:29.360Z,1718232809.360 [BPC1](INFO): Calculating totals. Valid battery stick count: 40. Valid reserve battery stick count: 6.
2024-06-12T22:53:29.363Z,1718232809.363 [BPC1](INFO): Received data from all battery sticks.
2024-06-12T22:54:52.982Z,1718232892.982 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T22:54:52.982Z,1718232892.982 [Default:CheckIn:C.Wait] Stopped
2024-06-12T22:54:52.982Z,1718232892.982 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T22:54:52.982Z,1718232892.982 [Default:CheckIn:D] Running Loop=1
2024-06-12T22:54:53.392Z,1718232893.392 [Default:CheckIn:D] Stopped
2024-06-12T22:54:53.392Z,1718232893.392 [Default:CheckIn:E] Running Loop=1
2024-06-12T22:54:53.805Z,1718232893.805 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  154.191309 min 
2024-06-12T22:54:53.806Z,1718232893.806 [Default:CheckIn:E] Stopped
2024-06-12T22:54:53.806Z,1718232893.806 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T22:54:53.806Z,1718232893.806 [Default:CheckIn] Stopped
2024-06-12T22:54:53.806Z,1718232893.806 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T22:54:53.806Z,1718232893.806 [Default:CheckIn](INFO): Running loop #27
2024-06-12T22:54:53.806Z,1718232893.806 [Default:CheckIn] Running Loop=27
2024-06-12T22:54:53.806Z,1718232893.806 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T22:54:53.806Z,1718232893.806 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T22:54:55.405Z,1718232895.405 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-06-12T22:54:55.406Z,1718232895.406 [NAL9602] Data Fault, FailCount= 1
2024-06-12T22:54:55.406Z,1718232895.406 [NAL9602](ERROR): Data Fault
2024-06-12T22:54:55.427Z,1718232895.427 [CBIT](ERROR): Data Fault in component: NAL9602
2024-06-12T22:54:55.805Z,1718232895.805 [NAL9602](INFO): Powering down
2024-06-12T22:54:56.628Z,1718232896.628 [CBIT](INFO): Clearing failed state for component NAL9602
2024-06-12T22:54:56.628Z,1718232896.628 [NAL9602] No Fault, FailCount= 1
2024-06-12T22:55:26.100Z,1718232926.100 [NAL9602](INFO): Powering up NAL9602
2024-06-12T22:55:37.014Z,1718232937.014 [NAL9602](INFO): NAL9602 initialized
2024-06-12T22:59:53.967Z,1718233193.967 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-06-12T22:54:53.8Z
2024-06-12T22:59:53.967Z,1718233193.967 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T22:59:53.967Z,1718233193.967 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T23:00:01.543Z,1718233201.543 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20240612T205756/Courier0060.lzma
2024-06-12T23:00:02.546Z,1718233202.546 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0060.lzma.bak
2024-06-12T23:00:02.546Z,1718233202.546 [DataOverHttps](INFO): SBD MOMSN=21202988
2024-06-12T23:00:18.864Z,1718233218.864 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20240612T205756/Express0061.lzma
2024-06-12T23:00:19.866Z,1718233219.866 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0061.lzma.bak
2024-06-12T23:00:19.866Z,1718233219.866 [DataOverHttps](INFO): SBD MOMSN=21203025
2024-06-12T23:00:21.451Z,1718233221.451 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T23:00:21.451Z,1718233221.451 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T23:00:21.451Z,1718233221.451 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T23:00:40.821Z,1718233240.821 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-06-12T23:01:11.525Z,1718233271.525 [NAL9602](INFO): Not Powering down - fast GPS
2024-06-12T23:05:22.015Z,1718233522.015 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-06-12T23:05:22.015Z,1718233522.015 [Default:CheckIn:C.Wait] Stopped
2024-06-12T23:05:22.015Z,1718233522.015 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T23:05:22.028Z,1718233522.028 [Default:CheckIn:D] Running Loop=1
2024-06-12T23:05:22.419Z,1718233522.419 [Default:CheckIn:D] Stopped
2024-06-12T23:05:22.419Z,1718233522.419 [Default:CheckIn:E] Running Loop=1
2024-06-12T23:05:22.824Z,1718233522.824 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  164.675081 min 
2024-06-12T23:05:22.824Z,1718233522.824 [Default:CheckIn:E] Stopped
2024-06-12T23:05:22.824Z,1718233522.824 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-06-12T23:05:22.824Z,1718233522.824 [Default:CheckIn] Stopped
2024-06-12T23:05:22.825Z,1718233522.825 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T23:05:22.825Z,1718233522.825 [Default:CheckIn](INFO): Running loop #28
2024-06-12T23:05:22.825Z,1718233522.825 [Default:CheckIn] Running Loop=28
2024-06-12T23:05:22.825Z,1718233522.825 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-06-12T23:05:22.825Z,1718233522.825 [Default:CheckIn:Read_GPS] Running Loop=1
2024-06-12T23:10:23.013Z,1718233823.013 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-06-12T23:05:22.8Z
2024-06-12T23:10:23.013Z,1718233823.013 [Default:CheckIn:Read_GPS] Stopped
2024-06-12T23:10:23.013Z,1718233823.013 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-06-12T23:10:26.617Z,1718233826.617 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-06-12T23:10:30.775Z,1718233830.775 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20240612T205756/Courier0063.lzma
2024-06-12T23:10:31.778Z,1718233831.778 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Courier0063.lzma.bak
2024-06-12T23:10:31.778Z,1718233831.778 [DataOverHttps](INFO): SBD MOMSN=21203049
2024-06-12T23:10:48.400Z,1718233848.400 [CommandExec](IMPORTANT): got command quit
2024-06-12T23:10:48.844Z,1718233848.844 [DataOverHttps](INFO): Sending 210 bytes from file Logs/20240612T205756/Express0064.lzma
2024-06-12T23:10:49.404Z,1718233849.404 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-06-12T23:10:49.404Z,1718233849.404 [CommandExec](INFO): Uninitializing the command executive.
2024-06-12T23:10:49.404Z,1718233849.404 [CommandExec](INFO): Uninitializing the command scheduler.
2024-06-12T23:10:49.404Z,1718233849.404 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:49.544Z,1718233849.544 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2024-06-12T23:10:49.544Z,1718233849.544 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-06-12T23:10:49.544Z,1718233849.544 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:49.545Z,1718233849.545 [NavChartDb](INFO): Join timeout helper Thread ID is 533
2024-06-12T23:10:49.780Z,1718233849.780 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-06-12T23:10:49.780Z,1718233849.780 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:49.796Z,1718233849.796 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-06-12T23:10:49.796Z,1718233849.796 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:49.796Z,1718233849.796 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 534
2024-06-12T23:10:49.797Z,1718233849.797 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-06-12T23:10:49.797Z,1718233849.797 [WetLabsBB2FL](INFO): Powering down
2024-06-12T23:10:49.798Z,1718233849.798 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:49.798Z,1718233849.798 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-06-12T23:10:49.798Z,1718233849.798 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:49.799Z,1718233849.799 [CTD_Seabird](INFO): Join timeout helper Thread ID is 535
2024-06-12T23:10:49.842Z,1718233849.842 [DataOverHttps](INFO): Moved sent file to Logs/20240612T205756/Express0064.lzma.bak
2024-06-12T23:10:49.842Z,1718233849.842 [DataOverHttps](INFO): SBD MOMSN=21203053
2024-06-12T23:10:50.360Z,1718233850.360 [CTD_Seabird](INFO): Powering down
2024-06-12T23:10:50.372Z,1718233850.372 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-06-12T23:10:50.372Z,1718233850.372 [CTD_Seabird](INFO): Powering down
2024-06-12T23:10:50.385Z,1718233850.385 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:50.396Z,1718233850.396 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2024-06-12T23:10:50.397Z,1718233850.397 [DAT ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:50.397Z,1718233850.397 [DAT](INFO): Join timeout helper Thread ID is 536
2024-06-12T23:10:50.524Z,1718233850.524 [DAT](INFO): Powering down
2024-06-12T23:10:50.596Z,1718233850.596 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2024-06-12T23:10:50.597Z,1718233850.597 [DAT](INFO): Powering down
2024-06-12T23:10:50.597Z,1718233850.597 [DAT ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:50.600Z,1718233850.600 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-06-12T23:10:50.600Z,1718233850.600 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:50.600Z,1718233850.600 [Radio_Surface](INFO): Join timeout helper Thread ID is 537
2024-06-12T23:10:50.628Z,1718233850.628 [Radio_Surface](INFO): Powering down
2024-06-12T23:10:50.629Z,1718233850.629 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-06-12T23:10:50.629Z,1718233850.629 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:50.668Z,1718233850.668 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-06-12T23:10:50.668Z,1718233850.668 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:50.669Z,1718233850.669 [Onboard](INFO): Join timeout helper Thread ID is 538
2024-06-12T23:10:51.171Z,1718233851.171 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2024-06-12T23:10:51.275Z,1718233851.275 [Default:CheckIn:Read_Iridium] Stopped
2024-06-12T23:10:51.275Z,1718233851.275 [Default:CheckIn:C.Wait] Running Loop=1
2024-06-12T23:10:51.275Z,1718233851.275 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-06-12T23:10:54.040Z,1718233854.040 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-06-12T23:10:54.040Z,1718233854.040 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:54.044Z,1718233854.044 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-06-12T23:10:54.045Z,1718233854.045 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:54.045Z,1718233854.045 [DataOverHttps](INFO): Join timeout helper Thread ID is 539
2024-06-12T23:10:54.860Z,1718233854.860 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-06-12T23:10:54.860Z,1718233854.860 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:54.868Z,1718233854.868 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-06-12T23:10:54.869Z,1718233854.869 [logger ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:54.869Z,1718233854.869 [logger](INFO): Join timeout helper Thread ID is 540
2024-06-12T23:10:54.892Z,1718233854.892 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-06-12T23:10:54.892Z,1718233854.892 [logger ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:54.897Z,1718233854.897 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-06-12T23:10:54.897Z,1718233854.897 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:54.897Z,1718233854.897 [CommandLine](INFO): Join timeout helper Thread ID is 541
2024-06-12T23:10:54.908Z,1718233854.908 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-06-12T23:10:54.908Z,1718233854.908 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:54.924Z,1718233854.924 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-06-12T23:10:54.925Z,1718233854.925 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:54.925Z,1718233854.925 [CommandExec](INFO): Join timeout helper Thread ID is 542
2024-06-12T23:10:54.926Z,1718233854.926 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-06-12T23:10:54.926Z,1718233854.926 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:54.927Z,1718233854.927 [controlThread](INFO): Join timeout helper Thread ID is 543
2024-06-12T23:10:55.284Z,1718233855.284 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-06-12T23:10:55.284Z,1718233855.284 [controlThread](DEBUG): Uninitializing ControlThread
2024-06-12T23:10:55.285Z,1718233855.284 [AHRS_M2](INFO): Powering down
2024-06-12T23:10:55.357Z,1718233855.357 [NAL9602](INFO): Powering down
2024-06-12T23:10:55.359Z,1718233855.359 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-06-12T23:10:55.360Z,1718233855.360 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-06-12T23:10:55.361Z,1718233855.361 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-06-12T23:10:55.361Z,1718233855.361 [MissionManager](INFO): Uninitializing Mission Default
2024-06-12T23:10:55.361Z,1718233855.361 [Default] Stopped
2024-06-12T23:10:55.361Z,1718233855.361 [Default](DEBUG): Aggregate::uninitialize Default
2024-06-12T23:10:55.361Z,1718233855.361 [Default:B.GoToSurface] Stopped
2024-06-12T23:10:55.361Z,1718233855.361 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-06-12T23:10:55.362Z,1718233855.362 [Default:CheckIn] Stopped
2024-06-12T23:10:55.362Z,1718233855.362 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-06-12T23:10:55.362Z,1718233855.362 [Default:CheckIn:C.Wait] Stopped
2024-06-12T23:10:55.362Z,1718233855.362 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-06-12T23:10:55.365Z,1718233855.365 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-06-12T23:10:55.365Z,1718233855.365 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-06-12T23:10:55.365Z,1718233855.365 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-06-12T23:10:55.365Z,1718233855.365 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-06-12T23:10:55.366Z,1718233855.366 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-06-12T23:10:55.366Z,1718233855.366 [BuoyancyServo](INFO): Powering down
2024-06-12T23:10:55.380Z,1718233855.380 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-06-12T23:10:55.380Z,1718233855.380 [ElevatorServo](INFO): Powering down
2024-06-12T23:10:55.381Z,1718233855.381 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-06-12T23:10:55.381Z,1718233855.381 [MassServo](INFO): Powering down
2024-06-12T23:10:55.382Z,1718233855.382 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-06-12T23:10:55.382Z,1718233855.382 [RudderServo](INFO): Powering down
2024-06-12T23:10:55.383Z,1718233855.383 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-06-12T23:10:55.383Z,1718233855.383 [ThrusterHE](INFO): Powering down
2024-06-12T23:10:55.383Z,1718233855.383 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-06-12T23:10:55.384Z,1718233855.384 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-06-12T23:10:55.384Z,1718233855.384 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-06-12T23:10:55.384Z,1718233855.384 [CBIT](DEBUG): Powering off loads.
2024-06-12T23:10:55.396Z,1718233855.396 [CBIT](DEBUG): Disabling WDT.
2024-06-12T23:10:55.408Z,1718233855.408 [CBIT](DEBUG): Opening all GF detection circuits.
2024-06-12T23:10:55.408Z,1718233855.408 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:55.463Z,1718233855.463 [DAT ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:55.468Z,1718233855.468 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:55.471Z,1718233855.471 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:55.477Z,1718233855.477 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:55.547Z,1718233855.547 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:55.552Z,1718233855.552 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:55.593Z,1718233855.593 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-06-12T23:10:55.687Z,1718233855.687 [logger ThreadHandler](INFO): Thread cancelled.