2023-02-17T22:40:39.364Z,1676673639.364 [CommandExec](IMPORTANT): got command restart logs 2023-02-17T22:40:40.637Z,1676673640.637 [DataOverHttps](INFO): Moved sent file to Logs/20230217T204910/Courier0039.lzma.bak 2023-02-17T22:40:40.637Z,1676673640.637 [DataOverHttps](INFO): SBD MOMSN=17482692 2023-02-17T22:41:00.014Z,1676673660.014 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230217T204910/Courier0042.lzma 2023-02-17T22:41:01.017Z,1676673661.017 [DataOverHttps](INFO): Moved sent file to Logs/20230217T204910/Courier0042.lzma.bak 2023-02-17T22:41:01.017Z,1676673661.017 [DataOverHttps](INFO): SBD MOMSN=17482696 2023-02-17T22:41:06.173Z,1676673666.173 [NAL9602](INFO): Not Powering down - fast GPS 2023-02-17T22:41:28.699Z,1676673688.699 [DataOverHttps](INFO): Sending 226 bytes from file Logs/20230217T204910/Express0040.lzma 2023-02-17T22:41:29.701Z,1676673689.701 [DataOverHttps](INFO): Moved sent file to Logs/20230217T204910/Express0040.lzma.bak 2023-02-17T22:41:29.701Z,1676673689.701 [DataOverHttps](INFO): SBD MOMSN=17482699 2023-02-17T22:41:45.443Z,1676673705.443 [DataOverHttps](INFO): Sending 115 bytes from file Logs/20230217T204910/Express0043.lzma 2023-02-17T22:41:46.445Z,1676673706.445 [DataOverHttps](INFO): Moved sent file to Logs/20230217T204910/Express0043.lzma.bak 2023-02-17T22:41:46.445Z,1676673706.445 [DataOverHttps](INFO): SBD MOMSN=17482702 2023-02-17T22:41:48.279Z,1676673708.279 [Default:CheckIn:Read_Iridium] Stopped 2023-02-17T22:41:48.279Z,1676673708.279 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-17T22:41:48.280Z,1676673708.280 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-17T22:42:54.043Z,1676673774.043 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:43:02.076Z,1676673782.076 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.252274 2023-02-17T22:43:41.516Z,1676673821.516 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003396 2023-02-17T22:45:17.148Z,1676673917.148 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.139404 2023-02-17T22:45:50.307Z,1676673950.307 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:46:25.447Z,1676673985.447 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:46:48.845Z,1676674008.845 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-17T22:46:48.845Z,1676674008.845 [Default:CheckIn:C.Wait] Stopped 2023-02-17T22:46:48.845Z,1676674008.845 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-17T22:46:48.846Z,1676674008.846 [Default:CheckIn:D] Running Loop=1 2023-02-17T22:46:49.245Z,1676674009.245 [Default:CheckIn:D] Stopped 2023-02-17T22:46:49.245Z,1676674009.245 [Default:CheckIn:E] Running Loop=1 2023-02-17T22:46:49.655Z,1676674009.655 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 38.399650 min 2023-02-17T22:46:49.656Z,1676674009.656 [Default:CheckIn:E] Stopped 2023-02-17T22:46:49.656Z,1676674009.656 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-17T22:46:49.656Z,1676674009.656 [Default:CheckIn] Stopped 2023-02-17T22:46:49.656Z,1676674009.656 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-17T22:46:49.656Z,1676674009.656 [Default:CheckIn](INFO): Running loop #7 2023-02-17T22:46:49.656Z,1676674009.656 [Default:CheckIn] Running Loop=7 2023-02-17T22:46:49.656Z,1676674009.656 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-17T22:46:49.656Z,1676674009.656 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-17T22:46:51.658Z,1676674011.658 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,224651.00,A,3648.48752,N,12147.22476,W,7.970,47.38,170223,,,D*4A 2023-02-17T22:46:51.660Z,1676674011.660 [NAL9602](INFO): GPS fix at 20230217T224651: (36.808125, -121.787079) 2023-02-17T22:46:51.687Z,1676674011.687 [Default:CheckIn:Read_GPS] Stopped 2023-02-17T22:46:51.687Z,1676674011.687 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-17T22:47:00.595Z,1676674020.595 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:47:17.970Z,1676674037.970 [NAL9602](INFO): SBD MO Status=2, MOMSN=12020, MT Status=2, MTMSN=0 2023-02-17T22:47:17.970Z,1676674037.970 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-02-17T22:47:35.747Z,1676674055.747 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:47:48.720Z,1676674068.720 [NAL9602](INFO): SBD MO Status=2, MOMSN=12020, MT Status=2, MTMSN=0 2023-02-17T22:47:48.721Z,1676674068.721 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-02-17T22:48:10.887Z,1676674090.887 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:48:46.039Z,1676674126.039 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:49:00.278Z,1676674140.278 [NAL9602](INFO): SBD MO Status=2, MOMSN=12020, MT Status=2, MTMSN=0 2023-02-17T22:49:00.279Z,1676674140.279 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-02-17T22:49:21.179Z,1676674161.179 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:49:48.806Z,1676674188.806 [NAL9602](INFO): SBD MO Status=2, MOMSN=12020, MT Status=2, MTMSN=0 2023-02-17T22:49:48.806Z,1676674188.806 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-02-17T22:49:56.319Z,1676674196.319 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:50:09.450Z,1676674209.450 [NAL9602](INFO): SBD MO Status=1, MOMSN=12020, MT Status=0, MTMSN=0 2023-02-17T22:50:09.503Z,1676674209.503 [NAL9602](INFO): Sent 267 bytes from file Logs/20230217T224039/Courier0003.lzma 2023-02-17T22:50:09.503Z,1676674209.503 [NAL9602](INFO): Packets left to send: 0 2023-02-17T22:50:18.558Z,1676674218.558 [NAL9602](INFO): SBD MO Status=1, MOMSN=12021, MT Status=0, MTMSN=0 2023-02-17T22:50:18.615Z,1676674218.615 [NAL9602](INFO): Sent 332 bytes from file Logs/20230217T224039/Express0004.lzma 2023-02-17T22:50:18.615Z,1676674218.615 [NAL9602](INFO): Packets left to send: 1 2023-02-17T22:50:26.858Z,1676674226.858 [NAL9602](INFO): SBD MO Status=1, MOMSN=12022, MT Status=0, MTMSN=0 2023-02-17T22:50:26.910Z,1676674226.910 [NAL9602](INFO): Sent 123 bytes from file Logs/20230217T224039/Express0004.lzma 2023-02-17T22:50:26.911Z,1676674226.911 [NAL9602](INFO): Packets left to send: 0 2023-02-17T22:50:31.459Z,1676674231.459 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:50:49.209Z,1676674249.209 [NAL9602](INFO): SBD MO Status=0, MOMSN=12023, MT Status=0, MTMSN=0 2023-02-17T22:50:49.288Z,1676674249.288 [Default:CheckIn:Read_Iridium] Stopped 2023-02-17T22:50:49.288Z,1676674249.288 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-17T22:50:49.288Z,1676674249.288 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-17T22:51:06.599Z,1676674266.599 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:51:19.908Z,1676674279.908 [NAL9602](INFO): Not Powering down - fast GPS 2023-02-17T22:51:41.739Z,1676674301.739 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:52:16.899Z,1676674336.899 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:52:52.055Z,1676674372.055 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:53:27.203Z,1676674407.203 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:54:02.355Z,1676674442.355 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:54:37.500Z,1676674477.500 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:55:12.651Z,1676674512.651 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:55:47.799Z,1676674547.799 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:55:49.796Z,1676674549.796 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-17T22:55:49.796Z,1676674549.796 [Default:CheckIn:C.Wait] Stopped 2023-02-17T22:55:49.796Z,1676674549.796 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-17T22:55:49.796Z,1676674549.796 [Default:CheckIn:D] Running Loop=1 2023-02-17T22:55:50.205Z,1676674550.205 [Default:CheckIn:D] Stopped 2023-02-17T22:55:50.205Z,1676674550.205 [Default:CheckIn:E] Running Loop=1 2023-02-17T22:55:50.594Z,1676674550.594 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 47.415641 min 2023-02-17T22:55:50.594Z,1676674550.594 [Default:CheckIn:E] Stopped 2023-02-17T22:55:50.594Z,1676674550.594 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-17T22:55:50.594Z,1676674550.594 [Default:CheckIn] Stopped 2023-02-17T22:55:50.594Z,1676674550.594 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-17T22:55:50.594Z,1676674550.594 [Default:CheckIn](INFO): Running loop #8 2023-02-17T22:55:50.594Z,1676674550.594 [Default:CheckIn] Running Loop=8 2023-02-17T22:55:50.595Z,1676674550.595 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-17T22:55:50.595Z,1676674550.595 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-17T22:55:52.612Z,1676674552.612 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225552.00,A,3648.14573,N,12147.21600,W,0.058,239.46,170223,,,D*75 2023-02-17T22:55:52.614Z,1676674552.614 [NAL9602](INFO): GPS fix at 20230217T225552: (36.802429, -121.786933) 2023-02-17T22:55:52.625Z,1676674552.625 [Default:CheckIn:Read_GPS] Stopped 2023-02-17T22:55:52.625Z,1676674552.625 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-17T22:56:11.645Z,1676674571.645 [NAL9602](INFO): SBD MO Status=1, MOMSN=12024, MT Status=0, MTMSN=0 2023-02-17T22:56:11.699Z,1676674571.699 [NAL9602](INFO): Sent 70 bytes from file Logs/20230217T224039/Courier0006.lzma 2023-02-17T22:56:11.699Z,1676674571.699 [NAL9602](INFO): Packets left to send: 0 2023-02-17T22:56:19.958Z,1676674579.958 [NAL9602](INFO): SBD MO Status=1, MOMSN=12025, MT Status=0, MTMSN=0 2023-02-17T22:56:20.010Z,1676674580.010 [NAL9602](INFO): Sent 146 bytes from file Logs/20230217T224039/Express0007.lzma 2023-02-17T22:56:20.010Z,1676674580.010 [NAL9602](INFO): Packets left to send: 0 2023-02-17T22:56:22.959Z,1676674582.959 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:56:27.786Z,1676674587.786 [NAL9602](INFO): SBD MO Status=0, MOMSN=12026, MT Status=0, MTMSN=0 2023-02-17T22:56:27.868Z,1676674587.868 [Default:CheckIn:Read_Iridium] Stopped 2023-02-17T22:56:27.868Z,1676674587.868 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-17T22:56:27.868Z,1676674587.868 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-17T22:56:58.099Z,1676674618.099 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:56:58.488Z,1676674618.488 [NAL9602](INFO): Not Powering down - fast GPS 2023-02-17T22:57:33.251Z,1676674653.251 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:58:08.400Z,1676674688.400 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:58:43.547Z,1676674723.547 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-02-17T22:58:55.984Z,1676674735.984 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003446 2023-02-17T23:01:28.392Z,1676674888.392 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-17T23:01:28.393Z,1676674888.393 [Default:CheckIn:C.Wait] Stopped 2023-02-17T23:01:28.393Z,1676674888.393 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-17T23:01:28.393Z,1676674888.393 [Default:CheckIn:D] Running Loop=1 2023-02-17T23:01:28.792Z,1676674888.792 [Default:CheckIn:D] Stopped 2023-02-17T23:01:28.792Z,1676674888.792 [Default:CheckIn:E] Running Loop=1 2023-02-17T23:01:29.190Z,1676674889.190 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 53.058752 min 2023-02-17T23:01:29.190Z,1676674889.190 [Default:CheckIn:E] Stopped 2023-02-17T23:01:29.190Z,1676674889.190 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-17T23:01:29.190Z,1676674889.190 [Default:CheckIn] Stopped 2023-02-17T23:01:29.190Z,1676674889.190 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-17T23:01:29.191Z,1676674889.191 [Default:CheckIn](INFO): Running loop #9 2023-02-17T23:01:29.191Z,1676674889.191 [Default:CheckIn] Running Loop=9 2023-02-17T23:01:29.191Z,1676674889.191 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-17T23:01:29.191Z,1676674889.191 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-17T23:01:31.206Z,1676674891.206 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230130.00,A,3648.14349,N,12147.22793,W,1.127,207.28,170223,,,D*7B 2023-02-17T23:01:31.215Z,1676674891.215 [NAL9602](INFO): GPS fix at 20230217T230130: (36.802391, -121.787132) 2023-02-17T23:01:31.232Z,1676674891.232 [Default:CheckIn:Read_GPS] Stopped 2023-02-17T23:01:31.232Z,1676674891.232 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-17T23:01:38.244Z,1676674898.244 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230217T224039/Courier0009.lzma 2023-02-17T23:01:39.241Z,1676674899.241 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Courier0009.lzma.bak 2023-02-17T23:01:39.241Z,1676674899.241 [DataOverHttps](INFO): SBD MOMSN=17482780 2023-02-17T23:01:55.037Z,1676674915.037 [NAL9602](INFO): SBD MO Status=2, MOMSN=12027, MT Status=2, MTMSN=0 2023-02-17T23:01:55.037Z,1676674915.037 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-02-17T23:01:55.047Z,1676674915.047 [DataOverHttps](INFO): Sending 192 bytes from file Logs/20230217T224039/Express0010.lzma 2023-02-17T23:01:56.049Z,1676674916.049 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Express0010.lzma.bak 2023-02-17T23:01:56.049Z,1676674916.049 [DataOverHttps](INFO): SBD MOMSN=17482783 2023-02-17T23:01:57.911Z,1676674917.911 [Default:CheckIn:Read_Iridium] Stopped 2023-02-17T23:01:57.911Z,1676674917.911 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-17T23:01:57.911Z,1676674917.911 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-17T23:02:15.650Z,1676674935.650 [NAL9602](INFO): SBD MO Status=0, MOMSN=12027, MT Status=0, MTMSN=0 2023-02-17T23:02:15.650Z,1676674935.650 [NAL9602](INFO): No messages in MT queue 2023-02-17T23:02:46.357Z,1676674966.357 [NAL9602](INFO): Not Powering down - fast GPS 2023-02-17T23:06:58.514Z,1676675218.514 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-17T23:06:58.514Z,1676675218.514 [Default:CheckIn:C.Wait] Stopped 2023-02-17T23:06:58.514Z,1676675218.514 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-17T23:06:58.514Z,1676675218.514 [Default:CheckIn:D] Running Loop=1 2023-02-17T23:06:58.915Z,1676675218.915 [Default:CheckIn:D] Stopped 2023-02-17T23:06:58.915Z,1676675218.915 [Default:CheckIn:E] Running Loop=1 2023-02-17T23:06:59.325Z,1676675219.325 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 58.560799 min 2023-02-17T23:06:59.325Z,1676675219.325 [Default:CheckIn:E] Stopped 2023-02-17T23:06:59.325Z,1676675219.325 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-17T23:06:59.325Z,1676675219.325 [Default:CheckIn] Stopped 2023-02-17T23:06:59.325Z,1676675219.325 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-17T23:06:59.326Z,1676675219.326 [Default:CheckIn](INFO): Running loop #10 2023-02-17T23:06:59.326Z,1676675219.326 [Default:CheckIn] Running Loop=10 2023-02-17T23:06:59.326Z,1676675219.326 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-17T23:06:59.326Z,1676675219.326 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-17T23:07:01.331Z,1676675221.331 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230700.00,A,3648.14246,N,12147.22860,W,0.039,209.91,170223,,,A*75 2023-02-17T23:07:01.333Z,1676675221.333 [NAL9602](INFO): GPS fix at 20230217T230700: (36.802374, -121.787143) 2023-02-17T23:07:01.363Z,1676675221.363 [Default:CheckIn:Read_GPS] Stopped 2023-02-17T23:07:01.363Z,1676675221.363 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-17T23:07:11.583Z,1676675231.583 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230217T224039/Courier0012.lzma 2023-02-17T23:07:12.585Z,1676675232.585 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Courier0012.lzma.bak 2023-02-17T23:07:12.585Z,1676675232.585 [DataOverHttps](INFO): SBD MOMSN=17482801 2023-02-17T23:07:22.174Z,1676675242.174 [NAL9602](INFO): SBD MO Status=2, MOMSN=12028, MT Status=2, MTMSN=0 2023-02-17T23:07:22.174Z,1676675242.174 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-02-17T23:07:29.447Z,1676675249.447 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-02-17T23:07:29.555Z,1676675249.555 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20230217T224039/Express0013.lzma 2023-02-17T23:07:30.557Z,1676675250.557 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Express0013.lzma.bak 2023-02-17T23:07:30.557Z,1676675250.557 [DataOverHttps](INFO): SBD MOMSN=17482804 2023-02-17T23:07:32.284Z,1676675252.284 [Default:CheckIn:Read_Iridium] Stopped 2023-02-17T23:07:32.284Z,1676675252.284 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-17T23:07:32.284Z,1676675252.284 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-17T23:07:42.773Z,1676675262.773 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-02-17T23:07:56.103Z,1676675276.103 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-02-17T23:07:57.786Z,1676675277.786 [NAL9602](INFO): SBD MO Status=0, MOMSN=12028, MT Status=0, MTMSN=0 2023-02-17T23:07:57.786Z,1676675277.786 [NAL9602](INFO): No messages in MT queue 2023-02-17T23:08:09.435Z,1676675289.435 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-02-17T23:08:23.189Z,1676675303.189 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-02-17T23:08:28.429Z,1676675308.429 [NAL9602](INFO): Not Powering down - fast GPS 2023-02-17T23:08:36.503Z,1676675316.503 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-02-17T23:08:49.835Z,1676675329.835 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-02-17T23:09:03.572Z,1676675343.572 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-02-17T23:09:16.185Z,1676675356.185 [DAT](INFO): received an acoustic signal 2023-02-17T23:09:16.186Z,1676675356.186 [DAT](INFO): received a packet notification 2023-02-17T23:09:16.904Z,1676675356.904 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-02-17T23:09:29.037Z,1676675369.037 [DAT](INFO): received an acoustic signal 2023-02-17T23:09:29.038Z,1676675369.038 [DAT](INFO): received a packet notification 2023-02-17T23:09:29.832Z,1676675369.832 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-02-17T23:09:43.163Z,1676675383.163 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-02-17T23:12:26.494Z,1676675546.494 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 5. 2023-02-17T23:12:26.497Z,1676675546.497 [BPC1](INFO): Received data from all battery sticks. 2023-02-17T23:12:32.969Z,1676675552.969 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-17T23:12:32.969Z,1676675552.969 [Default:CheckIn:C.Wait] Stopped 2023-02-17T23:12:32.969Z,1676675552.969 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-17T23:12:32.969Z,1676675552.969 [Default:CheckIn:D] Running Loop=1 2023-02-17T23:12:33.417Z,1676675553.417 [Default:CheckIn:D] Stopped 2023-02-17T23:12:33.417Z,1676675553.417 [Default:CheckIn:E] Running Loop=1 2023-02-17T23:12:33.766Z,1676675553.766 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 64.135836 min 2023-02-17T23:12:33.766Z,1676675553.766 [Default:CheckIn:E] Stopped 2023-02-17T23:12:33.766Z,1676675553.766 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-17T23:12:33.767Z,1676675553.767 [Default:CheckIn] Stopped 2023-02-17T23:12:33.767Z,1676675553.767 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-17T23:12:33.767Z,1676675553.767 [Default:CheckIn](INFO): Running loop #11 2023-02-17T23:12:33.767Z,1676675553.767 [Default:CheckIn] Running Loop=11 2023-02-17T23:12:33.767Z,1676675553.767 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-17T23:12:33.767Z,1676675553.767 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-17T23:12:35.778Z,1676675555.778 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231235.00,A,3648.16634,N,12147.28279,W,0.117,213.58,170223,,,A*7F 2023-02-17T23:12:35.781Z,1676675555.781 [NAL9602](INFO): GPS fix at 20230217T231235: (36.802772, -121.788046) 2023-02-17T23:12:35.792Z,1676675555.792 [Default:CheckIn:Read_GPS] Stopped 2023-02-17T23:12:35.792Z,1676675555.792 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-17T23:12:43.499Z,1676675563.499 [DataOverHttps](INFO): Sending 201 bytes from file Logs/20230217T224039/Courier0015.lzma 2023-02-17T23:12:44.501Z,1676675564.501 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Courier0015.lzma.bak 2023-02-17T23:12:44.501Z,1676675564.501 [DataOverHttps](INFO): SBD MOMSN=17482815 2023-02-17T23:13:00.179Z,1676675580.179 [DataOverHttps](INFO): Sending 220 bytes from file Logs/20230217T224039/Express0016.lzma 2023-02-17T23:13:01.181Z,1676675581.181 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Express0016.lzma.bak 2023-02-17T23:13:01.181Z,1676675581.181 [DataOverHttps](INFO): SBD MOMSN=17482818 2023-02-17T23:13:03.727Z,1676675583.727 [Default:CheckIn:Read_Iridium] Stopped 2023-02-17T23:13:03.728Z,1676675583.728 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-17T23:13:03.728Z,1676675583.728 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-17T23:17:38.521Z,1676675858.521 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-02-17T23:18:04.386Z,1676675884.386 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-17T23:18:04.386Z,1676675884.386 [Default:CheckIn:C.Wait] Stopped 2023-02-17T23:18:04.386Z,1676675884.386 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-17T23:18:04.386Z,1676675884.386 [Default:CheckIn:D] Running Loop=1 2023-02-17T23:18:04.797Z,1676675884.797 [Default:CheckIn:D] Stopped 2023-02-17T23:18:04.797Z,1676675884.797 [Default:CheckIn:E] Running Loop=1 2023-02-17T23:18:05.194Z,1676675885.194 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 69.658838 min 2023-02-17T23:18:05.194Z,1676675885.194 [Default:CheckIn:E] Stopped 2023-02-17T23:18:05.195Z,1676675885.195 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-17T23:18:05.195Z,1676675885.195 [Default:CheckIn] Stopped 2023-02-17T23:18:05.195Z,1676675885.195 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-17T23:18:05.195Z,1676675885.195 [Default:CheckIn](INFO): Running loop #12 2023-02-17T23:18:05.195Z,1676675885.195 [Default:CheckIn] Running Loop=12 2023-02-17T23:18:05.196Z,1676675885.196 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-17T23:18:05.196Z,1676675885.196 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-17T23:18:07.202Z,1676675887.202 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231806.00,A,3648.16844,N,12147.28421,W,0.564,213.58,170223,,,D*72 2023-02-17T23:18:07.204Z,1676675887.204 [NAL9602](INFO): GPS fix at 20230217T231806: (36.802807, -121.788070) 2023-02-17T23:18:07.216Z,1676675887.216 [Default:CheckIn:Read_GPS] Stopped 2023-02-17T23:18:07.216Z,1676675887.216 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-17T23:18:14.966Z,1676675894.966 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230217T224039/Courier0018.lzma 2023-02-17T23:18:15.969Z,1676675895.969 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Courier0018.lzma.bak 2023-02-17T23:18:15.969Z,1676675895.969 [DataOverHttps](INFO): SBD MOMSN=17482835 2023-02-17T23:18:35.523Z,1676675915.523 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20230217T224039/Express0019.lzma 2023-02-17T23:18:36.525Z,1676675916.525 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Express0019.lzma.bak 2023-02-17T23:18:36.525Z,1676675916.525 [DataOverHttps](INFO): SBD MOMSN=17482838 2023-02-17T23:18:38.386Z,1676675918.386 [Default:CheckIn:Read_Iridium] Stopped 2023-02-17T23:18:38.387Z,1676675918.387 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-17T23:18:38.387Z,1676675918.387 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-17T23:18:39.603Z,1676675919.603 [NAL9602](INFO): Not Powering down - fast GPS 2023-02-17T23:23:39.098Z,1676676219.098 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-17T23:23:39.098Z,1676676219.098 [Default:CheckIn:C.Wait] Stopped 2023-02-17T23:23:39.098Z,1676676219.098 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-17T23:23:39.099Z,1676676219.099 [Default:CheckIn:D] Running Loop=1 2023-02-17T23:23:39.461Z,1676676219.461 [Default:CheckIn:D] Stopped 2023-02-17T23:23:39.461Z,1676676219.461 [Default:CheckIn:E] Running Loop=1 2023-02-17T23:23:39.849Z,1676676219.849 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 75.236572 min 2023-02-17T23:23:39.850Z,1676676219.850 [Default:CheckIn:E] Stopped 2023-02-17T23:23:39.850Z,1676676219.850 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-17T23:23:39.850Z,1676676219.850 [Default:CheckIn] Stopped 2023-02-17T23:23:39.850Z,1676676219.850 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-17T23:23:39.850Z,1676676219.850 [Default:CheckIn](INFO): Running loop #13 2023-02-17T23:23:39.850Z,1676676219.850 [Default:CheckIn] Running Loop=13 2023-02-17T23:23:39.850Z,1676676219.850 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-17T23:23:39.850Z,1676676219.850 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-17T23:23:41.858Z,1676676221.858 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232341.00,A,3648.16648,N,12147.28444,W,0.214,326.73,170223,,,D*76 2023-02-17T23:23:41.861Z,1676676221.861 [NAL9602](INFO): GPS fix at 20230217T232341: (36.802775, -121.788074) 2023-02-17T23:23:41.871Z,1676676221.871 [Default:CheckIn:Read_GPS] Stopped 2023-02-17T23:23:41.871Z,1676676221.871 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-17T23:23:49.707Z,1676676229.707 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230217T224039/Courier0021.lzma 2023-02-17T23:23:50.709Z,1676676230.709 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Courier0021.lzma.bak 2023-02-17T23:23:50.709Z,1676676230.709 [DataOverHttps](INFO): SBD MOMSN=17482849 2023-02-17T23:24:06.427Z,1676676246.427 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230217T224039/Express0022.lzma 2023-02-17T23:24:07.429Z,1676676247.429 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Express0022.lzma.bak 2023-02-17T23:24:07.429Z,1676676247.429 [DataOverHttps](INFO): SBD MOMSN=17482852 2023-02-17T23:24:09.375Z,1676676249.375 [Default:CheckIn:Read_Iridium] Stopped 2023-02-17T23:24:09.375Z,1676676249.375 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-17T23:24:09.375Z,1676676249.375 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-17T23:28:44.108Z,1676676524.108 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-02-17T23:29:09.981Z,1676676549.981 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-17T23:29:09.982Z,1676676549.982 [Default:CheckIn:C.Wait] Stopped 2023-02-17T23:29:09.982Z,1676676549.982 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-17T23:29:09.982Z,1676676549.982 [Default:CheckIn:D] Running Loop=1 2023-02-17T23:29:10.396Z,1676676550.396 [Default:CheckIn:D] Stopped 2023-02-17T23:29:10.396Z,1676676550.396 [Default:CheckIn:E] Running Loop=1 2023-02-17T23:29:10.823Z,1676676550.823 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 80.752165 min 2023-02-17T23:29:10.823Z,1676676550.823 [Default:CheckIn:E] Stopped 2023-02-17T23:29:10.823Z,1676676550.823 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-17T23:29:10.823Z,1676676550.823 [Default:CheckIn] Stopped 2023-02-17T23:29:10.823Z,1676676550.823 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-17T23:29:10.824Z,1676676550.824 [Default:CheckIn](INFO): Running loop #14 2023-02-17T23:29:10.824Z,1676676550.824 [Default:CheckIn] Running Loop=14 2023-02-17T23:29:10.824Z,1676676550.824 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-17T23:29:10.824Z,1676676550.824 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-17T23:29:12.798Z,1676676552.798 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232912.00,A,3648.16868,N,12147.28390,W,0.369,150.84,170223,,,A*7D 2023-02-17T23:29:12.800Z,1676676552.800 [NAL9602](INFO): GPS fix at 20230217T232912: (36.802811, -121.788065) 2023-02-17T23:29:12.811Z,1676676552.811 [Default:CheckIn:Read_GPS] Stopped 2023-02-17T23:29:12.811Z,1676676552.811 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-17T23:29:21.614Z,1676676561.614 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230217T224039/Courier0024.lzma 2023-02-17T23:29:22.617Z,1676676562.617 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Courier0024.lzma.bak 2023-02-17T23:29:22.617Z,1676676562.617 [DataOverHttps](INFO): SBD MOMSN=17482869 2023-02-17T23:29:39.915Z,1676676579.915 [DataOverHttps](INFO): Sending 215 bytes from file Logs/20230217T224039/Express0025.lzma 2023-02-17T23:29:40.917Z,1676676580.917 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Express0025.lzma.bak 2023-02-17T23:29:40.917Z,1676676580.917 [DataOverHttps](INFO): SBD MOMSN=17482872 2023-02-17T23:29:42.708Z,1676676582.708 [Default:CheckIn:Read_Iridium] Stopped 2023-02-17T23:29:42.708Z,1676676582.708 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-17T23:29:42.708Z,1676676582.708 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-17T23:29:45.120Z,1676676585.120 [NAL9602](INFO): Not Powering down - fast GPS 2023-02-17T23:34:43.453Z,1676676883.453 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-17T23:34:43.453Z,1676676883.453 [Default:CheckIn:C.Wait] Stopped 2023-02-17T23:34:43.453Z,1676676883.453 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-17T23:34:43.454Z,1676676883.454 [Default:CheckIn:D] Running Loop=1 2023-02-17T23:34:43.794Z,1676676883.794 [Default:CheckIn:D] Stopped 2023-02-17T23:34:43.794Z,1676676883.794 [Default:CheckIn:E] Running Loop=1 2023-02-17T23:34:44.181Z,1676676884.181 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 86.308797 min 2023-02-17T23:34:44.181Z,1676676884.181 [Default:CheckIn:E] Stopped 2023-02-17T23:34:44.181Z,1676676884.181 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-17T23:34:44.181Z,1676676884.181 [Default:CheckIn] Stopped 2023-02-17T23:34:44.181Z,1676676884.181 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-17T23:34:44.182Z,1676676884.182 [Default:CheckIn](INFO): Running loop #15 2023-02-17T23:34:44.182Z,1676676884.182 [Default:CheckIn] Running Loop=15 2023-02-17T23:34:44.182Z,1676676884.182 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-17T23:34:44.182Z,1676676884.182 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-17T23:34:46.194Z,1676676886.194 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233445.00,A,3648.17074,N,12147.28131,W,0.447,77.36,170223,,,A*48 2023-02-17T23:34:46.197Z,1676676886.197 [NAL9602](INFO): GPS fix at 20230217T233445: (36.802846, -121.788022) 2023-02-17T23:34:46.208Z,1676676886.208 [Default:CheckIn:Read_GPS] Stopped 2023-02-17T23:34:46.208Z,1676676886.208 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-17T23:34:53.526Z,1676676893.526 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230217T224039/Courier0027.lzma 2023-02-17T23:34:54.529Z,1676676894.529 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Courier0027.lzma.bak 2023-02-17T23:34:54.529Z,1676676894.529 [DataOverHttps](INFO): SBD MOMSN=17482883 2023-02-17T23:35:12.903Z,1676676912.903 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20230217T224039/Express0028.lzma 2023-02-17T23:35:13.889Z,1676676913.889 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Express0028.lzma.bak 2023-02-17T23:35:13.889Z,1676676913.889 [DataOverHttps](INFO): SBD MOMSN=17482886 2023-02-17T23:35:15.763Z,1676676915.763 [Default:CheckIn:Read_Iridium] Stopped 2023-02-17T23:35:15.763Z,1676676915.763 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-17T23:35:15.763Z,1676676915.763 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-17T23:35:16.948Z,1676676916.948 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2023-02-17T23:35:17.031Z,1676676917.031 [NAL9602](ERROR): received: +CSQ:0 OK028, 0, 0, 0, 0 OK 2023-02-17T23:35:39.168Z,1676676939.168 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2023-02-17T23:35:39.168Z,1676676939.168 [DropWeight] Hardware Fault, FailCount= 1 2023-02-17T23:35:39.168Z,1676676939.168 [DropWeight](ERROR): Hardware Fault 2023-02-17T23:35:39.186Z,1676676939.186 [CommandExec](FAULT): Scheduling is paused 2023-02-17T23:35:39.186Z,1676676939.186 [CBIT](INFO): Critical error at 20230217T233539 2023-02-17T23:35:39.189Z,1676676939.189 [CBIT](ERROR): Hardware Fault in component: DropWeight 2023-02-17T23:35:39.190Z,1676676939.190 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2023-02-17T23:35:39.594Z,1676676939.594 [CBIT](INFO): Critical error at 20230217T233539 2023-02-17T23:39:48.110Z,1676677188.110 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-02-17T23:40:16.404Z,1676677216.404 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-17T23:40:16.405Z,1676677216.405 [Default:CheckIn:C.Wait] Stopped 2023-02-17T23:40:16.405Z,1676677216.405 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-17T23:40:16.405Z,1676677216.405 [Default:CheckIn:D] Running Loop=1 2023-02-17T23:40:16.813Z,1676677216.813 [Default:CheckIn:D] Stopped 2023-02-17T23:40:16.813Z,1676677216.813 [Default:CheckIn:E] Running Loop=1 2023-02-17T23:40:17.211Z,1676677217.211 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 91.859106 min 2023-02-17T23:40:17.211Z,1676677217.211 [Default:CheckIn:E] Stopped 2023-02-17T23:40:17.211Z,1676677217.211 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-17T23:40:17.212Z,1676677217.212 [Default:CheckIn] Stopped 2023-02-17T23:40:17.212Z,1676677217.212 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-17T23:40:17.212Z,1676677217.212 [Default:CheckIn](INFO): Running loop #16 2023-02-17T23:40:17.212Z,1676677217.212 [Default:CheckIn] Running Loop=16 2023-02-17T23:40:17.212Z,1676677217.212 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-17T23:40:17.212Z,1676677217.212 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-17T23:40:19.222Z,1676677219.222 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234018.00,A,3648.17365,N,12147.27924,W,1.108,169.28,170223,,,A*7D 2023-02-17T23:40:19.227Z,1676677219.227 [NAL9602](INFO): GPS fix at 20230217T234018: (36.802894, -121.787987) 2023-02-17T23:40:19.238Z,1676677219.238 [Default:CheckIn:Read_GPS] Stopped 2023-02-17T23:40:19.238Z,1676677219.238 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-17T23:40:26.395Z,1676677226.395 [DataOverHttps](INFO): Sending 178 bytes from file Logs/20230217T224039/Courier0030.lzma 2023-02-17T23:40:27.393Z,1676677227.393 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Courier0030.lzma.bak 2023-02-17T23:40:27.393Z,1676677227.393 [DataOverHttps](INFO): SBD MOMSN=17482903 2023-02-17T23:40:36.743Z,1676677236.743 [CommandExec](IMPORTANT): got command quit 2023-02-17T23:40:37.747Z,1676677237.747 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-17T23:40:37.747Z,1676677237.747 [CommandExec](INFO): Uninitializing the command executive. 2023-02-17T23:40:37.747Z,1676677237.747 [CommandExec](INFO): Uninitializing the command scheduler. 2023-02-17T23:40:37.748Z,1676677237.748 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:37.799Z,1676677237.799 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-02-17T23:40:37.799Z,1676677237.799 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-02-17T23:40:37.799Z,1676677237.799 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:37.800Z,1676677237.800 [NavChartDb](INFO): Join timeout helper Thread ID is 8485 2023-02-17T23:40:37.971Z,1676677237.971 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-17T23:40:37.971Z,1676677237.971 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:37.983Z,1676677237.983 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-02-17T23:40:37.983Z,1676677237.983 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:37.983Z,1676677237.983 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8486 2023-02-17T23:40:38.383Z,1676677238.383 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-17T23:40:38.384Z,1676677238.384 [WetLabsBB2FL](INFO): Powering down 2023-02-17T23:40:38.384Z,1676677238.384 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:38.387Z,1676677238.387 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-02-17T23:40:38.387Z,1676677238.387 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:38.387Z,1676677238.387 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8487 2023-02-17T23:40:39.323Z,1676677239.323 [CTD_Seabird](INFO): Powering down 2023-02-17T23:40:39.335Z,1676677239.335 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-17T23:40:39.335Z,1676677239.335 [CTD_Seabird](INFO): Powering down 2023-02-17T23:40:39.347Z,1676677239.347 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:39.351Z,1676677239.351 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2023-02-17T23:40:39.351Z,1676677239.351 [DAT ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:39.351Z,1676677239.351 [DAT](INFO): Join timeout helper Thread ID is 8488 2023-02-17T23:40:39.543Z,1676677239.543 [DAT](INFO): Powering down 2023-02-17T23:40:39.615Z,1676677239.615 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-17T23:40:39.616Z,1676677239.616 [DAT](INFO): Powering down 2023-02-17T23:40:39.617Z,1676677239.617 [DAT ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:39.627Z,1676677239.627 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-02-17T23:40:39.627Z,1676677239.627 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:39.628Z,1676677239.628 [Radio_Surface](INFO): Join timeout helper Thread ID is 8489 2023-02-17T23:40:39.643Z,1676677239.643 [Radio_Surface](INFO): Powering down 2023-02-17T23:40:39.644Z,1676677239.644 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-17T23:40:39.644Z,1676677239.644 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:39.648Z,1676677239.648 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-02-17T23:40:39.648Z,1676677239.648 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:39.648Z,1676677239.648 [Onboard](INFO): Join timeout helper Thread ID is 8490 2023-02-17T23:40:39.903Z,1676677239.903 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-17T23:40:39.903Z,1676677239.903 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:39.920Z,1676677239.920 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-02-17T23:40:39.920Z,1676677239.920 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:39.920Z,1676677239.920 [DataOverHttps](INFO): Join timeout helper Thread ID is 8491 2023-02-17T23:40:42.285Z,1676677242.285 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-17T23:40:42.293Z,1676677242.293 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.296Z,1676677242.296 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2023-02-17T23:40:42.296Z,1676677242.296 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.296Z,1676677242.296 [BackseatComponent](INFO): Join timeout helper Thread ID is 8492 2023-02-17T23:40:42.331Z,1676677242.331 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-17T23:40:42.332Z,1676677242.332 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.336Z,1676677242.336 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-02-17T23:40:42.336Z,1676677242.336 [logger ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.336Z,1676677242.336 [logger](INFO): Join timeout helper Thread ID is 8493 2023-02-17T23:40:42.350Z,1676677242.350 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-17T23:40:42.351Z,1676677242.351 [logger ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.352Z,1676677242.352 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-02-17T23:40:42.352Z,1676677242.352 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.353Z,1676677242.353 [CommandLine](INFO): Join timeout helper Thread ID is 8494 2023-02-17T23:40:42.443Z,1676677242.443 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-17T23:40:42.444Z,1676677242.444 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.452Z,1676677242.452 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-02-17T23:40:42.452Z,1676677242.452 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.452Z,1676677242.452 [CommandExec](INFO): Join timeout helper Thread ID is 8495 2023-02-17T23:40:42.454Z,1676677242.454 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-02-17T23:40:42.454Z,1676677242.454 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.454Z,1676677242.454 [controlThread](INFO): Join timeout helper Thread ID is 8496 2023-02-17T23:40:42.631Z,1676677242.631 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-17T23:40:42.631Z,1676677242.631 [controlThread](DEBUG): Uninitializing ControlThread 2023-02-17T23:40:42.632Z,1676677242.632 [AHRS_M2](INFO): Powering down 2023-02-17T23:40:42.704Z,1676677242.704 [MultiRay](INFO): Powering down. 2023-02-17T23:40:42.705Z,1676677242.705 [NAL9602](INFO): Powering down 2023-02-17T23:40:42.706Z,1676677242.706 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-02-17T23:40:42.707Z,1676677242.707 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-02-17T23:40:42.708Z,1676677242.708 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-02-17T23:40:42.708Z,1676677242.708 [MissionManager](INFO): Uninitializing Mission Default 2023-02-17T23:40:42.709Z,1676677242.709 [Default] Stopped 2023-02-17T23:40:42.709Z,1676677242.709 [Default](DEBUG): Aggregate::uninitialize Default 2023-02-17T23:40:42.709Z,1676677242.709 [Default:B.GoToSurface] Stopped 2023-02-17T23:40:42.709Z,1676677242.709 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-02-17T23:40:42.709Z,1676677242.709 [Default:CheckIn] Stopped 2023-02-17T23:40:42.709Z,1676677242.709 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-17T23:40:42.709Z,1676677242.709 [Default:CheckIn:Read_Iridium] Stopped 2023-02-17T23:40:42.712Z,1676677242.712 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-02-17T23:40:42.712Z,1676677242.712 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-02-17T23:40:42.713Z,1676677242.713 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-02-17T23:40:42.713Z,1676677242.713 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-02-17T23:40:42.713Z,1676677242.713 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-02-17T23:40:42.713Z,1676677242.713 [BuoyancyServo](INFO): Powering down 2023-02-17T23:40:42.727Z,1676677242.727 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-02-17T23:40:42.727Z,1676677242.727 [ElevatorServo](INFO): Powering down 2023-02-17T23:40:42.728Z,1676677242.728 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-02-17T23:40:42.728Z,1676677242.728 [MassServo](INFO): Powering down 2023-02-17T23:40:42.729Z,1676677242.729 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-02-17T23:40:42.729Z,1676677242.729 [RudderServo](INFO): Powering down 2023-02-17T23:40:42.730Z,1676677242.730 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2023-02-17T23:40:42.730Z,1676677242.730 [ThrusterHE](INFO): Powering down 2023-02-17T23:40:42.731Z,1676677242.731 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-02-17T23:40:42.731Z,1676677242.731 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-02-17T23:40:42.732Z,1676677242.732 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-02-17T23:40:42.732Z,1676677242.732 [CBIT](DEBUG): Powering off loads. 2023-02-17T23:40:42.743Z,1676677242.743 [CBIT](DEBUG): Disabling WDT. 2023-02-17T23:40:42.755Z,1676677242.755 [CBIT](DEBUG): Opening all GF detection circuits. 2023-02-17T23:40:42.756Z,1676677242.756 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.819Z,1676677242.819 [DAT ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.824Z,1676677242.824 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.826Z,1676677242.826 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.833Z,1676677242.833 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.874Z,1676677242.874 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.918Z,1676677242.918 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.922Z,1676677242.922 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:42.955Z,1676677242.955 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-02-17T23:40:43.033Z,1676677243.033 [logger ThreadHandler](INFO): Thread cancelled.