2023-10-04T21:23:33.429Z,1696454613.429 [CommandExec](IMPORTANT): got command restart logs 2023-10-04T21:25:08.216Z,1696454708.216 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:25:10.224Z,1696454710.224 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.247280 2023-10-04T21:25:21.256Z,1696454721.256 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T21:25:21.256Z,1696454721.256 [Default:CheckIn:C.Wait] Stopped 2023-10-04T21:25:21.256Z,1696454721.256 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T21:25:21.256Z,1696454721.256 [Default:CheckIn:D] Running Loop=1 2023-10-04T21:25:21.656Z,1696454721.656 [Default:CheckIn:D] Stopped 2023-10-04T21:25:21.656Z,1696454721.656 [Default:CheckIn:E] Running Loop=1 2023-10-04T21:25:22.054Z,1696454722.054 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 92.354940 min 2023-10-04T21:25:22.054Z,1696454722.054 [Default:CheckIn:E] Stopped 2023-10-04T21:25:22.055Z,1696454722.055 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T21:25:22.055Z,1696454722.055 [Default:CheckIn] Stopped 2023-10-04T21:25:22.055Z,1696454722.055 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T21:25:22.055Z,1696454722.055 [Default:CheckIn](INFO): Running loop #16 2023-10-04T21:25:22.055Z,1696454722.055 [Default:CheckIn] Running Loop=16 2023-10-04T21:25:22.055Z,1696454722.055 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T21:25:22.055Z,1696454722.055 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T21:25:24.070Z,1696454724.070 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212520.00,A,3651.48052,N,12210.61866,W,18.000,142.99,041023,,,D*40 2023-10-04T21:25:24.073Z,1696454724.073 [NAL9602](INFO): GPS fix at 20231004T212520: (36.858009, -122.176978) 2023-10-04T21:25:24.084Z,1696454724.084 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T21:25:24.084Z,1696454724.084 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T21:25:43.364Z,1696454743.364 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:25:45.539Z,1696454745.539 [NAL9602](INFO): SBD MO Status=2, MOMSN=31798, MT Status=2, MTMSN=0 2023-10-04T21:25:45.539Z,1696454745.539 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T21:26:11.438Z,1696454771.438 [NAL9602](INFO): SBD MO Status=2, MOMSN=31798, MT Status=2, MTMSN=0 2023-10-04T21:26:11.438Z,1696454771.438 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T21:26:18.512Z,1696454778.512 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:26:33.299Z,1696454793.299 [NAL9602](INFO): SBD MO Status=2, MOMSN=31798, MT Status=2, MTMSN=0 2023-10-04T21:26:33.299Z,1696454793.299 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T21:26:53.672Z,1696454813.672 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:27:02.826Z,1696454822.826 [NAL9602](INFO): SBD MO Status=2, MOMSN=31798, MT Status=2, MTMSN=0 2023-10-04T21:27:02.826Z,1696454822.826 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T21:27:28.811Z,1696454848.811 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:27:42.555Z,1696454862.555 [NAL9602](INFO): SBD MO Status=1, MOMSN=31798, MT Status=0, MTMSN=0 2023-10-04T21:27:42.604Z,1696454862.604 [NAL9602](INFO): Sent 39 bytes from file Logs/20231003T170143/Courier0160.lzma 2023-10-04T21:27:42.604Z,1696454862.604 [NAL9602](INFO): Packets left to send: 0 2023-10-04T21:27:54.320Z,1696454874.320 [NAL9602](INFO): SBD MO Status=1, MOMSN=31799, MT Status=0, MTMSN=0 2023-10-04T21:27:54.370Z,1696454874.370 [NAL9602](INFO): Sent 268 bytes from file Logs/20231004T212333/Courier0000.lzma 2023-10-04T21:27:54.370Z,1696454874.370 [NAL9602](INFO): Packets left to send: 0 2023-10-04T21:28:03.956Z,1696454883.956 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:28:16.286Z,1696454896.286 [NAL9602](INFO): SBD MO Status=2, MOMSN=31800, MT Status=2, MTMSN=0 2023-10-04T21:28:16.286Z,1696454896.286 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T21:28:39.112Z,1696454919.112 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:28:42.250Z,1696454922.250 [NAL9602](INFO): SBD MO Status=1, MOMSN=31800, MT Status=0, MTMSN=0 2023-10-04T21:28:42.299Z,1696454922.299 [NAL9602](INFO): Sent 114 bytes from file Logs/20231003T170143/Express0161.lzma 2023-10-04T21:28:42.300Z,1696454922.300 [NAL9602](INFO): Packets left to send: 0 2023-10-04T21:28:54.850Z,1696454934.850 [NAL9602](INFO): SBD MO Status=1, MOMSN=31801, MT Status=0, MTMSN=0 2023-10-04T21:28:54.900Z,1696454934.900 [NAL9602](INFO): Sent 332 bytes from file Logs/20231004T212333/Express0001.lzma 2023-10-04T21:28:54.900Z,1696454934.900 [NAL9602](INFO): Packets left to send: 1 2023-10-04T21:29:05.478Z,1696454945.478 [NAL9602](INFO): SBD MO Status=1, MOMSN=31802, MT Status=0, MTMSN=0 2023-10-04T21:29:05.528Z,1696454945.528 [NAL9602](INFO): Sent 115 bytes from file Logs/20231004T212333/Express0001.lzma 2023-10-04T21:29:05.528Z,1696454945.528 [NAL9602](INFO): Packets left to send: 0 2023-10-04T21:29:13.149Z,1696454953.149 [NAL9602](INFO): SBD MO Status=0, MOMSN=31803, MT Status=0, MTMSN=0 2023-10-04T21:29:13.236Z,1696454953.236 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T21:29:13.236Z,1696454953.236 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T21:29:13.236Z,1696454953.236 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T21:29:14.260Z,1696454954.260 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:29:43.851Z,1696454983.851 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T21:29:49.400Z,1696454989.400 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:30:24.540Z,1696455024.540 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:30:59.688Z,1696455059.688 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:31:34.828Z,1696455094.828 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:32:09.967Z,1696455129.967 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:32:45.108Z,1696455165.108 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:33:20.256Z,1696455200.256 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:33:55.407Z,1696455235.407 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:34:13.744Z,1696455253.744 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T21:34:13.745Z,1696455253.745 [Default:CheckIn:C.Wait] Stopped 2023-10-04T21:34:13.745Z,1696455253.745 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T21:34:13.745Z,1696455253.745 [Default:CheckIn:D] Running Loop=1 2023-10-04T21:34:14.143Z,1696455254.143 [Default:CheckIn:D] Stopped 2023-10-04T21:34:14.143Z,1696455254.143 [Default:CheckIn:E] Running Loop=1 2023-10-04T21:34:14.547Z,1696455254.547 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 101.229712 min 2023-10-04T21:34:14.547Z,1696455254.547 [Default:CheckIn:E] Stopped 2023-10-04T21:34:14.548Z,1696455254.548 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T21:34:14.548Z,1696455254.548 [Default:CheckIn] Stopped 2023-10-04T21:34:14.548Z,1696455254.548 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T21:34:14.548Z,1696455254.548 [Default:CheckIn](INFO): Running loop #17 2023-10-04T21:34:14.548Z,1696455254.548 [Default:CheckIn] Running Loop=17 2023-10-04T21:34:14.548Z,1696455254.548 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T21:34:14.548Z,1696455254.548 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T21:34:16.563Z,1696455256.563 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213412.00,A,3649.05524,N,12207.64854,W,21.110,128.95,041023,,,D*4D 2023-10-04T21:34:16.565Z,1696455256.565 [NAL9602](INFO): GPS fix at 20231004T213412: (36.817587, -122.127476) 2023-10-04T21:34:16.576Z,1696455256.576 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T21:34:16.576Z,1696455256.576 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T21:34:30.548Z,1696455270.548 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:35:02.668Z,1696455302.668 [NAL9602](INFO): SBD MO Status=2, MOMSN=31804, MT Status=2, MTMSN=0 2023-10-04T21:35:02.668Z,1696455302.668 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T21:35:05.707Z,1696455305.707 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:35:28.570Z,1696455328.570 [NAL9602](INFO): SBD MO Status=2, MOMSN=31804, MT Status=2, MTMSN=0 2023-10-04T21:35:28.570Z,1696455328.570 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T21:35:40.876Z,1696455340.876 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:35:54.469Z,1696455354.469 [NAL9602](INFO): SBD MO Status=2, MOMSN=31804, MT Status=2, MTMSN=0 2023-10-04T21:35:54.469Z,1696455354.469 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T21:36:16.016Z,1696455376.016 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:36:17.561Z,1696455377.561 [NAL9602](INFO): SBD MO Status=2, MOMSN=31804, MT Status=2, MTMSN=0 2023-10-04T21:36:17.561Z,1696455377.561 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T21:36:44.689Z,1696455404.689 [NAL9602](INFO): SBD MO Status=1, MOMSN=31804, MT Status=0, MTMSN=0 2023-10-04T21:36:44.736Z,1696455404.736 [NAL9602](INFO): Sent 72 bytes from file Logs/20231004T212333/Courier0003.lzma 2023-10-04T21:36:44.736Z,1696455404.736 [NAL9602](INFO): Packets left to send: 0 2023-10-04T21:36:51.156Z,1696455411.156 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:36:52.856Z,1696455412.856 [NAL9602](INFO): SBD MO Status=1, MOMSN=31805, MT Status=0, MTMSN=0 2023-10-04T21:36:52.909Z,1696455412.909 [NAL9602](INFO): Sent 156 bytes from file Logs/20231004T212333/Express0004.lzma 2023-10-04T21:36:52.909Z,1696455412.909 [NAL9602](INFO): Packets left to send: 0 2023-10-04T21:37:01.742Z,1696455421.742 [NAL9602](INFO): SBD MO Status=0, MOMSN=31806, MT Status=0, MTMSN=0 2023-10-04T21:37:01.820Z,1696455421.820 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T21:37:01.820Z,1696455421.820 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T21:37:01.820Z,1696455421.820 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T21:37:26.316Z,1696455446.316 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:37:32.445Z,1696455452.445 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T21:38:01.464Z,1696455481.464 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:38:36.604Z,1696455516.604 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:38:59.132Z,1696455539.132 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005471 2023-10-04T21:42:02.333Z,1696455722.333 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T21:42:02.333Z,1696455722.333 [Default:CheckIn:C.Wait] Stopped 2023-10-04T21:42:02.333Z,1696455722.333 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T21:42:02.333Z,1696455722.333 [Default:CheckIn:D] Running Loop=1 2023-10-04T21:42:02.732Z,1696455722.732 [Default:CheckIn:D] Stopped 2023-10-04T21:42:02.732Z,1696455722.732 [Default:CheckIn:E] Running Loop=1 2023-10-04T21:42:03.151Z,1696455723.151 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 109.039526 min 2023-10-04T21:42:03.151Z,1696455723.151 [Default:CheckIn:E] Stopped 2023-10-04T21:42:03.152Z,1696455723.152 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T21:42:03.152Z,1696455723.152 [Default:CheckIn] Stopped 2023-10-04T21:42:03.152Z,1696455723.152 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T21:42:03.152Z,1696455723.152 [Default:CheckIn](INFO): Running loop #18 2023-10-04T21:42:03.152Z,1696455723.152 [Default:CheckIn] Running Loop=18 2023-10-04T21:42:03.152Z,1696455723.152 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T21:42:03.152Z,1696455723.152 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T21:42:05.150Z,1696455725.150 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214201.00,A,3647.92215,N,12205.91601,W,4.082,93.69,041023,,,D*42 2023-10-04T21:42:05.152Z,1696455725.152 [NAL9602](INFO): GPS fix at 20231004T214201: (36.798702, -122.098600) 2023-10-04T21:42:05.192Z,1696455725.192 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T21:42:05.193Z,1696455725.193 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T21:42:12.719Z,1696455732.719 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0006.lzma 2023-10-04T21:42:13.721Z,1696455733.721 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0006.lzma.bak 2023-10-04T21:42:13.721Z,1696455733.721 [DataOverHttps](INFO): SBD MOMSN=18983155 2023-10-04T21:42:21.306Z,1696455741.306 [NAL9602](INFO): SBD MO Status=0, MOMSN=31807, MT Status=0, MTMSN=0 2023-10-04T21:42:21.307Z,1696455741.307 [NAL9602](INFO): No messages in MT queue 2023-10-04T21:42:31.535Z,1696455751.535 [DataOverHttps](INFO): Sending 156 bytes from file Logs/20231004T212333/Express0007.lzma 2023-10-04T21:42:32.537Z,1696455752.537 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0007.lzma.bak 2023-10-04T21:42:32.537Z,1696455752.537 [DataOverHttps](INFO): SBD MOMSN=18983158 2023-10-04T21:42:33.845Z,1696455753.845 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T21:42:33.845Z,1696455753.845 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T21:42:33.845Z,1696455753.845 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T21:42:52.009Z,1696455772.009 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T21:47:34.426Z,1696456054.426 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T21:47:34.426Z,1696456054.426 [Default:CheckIn:C.Wait] Stopped 2023-10-04T21:47:34.426Z,1696456054.426 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T21:47:34.426Z,1696456054.426 [Default:CheckIn:D] Running Loop=1 2023-10-04T21:47:34.820Z,1696456054.820 [Default:CheckIn:D] Stopped 2023-10-04T21:47:34.820Z,1696456054.820 [Default:CheckIn:E] Running Loop=1 2023-10-04T21:47:35.223Z,1696456055.223 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 114.574325 min 2023-10-04T21:47:35.223Z,1696456055.223 [Default:CheckIn:E] Stopped 2023-10-04T21:47:35.224Z,1696456055.224 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T21:47:35.224Z,1696456055.224 [Default:CheckIn] Stopped 2023-10-04T21:47:35.224Z,1696456055.224 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T21:47:35.224Z,1696456055.224 [Default:CheckIn](INFO): Running loop #19 2023-10-04T21:47:35.224Z,1696456055.224 [Default:CheckIn] Running Loop=19 2023-10-04T21:47:35.224Z,1696456055.224 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T21:47:35.224Z,1696456055.224 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T21:47:37.236Z,1696456057.236 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214733.00,A,3647.93775,N,12203.80912,W,15.006,77.75,041023,,,D*74 2023-10-04T21:47:37.238Z,1696456057.238 [NAL9602](INFO): GPS fix at 20231004T214733: (36.798963, -122.063485) 2023-10-04T21:47:37.249Z,1696456057.249 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T21:47:37.249Z,1696456057.249 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T21:47:50.162Z,1696456070.162 [NAL9602](INFO): SBD MO Status=0, MOMSN=31808, MT Status=0, MTMSN=0 2023-10-04T21:47:50.162Z,1696456070.162 [NAL9602](INFO): No messages in MT queue 2023-10-04T21:47:50.735Z,1696456070.735 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0012.lzma 2023-10-04T21:47:52.741Z,1696456072.741 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0012.lzma.bak 2023-10-04T21:47:52.741Z,1696456072.741 [DataOverHttps](INFO): SBD MOMSN=18983162 2023-10-04T21:48:10.815Z,1696456090.815 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20231004T212333/Express0013.lzma 2023-10-04T21:48:11.817Z,1696456091.817 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0013.lzma.bak 2023-10-04T21:48:11.818Z,1696456091.818 [DataOverHttps](INFO): SBD MOMSN=18983165 2023-10-04T21:48:13.204Z,1696456093.204 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T21:48:13.204Z,1696456093.204 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T21:48:13.204Z,1696456093.204 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T21:48:20.868Z,1696456100.868 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T21:52:58.048Z,1696456378.048 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.255608 2023-10-04T21:53:13.795Z,1696456393.795 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T21:53:13.795Z,1696456393.795 [Default:CheckIn:C.Wait] Stopped 2023-10-04T21:53:13.795Z,1696456393.795 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T21:53:13.796Z,1696456393.796 [Default:CheckIn:D] Running Loop=1 2023-10-04T21:53:14.204Z,1696456394.204 [Default:CheckIn:D] Stopped 2023-10-04T21:53:14.204Z,1696456394.204 [Default:CheckIn:E] Running Loop=1 2023-10-04T21:53:14.620Z,1696456394.620 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 120.230737 min 2023-10-04T21:53:14.620Z,1696456394.620 [Default:CheckIn:E] Stopped 2023-10-04T21:53:14.620Z,1696456394.620 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T21:53:14.620Z,1696456394.620 [Default:CheckIn] Stopped 2023-10-04T21:53:14.620Z,1696456394.620 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T21:53:14.620Z,1696456394.620 [Default:CheckIn](INFO): Running loop #20 2023-10-04T21:53:14.620Z,1696456394.620 [Default:CheckIn] Running Loop=20 2023-10-04T21:53:14.620Z,1696456394.620 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T21:53:14.620Z,1696456394.620 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T21:53:16.621Z,1696456396.621 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215313.00,A,3647.95300,N,12200.97436,W,29.430,83.39,041023,,,D*70 2023-10-04T21:53:16.623Z,1696456396.623 [NAL9602](INFO): GPS fix at 20231004T215313: (36.799217, -122.016239) 2023-10-04T21:53:16.634Z,1696456396.634 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T21:53:16.634Z,1696456396.634 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T21:53:33.630Z,1696456413.630 [NAL9602](INFO): SBD MO Status=1, MOMSN=31809, MT Status=0, MTMSN=0 2023-10-04T21:53:33.680Z,1696456413.680 [NAL9602](INFO): Sent 71 bytes from file Logs/20231004T212333/Courier0015.lzma 2023-10-04T21:53:33.680Z,1696456413.680 [NAL9602](INFO): Packets left to send: 0 2023-10-04T21:53:41.668Z,1696456421.668 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003180 2023-10-04T21:53:53.079Z,1696456433.079 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20231004T212333/Express0016.lzma 2023-10-04T21:53:53.525Z,1696456433.525 [NAL9602](INFO): SBD MO Status=1, MOMSN=31810, MT Status=0, MTMSN=0 2023-10-04T21:53:53.580Z,1696456433.580 [NAL9602](INFO): Sent 149 bytes from file Logs/20231004T212333/Express0016.lzma 2023-10-04T21:53:53.580Z,1696456433.580 [NAL9602](INFO): Packets left to send: 0 2023-10-04T21:53:54.348Z,1696456434.348 [DataOverHttps](FAULT): Server acknowledged file Logs/20231004T212333/Express0016.lzma, not 2023-10-04T21:53:54.348Z,1696456434.348 [DataOverHttps](INFO): SBD MOMSN=18983169 2023-10-04T21:53:54.358Z,1696456434.358 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T21:53:54.358Z,1696456434.358 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T21:53:54.358Z,1696456434.358 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T21:54:24.228Z,1696456464.228 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T21:55:00.864Z,1696456500.864 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:55:08.896Z,1696456508.896 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.247429 2023-10-04T21:56:11.144Z,1696456571.144 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:57:21.432Z,1696456641.432 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:57:56.580Z,1696456676.580 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:58:31.720Z,1696456711.720 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:58:54.918Z,1696456734.918 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T21:58:54.919Z,1696456734.919 [Default:CheckIn:C.Wait] Stopped 2023-10-04T21:58:54.919Z,1696456734.919 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T21:58:54.919Z,1696456734.919 [Default:CheckIn:D] Running Loop=1 2023-10-04T21:58:55.327Z,1696456735.327 [Default:CheckIn:D] Stopped 2023-10-04T21:58:55.327Z,1696456735.327 [Default:CheckIn:E] Running Loop=1 2023-10-04T21:58:55.732Z,1696456735.732 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 125.916113 min 2023-10-04T21:58:55.733Z,1696456735.733 [Default:CheckIn:E] Stopped 2023-10-04T21:58:55.733Z,1696456735.733 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T21:58:55.733Z,1696456735.733 [Default:CheckIn] Stopped 2023-10-04T21:58:55.733Z,1696456735.733 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T21:58:55.733Z,1696456735.733 [Default:CheckIn](INFO): Running loop #21 2023-10-04T21:58:55.733Z,1696456735.733 [Default:CheckIn] Running Loop=21 2023-10-04T21:58:55.733Z,1696456735.733 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T21:58:55.733Z,1696456735.733 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T21:58:57.738Z,1696456737.738 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215854.00,A,3648.14889,N,12158.43459,W,10.613,86.87,041023,,,D*73 2023-10-04T21:58:57.741Z,1696456737.741 [NAL9602](INFO): GPS fix at 20231004T215854: (36.802481, -121.973910) 2023-10-04T21:58:57.776Z,1696456737.776 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T21:58:57.776Z,1696456737.776 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T21:59:06.860Z,1696456746.860 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:59:21.622Z,1696456761.622 [NAL9602](INFO): SBD MO Status=2, MOMSN=31811, MT Status=2, MTMSN=0 2023-10-04T21:59:21.622Z,1696456761.622 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T21:59:42.012Z,1696456782.012 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T21:59:47.933Z,1696456787.933 [NAL9602](INFO): SBD MO Status=2, MOMSN=31811, MT Status=2, MTMSN=0 2023-10-04T21:59:47.934Z,1696456787.934 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T22:00:05.341Z,1696456805.341 [NAL9602](INFO): SBD MO Status=1, MOMSN=31811, MT Status=0, MTMSN=0 2023-10-04T22:00:05.391Z,1696456805.391 [NAL9602](INFO): Sent 72 bytes from file Logs/20231004T212333/Courier0018.lzma 2023-10-04T22:00:05.392Z,1696456805.392 [NAL9602](INFO): Packets left to send: 0 2023-10-04T22:00:17.180Z,1696456817.180 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:00:21.980Z,1696456821.980 [NAL9602](INFO): SBD MO Status=1, MOMSN=31812, MT Status=0, MTMSN=0 2023-10-04T22:00:22.029Z,1696456822.029 [NAL9602](INFO): Sent 251 bytes from file Logs/20231004T212333/Express0019.lzma 2023-10-04T22:00:22.029Z,1696456822.029 [NAL9602](INFO): Packets left to send: 0 2023-10-04T22:00:52.320Z,1696456852.320 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:00:53.078Z,1696456853.078 [NAL9602](INFO): SBD MO Status=2, MOMSN=31813, MT Status=2, MTMSN=0 2023-10-04T22:00:53.078Z,1696456853.078 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T22:01:05.207Z,1696456865.207 [NAL9602](INFO): SBD MO Status=0, MOMSN=31813, MT Status=0, MTMSN=0 2023-10-04T22:01:05.291Z,1696456865.291 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T22:01:05.291Z,1696456865.291 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T22:01:05.291Z,1696456865.291 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T22:01:27.460Z,1696456887.460 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:01:35.904Z,1696456895.904 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T22:02:02.599Z,1696456922.599 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:02:37.740Z,1696456957.740 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:03:12.892Z,1696456992.892 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:03:48.059Z,1696457028.059 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:04:23.200Z,1696457063.200 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:04:58.356Z,1696457098.356 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:05:33.496Z,1696457133.496 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:06:05.783Z,1696457165.783 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T22:06:05.783Z,1696457165.783 [Default:CheckIn:C.Wait] Stopped 2023-10-04T22:06:05.783Z,1696457165.783 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T22:06:05.784Z,1696457165.784 [Default:CheckIn:D] Running Loop=1 2023-10-04T22:06:06.190Z,1696457166.190 [Default:CheckIn:D] Stopped 2023-10-04T22:06:06.191Z,1696457166.191 [Default:CheckIn:E] Running Loop=1 2023-10-04T22:06:06.599Z,1696457166.599 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 133.097176 min 2023-10-04T22:06:06.599Z,1696457166.599 [Default:CheckIn:E] Stopped 2023-10-04T22:06:06.600Z,1696457166.600 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T22:06:06.600Z,1696457166.600 [Default:CheckIn] Stopped 2023-10-04T22:06:06.600Z,1696457166.600 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T22:06:06.600Z,1696457166.600 [Default:CheckIn](INFO): Running loop #22 2023-10-04T22:06:06.600Z,1696457166.600 [Default:CheckIn] Running Loop=22 2023-10-04T22:06:06.600Z,1696457166.600 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T22:06:06.600Z,1696457166.600 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T22:06:08.601Z,1696457168.601 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220604.00,A,3648.13033,N,12155.12473,W,25.795,87.01,041023,,,D*77 2023-10-04T22:06:08.614Z,1696457168.614 [NAL9602](INFO): GPS fix at 20231004T220604: (36.802172, -121.918745) 2023-10-04T22:06:08.626Z,1696457168.626 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T22:06:08.626Z,1696457168.626 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T22:06:08.652Z,1696457168.652 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:06:25.614Z,1696457185.614 [NAL9602](INFO): SBD MO Status=1, MOMSN=31814, MT Status=0, MTMSN=0 2023-10-04T22:06:25.667Z,1696457185.667 [NAL9602](INFO): Sent 72 bytes from file Logs/20231004T212333/Courier0021.lzma 2023-10-04T22:06:25.668Z,1696457185.668 [NAL9602](INFO): Packets left to send: 0 2023-10-04T22:06:33.351Z,1696457193.351 [NAL9602](INFO): SBD MO Status=1, MOMSN=31815, MT Status=0, MTMSN=0 2023-10-04T22:06:33.401Z,1696457193.401 [NAL9602](INFO): Sent 151 bytes from file Logs/20231004T212333/Express0022.lzma 2023-10-04T22:06:33.401Z,1696457193.401 [NAL9602](INFO): Packets left to send: 0 2023-10-04T22:06:41.425Z,1696457201.425 [NAL9602](INFO): SBD MO Status=0, MOMSN=31816, MT Status=0, MTMSN=0 2023-10-04T22:06:41.512Z,1696457201.512 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T22:06:41.512Z,1696457201.512 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T22:06:41.512Z,1696457201.512 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T22:06:43.804Z,1696457203.804 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:07:12.132Z,1696457232.132 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T22:07:18.951Z,1696457238.951 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:07:54.092Z,1696457274.092 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:08:29.260Z,1696457309.260 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:09:04.407Z,1696457344.407 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:09:39.556Z,1696457379.556 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:10:14.723Z,1696457414.723 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:10:49.864Z,1696457449.864 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:11:25.003Z,1696457485.003 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:11:42.025Z,1696457502.025 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T22:11:42.025Z,1696457502.025 [Default:CheckIn:C.Wait] Stopped 2023-10-04T22:11:42.025Z,1696457502.025 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T22:11:42.026Z,1696457502.026 [Default:CheckIn:D] Running Loop=1 2023-10-04T22:11:42.439Z,1696457502.439 [Default:CheckIn:D] Stopped 2023-10-04T22:11:42.439Z,1696457502.439 [Default:CheckIn:E] Running Loop=1 2023-10-04T22:11:42.819Z,1696457502.819 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 138.701058 min 2023-10-04T22:11:42.819Z,1696457502.819 [Default:CheckIn:E] Stopped 2023-10-04T22:11:42.819Z,1696457502.819 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T22:11:42.819Z,1696457502.819 [Default:CheckIn] Stopped 2023-10-04T22:11:42.820Z,1696457502.820 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T22:11:42.820Z,1696457502.820 [Default:CheckIn](INFO): Running loop #23 2023-10-04T22:11:42.820Z,1696457502.820 [Default:CheckIn] Running Loop=23 2023-10-04T22:11:42.820Z,1696457502.820 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T22:11:42.820Z,1696457502.820 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T22:11:44.832Z,1696457504.832 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221141.00,A,3648.21256,N,12152.29725,W,26.786,85.15,041023,,,D*79 2023-10-04T22:11:44.834Z,1696457504.834 [NAL9602](INFO): GPS fix at 20231004T221141: (36.803543, -121.871621) 2023-10-04T22:11:44.850Z,1696457504.850 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T22:11:44.850Z,1696457504.850 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T22:12:00.144Z,1696457520.144 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:12:00.630Z,1696457520.630 [NAL9602](INFO): SBD MO Status=1, MOMSN=31817, MT Status=0, MTMSN=0 2023-10-04T22:12:00.687Z,1696457520.687 [NAL9602](INFO): Sent 72 bytes from file Logs/20231004T212333/Courier0024.lzma 2023-10-04T22:12:00.688Z,1696457520.688 [NAL9602](INFO): Packets left to send: 0 2023-10-04T22:12:14.433Z,1696457534.433 [NAL9602](INFO): SBD MO Status=1, MOMSN=31818, MT Status=0, MTMSN=0 2023-10-04T22:12:14.491Z,1696457534.491 [NAL9602](INFO): Sent 152 bytes from file Logs/20231004T212333/Express0025.lzma 2023-10-04T22:12:14.492Z,1696457534.492 [NAL9602](INFO): Packets left to send: 0 2023-10-04T22:12:26.959Z,1696457546.959 [NAL9602](INFO): SBD MO Status=0, MOMSN=31819, MT Status=0, MTMSN=0 2023-10-04T22:12:27.040Z,1696457547.040 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T22:12:27.040Z,1696457547.040 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T22:12:27.040Z,1696457547.040 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T22:12:35.284Z,1696457555.284 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:12:57.661Z,1696457577.661 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T22:13:10.423Z,1696457590.423 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:13:45.572Z,1696457625.572 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:14:20.711Z,1696457660.711 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:14:55.852Z,1696457695.852 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:15:30.991Z,1696457730.991 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:16:06.151Z,1696457766.151 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:16:41.300Z,1696457801.300 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:17:16.440Z,1696457836.440 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:17:27.561Z,1696457847.561 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T22:17:27.561Z,1696457847.561 [Default:CheckIn:C.Wait] Stopped 2023-10-04T22:17:27.561Z,1696457847.561 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T22:17:27.562Z,1696457847.562 [Default:CheckIn:D] Running Loop=1 2023-10-04T22:17:27.973Z,1696457847.973 [Default:CheckIn:D] Stopped 2023-10-04T22:17:27.973Z,1696457847.973 [Default:CheckIn:E] Running Loop=1 2023-10-04T22:17:28.356Z,1696457848.356 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 144.460221 min 2023-10-04T22:17:28.356Z,1696457848.356 [Default:CheckIn:E] Stopped 2023-10-04T22:17:28.356Z,1696457848.356 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T22:17:28.357Z,1696457848.357 [Default:CheckIn] Stopped 2023-10-04T22:17:28.357Z,1696457848.357 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T22:17:28.357Z,1696457848.357 [Default:CheckIn](INFO): Running loop #24 2023-10-04T22:17:28.357Z,1696457848.357 [Default:CheckIn] Running Loop=24 2023-10-04T22:17:28.357Z,1696457848.357 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T22:17:28.357Z,1696457848.357 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T22:17:30.394Z,1696457850.394 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221726.00,A,3648.15457,N,12149.56478,W,18.797,80.05,041023,,,D*7E 2023-10-04T22:17:30.396Z,1696457850.396 [NAL9602](INFO): GPS fix at 20231004T221726: (36.802576, -121.826080) 2023-10-04T22:17:30.423Z,1696457850.423 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T22:17:30.424Z,1696457850.424 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T22:17:47.818Z,1696457867.818 [NAL9602](INFO): SBD MO Status=1, MOMSN=31820, MT Status=0, MTMSN=0 2023-10-04T22:17:47.880Z,1696457867.880 [NAL9602](INFO): Sent 72 bytes from file Logs/20231004T212333/Courier0027.lzma 2023-10-04T22:17:47.880Z,1696457867.880 [NAL9602](INFO): Packets left to send: 0 2023-10-04T22:17:51.584Z,1696457871.584 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:17:55.107Z,1696457875.107 [NAL9602](INFO): SBD MO Status=1, MOMSN=31821, MT Status=0, MTMSN=0 2023-10-04T22:17:55.167Z,1696457875.167 [NAL9602](INFO): Sent 151 bytes from file Logs/20231004T212333/Express0028.lzma 2023-10-04T22:17:55.168Z,1696457875.168 [NAL9602](INFO): Packets left to send: 0 2023-10-04T22:18:04.481Z,1696457884.481 [NAL9602](INFO): SBD MO Status=0, MOMSN=31822, MT Status=0, MTMSN=0 2023-10-04T22:18:04.570Z,1696457884.570 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T22:18:04.570Z,1696457884.570 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T22:18:04.570Z,1696457884.570 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T22:18:26.732Z,1696457906.732 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:18:35.103Z,1696457915.103 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T22:19:01.880Z,1696457941.880 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:19:37.020Z,1696457977.020 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:20:12.160Z,1696458012.160 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:20:47.300Z,1696458047.300 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:21:22.440Z,1696458082.440 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:21:57.612Z,1696458117.612 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-04T22:22:10.260Z,1696458130.260 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003108 2023-10-04T22:23:04.999Z,1696458184.999 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T22:23:04.999Z,1696458184.999 [Default:CheckIn:C.Wait] Stopped 2023-10-04T22:23:04.999Z,1696458184.999 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T22:23:04.000Z,1696458185.000 [Default:CheckIn:D] Running Loop=1 2023-10-04T22:23:05.400Z,1696458185.400 [Default:CheckIn:D] Stopped 2023-10-04T22:23:05.400Z,1696458185.400 [Default:CheckIn:E] Running Loop=1 2023-10-04T22:23:05.798Z,1696458185.798 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 150.084001 min 2023-10-04T22:23:05.798Z,1696458185.798 [Default:CheckIn:E] Stopped 2023-10-04T22:23:05.798Z,1696458185.798 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T22:23:05.798Z,1696458185.798 [Default:CheckIn] Stopped 2023-10-04T22:23:05.798Z,1696458185.798 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T22:23:05.798Z,1696458185.798 [Default:CheckIn](INFO): Running loop #25 2023-10-04T22:23:05.798Z,1696458185.798 [Default:CheckIn] Running Loop=25 2023-10-04T22:23:05.799Z,1696458185.799 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T22:23:05.799Z,1696458185.799 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T22:23:07.816Z,1696458187.816 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222304.00,A,3648.51125,N,12147.20177,W,8.903,67.90,041023,,,D*4B 2023-10-04T22:23:07.819Z,1696458187.819 [NAL9602](INFO): GPS fix at 20231004T222304: (36.808521, -121.786696) 2023-10-04T22:23:07.830Z,1696458187.830 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T22:23:07.831Z,1696458187.831 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T22:23:15.859Z,1696458195.859 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0030.lzma 2023-10-04T22:23:16.862Z,1696458196.862 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0030.lzma.bak 2023-10-04T22:23:16.862Z,1696458196.862 [DataOverHttps](INFO): SBD MOMSN=18983223 2023-10-04T22:23:22.762Z,1696458202.762 [NAL9602](INFO): SBD MO Status=0, MOMSN=31823, MT Status=0, MTMSN=0 2023-10-04T22:23:22.762Z,1696458202.762 [NAL9602](INFO): No messages in MT queue 2023-10-04T22:23:33.031Z,1696458213.031 [DataOverHttps](INFO): Sending 156 bytes from file Logs/20231004T212333/Express0031.lzma 2023-10-04T22:23:34.033Z,1696458214.033 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0031.lzma.bak 2023-10-04T22:23:34.033Z,1696458214.033 [DataOverHttps](INFO): SBD MOMSN=18983226 2023-10-04T22:23:35.309Z,1696458215.309 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T22:23:35.309Z,1696458215.309 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T22:23:35.309Z,1696458215.309 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T22:23:53.519Z,1696458233.519 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T22:23:55.091Z,1696458235.091 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2023-10-04T22:23:55.094Z,1696458235.094 [BPC1](INFO): Received data from all battery sticks. 2023-10-04T22:28:35.868Z,1696458515.868 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T22:28:35.868Z,1696458515.868 [Default:CheckIn:C.Wait] Stopped 2023-10-04T22:28:35.868Z,1696458515.868 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T22:28:35.868Z,1696458515.868 [Default:CheckIn:D] Running Loop=1 2023-10-04T22:28:36.272Z,1696458516.272 [Default:CheckIn:D] Stopped 2023-10-04T22:28:36.272Z,1696458516.272 [Default:CheckIn:E] Running Loop=1 2023-10-04T22:28:36.683Z,1696458516.683 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 155.598535 min 2023-10-04T22:28:36.683Z,1696458516.683 [Default:CheckIn:E] Stopped 2023-10-04T22:28:36.683Z,1696458516.683 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T22:28:36.683Z,1696458516.683 [Default:CheckIn] Stopped 2023-10-04T22:28:36.683Z,1696458516.683 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T22:28:36.683Z,1696458516.683 [Default:CheckIn](INFO): Running loop #26 2023-10-04T22:28:36.684Z,1696458516.684 [Default:CheckIn] Running Loop=26 2023-10-04T22:28:36.684Z,1696458516.684 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T22:28:36.684Z,1696458516.684 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T22:28:38.698Z,1696458518.698 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222835.00,A,3648.32097,N,12147.14353,W,0.019,239.49,041023,,,D*7B 2023-10-04T22:28:38.705Z,1696458518.705 [NAL9602](INFO): GPS fix at 20231004T222835: (36.805349, -121.785725) 2023-10-04T22:28:38.717Z,1696458518.717 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T22:28:38.717Z,1696458518.717 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T22:28:46.274Z,1696458526.274 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20231004T212333/Courier0033.lzma 2023-10-04T22:28:47.273Z,1696458527.273 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0033.lzma.bak 2023-10-04T22:28:47.274Z,1696458527.274 [DataOverHttps](INFO): SBD MOMSN=18983231 2023-10-04T22:29:03.323Z,1696458543.323 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20231004T212333/Express0034.lzma 2023-10-04T22:29:04.325Z,1696458544.325 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0034.lzma.bak 2023-10-04T22:29:04.325Z,1696458544.325 [DataOverHttps](INFO): SBD MOMSN=18983234 2023-10-04T22:29:05.784Z,1696458545.784 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T22:29:05.785Z,1696458545.784 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T22:29:05.785Z,1696458545.785 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T22:29:16.273Z,1696458556.273 [NAL9602](INFO): SBD MO Status=2, MOMSN=31824, MT Status=2, MTMSN=0 2023-10-04T22:29:16.273Z,1696458556.273 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T22:29:26.383Z,1696458566.383 [NAL9602](INFO): SBD MO Status=0, MOMSN=31824, MT Status=0, MTMSN=0 2023-10-04T22:29:26.383Z,1696458566.383 [NAL9602](INFO): No messages in MT queue 2023-10-04T22:29:57.075Z,1696458597.075 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T22:34:06.408Z,1696458846.408 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T22:34:06.408Z,1696458846.408 [Default:CheckIn:C.Wait] Stopped 2023-10-04T22:34:06.409Z,1696458846.409 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T22:34:06.409Z,1696458846.409 [Default:CheckIn:D] Running Loop=1 2023-10-04T22:34:06.807Z,1696458846.807 [Default:CheckIn:D] Stopped 2023-10-04T22:34:06.807Z,1696458846.807 [Default:CheckIn:E] Running Loop=1 2023-10-04T22:34:07.211Z,1696458847.211 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 161.107454 min 2023-10-04T22:34:07.211Z,1696458847.211 [Default:CheckIn:E] Stopped 2023-10-04T22:34:07.211Z,1696458847.211 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T22:34:07.211Z,1696458847.211 [Default:CheckIn] Stopped 2023-10-04T22:34:07.211Z,1696458847.211 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T22:34:07.212Z,1696458847.212 [Default:CheckIn](INFO): Running loop #27 2023-10-04T22:34:07.212Z,1696458847.212 [Default:CheckIn] Running Loop=27 2023-10-04T22:34:07.212Z,1696458847.212 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T22:34:07.212Z,1696458847.212 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T22:34:09.219Z,1696458849.219 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223405.00,A,3648.31987,N,12147.14472,W,0.039,239.49,041023,,,A*7D 2023-10-04T22:34:09.221Z,1696458849.221 [NAL9602](INFO): GPS fix at 20231004T223405: (36.805331, -121.785745) 2023-10-04T22:34:09.232Z,1696458849.232 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T22:34:09.232Z,1696458849.232 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T22:34:16.771Z,1696458856.771 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0036.lzma 2023-10-04T22:34:17.773Z,1696458857.773 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0036.lzma.bak 2023-10-04T22:34:17.773Z,1696458857.773 [DataOverHttps](INFO): SBD MOMSN=18983238 2023-10-04T22:34:30.226Z,1696458870.226 [NAL9602](INFO): SBD MO Status=0, MOMSN=31825, MT Status=0, MTMSN=0 2023-10-04T22:34:30.226Z,1696458870.226 [NAL9602](INFO): No messages in MT queue 2023-10-04T22:34:33.767Z,1696458873.767 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20231004T212333/Express0037.lzma 2023-10-04T22:34:34.771Z,1696458874.771 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0037.lzma.bak 2023-10-04T22:34:34.771Z,1696458874.771 [DataOverHttps](INFO): SBD MOMSN=18983241 2023-10-04T22:34:36.304Z,1696458876.304 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T22:34:36.304Z,1696458876.304 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T22:34:36.305Z,1696458876.305 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T22:35:00.927Z,1696458900.927 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T22:39:36.884Z,1696459176.884 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T22:39:36.884Z,1696459176.884 [Default:CheckIn:C.Wait] Stopped 2023-10-04T22:39:36.884Z,1696459176.884 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T22:39:36.885Z,1696459176.885 [Default:CheckIn:D] Running Loop=1 2023-10-04T22:39:37.280Z,1696459177.280 [Default:CheckIn:D] Stopped 2023-10-04T22:39:37.280Z,1696459177.280 [Default:CheckIn:E] Running Loop=1 2023-10-04T22:39:37.683Z,1696459177.683 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 166.615332 min 2023-10-04T22:39:37.683Z,1696459177.683 [Default:CheckIn:E] Stopped 2023-10-04T22:39:37.684Z,1696459177.684 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T22:39:37.684Z,1696459177.684 [Default:CheckIn] Stopped 2023-10-04T22:39:37.684Z,1696459177.684 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T22:39:37.684Z,1696459177.684 [Default:CheckIn](INFO): Running loop #28 2023-10-04T22:39:37.684Z,1696459177.684 [Default:CheckIn] Running Loop=28 2023-10-04T22:39:37.684Z,1696459177.684 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T22:39:37.684Z,1696459177.684 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T22:39:39.694Z,1696459179.694 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223935.00,A,3648.31982,N,12147.14412,W,0.039,239.49,041023,,,A*70 2023-10-04T22:39:39.696Z,1696459179.696 [NAL9602](INFO): GPS fix at 20231004T223935: (36.805330, -121.785735) 2023-10-04T22:39:39.708Z,1696459179.708 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T22:39:39.708Z,1696459179.708 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T22:39:47.083Z,1696459187.083 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0039.lzma 2023-10-04T22:39:48.087Z,1696459188.087 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0039.lzma.bak 2023-10-04T22:39:48.087Z,1696459188.087 [DataOverHttps](INFO): SBD MOMSN=18983245 2023-10-04T22:40:04.275Z,1696459204.275 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20231004T212333/Express0040.lzma 2023-10-04T22:40:05.277Z,1696459205.277 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0040.lzma.bak 2023-10-04T22:40:05.278Z,1696459205.278 [DataOverHttps](INFO): SBD MOMSN=18983248 2023-10-04T22:40:06.772Z,1696459206.772 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T22:40:06.772Z,1696459206.772 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T22:40:06.772Z,1696459206.772 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T22:40:23.730Z,1696459223.730 [NAL9602](INFO): SBD MO Status=0, MOMSN=31826, MT Status=0, MTMSN=0 2023-10-04T22:40:23.730Z,1696459223.730 [NAL9602](INFO): No messages in MT queue 2023-10-04T22:40:54.432Z,1696459254.432 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T22:45:07.342Z,1696459507.342 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T22:45:07.342Z,1696459507.342 [Default:CheckIn:C.Wait] Stopped 2023-10-04T22:45:07.342Z,1696459507.342 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T22:45:07.342Z,1696459507.342 [Default:CheckIn:D] Running Loop=1 2023-10-04T22:45:07.751Z,1696459507.751 [Default:CheckIn:D] Stopped 2023-10-04T22:45:07.751Z,1696459507.751 [Default:CheckIn:E] Running Loop=1 2023-10-04T22:45:08.151Z,1696459508.151 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 172.123177 min 2023-10-04T22:45:08.151Z,1696459508.151 [Default:CheckIn:E] Stopped 2023-10-04T22:45:08.151Z,1696459508.151 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T22:45:08.151Z,1696459508.151 [Default:CheckIn] Stopped 2023-10-04T22:45:08.151Z,1696459508.151 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T22:45:08.152Z,1696459508.152 [Default:CheckIn](INFO): Running loop #29 2023-10-04T22:45:08.152Z,1696459508.152 [Default:CheckIn] Running Loop=29 2023-10-04T22:45:08.152Z,1696459508.152 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T22:45:08.152Z,1696459508.152 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T22:45:10.166Z,1696459510.166 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,224506.00,A,3648.31982,N,12147.14478,W,0.039,239.49,041023,,,A*77 2023-10-04T22:45:10.168Z,1696459510.168 [NAL9602](INFO): GPS fix at 20231004T224506: (36.805330, -121.785746) 2023-10-04T22:45:10.197Z,1696459510.197 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T22:45:10.197Z,1696459510.197 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T22:45:17.975Z,1696459517.975 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0042.lzma 2023-10-04T22:45:18.977Z,1696459518.977 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0042.lzma.bak 2023-10-04T22:45:18.977Z,1696459518.977 [DataOverHttps](INFO): SBD MOMSN=18983254 2023-10-04T22:45:34.911Z,1696459534.911 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20231004T212333/Express0043.lzma 2023-10-04T22:45:35.214Z,1696459535.214 [NAL9602](INFO): SBD MO Status=0, MOMSN=31827, MT Status=0, MTMSN=0 2023-10-04T22:45:35.214Z,1696459535.214 [NAL9602](INFO): No messages in MT queue 2023-10-04T22:45:35.913Z,1696459535.913 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0043.lzma.bak 2023-10-04T22:45:35.913Z,1696459535.913 [DataOverHttps](INFO): SBD MOMSN=18983257 2023-10-04T22:45:37.248Z,1696459537.248 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T22:45:37.248Z,1696459537.248 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T22:45:37.248Z,1696459537.248 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T22:46:05.920Z,1696459565.920 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T22:50:37.834Z,1696459837.834 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T22:50:37.834Z,1696459837.834 [Default:CheckIn:C.Wait] Stopped 2023-10-04T22:50:37.834Z,1696459837.834 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T22:50:37.835Z,1696459837.835 [Default:CheckIn:D] Running Loop=1 2023-10-04T22:50:38.231Z,1696459838.231 [Default:CheckIn:D] Stopped 2023-10-04T22:50:38.231Z,1696459838.231 [Default:CheckIn:E] Running Loop=1 2023-10-04T22:50:38.635Z,1696459838.635 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 177.631185 min 2023-10-04T22:50:38.635Z,1696459838.635 [Default:CheckIn:E] Stopped 2023-10-04T22:50:38.635Z,1696459838.635 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T22:50:38.635Z,1696459838.635 [Default:CheckIn] Stopped 2023-10-04T22:50:38.635Z,1696459838.635 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T22:50:38.636Z,1696459838.636 [Default:CheckIn](INFO): Running loop #30 2023-10-04T22:50:38.636Z,1696459838.636 [Default:CheckIn] Running Loop=30 2023-10-04T22:50:38.636Z,1696459838.636 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T22:50:38.636Z,1696459838.636 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T22:50:40.646Z,1696459840.646 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225036.00,A,3648.31925,N,12147.14461,W,0.058,239.49,041023,,,A*72 2023-10-04T22:50:40.649Z,1696459840.649 [NAL9602](INFO): GPS fix at 20231004T225036: (36.805321, -121.785743) 2023-10-04T22:50:40.660Z,1696459840.660 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T22:50:40.660Z,1696459840.660 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T22:50:48.443Z,1696459848.443 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0045.lzma 2023-10-04T22:50:49.445Z,1696459849.445 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0045.lzma.bak 2023-10-04T22:50:49.445Z,1696459849.445 [DataOverHttps](INFO): SBD MOMSN=18983261 2023-10-04T22:51:05.415Z,1696459865.415 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20231004T212333/Express0046.lzma 2023-10-04T22:51:06.417Z,1696459866.417 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0046.lzma.bak 2023-10-04T22:51:06.417Z,1696459866.417 [DataOverHttps](INFO): SBD MOMSN=18983264 2023-10-04T22:51:07.728Z,1696459867.728 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T22:51:07.728Z,1696459867.728 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T22:51:07.728Z,1696459867.728 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T22:51:35.996Z,1696459895.996 [NAL9602](INFO): SBD MO Status=0, MOMSN=31828, MT Status=0, MTMSN=0 2023-10-04T22:51:35.996Z,1696459895.996 [NAL9602](INFO): No messages in MT queue 2023-10-04T22:52:06.691Z,1696459926.691 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T22:56:08.295Z,1696460168.295 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T22:56:08.295Z,1696460168.295 [Default:CheckIn:C.Wait] Stopped 2023-10-04T22:56:08.295Z,1696460168.295 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T22:56:08.295Z,1696460168.295 [Default:CheckIn:D] Running Loop=1 2023-10-04T22:56:08.710Z,1696460168.710 [Default:CheckIn:D] Stopped 2023-10-04T22:56:08.710Z,1696460168.710 [Default:CheckIn:E] Running Loop=1 2023-10-04T22:56:09.108Z,1696460169.108 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 183.139176 min 2023-10-04T22:56:09.108Z,1696460169.108 [Default:CheckIn:E] Stopped 2023-10-04T22:56:09.108Z,1696460169.108 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T22:56:09.108Z,1696460169.108 [Default:CheckIn] Stopped 2023-10-04T22:56:09.108Z,1696460169.108 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T22:56:09.108Z,1696460169.108 [Default:CheckIn](INFO): Running loop #31 2023-10-04T22:56:09.108Z,1696460169.108 [Default:CheckIn] Running Loop=31 2023-10-04T22:56:09.108Z,1696460169.108 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T22:56:09.109Z,1696460169.109 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T22:56:11.115Z,1696460171.115 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225607.00,A,3648.17997,N,12147.18081,W,1.808,219.19,041023,,,A*76 2023-10-04T22:56:11.117Z,1696460171.117 [NAL9602](INFO): GPS fix at 20231004T225607: (36.802999, -121.786347) 2023-10-04T22:56:11.129Z,1696460171.129 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T22:56:11.129Z,1696460171.129 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T22:56:19.099Z,1696460179.099 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0048.lzma 2023-10-04T22:56:20.101Z,1696460180.101 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0048.lzma.bak 2023-10-04T22:56:20.101Z,1696460180.101 [DataOverHttps](INFO): SBD MOMSN=18983268 2023-10-04T22:56:36.199Z,1696460196.199 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20231004T212333/Express0049.lzma 2023-10-04T22:56:37.201Z,1696460197.201 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0049.lzma.bak 2023-10-04T22:56:37.201Z,1696460197.201 [DataOverHttps](INFO): SBD MOMSN=18983271 2023-10-04T22:56:38.619Z,1696460198.619 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T22:56:38.619Z,1696460198.619 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T22:56:38.620Z,1696460198.620 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T22:56:59.190Z,1696460219.190 [NAL9602](INFO): SBD MO Status=0, MOMSN=31829, MT Status=0, MTMSN=0 2023-10-04T22:56:59.190Z,1696460219.190 [NAL9602](INFO): No messages in MT queue 2023-10-04T22:57:29.892Z,1696460249.892 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T23:01:39.179Z,1696460499.179 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T23:01:39.179Z,1696460499.179 [Default:CheckIn:C.Wait] Stopped 2023-10-04T23:01:39.179Z,1696460499.179 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T23:01:39.181Z,1696460499.181 [Default:CheckIn:D] Running Loop=1 2023-10-04T23:01:39.591Z,1696460499.591 [Default:CheckIn:D] Stopped 2023-10-04T23:01:39.591Z,1696460499.591 [Default:CheckIn:E] Running Loop=1 2023-10-04T23:01:39.983Z,1696460499.983 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 188.653841 min 2023-10-04T23:01:39.983Z,1696460499.983 [Default:CheckIn:E] Stopped 2023-10-04T23:01:39.983Z,1696460499.983 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T23:01:39.983Z,1696460499.983 [Default:CheckIn] Stopped 2023-10-04T23:01:39.983Z,1696460499.983 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T23:01:39.984Z,1696460499.984 [Default:CheckIn](INFO): Running loop #32 2023-10-04T23:01:39.984Z,1696460499.984 [Default:CheckIn] Running Loop=32 2023-10-04T23:01:39.984Z,1696460499.984 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T23:01:39.984Z,1696460499.984 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T23:01:41.995Z,1696460501.995 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230138.00,A,3648.14998,N,12147.22149,W,0.058,201.65,041023,,,A*77 2023-10-04T23:01:41.997Z,1696460501.997 [NAL9602](INFO): GPS fix at 20231004T230138: (36.802500, -121.787025) 2023-10-04T23:01:42.012Z,1696460502.012 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T23:01:42.012Z,1696460502.012 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T23:01:49.927Z,1696460509.927 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0051.lzma 2023-10-04T23:01:50.930Z,1696460510.930 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0051.lzma.bak 2023-10-04T23:01:50.930Z,1696460510.930 [DataOverHttps](INFO): SBD MOMSN=18983275 2023-10-04T23:01:59.770Z,1696460519.770 [NAL9602](INFO): SBD MO Status=0, MOMSN=31830, MT Status=0, MTMSN=0 2023-10-04T23:01:59.770Z,1696460519.770 [NAL9602](INFO): No messages in MT queue 2023-10-04T23:02:07.087Z,1696460527.087 [DataOverHttps](INFO): Sending 137 bytes from file Logs/20231004T212333/Express0052.lzma 2023-10-04T23:02:08.089Z,1696460528.089 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0052.lzma.bak 2023-10-04T23:02:08.090Z,1696460528.090 [DataOverHttps](INFO): SBD MOMSN=18983278 2023-10-04T23:02:09.475Z,1696460529.475 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T23:02:09.475Z,1696460529.475 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T23:02:09.475Z,1696460529.475 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T23:02:30.473Z,1696460550.473 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T23:03:24.680Z,1696460604.680 [CBIT](IMPORTANT): Beginning ground fault scan 2023-10-04T23:03:35.538Z,1696460615.538 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.037604 CHAN A1 (24V): 0.085932 CHAN A2 (12V): 0.031118 CHAN A3 (5V): 0.010370 CHAN B0 (3.3V): 0.008080 CHAN B1 (3.15aV): 0.007252 CHAN B2 (3.15bV): 0.007446 CHAN B3 (GND): -0.001383 OPEN: 0.007904 Full Scale: +/- 1 mA 2023-10-04T23:07:10.050Z,1696460830.050 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T23:07:10.050Z,1696460830.050 [Default:CheckIn:C.Wait] Stopped 2023-10-04T23:07:10.050Z,1696460830.050 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T23:07:10.050Z,1696460830.050 [Default:CheckIn:D] Running Loop=1 2023-10-04T23:07:10.460Z,1696460830.460 [Default:CheckIn:D] Stopped 2023-10-04T23:07:10.460Z,1696460830.460 [Default:CheckIn:E] Running Loop=1 2023-10-04T23:07:10.875Z,1696460830.875 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 194.168343 min 2023-10-04T23:07:10.875Z,1696460830.875 [Default:CheckIn:E] Stopped 2023-10-04T23:07:10.876Z,1696460830.876 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T23:07:10.876Z,1696460830.876 [Default:CheckIn] Stopped 2023-10-04T23:07:10.876Z,1696460830.876 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T23:07:10.876Z,1696460830.876 [Default:CheckIn](INFO): Running loop #33 2023-10-04T23:07:10.876Z,1696460830.876 [Default:CheckIn] Running Loop=33 2023-10-04T23:07:10.876Z,1696460830.876 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T23:07:10.876Z,1696460830.876 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T23:07:12.875Z,1696460832.875 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230709.00,A,3648.14999,N,12147.22325,W,0.039,201.65,041023,,,A*7D 2023-10-04T23:07:12.877Z,1696460832.877 [NAL9602](INFO): GPS fix at 20231004T230709: (36.802500, -121.787054) 2023-10-04T23:07:12.908Z,1696460832.908 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T23:07:12.908Z,1696460832.908 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T23:07:19.875Z,1696460839.875 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0054.lzma 2023-10-04T23:07:20.877Z,1696460840.877 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0054.lzma.bak 2023-10-04T23:07:20.877Z,1696460840.877 [DataOverHttps](INFO): SBD MOMSN=18983282 2023-10-04T23:07:24.994Z,1696460844.994 [NAL9602](INFO): SBD MO Status=0, MOMSN=31831, MT Status=0, MTMSN=0 2023-10-04T23:07:24.994Z,1696460844.994 [NAL9602](INFO): No messages in MT queue 2023-10-04T23:07:36.787Z,1696460856.787 [DataOverHttps](INFO): Sending 336 bytes from file Logs/20231004T212333/Express0055.lzma 2023-10-04T23:07:37.789Z,1696460857.789 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0055.lzma.bak 2023-10-04T23:07:37.789Z,1696460857.789 [DataOverHttps](INFO): SBD MOMSN=18983285 2023-10-04T23:07:39.260Z,1696460859.260 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T23:07:39.260Z,1696460859.260 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T23:07:39.260Z,1696460859.260 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T23:07:55.692Z,1696460875.692 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T23:12:39.713Z,1696461159.713 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T23:12:39.713Z,1696461159.713 [Default:CheckIn:C.Wait] Stopped 2023-10-04T23:12:39.713Z,1696461159.713 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T23:12:39.714Z,1696461159.714 [Default:CheckIn:D] Running Loop=1 2023-10-04T23:12:40.118Z,1696461160.118 [Default:CheckIn:D] Stopped 2023-10-04T23:12:40.118Z,1696461160.118 [Default:CheckIn:E] Running Loop=1 2023-10-04T23:12:40.536Z,1696461160.536 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 199.662646 min 2023-10-04T23:12:40.536Z,1696461160.536 [Default:CheckIn:E] Stopped 2023-10-04T23:12:40.536Z,1696461160.536 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T23:12:40.537Z,1696461160.537 [Default:CheckIn] Stopped 2023-10-04T23:12:40.537Z,1696461160.537 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T23:12:40.537Z,1696461160.537 [Default:CheckIn](INFO): Running loop #34 2023-10-04T23:12:40.537Z,1696461160.537 [Default:CheckIn] Running Loop=34 2023-10-04T23:12:40.537Z,1696461160.537 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T23:12:40.537Z,1696461160.537 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T23:12:42.535Z,1696461162.535 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231238.00,A,3648.14966,N,12147.22337,W,0.117,201.65,041023,,,A*75 2023-10-04T23:12:42.537Z,1696461162.537 [NAL9602](INFO): GPS fix at 20231004T231238: (36.802494, -121.787056) 2023-10-04T23:12:42.548Z,1696461162.548 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T23:12:42.548Z,1696461162.548 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T23:12:49.819Z,1696461169.819 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0057.lzma 2023-10-04T23:12:50.821Z,1696461170.821 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0057.lzma.bak 2023-10-04T23:12:50.821Z,1696461170.821 [DataOverHttps](INFO): SBD MOMSN=18983311 2023-10-04T23:13:06.879Z,1696461186.879 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20231004T212333/Express0058.lzma 2023-10-04T23:13:07.881Z,1696461187.881 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0058.lzma.bak 2023-10-04T23:13:07.881Z,1696461187.881 [DataOverHttps](INFO): SBD MOMSN=18983314 2023-10-04T23:13:09.216Z,1696461189.216 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T23:13:09.216Z,1696461189.216 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T23:13:09.216Z,1696461189.216 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T23:13:10.822Z,1696461190.822 [NAL9602](INFO): SBD MO Status=2, MOMSN=31832, MT Status=2, MTMSN=0 2023-10-04T23:13:10.822Z,1696461190.822 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T23:13:41.118Z,1696461221.118 [NAL9602](INFO): SBD MO Status=2, MOMSN=31832, MT Status=2, MTMSN=0 2023-10-04T23:13:41.118Z,1696461221.118 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T23:14:00.914Z,1696461240.914 [NAL9602](INFO): SBD MO Status=0, MOMSN=31832, MT Status=0, MTMSN=0 2023-10-04T23:14:00.914Z,1696461240.914 [NAL9602](INFO): No messages in MT queue 2023-10-04T23:14:31.624Z,1696461271.624 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T23:18:09.789Z,1696461489.789 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T23:18:09.789Z,1696461489.789 [Default:CheckIn:C.Wait] Stopped 2023-10-04T23:18:09.789Z,1696461489.789 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T23:18:09.790Z,1696461489.790 [Default:CheckIn:D] Running Loop=1 2023-10-04T23:18:10.199Z,1696461490.199 [Default:CheckIn:D] Stopped 2023-10-04T23:18:10.199Z,1696461490.199 [Default:CheckIn:E] Running Loop=1 2023-10-04T23:18:10.608Z,1696461490.608 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 205.163981 min 2023-10-04T23:18:10.608Z,1696461490.608 [Default:CheckIn:E] Stopped 2023-10-04T23:18:10.608Z,1696461490.608 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T23:18:10.609Z,1696461490.609 [Default:CheckIn] Stopped 2023-10-04T23:18:10.609Z,1696461490.609 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T23:18:10.609Z,1696461490.609 [Default:CheckIn](INFO): Running loop #35 2023-10-04T23:18:10.609Z,1696461490.609 [Default:CheckIn] Running Loop=35 2023-10-04T23:18:10.609Z,1696461490.609 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T23:18:10.609Z,1696461490.609 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T23:18:12.614Z,1696461492.614 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231808.00,A,3648.14246,N,12147.22856,W,0.019,216.81,041023,,,D*7F 2023-10-04T23:18:12.617Z,1696461492.617 [NAL9602](INFO): GPS fix at 20231004T231808: (36.802374, -121.787143) 2023-10-04T23:18:12.648Z,1696461492.648 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T23:18:12.648Z,1696461492.648 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T23:18:19.975Z,1696461499.975 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0060.lzma 2023-10-04T23:18:20.977Z,1696461500.977 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0060.lzma.bak 2023-10-04T23:18:20.977Z,1696461500.977 [DataOverHttps](INFO): SBD MOMSN=18983318 2023-10-04T23:18:37.311Z,1696461517.311 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20231004T212333/Express0061.lzma 2023-10-04T23:18:38.064Z,1696461518.064 [NAL9602](INFO): SBD MO Status=2, MOMSN=31833, MT Status=2, MTMSN=0 2023-10-04T23:18:38.064Z,1696461518.064 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-04T23:18:38.313Z,1696461518.313 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0061.lzma.bak 2023-10-04T23:18:38.313Z,1696461518.313 [DataOverHttps](INFO): SBD MOMSN=18983321 2023-10-04T23:18:39.699Z,1696461519.699 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T23:18:39.699Z,1696461519.699 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T23:18:39.700Z,1696461519.700 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T23:18:58.665Z,1696461538.665 [NAL9602](INFO): SBD MO Status=0, MOMSN=31833, MT Status=0, MTMSN=0 2023-10-04T23:18:58.665Z,1696461538.665 [NAL9602](INFO): No messages in MT queue 2023-10-04T23:19:29.369Z,1696461569.369 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T23:23:40.261Z,1696461820.261 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T23:23:40.262Z,1696461820.262 [Default:CheckIn:C.Wait] Stopped 2023-10-04T23:23:40.262Z,1696461820.262 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T23:23:40.262Z,1696461820.262 [Default:CheckIn:D] Running Loop=1 2023-10-04T23:23:40.671Z,1696461820.671 [Default:CheckIn:D] Stopped 2023-10-04T23:23:40.671Z,1696461820.671 [Default:CheckIn:E] Running Loop=1 2023-10-04T23:23:41.071Z,1696461821.071 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 210.671842 min 2023-10-04T23:23:41.071Z,1696461821.071 [Default:CheckIn:E] Stopped 2023-10-04T23:23:41.072Z,1696461821.072 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T23:23:41.072Z,1696461821.072 [Default:CheckIn] Stopped 2023-10-04T23:23:41.072Z,1696461821.072 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T23:23:41.072Z,1696461821.072 [Default:CheckIn](INFO): Running loop #36 2023-10-04T23:23:41.072Z,1696461821.072 [Default:CheckIn] Running Loop=36 2023-10-04T23:23:41.072Z,1696461821.072 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T23:23:41.072Z,1696461821.072 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T23:23:43.086Z,1696461823.086 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232339.00,A,3648.14204,N,12147.22884,W,0.019,216.81,041023,,,D*7C 2023-10-04T23:23:43.097Z,1696461823.097 [NAL9602](INFO): GPS fix at 20231004T232339: (36.802367, -121.787147) 2023-10-04T23:23:43.109Z,1696461823.109 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T23:23:43.109Z,1696461823.109 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T23:23:50.111Z,1696461830.111 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0063.lzma 2023-10-04T23:23:51.114Z,1696461831.114 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0063.lzma.bak 2023-10-04T23:23:51.114Z,1696461831.114 [DataOverHttps](INFO): SBD MOMSN=18983325 2023-10-04T23:23:53.186Z,1696461833.186 [NAL9602](INFO): SBD MO Status=0, MOMSN=31834, MT Status=0, MTMSN=0 2023-10-04T23:23:53.186Z,1696461833.186 [NAL9602](INFO): No messages in MT queue 2023-10-04T23:24:06.935Z,1696461846.935 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20231004T212333/Express0064.lzma 2023-10-04T23:24:07.938Z,1696461847.938 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0064.lzma.bak 2023-10-04T23:24:07.938Z,1696461847.938 [DataOverHttps](INFO): SBD MOMSN=18983328 2023-10-04T23:24:09.359Z,1696461849.359 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T23:24:09.359Z,1696461849.359 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T23:24:09.359Z,1696461849.359 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T23:24:23.885Z,1696461863.885 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T23:29:09.928Z,1696462149.928 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T23:29:09.928Z,1696462149.928 [Default:CheckIn:C.Wait] Stopped 2023-10-04T23:29:09.928Z,1696462149.928 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T23:29:09.928Z,1696462149.928 [Default:CheckIn:D] Running Loop=1 2023-10-04T23:29:10.335Z,1696462150.335 [Default:CheckIn:D] Stopped 2023-10-04T23:29:10.335Z,1696462150.335 [Default:CheckIn:E] Running Loop=1 2023-10-04T23:29:10.743Z,1696462150.743 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 216.166243 min 2023-10-04T23:29:10.743Z,1696462150.743 [Default:CheckIn:E] Stopped 2023-10-04T23:29:10.744Z,1696462150.744 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T23:29:10.744Z,1696462150.744 [Default:CheckIn] Stopped 2023-10-04T23:29:10.744Z,1696462150.744 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T23:29:10.744Z,1696462150.744 [Default:CheckIn](INFO): Running loop #37 2023-10-04T23:29:10.744Z,1696462150.744 [Default:CheckIn] Running Loop=37 2023-10-04T23:29:10.744Z,1696462150.744 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T23:29:10.744Z,1696462150.744 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T23:29:12.746Z,1696462152.746 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232909.00,A,3648.14242,N,12147.22944,W,0.019,216.81,041023,,,D*7A 2023-10-04T23:29:12.748Z,1696462152.748 [NAL9602](INFO): GPS fix at 20231004T232909: (36.802374, -121.787157) 2023-10-04T23:29:12.780Z,1696462152.780 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T23:29:12.780Z,1696462152.780 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T23:29:20.527Z,1696462160.527 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0066.lzma 2023-10-04T23:29:21.529Z,1696462161.529 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0066.lzma.bak 2023-10-04T23:29:21.529Z,1696462161.529 [DataOverHttps](INFO): SBD MOMSN=18983332 2023-10-04T23:29:37.627Z,1696462177.627 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20231004T212333/Express0067.lzma 2023-10-04T23:29:38.612Z,1696462178.612 [NAL9602](INFO): SBD MO Status=0, MOMSN=31835, MT Status=0, MTMSN=0 2023-10-04T23:29:38.612Z,1696462178.612 [NAL9602](INFO): No messages in MT queue 2023-10-04T23:29:38.629Z,1696462178.629 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0067.lzma.bak 2023-10-04T23:29:38.630Z,1696462178.630 [DataOverHttps](INFO): SBD MOMSN=18983335 2023-10-04T23:29:40.239Z,1696462180.239 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T23:29:40.239Z,1696462180.239 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T23:29:40.239Z,1696462180.239 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T23:30:09.308Z,1696462209.308 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T23:31:20.023Z,1696462280.023 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2023-10-04T23:31:20.027Z,1696462280.027 [BPC1](INFO): Received data from all battery sticks. 2023-10-04T23:34:40.807Z,1696462480.807 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T23:34:40.807Z,1696462480.807 [Default:CheckIn:C.Wait] Stopped 2023-10-04T23:34:40.823Z,1696462480.823 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T23:34:40.824Z,1696462480.824 [Default:CheckIn:D] Running Loop=1 2023-10-04T23:34:41.211Z,1696462481.211 [Default:CheckIn:D] Stopped 2023-10-04T23:34:41.211Z,1696462481.211 [Default:CheckIn:E] Running Loop=1 2023-10-04T23:34:41.612Z,1696462481.612 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 221.680843 min 2023-10-04T23:34:41.612Z,1696462481.612 [Default:CheckIn:E] Stopped 2023-10-04T23:34:41.612Z,1696462481.612 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T23:34:41.612Z,1696462481.612 [Default:CheckIn] Stopped 2023-10-04T23:34:41.612Z,1696462481.612 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T23:34:41.612Z,1696462481.612 [Default:CheckIn](INFO): Running loop #38 2023-10-04T23:34:41.612Z,1696462481.612 [Default:CheckIn] Running Loop=38 2023-10-04T23:34:41.613Z,1696462481.613 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T23:34:41.613Z,1696462481.613 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T23:34:43.626Z,1696462483.626 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233439.00,A,3648.17170,N,12147.28037,W,0.233,245.50,041023,,,D*73 2023-10-04T23:34:43.638Z,1696462483.638 [NAL9602](INFO): GPS fix at 20231004T233439: (36.802862, -121.788006) 2023-10-04T23:34:43.649Z,1696462483.649 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T23:34:43.649Z,1696462483.649 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T23:34:51.395Z,1696462491.395 [DataOverHttps](INFO): Sending 83 bytes from file Logs/20231004T212333/Courier0069.lzma 2023-10-04T23:34:52.397Z,1696462492.397 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0069.lzma.bak 2023-10-04T23:34:52.397Z,1696462492.397 [DataOverHttps](INFO): SBD MOMSN=18983339 2023-10-04T23:34:56.146Z,1696462496.146 [NAL9602](INFO): SBD MO Status=0, MOMSN=31836, MT Status=0, MTMSN=0 2023-10-04T23:34:56.146Z,1696462496.146 [NAL9602](INFO): No messages in MT queue 2023-10-04T23:35:08.368Z,1696462508.368 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20231004T212333/Express0070.lzma 2023-10-04T23:35:09.369Z,1696462509.369 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0070.lzma.bak 2023-10-04T23:35:09.370Z,1696462509.370 [DataOverHttps](INFO): SBD MOMSN=18983342 2023-10-04T23:35:10.704Z,1696462510.704 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T23:35:10.704Z,1696462510.704 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T23:35:10.705Z,1696462510.705 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T23:35:26.848Z,1696462526.848 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T23:40:11.274Z,1696462811.274 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T23:40:11.274Z,1696462811.274 [Default:CheckIn:C.Wait] Stopped 2023-10-04T23:40:11.274Z,1696462811.274 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T23:40:11.274Z,1696462811.274 [Default:CheckIn:D] Running Loop=1 2023-10-04T23:40:11.679Z,1696462811.679 [Default:CheckIn:D] Stopped 2023-10-04T23:40:11.679Z,1696462811.679 [Default:CheckIn:E] Running Loop=1 2023-10-04T23:40:12.097Z,1696462812.097 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 227.188656 min 2023-10-04T23:40:12.097Z,1696462812.097 [Default:CheckIn:E] Stopped 2023-10-04T23:40:12.098Z,1696462812.098 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T23:40:12.098Z,1696462812.098 [Default:CheckIn] Stopped 2023-10-04T23:40:12.098Z,1696462812.098 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T23:40:12.098Z,1696462812.098 [Default:CheckIn](INFO): Running loop #39 2023-10-04T23:40:12.098Z,1696462812.098 [Default:CheckIn] Running Loop=39 2023-10-04T23:40:12.098Z,1696462812.098 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T23:40:12.098Z,1696462812.098 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T23:40:14.094Z,1696462814.094 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234010.00,A,3648.17480,N,12147.28007,W,0.039,245.50,041023,,,D*7A 2023-10-04T23:40:14.096Z,1696462814.096 [NAL9602](INFO): GPS fix at 20231004T234010: (36.802913, -121.788001) 2023-10-04T23:40:14.107Z,1696462814.107 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T23:40:14.107Z,1696462814.107 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T23:40:21.119Z,1696462821.119 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20231004T212333/Courier0072.lzma 2023-10-04T23:40:22.121Z,1696462822.121 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0072.lzma.bak 2023-10-04T23:40:22.121Z,1696462822.121 [DataOverHttps](INFO): SBD MOMSN=18983346 2023-10-04T23:40:37.122Z,1696462837.122 [NAL9602](INFO): SBD MO Status=0, MOMSN=31837, MT Status=0, MTMSN=0 2023-10-04T23:40:37.122Z,1696462837.122 [NAL9602](INFO): No messages in MT queue 2023-10-04T23:40:37.987Z,1696462837.987 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20231004T212333/Express0073.lzma 2023-10-04T23:40:38.989Z,1696462838.989 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0073.lzma.bak 2023-10-04T23:40:38.989Z,1696462838.989 [DataOverHttps](INFO): SBD MOMSN=18983349 2023-10-04T23:40:40.368Z,1696462840.368 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T23:40:40.368Z,1696462840.368 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T23:40:40.368Z,1696462840.368 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T23:41:07.828Z,1696462867.828 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T23:45:40.937Z,1696463140.937 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T23:45:40.938Z,1696463140.938 [Default:CheckIn:C.Wait] Stopped 2023-10-04T23:45:40.938Z,1696463140.938 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T23:45:40.938Z,1696463140.938 [Default:CheckIn:D] Running Loop=1 2023-10-04T23:45:41.351Z,1696463141.351 [Default:CheckIn:D] Stopped 2023-10-04T23:45:41.351Z,1696463141.351 [Default:CheckIn:E] Running Loop=1 2023-10-04T23:45:41.760Z,1696463141.760 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 232.683171 min 2023-10-04T23:45:41.760Z,1696463141.760 [Default:CheckIn:E] Stopped 2023-10-04T23:45:41.760Z,1696463141.760 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T23:45:41.760Z,1696463141.760 [Default:CheckIn] Stopped 2023-10-04T23:45:41.761Z,1696463141.761 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T23:45:41.761Z,1696463141.761 [Default:CheckIn](INFO): Running loop #40 2023-10-04T23:45:41.761Z,1696463141.761 [Default:CheckIn] Running Loop=40 2023-10-04T23:45:41.761Z,1696463141.761 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T23:45:41.761Z,1696463141.761 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T23:45:43.762Z,1696463143.762 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234540.00,A,3648.17408,N,12147.28188,W,0.078,245.50,041023,,,A*7C 2023-10-04T23:45:43.765Z,1696463143.765 [NAL9602](INFO): GPS fix at 20231004T234540: (36.802901, -121.788031) 2023-10-04T23:45:43.791Z,1696463143.791 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T23:45:43.792Z,1696463143.792 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T23:45:51.155Z,1696463151.155 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0075.lzma 2023-10-04T23:45:52.157Z,1696463152.157 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0075.lzma.bak 2023-10-04T23:45:52.157Z,1696463152.157 [DataOverHttps](INFO): SBD MOMSN=18983361 2023-10-04T23:46:03.149Z,1696463163.149 [NAL9602](INFO): SBD MO Status=0, MOMSN=31838, MT Status=0, MTMSN=0 2023-10-04T23:46:03.149Z,1696463163.149 [NAL9602](INFO): No messages in MT queue 2023-10-04T23:46:08.099Z,1696463168.099 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20231004T212333/Express0076.lzma 2023-10-04T23:46:09.101Z,1696463169.101 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0076.lzma.bak 2023-10-04T23:46:09.101Z,1696463169.101 [DataOverHttps](INFO): SBD MOMSN=18983364 2023-10-04T23:46:10.448Z,1696463170.448 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T23:46:10.448Z,1696463170.448 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T23:46:10.448Z,1696463170.448 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T23:46:33.856Z,1696463193.856 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T23:51:11.005Z,1696463471.005 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T23:51:11.005Z,1696463471.005 [Default:CheckIn:C.Wait] Stopped 2023-10-04T23:51:11.005Z,1696463471.005 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T23:51:11.006Z,1696463471.006 [Default:CheckIn:D] Running Loop=1 2023-10-04T23:51:11.415Z,1696463471.415 [Default:CheckIn:D] Stopped 2023-10-04T23:51:11.415Z,1696463471.415 [Default:CheckIn:E] Running Loop=1 2023-10-04T23:51:11.820Z,1696463471.820 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 238.184245 min 2023-10-04T23:51:11.820Z,1696463471.820 [Default:CheckIn:E] Stopped 2023-10-04T23:51:11.821Z,1696463471.821 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T23:51:11.821Z,1696463471.821 [Default:CheckIn] Stopped 2023-10-04T23:51:11.821Z,1696463471.821 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T23:51:11.821Z,1696463471.821 [Default:CheckIn](INFO): Running loop #41 2023-10-04T23:51:11.821Z,1696463471.821 [Default:CheckIn] Running Loop=41 2023-10-04T23:51:11.821Z,1696463471.821 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T23:51:11.821Z,1696463471.821 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T23:51:13.825Z,1696463473.825 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235110.00,A,3648.17119,N,12147.27568,W,0.233,0.00,041023,,,A*77 2023-10-04T23:51:13.828Z,1696463473.828 [NAL9602](INFO): GPS fix at 20231004T235110: (36.802853, -121.787928) 2023-10-04T23:51:13.851Z,1696463473.851 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T23:51:13.851Z,1696463473.851 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T23:51:21.059Z,1696463481.059 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0078.lzma 2023-10-04T23:51:22.061Z,1696463482.061 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0078.lzma.bak 2023-10-04T23:51:22.061Z,1696463482.061 [DataOverHttps](INFO): SBD MOMSN=18983376 2023-10-04T23:51:29.594Z,1696463489.594 [NAL9602](INFO): SBD MO Status=0, MOMSN=31839, MT Status=0, MTMSN=0 2023-10-04T23:51:29.595Z,1696463489.595 [NAL9602](INFO): No messages in MT queue 2023-10-04T23:51:38.423Z,1696463498.423 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20231004T212333/Express0079.lzma 2023-10-04T23:51:39.425Z,1696463499.425 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0079.lzma.bak 2023-10-04T23:51:39.425Z,1696463499.425 [DataOverHttps](INFO): SBD MOMSN=18983379 2023-10-04T23:51:40.920Z,1696463500.920 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T23:51:40.920Z,1696463500.920 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T23:51:40.920Z,1696463500.920 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T23:52:00.293Z,1696463520.293 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-04T23:56:41.511Z,1696463801.511 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-04T23:56:41.511Z,1696463801.511 [Default:CheckIn:C.Wait] Stopped 2023-10-04T23:56:41.512Z,1696463801.512 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-04T23:56:41.512Z,1696463801.512 [Default:CheckIn:D] Running Loop=1 2023-10-04T23:56:41.915Z,1696463801.915 [Default:CheckIn:D] Stopped 2023-10-04T23:56:41.915Z,1696463801.915 [Default:CheckIn:E] Running Loop=1 2023-10-04T23:56:42.332Z,1696463802.332 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 243.692578 min 2023-10-04T23:56:42.332Z,1696463802.332 [Default:CheckIn:E] Stopped 2023-10-04T23:56:42.332Z,1696463802.332 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-04T23:56:42.332Z,1696463802.332 [Default:CheckIn] Stopped 2023-10-04T23:56:42.332Z,1696463802.332 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-04T23:56:42.332Z,1696463802.332 [Default:CheckIn](INFO): Running loop #42 2023-10-04T23:56:42.332Z,1696463802.332 [Default:CheckIn] Running Loop=42 2023-10-04T23:56:42.333Z,1696463802.333 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-04T23:56:42.333Z,1696463802.333 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-04T23:56:44.329Z,1696463804.329 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235640.00,A,3648.17410,N,12147.27771,W,0.680,164.57,041023,,,A*7E 2023-10-04T23:56:44.332Z,1696463804.332 [NAL9602](INFO): GPS fix at 20231004T235640: (36.802902, -121.787962) 2023-10-04T23:56:44.342Z,1696463804.342 [Default:CheckIn:Read_GPS] Stopped 2023-10-04T23:56:44.343Z,1696463804.343 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-04T23:56:52.155Z,1696463812.155 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0081.lzma 2023-10-04T23:56:53.159Z,1696463813.159 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0081.lzma.bak 2023-10-04T23:56:53.159Z,1696463813.159 [DataOverHttps](INFO): SBD MOMSN=18983389 2023-10-04T23:57:09.231Z,1696463829.231 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20231004T212333/Express0082.lzma 2023-10-04T23:57:10.233Z,1696463830.233 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0082.lzma.bak 2023-10-04T23:57:10.234Z,1696463830.234 [DataOverHttps](INFO): SBD MOMSN=18983392 2023-10-04T23:57:11.812Z,1696463831.812 [Default:CheckIn:Read_Iridium] Stopped 2023-10-04T23:57:11.812Z,1696463831.812 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-04T23:57:11.812Z,1696463831.812 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-04T23:59:00.886Z,1696463940.886 [NAL9602](INFO): SBD MO Status=0, MOMSN=31840, MT Status=0, MTMSN=0 2023-10-04T23:59:00.886Z,1696463940.886 [NAL9602](INFO): No messages in MT queue 2023-10-04T23:59:31.589Z,1696463971.589 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-05T00:02:12.388Z,1696464132.388 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-05T00:02:12.388Z,1696464132.388 [Default:CheckIn:C.Wait] Stopped 2023-10-05T00:02:12.388Z,1696464132.388 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-05T00:02:12.388Z,1696464132.388 [Default:CheckIn:D] Running Loop=1 2023-10-05T00:02:12.802Z,1696464132.802 [Default:CheckIn:D] Stopped 2023-10-05T00:02:12.802Z,1696464132.802 [Default:CheckIn:E] Running Loop=1 2023-10-05T00:02:13.215Z,1696464133.215 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 249.207373 min 2023-10-05T00:02:13.215Z,1696464133.215 [Default:CheckIn:E] Stopped 2023-10-05T00:02:13.215Z,1696464133.215 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-05T00:02:13.216Z,1696464133.216 [Default:CheckIn] Stopped 2023-10-05T00:02:13.216Z,1696464133.216 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-05T00:02:13.216Z,1696464133.216 [Default:CheckIn](INFO): Running loop #43 2023-10-05T00:02:13.216Z,1696464133.216 [Default:CheckIn] Running Loop=43 2023-10-05T00:02:13.216Z,1696464133.216 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-05T00:02:13.216Z,1696464133.216 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-05T00:02:15.212Z,1696464135.212 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,000211.00,A,3648.17566,N,12147.28532,W,0.816,283.76,051023,,,A*79 2023-10-05T00:02:15.214Z,1696464135.214 [NAL9602](INFO): GPS fix at 20231005T000211: (36.802928, -121.788089) 2023-10-05T00:02:15.225Z,1696464135.225 [Default:CheckIn:Read_GPS] Stopped 2023-10-05T00:02:15.225Z,1696464135.225 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-05T00:02:23.119Z,1696464143.119 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20231004T212333/Courier0084.lzma 2023-10-05T00:02:24.121Z,1696464144.121 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0084.lzma.bak 2023-10-05T00:02:24.122Z,1696464144.122 [DataOverHttps](INFO): SBD MOMSN=18983404 2023-10-05T00:02:40.199Z,1696464160.199 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20231004T212333/Express0085.lzma 2023-10-05T00:02:41.201Z,1696464161.201 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0085.lzma.bak 2023-10-05T00:02:41.202Z,1696464161.202 [DataOverHttps](INFO): SBD MOMSN=18983409 2023-10-05T00:02:42.712Z,1696464162.712 [Default:CheckIn:Read_Iridium] Stopped 2023-10-05T00:02:42.712Z,1696464162.712 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-05T00:02:42.712Z,1696464162.712 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-05T00:03:26.712Z,1696464206.712 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2023-10-05T00:03:26.712Z,1696464206.712 [DropWeight] Hardware Fault, FailCount= 1 2023-10-05T00:03:26.712Z,1696464206.712 [DropWeight](ERROR): Hardware Fault 2023-10-05T00:03:26.752Z,1696464206.752 [CommandExec](FAULT): Scheduling is paused for 4 commands 2023-10-05T00:03:26.752Z,1696464206.752 [CBIT](INFO): Critical error at 20231005T000326 2023-10-05T00:03:26.755Z,1696464206.755 [CBIT](ERROR): Hardware Fault in component: DropWeight 2023-10-05T00:03:26.760Z,1696464206.760 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2023-10-05T00:03:27.179Z,1696464207.179 [CBIT](INFO): Critical error at 20231005T000326 2023-10-05T00:03:41.667Z,1696464221.667 [NAL9602](INFO): SBD MO Status=2, MOMSN=31841, MT Status=2, MTMSN=0 2023-10-05T00:03:41.668Z,1696464221.668 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-10-05T00:06:48.160Z,1696464408.160 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.255280 2023-10-05T00:07:17.396Z,1696464437.396 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-10-05T00:07:21.292Z,1696464441.292 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-05T00:07:43.262Z,1696464463.262 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-05T00:07:43.262Z,1696464463.262 [Default:CheckIn:C.Wait] Stopped 2023-10-05T00:07:43.262Z,1696464463.262 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-05T00:07:43.262Z,1696464463.262 [Default:CheckIn:D] Running Loop=1 2023-10-05T00:07:43.675Z,1696464463.675 [Default:CheckIn:D] Stopped 2023-10-05T00:07:43.675Z,1696464463.675 [Default:CheckIn:E] Running Loop=1 2023-10-05T00:07:44.084Z,1696464464.084 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 254.721924 min 2023-10-05T00:07:44.085Z,1696464464.085 [Default:CheckIn:E] Stopped 2023-10-05T00:07:44.085Z,1696464464.085 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-05T00:07:44.085Z,1696464464.085 [Default:CheckIn] Stopped 2023-10-05T00:07:44.085Z,1696464464.085 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-05T00:07:44.085Z,1696464464.085 [Default:CheckIn](INFO): Running loop #44 2023-10-05T00:07:44.085Z,1696464464.085 [Default:CheckIn] Running Loop=44 2023-10-05T00:07:44.085Z,1696464464.085 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-05T00:07:44.085Z,1696464464.085 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-05T00:07:46.081Z,1696464466.081 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,000742.00,A,3648.15504,N,12147.29073,W,1.127,173.13,051023,,,A*78 2023-10-05T00:07:46.084Z,1696464466.084 [NAL9602](INFO): GPS fix at 20231005T000742: (36.802584, -121.788179) 2023-10-05T00:07:46.094Z,1696464466.094 [Default:CheckIn:Read_GPS] Stopped 2023-10-05T00:07:46.094Z,1696464466.094 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-10-05T00:07:56.431Z,1696464476.431 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-10-05T00:08:08.976Z,1696464488.976 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003290 2023-10-05T00:08:16.463Z,1696464496.463 [DataOverHttps](INFO): Sending 180 bytes from file Logs/20231004T212333/Courier0087.lzma 2023-10-05T00:08:16.789Z,1696464496.789 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response. 2023-10-05T00:08:16.871Z,1696464496.871 [NAL9602](ERROR): received: +CSQ:0 OK841, 2, 0, 0, 0 OK 2023-10-05T00:08:17.468Z,1696464497.468 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Courier0087.lzma.bak 2023-10-05T00:08:17.469Z,1696464497.469 [DataOverHttps](INFO): SBD MOMSN=18983416 2023-10-05T00:08:33.319Z,1696464513.319 [DataOverHttps](INFO): Sending 275 bytes from file Logs/20231004T212333/Express0088.lzma 2023-10-05T00:08:34.321Z,1696464514.321 [DataOverHttps](INFO): Moved sent file to Logs/20231004T212333/Express0088.lzma.bak 2023-10-05T00:08:34.322Z,1696464514.322 [DataOverHttps](INFO): SBD MOMSN=18983421 2023-10-05T00:08:35.788Z,1696464515.788 [Default:CheckIn:Read_Iridium] Stopped 2023-10-05T00:08:35.788Z,1696464515.788 [Default:CheckIn:C.Wait] Running Loop=1 2023-10-05T00:08:35.788Z,1696464515.788 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-10-05T00:08:47.489Z,1696464527.489 [NAL9602](INFO): Not Powering down - fast GPS 2023-10-05T00:13:36.384Z,1696464816.384 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-10-05T00:13:36.384Z,1696464816.384 [Default:CheckIn:C.Wait] Stopped 2023-10-05T00:13:36.384Z,1696464816.384 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-10-05T00:13:36.385Z,1696464816.385 [Default:CheckIn:D] Running Loop=1 2023-10-05T00:13:36.796Z,1696464816.796 [Default:CheckIn:D] Stopped 2023-10-05T00:13:36.796Z,1696464816.796 [Default:CheckIn:E] Running Loop=1 2023-10-05T00:13:37.200Z,1696464817.200 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 260.607275 min 2023-10-05T00:13:37.200Z,1696464817.200 [Default:CheckIn:E] Stopped 2023-10-05T00:13:37.200Z,1696464817.200 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-10-05T00:13:37.201Z,1696464817.201 [Default:CheckIn] Stopped 2023-10-05T00:13:37.201Z,1696464817.201 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-05T00:13:37.201Z,1696464817.201 [Default:CheckIn](INFO): Running loop #45 2023-10-05T00:13:37.201Z,1696464817.201 [Default:CheckIn] Running Loop=45 2023-10-05T00:13:37.201Z,1696464817.201 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-05T00:13:37.201Z,1696464817.201 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-05T00:14:16.036Z,1696464856.036 [CommandExec](IMPORTANT): got command quit 2023-10-05T00:14:17.040Z,1696464857.040 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-05T00:14:17.040Z,1696464857.040 [CommandExec](INFO): Uninitializing the command executive. 2023-10-05T00:14:17.040Z,1696464857.040 [CommandExec](INFO): Uninitializing the command scheduler. 2023-10-05T00:14:17.040Z,1696464857.040 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:17.119Z,1696464857.119 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-10-05T00:14:17.120Z,1696464857.120 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-10-05T00:14:17.120Z,1696464857.120 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:17.157Z,1696464857.157 [NavChartDb](INFO): Join timeout helper Thread ID is 6677 2023-10-05T00:14:17.440Z,1696464857.440 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-05T00:14:17.440Z,1696464857.440 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:17.451Z,1696464857.451 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2023-10-05T00:14:17.452Z,1696464857.452 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:17.452Z,1696464857.452 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 6678 2023-10-05T00:14:17.719Z,1696464857.719 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-05T00:14:17.720Z,1696464857.720 [WetLabsUBAT](INFO): Powering down 2023-10-05T00:14:17.720Z,1696464857.720 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:17.727Z,1696464857.727 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-10-05T00:14:17.727Z,1696464857.727 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:17.728Z,1696464857.728 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6679 2023-10-05T00:14:17.824Z,1696464857.824 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-05T00:14:17.824Z,1696464857.824 [WetLabsBB2FL](INFO): Powering down 2023-10-05T00:14:17.839Z,1696464857.839 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:17.848Z,1696464857.848 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-10-05T00:14:17.848Z,1696464857.848 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:17.848Z,1696464857.848 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6680 2023-10-05T00:14:18.851Z,1696464858.851 [CTD_Seabird](INFO): Powering down 2023-10-05T00:14:18.869Z,1696464858.869 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-05T00:14:18.870Z,1696464858.870 [CTD_Seabird](INFO): Powering down 2023-10-05T00:14:18.883Z,1696464858.883 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:18.888Z,1696464858.888 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2023-10-05T00:14:18.888Z,1696464858.888 [DAT ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:18.888Z,1696464858.888 [DAT](INFO): Join timeout helper Thread ID is 6681 2023-10-05T00:14:19.012Z,1696464859.012 [DAT](INFO): Powering down 2023-10-05T00:14:19.084Z,1696464859.084 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-05T00:14:19.084Z,1696464859.084 [DAT](INFO): Powering down 2023-10-05T00:14:19.085Z,1696464859.085 [DAT ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:19.092Z,1696464859.092 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-10-05T00:14:19.092Z,1696464859.092 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:19.093Z,1696464859.093 [Radio_Surface](INFO): Join timeout helper Thread ID is 6682 2023-10-05T00:14:19.436Z,1696464859.436 [Radio_Surface](INFO): Powering down 2023-10-05T00:14:19.437Z,1696464859.437 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-05T00:14:19.437Z,1696464859.437 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:19.440Z,1696464859.440 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2023-10-05T00:14:19.452Z,1696464859.452 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-10-05T00:14:19.452Z,1696464859.452 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:19.453Z,1696464859.453 [Onboard](INFO): Join timeout helper Thread ID is 6683 2023-10-05T00:14:23.675Z,1696464863.675 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-05T00:14:23.676Z,1696464863.676 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:23.684Z,1696464863.684 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-10-05T00:14:23.684Z,1696464863.684 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:23.705Z,1696464863.705 [DataOverHttps](INFO): Join timeout helper Thread ID is 6684 2023-10-05T00:14:24.459Z,1696464864.459 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-05T00:14:24.460Z,1696464864.460 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:24.461Z,1696464864.461 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2023-10-05T00:14:24.461Z,1696464864.461 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:24.462Z,1696464864.462 [BackseatComponent](INFO): Join timeout helper Thread ID is 6685 2023-10-05T00:14:24.579Z,1696464864.579 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-05T00:14:24.580Z,1696464864.580 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:24.588Z,1696464864.588 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-10-05T00:14:24.588Z,1696464864.588 [logger ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:24.588Z,1696464864.588 [logger](INFO): Join timeout helper Thread ID is 6686 2023-10-05T00:14:24.607Z,1696464864.607 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-05T00:14:24.608Z,1696464864.608 [logger ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:24.628Z,1696464864.628 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-10-05T00:14:24.628Z,1696464864.628 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:24.629Z,1696464864.629 [CommandLine](INFO): Join timeout helper Thread ID is 6687 2023-10-05T00:14:24.728Z,1696464864.728 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-05T00:14:24.728Z,1696464864.728 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:24.748Z,1696464864.748 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-10-05T00:14:24.748Z,1696464864.748 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:24.748Z,1696464864.748 [CommandExec](INFO): Join timeout helper Thread ID is 6688 2023-10-05T00:14:24.750Z,1696464864.750 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-10-05T00:14:24.750Z,1696464864.750 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:24.750Z,1696464864.750 [controlThread](INFO): Join timeout helper Thread ID is 6689 2023-10-05T00:14:24.811Z,1696464864.811 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-05T00:14:24.812Z,1696464864.812 [controlThread](DEBUG): Uninitializing ControlThread 2023-10-05T00:14:24.812Z,1696464864.812 [AHRS_M2](INFO): Powering down 2023-10-05T00:14:24.884Z,1696464864.884 [NAL9602](INFO): Powering down 2023-10-05T00:14:24.886Z,1696464864.886 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-10-05T00:14:24.887Z,1696464864.887 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-10-05T00:14:24.888Z,1696464864.888 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-10-05T00:14:24.888Z,1696464864.888 [MissionManager](INFO): Uninitializing Mission Default 2023-10-05T00:14:24.888Z,1696464864.888 [Default] Stopped 2023-10-05T00:14:24.888Z,1696464864.888 [Default](DEBUG): Aggregate::uninitialize Default 2023-10-05T00:14:24.888Z,1696464864.888 [Default:B.GoToSurface] Stopped 2023-10-05T00:14:24.888Z,1696464864.888 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-10-05T00:14:24.888Z,1696464864.888 [Default:CheckIn] Stopped 2023-10-05T00:14:24.889Z,1696464864.889 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-05T00:14:24.889Z,1696464864.889 [Default:CheckIn:Read_GPS] Stopped 2023-10-05T00:14:24.891Z,1696464864.891 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-10-05T00:14:24.892Z,1696464864.892 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-10-05T00:14:24.892Z,1696464864.892 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-10-05T00:14:24.892Z,1696464864.892 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-10-05T00:14:24.893Z,1696464864.893 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-10-05T00:14:24.893Z,1696464864.893 [BuoyancyServo](INFO): Powering down 2023-10-05T00:14:24.907Z,1696464864.907 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-10-05T00:14:24.907Z,1696464864.907 [ElevatorServo](INFO): Powering down 2023-10-05T00:14:24.908Z,1696464864.908 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-10-05T00:14:24.908Z,1696464864.908 [MassServo](INFO): Powering down 2023-10-05T00:14:24.909Z,1696464864.909 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-10-05T00:14:24.909Z,1696464864.909 [RudderServo](INFO): Powering down 2023-10-05T00:14:24.910Z,1696464864.910 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2023-10-05T00:14:24.910Z,1696464864.910 [ThrusterServo](INFO): Powering down 2023-10-05T00:14:24.911Z,1696464864.911 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-10-05T00:14:24.912Z,1696464864.912 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-10-05T00:14:24.912Z,1696464864.912 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-10-05T00:14:24.912Z,1696464864.912 [CBIT](DEBUG): Powering off loads. 2023-10-05T00:14:24.923Z,1696464864.923 [CBIT](DEBUG): Disabling WDT. 2023-10-05T00:14:24.935Z,1696464864.935 [CBIT](DEBUG): Opening all GF detection circuits. 2023-10-05T00:14:24.936Z,1696464864.936 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:24.996Z,1696464864.996 [DAT ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:25.001Z,1696464865.001 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:25.004Z,1696464865.004 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:25.010Z,1696464865.010 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:25.054Z,1696464865.054 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:25.122Z,1696464865.122 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:25.124Z,1696464865.124 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:25.128Z,1696464865.128 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:25.136Z,1696464865.136 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-10-05T00:14:25.254Z,1696464865.254 [logger ThreadHandler](INFO): Thread cancelled.