2024-12-03T22:31:37.813Z,1733265097.813 [CommandExec](IMPORTANT): got command restart logs 2024-12-03T22:32:49.319Z,1733265169.319 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-03T22:32:49.331Z,1733265169.331 [Default:CheckIn:C.Wait] Stopped 2024-12-03T22:32:49.331Z,1733265169.331 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-03T22:32:49.332Z,1733265169.332 [Default:CheckIn:D] Running Loop=1 2024-12-03T22:32:49.714Z,1733265169.714 [Default:CheckIn:D] Stopped 2024-12-03T22:32:49.714Z,1733265169.714 [Default:CheckIn:E] Running Loop=1 2024-12-03T22:32:50.120Z,1733265170.120 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 8.588153 min 2024-12-03T22:32:50.120Z,1733265170.120 [Default:CheckIn:E] Stopped 2024-12-03T22:32:50.121Z,1733265170.121 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-03T22:32:50.121Z,1733265170.121 [Default:CheckIn] Stopped 2024-12-03T22:32:50.121Z,1733265170.121 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-03T22:32:50.121Z,1733265170.121 [Default:CheckIn](INFO): Running loop #2 2024-12-03T22:32:50.121Z,1733265170.121 [Default:CheckIn] Running Loop=2 2024-12-03T22:32:50.121Z,1733265170.121 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-03T22:32:50.121Z,1733265170.121 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-03T22:32:52.121Z,1733265172.121 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223251.00,A,3648.23094,N,12149.67539,W,0.836,165.20,031224,,,D*73 2024-12-03T22:32:52.124Z,1733265172.124 [NAL9602](INFO): GPS fix at 20241203T223251: (36.803849, -121.827923) 2024-12-03T22:32:52.167Z,1733265172.167 [Default:CheckIn:Read_GPS] Stopped 2024-12-03T22:32:52.167Z,1733265172.167 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-03T22:33:00.015Z,1733265180.015 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241203T211000/Courier0042.lzma 2024-12-03T22:33:01.017Z,1733265181.017 [DataOverHttps](INFO): Moved sent file to Logs/20241203T211000/Courier0042.lzma.bak 2024-12-03T22:33:01.017Z,1733265181.017 [DataOverHttps](INFO): SBD MOMSN=23591710 2024-12-03T22:33:06.466Z,1733265186.466 [NAL9602](INFO): SBD MO Status=0, MOMSN=19833, MT Status=0, MTMSN=0 2024-12-03T22:33:06.466Z,1733265186.466 [NAL9602](INFO): No messages in MT queue 2024-12-03T22:33:16.915Z,1733265196.915 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20241203T223137/Courier0000.lzma 2024-12-03T22:33:17.917Z,1733265197.917 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Courier0000.lzma.bak 2024-12-03T22:33:17.917Z,1733265197.917 [DataOverHttps](INFO): SBD MOMSN=23591712 2024-12-03T22:33:33.843Z,1733265213.843 [DataOverHttps](INFO): Sending 194 bytes from file Logs/20241203T211000/Express0043.lzma 2024-12-03T22:33:34.845Z,1733265214.845 [DataOverHttps](INFO): Moved sent file to Logs/20241203T211000/Express0043.lzma.bak 2024-12-03T22:33:34.846Z,1733265214.846 [DataOverHttps](INFO): SBD MOMSN=23591716 2024-12-03T22:33:37.172Z,1733265217.172 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-03T22:33:50.668Z,1733265230.668 [DataOverHttps](INFO): Sending 398 bytes from file Logs/20241203T223137/Express0001.lzma 2024-12-03T22:33:51.669Z,1733265231.669 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Express0001.lzma.bak 2024-12-03T22:33:51.669Z,1733265231.669 [DataOverHttps](INFO): SBD MOMSN=23591720 2024-12-03T22:33:52.940Z,1733265232.940 [Default:CheckIn:Read_Iridium] Stopped 2024-12-03T22:33:52.940Z,1733265232.940 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-03T22:33:52.941Z,1733265232.941 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-03T22:37:27.236Z,1733265447.236 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-12-03T22:37:58.380Z,1733265478.380 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-12-03T22:38:53.519Z,1733265533.519 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-03T22:38:53.519Z,1733265533.519 [Default:CheckIn:C.Wait] Stopped 2024-12-03T22:38:53.519Z,1733265533.519 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-03T22:38:53.520Z,1733265533.520 [Default:CheckIn:D] Running Loop=1 2024-12-03T22:38:53.933Z,1733265533.933 [Default:CheckIn:D] Stopped 2024-12-03T22:38:53.933Z,1733265533.933 [Default:CheckIn:E] Running Loop=1 2024-12-03T22:38:54.333Z,1733265534.333 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 14.658462 min 2024-12-03T22:38:54.333Z,1733265534.333 [Default:CheckIn:E] Stopped 2024-12-03T22:38:54.333Z,1733265534.333 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-03T22:38:54.333Z,1733265534.333 [Default:CheckIn] Stopped 2024-12-03T22:38:54.333Z,1733265534.333 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-03T22:38:54.333Z,1733265534.333 [Default:CheckIn](INFO): Running loop #3 2024-12-03T22:38:54.333Z,1733265534.333 [Default:CheckIn] Running Loop=3 2024-12-03T22:38:54.333Z,1733265534.333 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-03T22:38:54.334Z,1733265534.334 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-03T22:38:56.334Z,1733265536.334 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223855.00,A,3648.39358,N,12147.40874,W,24.726,51.62,031224,,,D*72 2024-12-03T22:38:56.337Z,1733265536.337 [NAL9602](INFO): GPS fix at 20241203T223855: (36.806560, -121.790146) 2024-12-03T22:38:56.365Z,1733265536.365 [Default:CheckIn:Read_GPS] Stopped 2024-12-03T22:38:56.365Z,1733265536.365 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-03T22:39:03.895Z,1733265543.895 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241203T223137/Courier0005.lzma 2024-12-03T22:39:04.897Z,1733265544.897 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Courier0005.lzma.bak 2024-12-03T22:39:04.897Z,1733265544.897 [DataOverHttps](INFO): SBD MOMSN=23591724 2024-12-03T22:39:18.958Z,1733265558.958 [NAL9602](INFO): SBD MO Status=0, MOMSN=19834, MT Status=0, MTMSN=0 2024-12-03T22:39:18.958Z,1733265558.958 [NAL9602](INFO): No messages in MT queue 2024-12-03T22:39:20.847Z,1733265560.847 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20241203T223137/Express0004.lzma 2024-12-03T22:39:21.849Z,1733265561.849 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Express0004.lzma.bak 2024-12-03T22:39:21.849Z,1733265561.849 [DataOverHttps](INFO): SBD MOMSN=23591727 2024-12-03T22:39:23.418Z,1733265563.418 [Default:CheckIn:Read_Iridium] Stopped 2024-12-03T22:39:23.418Z,1733265563.418 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-03T22:39:23.418Z,1733265563.418 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-03T22:39:49.664Z,1733265589.664 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-03T22:44:24.000Z,1733265864.000 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-03T22:44:24.000Z,1733265864.000 [Default:CheckIn:C.Wait] Stopped 2024-12-03T22:44:24.000Z,1733265864.000 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-03T22:44:24.001Z,1733265864.001 [Default:CheckIn:D] Running Loop=1 2024-12-03T22:44:24.406Z,1733265864.406 [Default:CheckIn:D] Stopped 2024-12-03T22:44:24.406Z,1733265864.406 [Default:CheckIn:E] Running Loop=1 2024-12-03T22:44:24.794Z,1733265864.794 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.166345 min 2024-12-03T22:44:24.795Z,1733265864.795 [Default:CheckIn:E] Stopped 2024-12-03T22:44:24.795Z,1733265864.795 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-03T22:44:24.795Z,1733265864.795 [Default:CheckIn] Stopped 2024-12-03T22:44:24.795Z,1733265864.795 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-03T22:44:24.795Z,1733265864.795 [Default:CheckIn](INFO): Running loop #4 2024-12-03T22:44:24.795Z,1733265864.795 [Default:CheckIn] Running Loop=4 2024-12-03T22:44:24.795Z,1733265864.795 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-03T22:44:24.796Z,1733265864.796 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-03T22:44:26.810Z,1733265866.810 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,224426.00,A,3648.18807,N,12147.18125,W,2.799,212.85,031224,,,D*73 2024-12-03T22:44:26.812Z,1733265866.812 [NAL9602](INFO): GPS fix at 20241203T224426: (36.803134, -121.786354) 2024-12-03T22:44:26.824Z,1733265866.824 [Default:CheckIn:Read_GPS] Stopped 2024-12-03T22:44:26.824Z,1733265866.824 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-03T22:44:34.399Z,1733265874.399 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241203T223137/Courier0009.lzma 2024-12-03T22:44:35.401Z,1733265875.401 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Courier0009.lzma.bak 2024-12-03T22:44:35.401Z,1733265875.401 [DataOverHttps](INFO): SBD MOMSN=23591877 2024-12-03T22:44:49.479Z,1733265889.479 [NAL9602](INFO): SBD MO Status=0, MOMSN=19835, MT Status=0, MTMSN=0 2024-12-03T22:44:49.479Z,1733265889.479 [NAL9602](INFO): No messages in MT queue 2024-12-03T22:44:53.960Z,1733265893.960 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20241203T223137/Express0010.lzma 2024-12-03T22:44:54.961Z,1733265894.961 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Express0010.lzma.bak 2024-12-03T22:44:54.962Z,1733265894.962 [DataOverHttps](INFO): SBD MOMSN=23591880 2024-12-03T22:44:56.384Z,1733265896.384 [Default:CheckIn:Read_Iridium] Stopped 2024-12-03T22:44:56.384Z,1733265896.384 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-03T22:44:56.384Z,1733265896.384 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-03T22:45:20.195Z,1733265920.195 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-03T22:49:56.949Z,1733266196.949 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-03T22:49:56.949Z,1733266196.949 [Default:CheckIn:C.Wait] Stopped 2024-12-03T22:49:56.949Z,1733266196.949 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-03T22:49:56.949Z,1733266196.949 [Default:CheckIn:D] Running Loop=1 2024-12-03T22:49:57.364Z,1733266197.364 [Default:CheckIn:D] Stopped 2024-12-03T22:49:57.364Z,1733266197.364 [Default:CheckIn:E] Running Loop=1 2024-12-03T22:49:57.774Z,1733266197.774 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.715651 min 2024-12-03T22:49:57.774Z,1733266197.774 [Default:CheckIn:E] Stopped 2024-12-03T22:49:57.774Z,1733266197.774 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-03T22:49:57.774Z,1733266197.774 [Default:CheckIn] Stopped 2024-12-03T22:49:57.774Z,1733266197.774 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-03T22:49:57.774Z,1733266197.774 [Default:CheckIn](INFO): Running loop #5 2024-12-03T22:49:57.774Z,1733266197.774 [Default:CheckIn] Running Loop=5 2024-12-03T22:49:57.775Z,1733266197.775 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-03T22:49:57.775Z,1733266197.775 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-03T22:49:59.770Z,1733266199.770 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,224959.00,A,3648.14926,N,12147.22119,W,0.408,207.67,031224,,,D*7F 2024-12-03T22:49:59.773Z,1733266199.773 [NAL9602](INFO): GPS fix at 20241203T224959: (36.802488, -121.787020) 2024-12-03T22:49:59.784Z,1733266199.784 [Default:CheckIn:Read_GPS] Stopped 2024-12-03T22:49:59.784Z,1733266199.784 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-03T22:50:07.179Z,1733266207.179 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241203T223137/Courier0012.lzma 2024-12-03T22:50:08.181Z,1733266208.181 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Courier0012.lzma.bak 2024-12-03T22:50:08.181Z,1733266208.181 [DataOverHttps](INFO): SBD MOMSN=23591884 2024-12-03T22:50:24.003Z,1733266224.003 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20241203T223137/Express0013.lzma 2024-12-03T22:50:25.005Z,1733266225.005 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Express0013.lzma.bak 2024-12-03T22:50:25.005Z,1733266225.005 [DataOverHttps](INFO): SBD MOMSN=23591893 2024-12-03T22:50:26.474Z,1733266226.474 [Default:CheckIn:Read_Iridium] Stopped 2024-12-03T22:50:26.474Z,1733266226.474 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-03T22:50:26.474Z,1733266226.474 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-03T22:51:22.210Z,1733266282.210 [NAL9602](INFO): SBD MO Status=2, MOMSN=19836, MT Status=2, MTMSN=0 2024-12-03T22:51:22.210Z,1733266282.210 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-03T22:51:38.370Z,1733266298.370 [NAL9602](INFO): SBD MO Status=2, MOMSN=19836, MT Status=2, MTMSN=0 2024-12-03T22:51:38.370Z,1733266298.370 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-03T22:51:46.854Z,1733266306.854 [NAL9602](INFO): SBD MO Status=0, MOMSN=19836, MT Status=0, MTMSN=0 2024-12-03T22:51:46.854Z,1733266306.854 [NAL9602](INFO): No messages in MT queue 2024-12-03T22:52:17.552Z,1733266337.552 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-03T22:55:27.072Z,1733266527.072 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-03T22:55:27.073Z,1733266527.073 [Default:CheckIn:C.Wait] Stopped 2024-12-03T22:55:27.073Z,1733266527.073 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-03T22:55:27.073Z,1733266527.073 [Default:CheckIn:D] Running Loop=1 2024-12-03T22:55:27.467Z,1733266527.467 [Default:CheckIn:D] Stopped 2024-12-03T22:55:27.467Z,1733266527.467 [Default:CheckIn:E] Running Loop=1 2024-12-03T22:55:27.872Z,1733266527.872 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.217356 min 2024-12-03T22:55:27.872Z,1733266527.872 [Default:CheckIn:E] Stopped 2024-12-03T22:55:27.872Z,1733266527.872 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-03T22:55:27.873Z,1733266527.873 [Default:CheckIn] Stopped 2024-12-03T22:55:27.873Z,1733266527.873 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-03T22:55:27.873Z,1733266527.873 [Default:CheckIn](INFO): Running loop #6 2024-12-03T22:55:27.873Z,1733266527.873 [Default:CheckIn] Running Loop=6 2024-12-03T22:55:27.873Z,1733266527.873 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-03T22:55:27.873Z,1733266527.873 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-03T22:55:29.885Z,1733266529.885 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225529.00,A,3648.14973,N,12147.22451,W,0.000,250.92,031224,,,A*7D 2024-12-03T22:55:29.887Z,1733266529.887 [NAL9602](INFO): GPS fix at 20241203T225529: (36.802495, -121.787075) 2024-12-03T22:55:29.898Z,1733266529.898 [Default:CheckIn:Read_GPS] Stopped 2024-12-03T22:55:29.898Z,1733266529.898 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-03T22:55:36.907Z,1733266536.907 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241203T223137/Courier0015.lzma 2024-12-03T22:55:37.909Z,1733266537.909 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Courier0015.lzma.bak 2024-12-03T22:55:37.909Z,1733266537.909 [DataOverHttps](INFO): SBD MOMSN=23592042 2024-12-03T22:55:45.297Z,1733266545.297 [NAL9602](INFO): SBD MO Status=2, MOMSN=19837, MT Status=2, MTMSN=0 2024-12-03T22:55:45.297Z,1733266545.297 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-03T22:55:53.720Z,1733266553.720 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20241203T223137/Express0016.lzma 2024-12-03T22:55:54.721Z,1733266554.721 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Express0016.lzma.bak 2024-12-03T22:55:54.721Z,1733266554.721 [DataOverHttps](INFO): SBD MOMSN=23592045 2024-12-03T22:55:56.226Z,1733266556.226 [Default:CheckIn:Read_Iridium] Stopped 2024-12-03T22:55:56.226Z,1733266556.226 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-03T22:55:56.226Z,1733266556.226 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-03T22:56:02.265Z,1733266562.265 [NAL9602](INFO): SBD MO Status=2, MOMSN=19837, MT Status=2, MTMSN=0 2024-12-03T22:56:02.265Z,1733266562.265 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-03T22:56:19.642Z,1733266579.642 [NAL9602](INFO): SBD MO Status=2, MOMSN=19837, MT Status=2, MTMSN=0 2024-12-03T22:56:19.642Z,1733266579.642 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-03T22:58:02.254Z,1733266682.254 [NAL9602](INFO): SBD MO Status=0, MOMSN=19837, MT Status=0, MTMSN=0 2024-12-03T22:58:02.254Z,1733266682.254 [NAL9602](INFO): No messages in MT queue 2024-12-03T22:58:32.960Z,1733266712.960 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-03T23:00:56.811Z,1733266856.811 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-03T23:00:56.812Z,1733266856.812 [Default:CheckIn:C.Wait] Stopped 2024-12-03T23:00:56.812Z,1733266856.812 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-03T23:00:56.812Z,1733266856.812 [Default:CheckIn:D] Running Loop=1 2024-12-03T23:00:57.194Z,1733266857.194 [Default:CheckIn:D] Stopped 2024-12-03T23:00:57.194Z,1733266857.194 [Default:CheckIn:E] Running Loop=1 2024-12-03T23:00:57.608Z,1733266857.608 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.712809 min 2024-12-03T23:00:57.608Z,1733266857.608 [Default:CheckIn:E] Stopped 2024-12-03T23:00:57.608Z,1733266857.608 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-03T23:00:57.608Z,1733266857.608 [Default:CheckIn] Stopped 2024-12-03T23:00:57.608Z,1733266857.608 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-03T23:00:57.608Z,1733266857.608 [Default:CheckIn](INFO): Running loop #7 2024-12-03T23:00:57.608Z,1733266857.608 [Default:CheckIn] Running Loop=7 2024-12-03T23:00:57.608Z,1733266857.608 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-03T23:00:57.609Z,1733266857.609 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-03T23:00:59.609Z,1733266859.609 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230058.00,A,3648.14925,N,12147.22353,W,0.000,250.92,031224,,,A*7C 2024-12-03T23:00:59.611Z,1733266859.611 [NAL9602](INFO): GPS fix at 20241203T230058: (36.802487, -121.787059) 2024-12-03T23:00:59.641Z,1733266859.641 [Default:CheckIn:Read_GPS] Stopped 2024-12-03T23:00:59.641Z,1733266859.641 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-03T23:01:07.415Z,1733266867.415 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241203T223137/Courier0018.lzma 2024-12-03T23:01:08.417Z,1733266868.417 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Courier0018.lzma.bak 2024-12-03T23:01:08.417Z,1733266868.417 [DataOverHttps](INFO): SBD MOMSN=23592087 2024-12-03T23:01:13.346Z,1733266873.346 [NAL9602](INFO): SBD MO Status=0, MOMSN=19838, MT Status=0, MTMSN=0 2024-12-03T23:01:13.346Z,1733266873.346 [NAL9602](INFO): No messages in MT queue 2024-12-03T23:01:24.215Z,1733266884.215 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20241203T223137/Express0019.lzma 2024-12-03T23:01:25.218Z,1733266885.218 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Express0019.lzma.bak 2024-12-03T23:01:25.218Z,1733266885.218 [DataOverHttps](INFO): SBD MOMSN=23592090 2024-12-03T23:01:26.704Z,1733266886.704 [Default:CheckIn:Read_Iridium] Stopped 2024-12-03T23:01:26.704Z,1733266886.704 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-03T23:01:26.704Z,1733266886.704 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-03T23:01:44.054Z,1733266904.054 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-03T23:06:27.284Z,1733267187.284 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-03T23:06:27.284Z,1733267187.284 [Default:CheckIn:C.Wait] Stopped 2024-12-03T23:06:27.284Z,1733267187.284 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-03T23:06:27.285Z,1733267187.285 [Default:CheckIn:D] Running Loop=1 2024-12-03T23:06:27.671Z,1733267187.671 [Default:CheckIn:D] Stopped 2024-12-03T23:06:27.671Z,1733267187.671 [Default:CheckIn:E] Running Loop=1 2024-12-03T23:06:28.073Z,1733267188.073 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.220768 min 2024-12-03T23:06:28.073Z,1733267188.073 [Default:CheckIn:E] Stopped 2024-12-03T23:06:28.073Z,1733267188.073 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-03T23:06:28.073Z,1733267188.073 [Default:CheckIn] Stopped 2024-12-03T23:06:28.073Z,1733267188.073 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-03T23:06:28.073Z,1733267188.073 [Default:CheckIn](INFO): Running loop #8 2024-12-03T23:06:28.073Z,1733267188.073 [Default:CheckIn] Running Loop=8 2024-12-03T23:06:28.073Z,1733267188.073 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-03T23:06:28.074Z,1733267188.074 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-03T23:06:30.095Z,1733267190.095 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230629.00,A,3648.17542,N,12147.27923,W,0.583,215.53,031224,,,A*78 2024-12-03T23:06:30.097Z,1733267190.097 [NAL9602](INFO): GPS fix at 20241203T230629: (36.802924, -121.787987) 2024-12-03T23:06:30.109Z,1733267190.109 [Default:CheckIn:Read_GPS] Stopped 2024-12-03T23:06:30.109Z,1733267190.109 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-03T23:06:37.955Z,1733267197.955 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20241203T223137/Courier0021.lzma 2024-12-03T23:06:38.957Z,1733267198.957 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Courier0021.lzma.bak 2024-12-03T23:06:38.957Z,1733267198.957 [DataOverHttps](INFO): SBD MOMSN=23592205 2024-12-03T23:06:57.412Z,1733267217.412 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20241203T223137/Express0022.lzma 2024-12-03T23:06:58.413Z,1733267218.413 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Express0022.lzma.bak 2024-12-03T23:06:58.413Z,1733267218.413 [DataOverHttps](INFO): SBD MOMSN=23592208 2024-12-03T23:07:00.044Z,1733267220.044 [Default:CheckIn:Read_Iridium] Stopped 2024-12-03T23:07:00.044Z,1733267220.044 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-03T23:07:00.044Z,1733267220.044 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-03T23:08:32.951Z,1733267312.951 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:08:47.890Z,1733267327.890 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:09:03.242Z,1733267343.242 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:09:18.999Z,1733267358.999 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:09:34.002Z,1733267374.002 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:09:49.298Z,1733267389.298 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:10:04.246Z,1733267404.246 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:10:19.599Z,1733267419.599 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:10:34.142Z,1733267434.142 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2024-12-03T23:11:32.325Z,1733267492.325 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-12-03T23:12:00.615Z,1733267520.615 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-03T23:12:00.616Z,1733267520.616 [Default:CheckIn:C.Wait] Stopped 2024-12-03T23:12:00.616Z,1733267520.616 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-03T23:12:00.616Z,1733267520.616 [Default:CheckIn:D] Running Loop=1 2024-12-03T23:12:01.024Z,1733267521.024 [Default:CheckIn:D] Stopped 2024-12-03T23:12:01.024Z,1733267521.024 [Default:CheckIn:E] Running Loop=1 2024-12-03T23:12:01.440Z,1733267521.440 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 47.776652 min 2024-12-03T23:12:01.440Z,1733267521.440 [Default:CheckIn:E] Stopped 2024-12-03T23:12:01.440Z,1733267521.440 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-03T23:12:01.440Z,1733267521.440 [Default:CheckIn] Stopped 2024-12-03T23:12:01.440Z,1733267521.440 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-03T23:12:01.440Z,1733267521.440 [Default:CheckIn](INFO): Running loop #9 2024-12-03T23:12:01.440Z,1733267521.440 [Default:CheckIn] Running Loop=9 2024-12-03T23:12:01.440Z,1733267521.440 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-03T23:12:01.440Z,1733267521.440 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-03T23:12:03.431Z,1733267523.431 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231202.00,A,3648.16666,N,12147.28291,W,0.194,300.28,031224,,,A*76 2024-12-03T23:12:03.433Z,1733267523.433 [NAL9602](INFO): GPS fix at 20241203T231202: (36.802778, -121.788049) 2024-12-03T23:12:03.445Z,1733267523.445 [Default:CheckIn:Read_GPS] Stopped 2024-12-03T23:12:03.445Z,1733267523.445 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-03T23:12:06.258Z,1733267526.258 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2024-12-03T23:12:10.723Z,1733267530.723 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241203T223137/Courier0024.lzma 2024-12-03T23:12:11.725Z,1733267531.725 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Courier0024.lzma.bak 2024-12-03T23:12:11.725Z,1733267531.725 [DataOverHttps](INFO): SBD MOMSN=23592278 2024-12-03T23:12:27.896Z,1733267547.896 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20241203T223137/Express0025.lzma 2024-12-03T23:12:28.897Z,1733267548.897 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Express0025.lzma.bak 2024-12-03T23:12:28.897Z,1733267548.897 [DataOverHttps](INFO): SBD MOMSN=23592281 2024-12-03T23:12:30.161Z,1733267550.161 [Default:CheckIn:Read_Iridium] Stopped 2024-12-03T23:12:30.161Z,1733267550.161 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-03T23:12:30.161Z,1733267550.161 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-03T23:12:35.344Z,1733267555.344 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-03T23:12:57.618Z,1733267577.618 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2024-12-03T23:13:04.084Z,1733267584.084 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:13:18.222Z,1733267598.222 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:13:31.959Z,1733267611.959 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:13:45.695Z,1733267625.695 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:13:59.836Z,1733267639.836 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:14:14.380Z,1733267654.380 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:14:28.518Z,1733267668.518 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:14:42.262Z,1733267682.262 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:14:55.995Z,1733267695.995 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:15:09.322Z,1733267709.322 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-12-03T23:15:23.472Z,1733267723.472 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2024-12-03T23:15:23.473Z,1733267723.473 [BPC1](INFO): Calculating totals. Valid battery stick count: 45. Valid reserve battery stick count: 5. 2024-12-03T23:15:23.475Z,1733267723.475 [BPC1](INFO): Received data from all battery sticks. 2024-12-03T23:17:30.746Z,1733267850.746 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-03T23:17:30.746Z,1733267850.746 [Default:CheckIn:C.Wait] Stopped 2024-12-03T23:17:30.746Z,1733267850.746 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-03T23:17:30.747Z,1733267850.747 [Default:CheckIn:D] Running Loop=1 2024-12-03T23:17:31.141Z,1733267851.141 [Default:CheckIn:D] Stopped 2024-12-03T23:17:31.141Z,1733267851.141 [Default:CheckIn:E] Running Loop=1 2024-12-03T23:17:31.543Z,1733267851.543 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 53.278589 min 2024-12-03T23:17:31.543Z,1733267851.543 [Default:CheckIn:E] Stopped 2024-12-03T23:17:31.543Z,1733267851.543 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-03T23:17:31.543Z,1733267851.543 [Default:CheckIn] Stopped 2024-12-03T23:17:31.544Z,1733267851.544 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-03T23:17:31.544Z,1733267851.544 [Default:CheckIn](INFO): Running loop #10 2024-12-03T23:17:31.544Z,1733267851.544 [Default:CheckIn] Running Loop=10 2024-12-03T23:17:31.544Z,1733267851.544 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-03T23:17:31.544Z,1733267851.544 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-03T23:17:33.554Z,1733267853.554 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231732.00,A,3648.17500,N,12147.28370,W,0.797,32.71,031224,,,A*47 2024-12-03T23:17:33.557Z,1733267853.557 [NAL9602](INFO): GPS fix at 20241203T231732: (36.802917, -121.788062) 2024-12-03T23:17:33.568Z,1733267853.568 [Default:CheckIn:Read_GPS] Stopped 2024-12-03T23:17:33.568Z,1733267853.568 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-03T23:17:40.847Z,1733267860.847 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20241203T223137/Courier0027.lzma 2024-12-03T23:17:41.849Z,1733267861.849 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Courier0027.lzma.bak 2024-12-03T23:17:41.849Z,1733267861.849 [DataOverHttps](INFO): SBD MOMSN=23592395 2024-12-03T23:17:57.728Z,1733267877.728 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20241203T223137/Express0028.lzma 2024-12-03T23:17:58.729Z,1733267878.729 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Express0028.lzma.bak 2024-12-03T23:17:58.729Z,1733267878.729 [DataOverHttps](INFO): SBD MOMSN=23592398 2024-12-03T23:18:00.248Z,1733267880.248 [Default:CheckIn:Read_Iridium] Stopped 2024-12-03T23:18:00.248Z,1733267880.248 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-03T23:18:00.248Z,1733267880.248 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-03T23:18:04.257Z,1733267884.257 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-12-03T23:18:04.335Z,1733267884.335 [NAL9602](ERROR): received: +CSQ:0 OK838, 0, 0, 0, 0 OK 2024-12-03T23:22:35.341Z,1733268155.341 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-12-03T23:23:00.807Z,1733268180.807 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-03T23:23:00.807Z,1733268180.807 [Default:CheckIn:C.Wait] Stopped 2024-12-03T23:23:00.807Z,1733268180.807 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-03T23:23:00.823Z,1733268180.823 [Default:CheckIn:D] Running Loop=1 2024-12-03T23:23:01.207Z,1733268181.207 [Default:CheckIn:D] Stopped 2024-12-03T23:23:01.207Z,1733268181.207 [Default:CheckIn:E] Running Loop=1 2024-12-03T23:23:01.616Z,1733268181.616 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 58.779692 min 2024-12-03T23:23:01.616Z,1733268181.616 [Default:CheckIn:E] Stopped 2024-12-03T23:23:01.616Z,1733268181.616 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-03T23:23:01.616Z,1733268181.616 [Default:CheckIn] Stopped 2024-12-03T23:23:01.616Z,1733268181.616 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-03T23:23:01.617Z,1733268181.617 [Default:CheckIn](INFO): Running loop #11 2024-12-03T23:23:01.617Z,1733268181.617 [Default:CheckIn] Running Loop=11 2024-12-03T23:23:01.617Z,1733268181.617 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-03T23:23:01.617Z,1733268181.617 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-03T23:23:03.631Z,1733268183.631 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232302.00,A,3648.15364,N,12147.30216,W,1.069,229.14,031224,,,A*71 2024-12-03T23:23:03.634Z,1733268183.634 [NAL9602](INFO): GPS fix at 20241203T232302: (36.802561, -121.788369) 2024-12-03T23:23:03.645Z,1733268183.645 [Default:CheckIn:Read_GPS] Stopped 2024-12-03T23:23:03.645Z,1733268183.645 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-03T23:23:10.667Z,1733268190.667 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241203T223137/Courier0030.lzma 2024-12-03T23:23:11.669Z,1733268191.669 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Courier0030.lzma.bak 2024-12-03T23:23:11.669Z,1733268191.669 [DataOverHttps](INFO): SBD MOMSN=23592441 2024-12-03T23:23:27.427Z,1733268207.427 [DataOverHttps](INFO): Sending 224 bytes from file Logs/20241203T223137/Express0031.lzma 2024-12-03T23:23:28.429Z,1733268208.429 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Express0031.lzma.bak 2024-12-03T23:23:28.429Z,1733268208.429 [DataOverHttps](INFO): SBD MOMSN=23592444 2024-12-03T23:23:29.896Z,1733268209.896 [Default:CheckIn:Read_Iridium] Stopped 2024-12-03T23:23:29.897Z,1733268209.897 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-03T23:23:29.897Z,1733268209.897 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-03T23:23:36.345Z,1733268216.345 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-03T23:28:30.474Z,1733268510.474 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-03T23:28:30.474Z,1733268510.474 [Default:CheckIn:C.Wait] Stopped 2024-12-03T23:28:30.474Z,1733268510.474 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-03T23:28:30.474Z,1733268510.474 [Default:CheckIn:D] Running Loop=1 2024-12-03T23:28:30.888Z,1733268510.888 [Default:CheckIn:D] Stopped 2024-12-03T23:28:30.888Z,1733268510.888 [Default:CheckIn:E] Running Loop=1 2024-12-03T23:28:31.291Z,1733268511.291 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 64.274373 min 2024-12-03T23:28:31.292Z,1733268511.292 [Default:CheckIn:E] Stopped 2024-12-03T23:28:31.292Z,1733268511.292 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-03T23:28:31.292Z,1733268511.292 [Default:CheckIn] Stopped 2024-12-03T23:28:31.292Z,1733268511.292 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-03T23:28:31.292Z,1733268511.292 [Default:CheckIn](INFO): Running loop #12 2024-12-03T23:28:31.292Z,1733268511.292 [Default:CheckIn] Running Loop=12 2024-12-03T23:28:31.292Z,1733268511.292 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-03T23:28:31.292Z,1733268511.292 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-03T23:28:33.298Z,1733268513.298 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232832.00,A,3648.17426,N,12147.27156,W,4.918,33.86,031224,,,A*43 2024-12-03T23:28:33.301Z,1733268513.301 [NAL9602](INFO): GPS fix at 20241203T232832: (36.802904, -121.787859) 2024-12-03T23:28:33.332Z,1733268513.332 [Default:CheckIn:Read_GPS] Stopped 2024-12-03T23:28:33.333Z,1733268513.333 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-03T23:28:41.131Z,1733268521.131 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241203T223137/Courier0033.lzma 2024-12-03T23:28:42.133Z,1733268522.133 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Courier0033.lzma.bak 2024-12-03T23:28:42.133Z,1733268522.133 [DataOverHttps](INFO): SBD MOMSN=23592552 2024-12-03T23:28:57.951Z,1733268537.951 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20241203T223137/Express0034.lzma 2024-12-03T23:28:58.953Z,1733268538.953 [DataOverHttps](INFO): Moved sent file to Logs/20241203T223137/Express0034.lzma.bak 2024-12-03T23:28:58.953Z,1733268538.953 [DataOverHttps](INFO): SBD MOMSN=23592556 2024-12-03T23:29:00.385Z,1733268540.385 [Default:CheckIn:Read_Iridium] Stopped 2024-12-03T23:29:00.385Z,1733268540.385 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-03T23:29:00.385Z,1733268540.385 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-03T23:29:04.001Z,1733268544.001 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-12-03T23:29:04.075Z,1733268544.075 [NAL9602](ERROR): received: +CSQ:0 OK838, 0, 0, 0, 0 OK 2024-12-03T23:29:38.746Z,1733268578.746 [CommandExec](IMPORTANT): got command quit 2024-12-03T23:29:39.747Z,1733268579.747 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-03T23:29:39.748Z,1733268579.748 [CommandExec](INFO): Uninitializing the command executive. 2024-12-03T23:29:39.748Z,1733268579.748 [CommandExec](INFO): Uninitializing the command scheduler. 2024-12-03T23:29:39.748Z,1733268579.748 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:39.919Z,1733268579.919 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-12-03T23:29:39.919Z,1733268579.919 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-12-03T23:29:39.920Z,1733268579.920 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:39.920Z,1733268579.920 [NavChartDb](INFO): Join timeout helper Thread ID is 1400 2024-12-03T23:29:40.092Z,1733268580.092 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-03T23:29:40.092Z,1733268580.092 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:40.107Z,1733268580.107 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-12-03T23:29:40.107Z,1733268580.107 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:40.108Z,1733268580.108 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1401 2024-12-03T23:29:40.155Z,1733268580.155 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-03T23:29:40.156Z,1733268580.156 [WetLabsBB2FL](INFO): Powering down 2024-12-03T23:29:40.156Z,1733268580.156 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:40.168Z,1733268580.168 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-12-03T23:29:40.168Z,1733268580.168 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:40.168Z,1733268580.168 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1402 2024-12-03T23:29:40.431Z,1733268580.431 [CTD_Seabird](INFO): Powering down 2024-12-03T23:29:40.444Z,1733268580.444 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-03T23:29:40.444Z,1733268580.444 [CTD_Seabird](INFO): Powering down 2024-12-03T23:29:40.455Z,1733268580.455 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:40.475Z,1733268580.475 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-12-03T23:29:40.476Z,1733268580.476 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:40.476Z,1733268580.476 [Radio_Surface](INFO): Join timeout helper Thread ID is 1403 2024-12-03T23:29:40.535Z,1733268580.535 [Radio_Surface](INFO): Powering down 2024-12-03T23:29:40.536Z,1733268580.536 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-03T23:29:40.537Z,1733268580.537 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:40.547Z,1733268580.547 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-12-03T23:29:40.547Z,1733268580.547 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:40.548Z,1733268580.548 [Onboard](INFO): Join timeout helper Thread ID is 1404 2024-12-03T23:29:41.092Z,1733268581.092 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-12-03T23:29:41.359Z,1733268581.359 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-03T23:29:41.360Z,1733268581.360 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:41.372Z,1733268581.372 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-12-03T23:29:41.372Z,1733268581.372 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:41.373Z,1733268581.373 [DataOverHttps](INFO): Join timeout helper Thread ID is 1405 2024-12-03T23:29:42.095Z,1733268582.095 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-03T23:29:42.096Z,1733268582.096 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:42.108Z,1733268582.108 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-12-03T23:29:42.108Z,1733268582.108 [DAT ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:42.109Z,1733268582.109 [DAT](INFO): Join timeout helper Thread ID is 1406 2024-12-03T23:29:42.175Z,1733268582.175 [DAT](INFO): Powering down 2024-12-03T23:29:42.248Z,1733268582.248 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-03T23:29:42.248Z,1733268582.248 [DAT](INFO): Powering down 2024-12-03T23:29:42.249Z,1733268582.249 [DAT ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:42.252Z,1733268582.252 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-12-03T23:29:42.252Z,1733268582.252 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:42.253Z,1733268582.253 [BackseatComponent](INFO): Join timeout helper Thread ID is 1407 2024-12-03T23:29:42.359Z,1733268582.359 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-03T23:29:42.360Z,1733268582.360 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:42.379Z,1733268582.379 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-12-03T23:29:42.379Z,1733268582.379 [logger ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:42.379Z,1733268582.379 [logger](INFO): Join timeout helper Thread ID is 1408 2024-12-03T23:29:42.395Z,1733268582.395 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-03T23:29:42.396Z,1733268582.396 [logger ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:42.408Z,1733268582.408 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-12-03T23:29:42.408Z,1733268582.408 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:42.409Z,1733268582.409 [CommandLine](INFO): Join timeout helper Thread ID is 1409 2024-12-03T23:29:42.472Z,1733268582.472 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-03T23:29:42.472Z,1733268582.472 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:42.492Z,1733268582.492 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-12-03T23:29:42.492Z,1733268582.492 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:42.492Z,1733268582.492 [CommandExec](INFO): Join timeout helper Thread ID is 1410 2024-12-03T23:29:42.494Z,1733268582.494 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-12-03T23:29:42.494Z,1733268582.494 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:42.494Z,1733268582.494 [controlThread](INFO): Join timeout helper Thread ID is 1411 2024-12-03T23:29:42.763Z,1733268582.763 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-03T23:29:42.764Z,1733268582.764 [controlThread](DEBUG): Uninitializing ControlThread 2024-12-03T23:29:42.764Z,1733268582.764 [AHRS_M2](INFO): Powering down 2024-12-03T23:29:42.836Z,1733268582.836 [NAL9602](INFO): Powering down 2024-12-03T23:29:42.837Z,1733268582.837 [Sonardyne_Nano](INFO): Powering down 2024-12-03T23:29:42.956Z,1733268582.956 [Waterlinked](INFO): Powering down 2024-12-03T23:29:42.957Z,1733268582.957 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-12-03T23:29:42.958Z,1733268582.958 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-12-03T23:29:42.958Z,1733268582.958 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-12-03T23:29:42.959Z,1733268582.959 [MissionManager](INFO): Uninitializing Mission Default 2024-12-03T23:29:42.959Z,1733268582.959 [Default] Stopped 2024-12-03T23:29:42.959Z,1733268582.959 [Default](DEBUG): Aggregate::uninitialize Default 2024-12-03T23:29:42.959Z,1733268582.959 [Default:B.GoToSurface] Stopped 2024-12-03T23:29:42.959Z,1733268582.959 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-12-03T23:29:42.959Z,1733268582.959 [Default:CheckIn] Stopped 2024-12-03T23:29:42.960Z,1733268582.960 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-03T23:29:42.960Z,1733268582.960 [Default:CheckIn:C.Wait] Stopped 2024-12-03T23:29:42.960Z,1733268582.960 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-03T23:29:42.962Z,1733268582.962 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-12-03T23:29:42.963Z,1733268582.963 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-12-03T23:29:42.963Z,1733268582.963 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-12-03T23:29:42.964Z,1733268582.964 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-12-03T23:29:42.964Z,1733268582.964 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-12-03T23:29:42.964Z,1733268582.964 [BuoyancyServo](INFO): Powering down 2024-12-03T23:29:42.975Z,1733268582.975 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-12-03T23:29:42.975Z,1733268582.975 [ElevatorServo](INFO): Powering down 2024-12-03T23:29:42.976Z,1733268582.976 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-12-03T23:29:42.976Z,1733268582.976 [MassServo](INFO): Powering down 2024-12-03T23:29:42.977Z,1733268582.977 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-12-03T23:29:42.977Z,1733268582.977 [RudderServo](INFO): Powering down 2024-12-03T23:29:42.978Z,1733268582.978 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-12-03T23:29:42.978Z,1733268582.978 [ThrusterHE](INFO): Powering down 2024-12-03T23:29:42.979Z,1733268582.979 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-12-03T23:29:42.979Z,1733268582.979 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-12-03T23:29:42.980Z,1733268582.980 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-12-03T23:29:42.980Z,1733268582.980 [CBIT](DEBUG): Powering off loads. 2024-12-03T23:29:42.991Z,1733268582.991 [CBIT](DEBUG): Disabling WDT. 2024-12-03T23:29:43.003Z,1733268583.003 [CBIT](DEBUG): Opening all GF detection circuits. 2024-12-03T23:29:43.004Z,1733268583.004 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:43.042Z,1733268583.042 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:43.045Z,1733268583.045 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:43.051Z,1733268583.051 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:43.057Z,1733268583.057 [DAT ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:43.096Z,1733268583.096 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:43.184Z,1733268583.184 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:43.190Z,1733268583.190 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:43.198Z,1733268583.198 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-12-03T23:29:43.276Z,1733268583.276 [logger ThreadHandler](INFO): Thread cancelled.