2023-07-11T17:45:39.443Z,1689097539.443 [NAL9602](INFO): Received command: restart logs 2023-07-11T17:45:39.459Z,1689097539.459 [CommandExec](IMPORTANT): got command restart logs 2023-07-11T17:45:59.572Z,1689097559.572 [NAL9602](INFO): SBD MO Status=2, MOMSN=44218, MT Status=2, MTMSN=0 2023-07-11T17:45:59.572Z,1689097559.572 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T17:46:28.708Z,1689097588.708 [NAL9602](INFO): SBD MO Status=1, MOMSN=44218, MT Status=0, MTMSN=0 2023-07-11T17:46:28.762Z,1689097588.762 [NAL9602](INFO): Sent 39 bytes from file Logs/20230711T171212/Courier0019.lzma 2023-07-11T17:46:28.762Z,1689097588.762 [NAL9602](INFO): Packets left to send: 0 2023-07-11T17:46:36.762Z,1689097596.762 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002770 2023-07-11T17:46:47.738Z,1689097607.738 [NAL9602](INFO): SBD MO Status=2, MOMSN=44219, MT Status=2, MTMSN=0 2023-07-11T17:46:47.739Z,1689097607.739 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T17:46:53.103Z,1689097613.103 [DataOverHttps](INFO): Sending 1114 bytes from file Logs/20230711T171212/Express0017.lzma 2023-07-11T17:47:07.164Z,1689097627.164 [DataOverHttps](INFO): Moved sent file to Logs/20230711T171212/Express0017.lzma.bak 2023-07-11T17:47:07.164Z,1689097627.164 [DataOverHttps](INFO): SBD MOMSN=18460799 2023-07-11T17:47:18.459Z,1689097638.459 [NAL9602](INFO): Not Powering down - fast GPS 2023-07-11T17:47:22.813Z,1689097642.813 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20230711T171212/Express0020.lzma 2023-07-11T17:47:23.817Z,1689097643.817 [DataOverHttps](INFO): Moved sent file to Logs/20230711T171212/Express0020.lzma.bak 2023-07-11T17:47:23.817Z,1689097643.817 [DataOverHttps](INFO): SBD MOMSN=18460842 2023-07-11T17:47:24.930Z,1689097644.930 [Default:CheckIn:Read_Iridium] Stopped 2023-07-11T17:47:24.930Z,1689097644.930 [Default:CheckIn:C.Wait] Running Loop=1 2023-07-11T17:47:24.930Z,1689097644.930 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-07-11T17:52:25.564Z,1689097945.564 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-07-11T17:52:25.564Z,1689097945.564 [Default:CheckIn:C.Wait] Stopped 2023-07-11T17:52:25.564Z,1689097945.564 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-07-11T17:52:25.564Z,1689097945.564 [Default:CheckIn:D] Running Loop=1 2023-07-11T17:52:25.965Z,1689097945.965 [Default:CheckIn:D] Stopped 2023-07-11T17:52:25.965Z,1689097945.965 [Default:CheckIn:E] Running Loop=1 2023-07-11T17:52:26.377Z,1689097946.377 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 35.873401 min 2023-07-11T17:52:26.377Z,1689097946.377 [Default:CheckIn:E] Stopped 2023-07-11T17:52:26.377Z,1689097946.377 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-07-11T17:52:26.377Z,1689097946.377 [Default:CheckIn] Stopped 2023-07-11T17:52:26.377Z,1689097946.377 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T17:52:26.377Z,1689097946.377 [Default:CheckIn](INFO): Running loop #6 2023-07-11T17:52:26.377Z,1689097946.377 [Default:CheckIn] Running Loop=6 2023-07-11T17:52:26.378Z,1689097946.378 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-07-11T17:52:26.378Z,1689097946.378 [Default:CheckIn:Read_GPS] Running Loop=1 2023-07-11T17:52:28.381Z,1689097948.381 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175227.00,A,3639.14014,N,12205.83902,W,31.199,58.14,110723,,,D*7B 2023-07-11T17:52:28.383Z,1689097948.383 [NAL9602](INFO): GPS fix at 20230711T175227: (36.652336, -122.097317) 2023-07-11T17:52:28.394Z,1689097948.394 [Default:CheckIn:Read_GPS] Stopped 2023-07-11T17:52:28.394Z,1689097948.394 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-07-11T17:52:29.215Z,1689097949.215 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:52:57.068Z,1689097977.068 [NAL9602](INFO): SBD MO Status=1, MOMSN=44219, MT Status=0, MTMSN=0 2023-07-11T17:52:57.068Z,1689097977.068 [NAL9602](INFO): No messages in MT queue 2023-07-11T17:53:00.302Z,1689097980.302 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:53:27.766Z,1689098007.766 [NAL9602](INFO): Not Powering down - fast GPS 2023-07-11T17:53:31.426Z,1689098011.426 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:54:02.550Z,1689098042.550 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:54:33.679Z,1689098073.679 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:54:36.690Z,1689098076.690 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.739487 2023-07-11T17:54:51.449Z,1689098091.449 [NAL9602](INFO): SBD MO Status=1, MOMSN=44220, MT Status=0, MTMSN=0 2023-07-11T17:54:51.510Z,1689098091.510 [NAL9602](INFO): Sent 268 bytes from file Logs/20230711T174539/Courier0000.lzma 2023-07-11T17:54:51.510Z,1689098091.510 [NAL9602](INFO): Packets left to send: 0 2023-07-11T17:55:05.245Z,1689098105.245 [NAL9602](INFO): SBD MO Status=1, MOMSN=44221, MT Status=0, MTMSN=0 2023-07-11T17:55:05.298Z,1689098105.298 [NAL9602](INFO): Sent 332 bytes from file Logs/20230711T174539/Express0001.lzma 2023-07-11T17:55:05.298Z,1689098105.298 [NAL9602](INFO): Packets left to send: 1 2023-07-11T17:55:07.814Z,1689098107.814 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:55:22.680Z,1689098122.680 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T17:55:22.681Z,1689098122.681 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T17:55:38.938Z,1689098138.938 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:55:46.961Z,1689098146.961 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T17:55:46.961Z,1689098146.961 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T17:56:10.062Z,1689098170.062 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:56:40.728Z,1689098200.728 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T17:56:40.729Z,1689098200.729 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T17:56:41.186Z,1689098201.186 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:57:05.836Z,1689098225.836 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T17:57:05.837Z,1689098225.837 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T17:57:12.310Z,1689098232.310 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:57:43.434Z,1689098263.434 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:57:49.095Z,1689098269.095 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T17:57:49.095Z,1689098269.095 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T17:58:14.570Z,1689098294.570 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:58:17.029Z,1689098297.029 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T17:58:17.029Z,1689098297.029 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T17:58:45.694Z,1689098325.694 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:58:56.251Z,1689098336.251 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T17:58:56.251Z,1689098336.251 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T17:59:16.818Z,1689098356.818 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T17:59:22.173Z,1689098362.173 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T17:59:22.173Z,1689098362.173 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T17:59:47.697Z,1689098387.697 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T17:59:47.697Z,1689098387.697 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T17:59:47.942Z,1689098387.942 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:00:04.712Z,1689098404.712 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T18:00:04.712Z,1689098404.712 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T18:00:19.070Z,1689098419.070 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:00:22.124Z,1689098422.124 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T18:00:22.125Z,1689098422.125 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T18:00:41.530Z,1689098441.530 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003135 2023-07-11T18:00:41.985Z,1689098441.985 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T18:00:41.985Z,1689098441.985 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T18:00:50.174Z,1689098450.174 [DataOverHttps](INFO): Sending 397 bytes from file Logs/20230711T174539/Express0001.lzma 2023-07-11T18:00:51.176Z,1689098451.176 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Express0001.lzma.bak 2023-07-11T18:00:51.176Z,1689098451.176 [DataOverHttps](INFO): SBD MOMSN=18460863 2023-07-11T18:00:52.505Z,1689098452.505 [Default:CheckIn:Read_Iridium] Stopped 2023-07-11T18:00:52.505Z,1689098452.505 [Default:CheckIn:C.Wait] Running Loop=1 2023-07-11T18:00:52.505Z,1689098452.505 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-07-11T18:01:12.719Z,1689098472.719 [NAL9602](INFO): Not Powering down - fast GPS 2023-07-11T18:05:53.104Z,1689098753.104 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-07-11T18:05:53.104Z,1689098753.104 [Default:CheckIn:C.Wait] Stopped 2023-07-11T18:05:53.104Z,1689098753.104 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-07-11T18:05:53.104Z,1689098753.104 [Default:CheckIn:D] Running Loop=1 2023-07-11T18:05:53.505Z,1689098753.505 [Default:CheckIn:D] Stopped 2023-07-11T18:05:53.505Z,1689098753.505 [Default:CheckIn:E] Running Loop=1 2023-07-11T18:05:53.921Z,1689098753.921 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 49.332410 min 2023-07-11T18:05:53.921Z,1689098753.921 [Default:CheckIn:E] Stopped 2023-07-11T18:05:53.922Z,1689098753.922 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-07-11T18:05:53.922Z,1689098753.922 [Default:CheckIn] Stopped 2023-07-11T18:05:53.922Z,1689098753.922 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T18:05:53.922Z,1689098753.922 [Default:CheckIn](INFO): Running loop #7 2023-07-11T18:05:53.922Z,1689098753.922 [Default:CheckIn] Running Loop=7 2023-07-11T18:05:53.922Z,1689098753.922 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-07-11T18:05:53.922Z,1689098753.922 [Default:CheckIn:Read_GPS] Running Loop=1 2023-07-11T18:05:55.925Z,1689098755.925 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180555.00,A,3642.48988,N,12158.72439,W,31.063,47.44,110723,,,D*75 2023-07-11T18:05:55.927Z,1689098755.927 [NAL9602](INFO): GPS fix at 20230711T180555: (36.708165, -121.978740) 2023-07-11T18:05:55.959Z,1689098755.959 [Default:CheckIn:Read_GPS] Stopped 2023-07-11T18:05:55.959Z,1689098755.959 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-07-11T18:06:02.801Z,1689098762.801 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230711T174539/Courier0003.lzma 2023-07-11T18:06:03.803Z,1689098763.803 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Courier0003.lzma.bak 2023-07-11T18:06:03.804Z,1689098763.804 [DataOverHttps](INFO): SBD MOMSN=18460867 2023-07-11T18:06:24.465Z,1689098784.465 [DataOverHttps](INFO): Sending 143 bytes from file Logs/20230711T174539/Express0004.lzma 2023-07-11T18:06:25.468Z,1689098785.468 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Express0004.lzma.bak 2023-07-11T18:06:25.468Z,1689098785.468 [DataOverHttps](INFO): SBD MOMSN=18460870 2023-07-11T18:06:25.876Z,1689098785.876 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T18:06:25.877Z,1689098785.877 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T18:06:26.719Z,1689098786.719 [Default:CheckIn:Read_Iridium] Stopped 2023-07-11T18:06:26.719Z,1689098786.719 [Default:CheckIn:C.Wait] Running Loop=1 2023-07-11T18:06:26.719Z,1689098786.719 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-07-11T18:06:59.000Z,1689098819.000 [NAL9602](INFO): SBD MO Status=2, MOMSN=44222, MT Status=2, MTMSN=0 2023-07-11T18:06:59.001Z,1689098819.001 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T18:07:47.076Z,1689098867.076 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=44222, MT Status=1, MTMSN=3017 2023-07-11T18:07:47.077Z,1689098867.077 [NAL9602](INFO): Data available in MT queue 2023-07-11T18:07:47.570Z,1689098867.570 [NAL9602](INFO): Received command: strobe off 2023-07-11T18:07:47.660Z,1689098867.660 [CommandExec](IMPORTANT): got command strobe off 2023-07-11T18:07:47.661Z,1689098867.661 [CommandExec](IMPORTANT): Deactivating strobe 2023-07-11T18:07:57.978Z,1689098877.978 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:08:18.192Z,1689098898.192 [NAL9602](INFO): Not Powering down - fast GPS 2023-07-11T18:08:29.102Z,1689098909.102 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:09:00.226Z,1689098940.226 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:09:31.350Z,1689098971.350 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:09:35.367Z,1689098975.367 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.784073 2023-07-11T18:10:32.594Z,1689099032.594 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:11:03.762Z,1689099063.762 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:11:27.269Z,1689099087.269 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-07-11T18:11:27.269Z,1689099087.269 [Default:CheckIn:C.Wait] Stopped 2023-07-11T18:11:27.269Z,1689099087.269 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-07-11T18:11:27.269Z,1689099087.269 [Default:CheckIn:D] Running Loop=1 2023-07-11T18:11:27.678Z,1689099087.678 [Default:CheckIn:D] Stopped 2023-07-11T18:11:27.678Z,1689099087.678 [Default:CheckIn:E] Running Loop=1 2023-07-11T18:11:28.072Z,1689099088.072 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 54.901957 min 2023-07-11T18:11:28.072Z,1689099088.072 [Default:CheckIn:E] Stopped 2023-07-11T18:11:28.072Z,1689099088.072 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-07-11T18:11:28.072Z,1689099088.072 [Default:CheckIn] Stopped 2023-07-11T18:11:28.072Z,1689099088.072 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T18:11:28.073Z,1689099088.073 [Default:CheckIn](INFO): Running loop #8 2023-07-11T18:11:28.073Z,1689099088.073 [Default:CheckIn] Running Loop=8 2023-07-11T18:11:28.073Z,1689099088.073 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-07-11T18:11:28.073Z,1689099088.073 [Default:CheckIn:Read_GPS] Running Loop=1 2023-07-11T18:11:30.093Z,1689099090.093 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181129.00,A,3643.87156,N,12155.75897,W,28.438,53.82,110723,,,D*7D 2023-07-11T18:11:30.095Z,1689099090.095 [NAL9602](INFO): GPS fix at 20230711T181129: (36.731193, -121.929316) 2023-07-11T18:11:30.105Z,1689099090.105 [Default:CheckIn:Read_GPS] Stopped 2023-07-11T18:11:30.106Z,1689099090.106 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-07-11T18:11:34.886Z,1689099094.886 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:11:54.368Z,1689099114.368 [NAL9602](INFO): SBD MO Status=1, MOMSN=44223, MT Status=0, MTMSN=0 2023-07-11T18:11:54.430Z,1689099114.430 [NAL9602](INFO): Sent 72 bytes from file Logs/20230711T174539/Courier0006.lzma 2023-07-11T18:11:54.430Z,1689099114.430 [NAL9602](INFO): Packets left to send: 0 2023-07-11T18:12:06.010Z,1689099126.010 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:12:13.412Z,1689099133.412 [NAL9602](INFO): SBD MO Status=2, MOMSN=44224, MT Status=2, MTMSN=0 2023-07-11T18:12:13.412Z,1689099133.412 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T18:12:37.142Z,1689099157.142 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:13:01.140Z,1689099181.140 [NAL9602](INFO): SBD MO Status=1, MOMSN=44224, MT Status=0, MTMSN=0 2023-07-11T18:13:01.190Z,1689099181.190 [NAL9602](INFO): Sent 254 bytes from file Logs/20230711T174539/Express0007.lzma 2023-07-11T18:13:01.190Z,1689099181.190 [NAL9602](INFO): Packets left to send: 0 2023-07-11T18:13:08.270Z,1689099188.270 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:13:11.639Z,1689099191.639 [NAL9602](INFO): SBD MO Status=2, MOMSN=44225, MT Status=2, MTMSN=0 2023-07-11T18:13:11.639Z,1689099191.639 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T18:13:21.335Z,1689099201.335 [NAL9602](INFO): SBD MO Status=0, MOMSN=44225, MT Status=0, MTMSN=0 2023-07-11T18:13:21.419Z,1689099201.419 [Default:CheckIn:Read_Iridium] Stopped 2023-07-11T18:13:21.419Z,1689099201.419 [Default:CheckIn:C.Wait] Running Loop=1 2023-07-11T18:13:21.419Z,1689099201.419 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-07-11T18:13:39.418Z,1689099219.418 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:13:52.044Z,1689099232.044 [NAL9602](INFO): Not Powering down - fast GPS 2023-07-11T18:14:10.554Z,1689099250.554 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:14:18.886Z,1689099258.886 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002884 2023-07-11T18:18:22.098Z,1689099502.098 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-07-11T18:18:22.098Z,1689099502.098 [Default:CheckIn:C.Wait] Stopped 2023-07-11T18:18:22.098Z,1689099502.098 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-07-11T18:18:22.098Z,1689099502.098 [Default:CheckIn:D] Running Loop=1 2023-07-11T18:18:22.499Z,1689099502.499 [Default:CheckIn:D] Stopped 2023-07-11T18:18:22.499Z,1689099502.499 [Default:CheckIn:E] Running Loop=1 2023-07-11T18:18:22.873Z,1689099502.873 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 61.815641 min 2023-07-11T18:18:22.873Z,1689099502.873 [Default:CheckIn:E] Stopped 2023-07-11T18:18:22.873Z,1689099502.873 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-07-11T18:18:22.873Z,1689099502.873 [Default:CheckIn] Stopped 2023-07-11T18:18:22.873Z,1689099502.873 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T18:18:22.873Z,1689099502.873 [Default:CheckIn](INFO): Running loop #9 2023-07-11T18:18:22.873Z,1689099502.873 [Default:CheckIn] Running Loop=9 2023-07-11T18:18:22.873Z,1689099502.873 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-07-11T18:18:22.874Z,1689099502.874 [Default:CheckIn:Read_GPS] Running Loop=1 2023-07-11T18:18:24.889Z,1689099504.889 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181824.00,A,3645.76483,N,12152.05512,W,27.719,63.33,110723,,,D*7A 2023-07-11T18:18:24.891Z,1689099504.891 [NAL9602](INFO): GPS fix at 20230711T181824: (36.762747, -121.867585) 2023-07-11T18:18:24.939Z,1689099504.939 [Default:CheckIn:Read_GPS] Stopped 2023-07-11T18:18:24.940Z,1689099504.940 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-07-11T18:18:26.777Z,1689099506.777 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230711T174539/Courier0009.lzma 2023-07-11T18:18:33.803Z,1689099513.803 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Courier0009.lzma.bak 2023-07-11T18:18:33.804Z,1689099513.804 [DataOverHttps](INFO): SBD MOMSN=18460888 2023-07-11T18:18:39.084Z,1689099519.084 [NAL9602](INFO): SBD MO Status=0, MOMSN=44226, MT Status=0, MTMSN=0 2023-07-11T18:18:39.085Z,1689099519.085 [NAL9602](INFO): No messages in MT queue 2023-07-11T18:18:56.405Z,1689099536.405 [DataOverHttps](INFO): Sending 143 bytes from file Logs/20230711T174539/Express0010.lzma 2023-07-11T18:18:57.408Z,1689099537.408 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Express0010.lzma.bak 2023-07-11T18:18:57.408Z,1689099537.408 [DataOverHttps](INFO): SBD MOMSN=18460892 2023-07-11T18:18:58.887Z,1689099538.887 [Default:CheckIn:Read_Iridium] Stopped 2023-07-11T18:18:58.888Z,1689099538.888 [Default:CheckIn:C.Wait] Running Loop=1 2023-07-11T18:18:58.888Z,1689099538.888 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-07-11T18:19:09.787Z,1689099549.787 [NAL9602](INFO): Not Powering down - fast GPS 2023-07-11T18:21:30.502Z,1689099690.502 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:22:01.626Z,1689099721.626 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:22:32.786Z,1689099752.786 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:23:03.910Z,1689099783.910 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T18:23:59.476Z,1689099839.476 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-07-11T18:23:59.476Z,1689099839.476 [Default:CheckIn:C.Wait] Stopped 2023-07-11T18:23:59.476Z,1689099839.476 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-07-11T18:23:59.476Z,1689099839.476 [Default:CheckIn:D] Running Loop=1 2023-07-11T18:23:59.880Z,1689099839.880 [Default:CheckIn:D] Stopped 2023-07-11T18:23:59.880Z,1689099839.880 [Default:CheckIn:E] Running Loop=1 2023-07-11T18:24:00.274Z,1689099840.274 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 67.438660 min 2023-07-11T18:24:00.274Z,1689099840.274 [Default:CheckIn:E] Stopped 2023-07-11T18:24:00.274Z,1689099840.274 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-07-11T18:24:00.274Z,1689099840.274 [Default:CheckIn] Stopped 2023-07-11T18:24:00.275Z,1689099840.275 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T18:24:00.275Z,1689099840.275 [Default:CheckIn](INFO): Running loop #10 2023-07-11T18:24:00.275Z,1689099840.275 [Default:CheckIn] Running Loop=10 2023-07-11T18:24:00.275Z,1689099840.275 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-07-11T18:24:00.275Z,1689099840.275 [Default:CheckIn:Read_GPS] Running Loop=1 2023-07-11T18:24:02.281Z,1689099842.281 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182401.00,A,3647.32333,N,12149.02025,W,30.693,49.72,110723,,,D*78 2023-07-11T18:24:02.283Z,1689099842.283 [NAL9602](INFO): GPS fix at 20230711T182401: (36.788722, -121.817004) 2023-07-11T18:24:02.311Z,1689099842.311 [Default:CheckIn:Read_GPS] Stopped 2023-07-11T18:24:02.311Z,1689099842.311 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-07-11T18:24:09.269Z,1689099849.269 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230711T174539/Courier0012.lzma 2023-07-11T18:24:10.271Z,1689099850.271 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Courier0012.lzma.bak 2023-07-11T18:24:10.272Z,1689099850.272 [DataOverHttps](INFO): SBD MOMSN=18460902 2023-07-11T18:24:29.669Z,1689099869.669 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20230711T174539/Express0013.lzma 2023-07-11T18:24:30.672Z,1689099870.672 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Express0013.lzma.bak 2023-07-11T18:24:30.672Z,1689099870.672 [DataOverHttps](INFO): SBD MOMSN=18460905 2023-07-11T18:24:31.819Z,1689099871.819 [Default:CheckIn:Read_Iridium] Stopped 2023-07-11T18:24:31.819Z,1689099871.819 [Default:CheckIn:C.Wait] Running Loop=1 2023-07-11T18:24:31.819Z,1689099871.819 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-07-11T18:24:36.616Z,1689099876.616 [NAL9602](INFO): SBD MO Status=2, MOMSN=44227, MT Status=2, MTMSN=0 2023-07-11T18:24:36.616Z,1689099876.616 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T18:24:37.420Z,1689099877.420 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2023-07-11T18:24:52.370Z,1689099892.370 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2023-07-11T18:24:54.396Z,1689099894.396 [NAL9602](INFO): SBD MO Status=0, MOMSN=44227, MT Status=0, MTMSN=0 2023-07-11T18:24:54.396Z,1689099894.396 [NAL9602](INFO): No messages in MT queue 2023-07-11T18:25:07.316Z,1689099907.316 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2023-07-11T18:25:22.669Z,1689099922.669 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2023-07-11T18:25:25.105Z,1689099925.105 [NAL9602](INFO): Not Powering down - fast GPS 2023-07-11T18:25:38.020Z,1689099938.020 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2023-07-11T18:25:52.564Z,1689099952.564 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2023-07-11T18:26:07.917Z,1689099967.917 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2023-07-11T18:26:23.269Z,1689099983.269 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2023-07-11T18:26:38.620Z,1689099998.620 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2023-07-11T18:26:53.568Z,1689100013.568 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2023-07-11T18:27:01.252Z,1689100021.252 [BPC1](INFO): Calculating totals. Valid battery stick count: 40. Valid reserve battery stick count: 5. 2023-07-11T18:27:01.254Z,1689100021.254 [BPC1](INFO): Received data from all battery sticks. 2023-07-11T18:29:32.357Z,1689100172.357 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-07-11T18:29:32.357Z,1689100172.357 [Default:CheckIn:C.Wait] Stopped 2023-07-11T18:29:32.357Z,1689100172.357 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-07-11T18:29:32.357Z,1689100172.357 [Default:CheckIn:D] Running Loop=1 2023-07-11T18:29:32.769Z,1689100172.769 [Default:CheckIn:D] Stopped 2023-07-11T18:29:32.769Z,1689100172.769 [Default:CheckIn:E] Running Loop=1 2023-07-11T18:29:33.160Z,1689100173.160 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 72.986808 min 2023-07-11T18:29:33.160Z,1689100173.160 [Default:CheckIn:E] Stopped 2023-07-11T18:29:33.160Z,1689100173.160 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-07-11T18:29:33.160Z,1689100173.160 [Default:CheckIn] Stopped 2023-07-11T18:29:33.160Z,1689100173.160 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T18:29:33.160Z,1689100173.160 [Default:CheckIn](INFO): Running loop #11 2023-07-11T18:29:33.160Z,1689100173.160 [Default:CheckIn] Running Loop=11 2023-07-11T18:29:33.160Z,1689100173.160 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-07-11T18:29:33.160Z,1689100173.160 [Default:CheckIn:Read_GPS] Running Loop=1 2023-07-11T18:29:35.177Z,1689100175.177 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182934.00,A,3648.52890,N,12147.14620,W,5.210,112.82,110723,,,D*7B 2023-07-11T18:29:35.179Z,1689100175.179 [NAL9602](INFO): GPS fix at 20230711T182934: (36.808815, -121.785770) 2023-07-11T18:29:35.189Z,1689100175.189 [Default:CheckIn:Read_GPS] Stopped 2023-07-11T18:29:35.189Z,1689100175.189 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-07-11T18:29:42.445Z,1689100182.445 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20230711T174539/Courier0015.lzma 2023-07-11T18:29:43.448Z,1689100183.448 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Courier0015.lzma.bak 2023-07-11T18:29:43.448Z,1689100183.448 [DataOverHttps](INFO): SBD MOMSN=18460909 2023-07-11T18:29:59.157Z,1689100199.157 [DataOverHttps](INFO): Sending 143 bytes from file Logs/20230711T174539/Express0016.lzma 2023-07-11T18:30:00.160Z,1689100200.160 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Express0016.lzma.bak 2023-07-11T18:30:00.160Z,1689100200.160 [DataOverHttps](INFO): SBD MOMSN=18460912 2023-07-11T18:30:01.459Z,1689100201.459 [Default:CheckIn:Read_Iridium] Stopped 2023-07-11T18:30:01.459Z,1689100201.459 [Default:CheckIn:C.Wait] Running Loop=1 2023-07-11T18:30:01.459Z,1689100201.459 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-07-11T18:30:14.765Z,1689100214.765 [NAL9602](INFO): SBD MO Status=0, MOMSN=44228, MT Status=0, MTMSN=0 2023-07-11T18:30:14.765Z,1689100214.765 [NAL9602](INFO): No messages in MT queue 2023-07-11T18:30:45.471Z,1689100245.471 [NAL9602](INFO): Not Powering down - fast GPS 2023-07-11T18:35:02.026Z,1689100502.026 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-07-11T18:35:02.026Z,1689100502.026 [Default:CheckIn:C.Wait] Stopped 2023-07-11T18:35:02.027Z,1689100502.027 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-07-11T18:35:02.027Z,1689100502.027 [Default:CheckIn:D] Running Loop=1 2023-07-11T18:35:02.423Z,1689100502.423 [Default:CheckIn:D] Stopped 2023-07-11T18:35:02.423Z,1689100502.423 [Default:CheckIn:E] Running Loop=1 2023-07-11T18:35:02.828Z,1689100502.828 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 78.481047 min 2023-07-11T18:35:02.828Z,1689100502.828 [Default:CheckIn:E] Stopped 2023-07-11T18:35:02.828Z,1689100502.828 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-07-11T18:35:02.828Z,1689100502.828 [Default:CheckIn] Stopped 2023-07-11T18:35:02.828Z,1689100502.828 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T18:35:02.828Z,1689100502.828 [Default:CheckIn](INFO): Running loop #12 2023-07-11T18:35:02.828Z,1689100502.828 [Default:CheckIn] Running Loop=12 2023-07-11T18:35:02.828Z,1689100502.828 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-07-11T18:35:02.828Z,1689100502.828 [Default:CheckIn:Read_GPS] Running Loop=1 2023-07-11T18:35:04.834Z,1689100504.834 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183504.00,A,3648.15818,N,12147.21711,W,0.564,219.55,110723,,,D*70 2023-07-11T18:35:04.841Z,1689100504.841 [NAL9602](INFO): GPS fix at 20230711T183504: (36.802636, -121.786952) 2023-07-11T18:35:04.851Z,1689100504.851 [Default:CheckIn:Read_GPS] Stopped 2023-07-11T18:35:04.851Z,1689100504.851 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-07-11T18:35:11.834Z,1689100511.834 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230711T174539/Courier0018.lzma 2023-07-11T18:35:12.837Z,1689100512.837 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Courier0018.lzma.bak 2023-07-11T18:35:12.837Z,1689100512.837 [DataOverHttps](INFO): SBD MOMSN=18460938 2023-07-11T18:35:28.495Z,1689100528.495 [DataOverHttps](INFO): Sending 142 bytes from file Logs/20230711T174539/Express0019.lzma 2023-07-11T18:35:29.497Z,1689100529.497 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Express0019.lzma.bak 2023-07-11T18:35:29.497Z,1689100529.497 [DataOverHttps](INFO): SBD MOMSN=18460941 2023-07-11T18:35:30.911Z,1689100530.911 [Default:CheckIn:Read_Iridium] Stopped 2023-07-11T18:35:30.911Z,1689100530.911 [Default:CheckIn:C.Wait] Running Loop=1 2023-07-11T18:35:30.912Z,1689100530.912 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-07-11T18:35:41.406Z,1689100541.406 [NAL9602](INFO): SBD MO Status=0, MOMSN=44229, MT Status=0, MTMSN=0 2023-07-11T18:35:41.406Z,1689100541.406 [NAL9602](INFO): No messages in MT queue 2023-07-11T18:36:12.112Z,1689100572.112 [NAL9602](INFO): Not Powering down - fast GPS 2023-07-11T18:40:31.503Z,1689100831.503 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-07-11T18:40:31.504Z,1689100831.504 [Default:CheckIn:C.Wait] Stopped 2023-07-11T18:40:31.504Z,1689100831.504 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-07-11T18:40:31.504Z,1689100831.504 [Default:CheckIn:D] Running Loop=1 2023-07-11T18:40:31.920Z,1689100831.920 [Default:CheckIn:D] Stopped 2023-07-11T18:40:31.920Z,1689100831.920 [Default:CheckIn:E] Running Loop=1 2023-07-11T18:40:32.310Z,1689100832.310 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 83.972648 min 2023-07-11T18:40:32.310Z,1689100832.310 [Default:CheckIn:E] Stopped 2023-07-11T18:40:32.310Z,1689100832.310 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-07-11T18:40:32.310Z,1689100832.310 [Default:CheckIn] Stopped 2023-07-11T18:40:32.310Z,1689100832.310 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T18:40:32.310Z,1689100832.310 [Default:CheckIn](INFO): Running loop #13 2023-07-11T18:40:32.311Z,1689100832.311 [Default:CheckIn] Running Loop=13 2023-07-11T18:40:32.311Z,1689100832.311 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-07-11T18:40:32.311Z,1689100832.311 [Default:CheckIn:Read_GPS] Running Loop=1 2023-07-11T18:40:34.323Z,1689100834.323 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184033.00,A,3648.15107,N,12147.22284,W,0.058,205.55,110723,,,D*7C 2023-07-11T18:40:34.325Z,1689100834.325 [NAL9602](INFO): GPS fix at 20230711T184033: (36.802518, -121.787047) 2023-07-11T18:40:34.336Z,1689100834.336 [Default:CheckIn:Read_GPS] Stopped 2023-07-11T18:40:34.336Z,1689100834.336 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-07-11T18:40:41.566Z,1689100841.566 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230711T174539/Courier0021.lzma 2023-07-11T18:40:42.569Z,1689100842.569 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Courier0021.lzma.bak 2023-07-11T18:40:42.569Z,1689100842.569 [DataOverHttps](INFO): SBD MOMSN=18460949 2023-07-11T18:40:44.422Z,1689100844.422 [NAL9602](INFO): SBD MO Status=0, MOMSN=44230, MT Status=0, MTMSN=0 2023-07-11T18:40:44.422Z,1689100844.422 [NAL9602](INFO): No messages in MT queue 2023-07-11T18:41:01.307Z,1689100861.307 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20230711T174539/Express0022.lzma 2023-07-11T18:41:02.309Z,1689100862.309 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Express0022.lzma.bak 2023-07-11T18:41:02.309Z,1689100862.309 [DataOverHttps](INFO): SBD MOMSN=18460953 2023-07-11T18:41:03.459Z,1689100863.459 [Default:CheckIn:Read_Iridium] Stopped 2023-07-11T18:41:03.459Z,1689100863.459 [Default:CheckIn:C.Wait] Running Loop=1 2023-07-11T18:41:03.460Z,1689100863.460 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-07-11T18:41:15.159Z,1689100875.159 [NAL9602](INFO): Not Powering down - fast GPS 2023-07-11T18:46:04.058Z,1689101164.058 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-07-11T18:46:04.058Z,1689101164.058 [Default:CheckIn:C.Wait] Stopped 2023-07-11T18:46:04.058Z,1689101164.058 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-07-11T18:46:04.058Z,1689101164.058 [Default:CheckIn:D] Running Loop=1 2023-07-11T18:46:04.478Z,1689101164.478 [Default:CheckIn:D] Stopped 2023-07-11T18:46:04.478Z,1689101164.478 [Default:CheckIn:E] Running Loop=1 2023-07-11T18:46:04.891Z,1689101164.891 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 89.515283 min 2023-07-11T18:46:04.891Z,1689101164.891 [Default:CheckIn:E] Stopped 2023-07-11T18:46:04.891Z,1689101164.891 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-07-11T18:46:04.891Z,1689101164.891 [Default:CheckIn] Stopped 2023-07-11T18:46:04.891Z,1689101164.891 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T18:46:04.892Z,1689101164.892 [Default:CheckIn](INFO): Running loop #14 2023-07-11T18:46:04.892Z,1689101164.892 [Default:CheckIn] Running Loop=14 2023-07-11T18:46:04.892Z,1689101164.892 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-07-11T18:46:04.892Z,1689101164.892 [Default:CheckIn:Read_GPS] Running Loop=1 2023-07-11T18:46:06.883Z,1689101166.883 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184606.00,A,3648.14864,N,12147.22391,W,0.078,244.74,110723,,,D*70 2023-07-11T18:46:06.886Z,1689101166.886 [NAL9602](INFO): GPS fix at 20230711T184606: (36.802477, -121.787065) 2023-07-11T18:46:06.896Z,1689101166.896 [Default:CheckIn:Read_GPS] Stopped 2023-07-11T18:46:06.896Z,1689101166.896 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-07-11T18:46:14.126Z,1689101174.126 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230711T174539/Courier0024.lzma 2023-07-11T18:46:15.129Z,1689101175.129 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Courier0024.lzma.bak 2023-07-11T18:46:15.129Z,1689101175.129 [DataOverHttps](INFO): SBD MOMSN=18460958 2023-07-11T18:46:19.834Z,1689101179.834 [NAL9602](INFO): SBD MO Status=0, MOMSN=44231, MT Status=0, MTMSN=0 2023-07-11T18:46:19.834Z,1689101179.834 [NAL9602](INFO): No messages in MT queue 2023-07-11T18:46:33.487Z,1689101193.487 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20230711T174539/Express0025.lzma 2023-07-11T18:46:34.489Z,1689101194.489 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Express0025.lzma.bak 2023-07-11T18:46:34.489Z,1689101194.489 [DataOverHttps](INFO): SBD MOMSN=18460962 2023-07-11T18:46:35.642Z,1689101195.642 [Default:CheckIn:Read_Iridium] Stopped 2023-07-11T18:46:35.642Z,1689101195.642 [Default:CheckIn:C.Wait] Running Loop=1 2023-07-11T18:46:35.642Z,1689101195.642 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-07-11T18:46:50.577Z,1689101210.577 [NAL9602](INFO): Not Powering down - fast GPS 2023-07-11T18:51:36.215Z,1689101496.215 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-07-11T18:51:36.215Z,1689101496.215 [Default:CheckIn:C.Wait] Stopped 2023-07-11T18:51:36.215Z,1689101496.215 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-07-11T18:51:36.215Z,1689101496.215 [Default:CheckIn:D] Running Loop=1 2023-07-11T18:51:36.630Z,1689101496.630 [Default:CheckIn:D] Stopped 2023-07-11T18:51:36.630Z,1689101496.630 [Default:CheckIn:E] Running Loop=1 2023-07-11T18:51:37.021Z,1689101497.021 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 95.051164 min 2023-07-11T18:51:37.022Z,1689101497.022 [Default:CheckIn:E] Stopped 2023-07-11T18:51:37.022Z,1689101497.022 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-07-11T18:51:37.022Z,1689101497.022 [Default:CheckIn] Stopped 2023-07-11T18:51:37.022Z,1689101497.022 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T18:51:37.022Z,1689101497.022 [Default:CheckIn](INFO): Running loop #15 2023-07-11T18:51:37.022Z,1689101497.022 [Default:CheckIn] Running Loop=15 2023-07-11T18:51:37.022Z,1689101497.022 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-07-11T18:51:37.022Z,1689101497.022 [Default:CheckIn:Read_GPS] Running Loop=1 2023-07-11T18:51:39.039Z,1689101499.039 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185138.00,A,3648.17513,N,12147.27980,W,0.078,273.94,110723,,,D*70 2023-07-11T18:51:39.041Z,1689101499.041 [NAL9602](INFO): GPS fix at 20230711T185138: (36.802919, -121.787997) 2023-07-11T18:51:39.051Z,1689101499.051 [Default:CheckIn:Read_GPS] Stopped 2023-07-11T18:51:39.051Z,1689101499.051 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-07-11T18:51:46.606Z,1689101506.606 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230711T174539/Courier0027.lzma 2023-07-11T18:51:47.609Z,1689101507.609 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Courier0027.lzma.bak 2023-07-11T18:51:47.609Z,1689101507.609 [DataOverHttps](INFO): SBD MOMSN=18460968 2023-07-11T18:52:03.303Z,1689101523.303 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20230711T174539/Express0028.lzma 2023-07-11T18:52:04.305Z,1689101524.305 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Express0028.lzma.bak 2023-07-11T18:52:04.305Z,1689101524.305 [DataOverHttps](INFO): SBD MOMSN=18460971 2023-07-11T18:52:05.720Z,1689101525.720 [Default:CheckIn:Read_Iridium] Stopped 2023-07-11T18:52:05.720Z,1689101525.720 [Default:CheckIn:C.Wait] Running Loop=1 2023-07-11T18:52:05.720Z,1689101525.720 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-07-11T18:52:55.398Z,1689101575.398 [NAL9602](INFO): SBD MO Status=2, MOMSN=44232, MT Status=2, MTMSN=0 2023-07-11T18:52:55.398Z,1689101575.398 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T18:53:30.137Z,1689101610.137 [NAL9602](INFO): SBD MO Status=2, MOMSN=44232, MT Status=2, MTMSN=0 2023-07-11T18:53:30.137Z,1689101610.137 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-07-11T18:56:41.238Z,1689101801.238 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-07-11T18:57:06.301Z,1689101826.301 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-07-11T18:57:06.302Z,1689101826.302 [Default:CheckIn:C.Wait] Stopped 2023-07-11T18:57:06.302Z,1689101826.302 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-07-11T18:57:06.302Z,1689101826.302 [Default:CheckIn:D] Running Loop=1 2023-07-11T18:57:06.703Z,1689101826.703 [Default:CheckIn:D] Stopped 2023-07-11T18:57:06.703Z,1689101826.703 [Default:CheckIn:E] Running Loop=1 2023-07-11T18:57:07.116Z,1689101827.116 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 100.552376 min 2023-07-11T18:57:07.116Z,1689101827.116 [Default:CheckIn:E] Stopped 2023-07-11T18:57:07.116Z,1689101827.116 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-07-11T18:57:07.116Z,1689101827.116 [Default:CheckIn] Stopped 2023-07-11T18:57:07.116Z,1689101827.116 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T18:57:07.116Z,1689101827.116 [Default:CheckIn](INFO): Running loop #16 2023-07-11T18:57:07.116Z,1689101827.116 [Default:CheckIn] Running Loop=16 2023-07-11T18:57:07.116Z,1689101827.116 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-07-11T18:57:07.117Z,1689101827.117 [Default:CheckIn:Read_GPS] Running Loop=1 2023-07-11T18:57:09.118Z,1689101829.118 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185708.00,A,3648.16652,N,12147.27838,W,0.136,287.38,110723,,,D*76 2023-07-11T18:57:09.121Z,1689101829.121 [NAL9602](INFO): GPS fix at 20230711T185708: (36.802775, -121.787973) 2023-07-11T18:57:09.148Z,1689101829.148 [Default:CheckIn:Read_GPS] Stopped 2023-07-11T18:57:09.148Z,1689101829.148 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-07-11T18:57:15.926Z,1689101835.926 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20230711T174539/Courier0030.lzma 2023-07-11T18:57:16.929Z,1689101836.929 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Courier0030.lzma.bak 2023-07-11T18:57:16.929Z,1689101836.929 [DataOverHttps](INFO): SBD MOMSN=18460978 2023-07-11T18:57:32.540Z,1689101852.540 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20230711T174539/Express0031.lzma 2023-07-11T18:57:33.541Z,1689101853.541 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Express0031.lzma.bak 2023-07-11T18:57:33.541Z,1689101853.541 [DataOverHttps](INFO): SBD MOMSN=18460981 2023-07-11T18:57:34.990Z,1689101854.990 [Default:CheckIn:Read_Iridium] Stopped 2023-07-11T18:57:34.990Z,1689101854.990 [Default:CheckIn:C.Wait] Running Loop=1 2023-07-11T18:57:34.990Z,1689101854.990 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-07-11T18:57:41.432Z,1689101861.432 [NAL9602](INFO): Not Powering down - fast GPS 2023-07-11T19:02:35.569Z,1689102155.569 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-07-11T19:02:35.569Z,1689102155.569 [Default:CheckIn:C.Wait] Stopped 2023-07-11T19:02:35.569Z,1689102155.569 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-07-11T19:02:35.569Z,1689102155.569 [Default:CheckIn:D] Running Loop=1 2023-07-11T19:02:35.978Z,1689102155.978 [Default:CheckIn:D] Stopped 2023-07-11T19:02:35.978Z,1689102155.978 [Default:CheckIn:E] Running Loop=1 2023-07-11T19:02:36.380Z,1689102156.380 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 106.040283 min 2023-07-11T19:02:36.380Z,1689102156.380 [Default:CheckIn:E] Stopped 2023-07-11T19:02:36.380Z,1689102156.380 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-07-11T19:02:36.380Z,1689102156.380 [Default:CheckIn] Stopped 2023-07-11T19:02:36.380Z,1689102156.380 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T19:02:36.380Z,1689102156.380 [Default:CheckIn](INFO): Running loop #17 2023-07-11T19:02:36.380Z,1689102156.380 [Default:CheckIn] Running Loop=17 2023-07-11T19:02:36.380Z,1689102156.380 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-07-11T19:02:36.381Z,1689102156.381 [Default:CheckIn:Read_GPS] Running Loop=1 2023-07-11T19:02:38.394Z,1689102158.394 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190237.00,A,3648.14425,N,12147.27845,W,3.732,174.14,110723,,,A*74 2023-07-11T19:02:38.406Z,1689102158.406 [NAL9602](INFO): GPS fix at 20230711T190237: (36.802404, -121.787974) 2023-07-11T19:02:38.417Z,1689102158.417 [Default:CheckIn:Read_GPS] Stopped 2023-07-11T19:02:38.417Z,1689102158.417 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-07-11T19:02:45.202Z,1689102165.202 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230711T174539/Courier0033.lzma 2023-07-11T19:02:46.205Z,1689102166.205 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Courier0033.lzma.bak 2023-07-11T19:02:46.205Z,1689102166.205 [DataOverHttps](INFO): SBD MOMSN=18460989 2023-07-11T19:03:04.715Z,1689102184.715 [DataOverHttps](INFO): Sending 136 bytes from file Logs/20230711T174539/Express0034.lzma 2023-07-11T19:03:05.717Z,1689102185.717 [DataOverHttps](INFO): Moved sent file to Logs/20230711T174539/Express0034.lzma.bak 2023-07-11T19:03:05.717Z,1689102185.717 [DataOverHttps](INFO): SBD MOMSN=18460992 2023-07-11T19:03:07.164Z,1689102187.164 [Default:CheckIn:Read_Iridium] Stopped 2023-07-11T19:03:07.164Z,1689102187.164 [Default:CheckIn:C.Wait] Running Loop=1 2023-07-11T19:03:07.164Z,1689102187.164 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-07-11T19:03:09.173Z,1689102189.173 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2023-07-11T19:03:09.247Z,1689102189.247 [NAL9602](ERROR): received: +CSQ:0 OK232, 2, 0, 0, 0 OK 2023-07-11T19:06:09.132Z,1689102369.132 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T19:06:40.255Z,1689102400.255 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T19:07:11.383Z,1689102431.383 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T19:07:40.264Z,1689102460.264 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-07-11T19:07:42.508Z,1689102462.508 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T19:08:07.751Z,1689102487.751 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-07-11T19:08:07.751Z,1689102487.751 [Default:CheckIn:C.Wait] Stopped 2023-07-11T19:08:07.751Z,1689102487.751 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-07-11T19:08:07.751Z,1689102487.751 [Default:CheckIn:D] Running Loop=1 2023-07-11T19:08:08.152Z,1689102488.152 [Default:CheckIn:D] Stopped 2023-07-11T19:08:08.152Z,1689102488.152 [Default:CheckIn:E] Running Loop=1 2023-07-11T19:08:08.549Z,1689102488.549 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 111.576514 min 2023-07-11T19:08:08.550Z,1689102488.550 [Default:CheckIn:E] Stopped 2023-07-11T19:08:08.550Z,1689102488.550 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-07-11T19:08:08.550Z,1689102488.550 [Default:CheckIn] Stopped 2023-07-11T19:08:08.550Z,1689102488.550 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T19:08:08.550Z,1689102488.550 [Default:CheckIn](INFO): Running loop #18 2023-07-11T19:08:08.550Z,1689102488.550 [Default:CheckIn] Running Loop=18 2023-07-11T19:08:08.550Z,1689102488.550 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-07-11T19:08:08.550Z,1689102488.550 [Default:CheckIn:Read_GPS] Running Loop=1 2023-07-11T19:08:13.643Z,1689102493.643 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T19:08:16.683Z,1689102496.683 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.778427 2023-07-11T19:09:14.947Z,1689102554.947 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-07-11T19:09:19.588Z,1689102559.588 [CommandExec](IMPORTANT): got command quit 2023-07-11T19:09:20.591Z,1689102560.591 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2023-07-11T19:09:20.591Z,1689102560.591 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-07-11T19:09:20.592Z,1689102560.592 [CommandExec](INFO): Uninitializing the command executive. 2023-07-11T19:09:20.592Z,1689102560.592 [CommandExec](INFO): Uninitializing the command scheduler. 2023-07-11T19:09:20.592Z,1689102560.592 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:20.783Z,1689102560.783 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-07-11T19:09:20.783Z,1689102560.783 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-07-11T19:09:20.783Z,1689102560.783 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:20.784Z,1689102560.784 [NavChartDb](INFO): Join timeout helper Thread ID is 7601 2023-07-11T19:09:21.115Z,1689102561.115 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-07-11T19:09:21.115Z,1689102561.115 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:21.129Z,1689102561.129 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-07-11T19:09:21.129Z,1689102561.129 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:21.130Z,1689102561.130 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7602 2023-07-11T19:09:21.375Z,1689102561.375 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-07-11T19:09:21.376Z,1689102561.376 [WetLabsBB2FL](INFO): Powering down 2023-07-11T19:09:21.376Z,1689102561.376 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:21.389Z,1689102561.389 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-07-11T19:09:21.389Z,1689102561.389 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:21.390Z,1689102561.390 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7603 2023-07-11T19:09:21.587Z,1689102561.587 [CTD_Seabird](INFO): Powering down 2023-07-11T19:09:21.599Z,1689102561.599 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-07-11T19:09:21.600Z,1689102561.600 [CTD_Seabird](INFO): Powering down 2023-07-11T19:09:21.611Z,1689102561.611 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:21.623Z,1689102561.623 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-07-11T19:09:21.623Z,1689102561.623 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:21.623Z,1689102561.623 [Radio_Surface](INFO): Join timeout helper Thread ID is 7604 2023-07-11T19:09:21.635Z,1689102561.635 [Radio_Surface](INFO): Powering down 2023-07-11T19:09:21.636Z,1689102561.636 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-07-11T19:09:21.636Z,1689102561.636 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:21.651Z,1689102561.651 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-07-11T19:09:21.685Z,1689102561.685 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:21.686Z,1689102561.686 [Onboard](INFO): Join timeout helper Thread ID is 7605 2023-07-11T19:09:23.539Z,1689102563.539 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-07-11T19:09:23.540Z,1689102563.540 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:23.556Z,1689102563.556 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-07-11T19:09:23.556Z,1689102563.556 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:23.556Z,1689102563.556 [DataOverHttps](INFO): Join timeout helper Thread ID is 7606 2023-07-11T19:09:23.983Z,1689102563.983 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-07-11T19:09:23.984Z,1689102563.984 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.004Z,1689102564.004 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-07-11T19:09:24.004Z,1689102564.004 [logger ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.004Z,1689102564.004 [logger](INFO): Join timeout helper Thread ID is 7607 2023-07-11T19:09:24.011Z,1689102564.011 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-07-11T19:09:24.011Z,1689102564.011 [logger ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.024Z,1689102564.024 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-07-11T19:09:24.024Z,1689102564.024 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.024Z,1689102564.024 [CommandLine](INFO): Join timeout helper Thread ID is 7608 2023-07-11T19:09:24.047Z,1689102564.047 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-07-11T19:09:24.048Z,1689102564.048 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.064Z,1689102564.064 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-07-11T19:09:24.064Z,1689102564.064 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.064Z,1689102564.064 [CommandExec](INFO): Join timeout helper Thread ID is 7609 2023-07-11T19:09:24.065Z,1689102564.065 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-07-11T19:09:24.065Z,1689102564.065 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.066Z,1689102564.066 [controlThread](INFO): Join timeout helper Thread ID is 7610 2023-07-11T19:09:24.076Z,1689102564.076 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-07-11T19:09:24.077Z,1689102564.077 [controlThread](DEBUG): Uninitializing ControlThread 2023-07-11T19:09:24.078Z,1689102564.078 [AHRS_M2](INFO): Powering down 2023-07-11T19:09:24.152Z,1689102564.152 [NAL9602](INFO): Powering down 2023-07-11T19:09:24.154Z,1689102564.154 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-07-11T19:09:24.155Z,1689102564.155 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-07-11T19:09:24.156Z,1689102564.156 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-07-11T19:09:24.156Z,1689102564.156 [MissionManager](INFO): Uninitializing Mission Default 2023-07-11T19:09:24.156Z,1689102564.156 [Default] Stopped 2023-07-11T19:09:24.157Z,1689102564.157 [Default](DEBUG): Aggregate::uninitialize Default 2023-07-11T19:09:24.157Z,1689102564.157 [Default:B.GoToSurface] Stopped 2023-07-11T19:09:24.157Z,1689102564.157 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-07-11T19:09:24.157Z,1689102564.157 [Default:CheckIn] Stopped 2023-07-11T19:09:24.157Z,1689102564.157 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-07-11T19:09:24.157Z,1689102564.157 [Default:CheckIn:Read_GPS] Stopped 2023-07-11T19:09:24.160Z,1689102564.160 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-07-11T19:09:24.160Z,1689102564.160 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-07-11T19:09:24.160Z,1689102564.160 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-07-11T19:09:24.161Z,1689102564.161 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-07-11T19:09:24.161Z,1689102564.161 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-07-11T19:09:24.161Z,1689102564.161 [BuoyancyServo](INFO): Powering down 2023-07-11T19:09:24.175Z,1689102564.175 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-07-11T19:09:24.175Z,1689102564.175 [ElevatorServo](INFO): Powering down 2023-07-11T19:09:24.176Z,1689102564.176 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-07-11T19:09:24.176Z,1689102564.176 [MassServo](INFO): Powering down 2023-07-11T19:09:24.177Z,1689102564.177 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-07-11T19:09:24.177Z,1689102564.177 [RudderServo](INFO): Powering down 2023-07-11T19:09:24.178Z,1689102564.178 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2023-07-11T19:09:24.178Z,1689102564.178 [ThrusterServo](INFO): Powering down 2023-07-11T19:09:24.179Z,1689102564.179 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-07-11T19:09:24.179Z,1689102564.179 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-07-11T19:09:24.180Z,1689102564.180 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-07-11T19:09:24.180Z,1689102564.180 [CBIT](DEBUG): Powering off loads. 2023-07-11T19:09:24.191Z,1689102564.191 [CBIT](DEBUG): Disabling WDT. 2023-07-11T19:09:24.203Z,1689102564.203 [CBIT](DEBUG): Opening all GF detection circuits. 2023-07-11T19:09:24.204Z,1689102564.204 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.263Z,1689102564.263 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.266Z,1689102564.266 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.272Z,1689102564.272 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.344Z,1689102564.344 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.348Z,1689102564.348 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.391Z,1689102564.391 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-07-11T19:09:24.484Z,1689102564.484 [logger ThreadHandler](INFO): Thread cancelled.