2021-07-14T17:41:17.987Z,1626284477.987 [DataOverHttps](INFO): Received command:restart logs
2021-07-14T17:41:17.997Z,1626284477.997 [CommandLine](IMPORTANT): got command restart logs
2021-07-14T17:41:29.547Z,1626284489.547 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20210714T140512/Express0092.lzma
2021-07-14T17:41:30.550Z,1626284490.550 [DataOverHttps](INFO): Moved sent file to Logs/20210714T140512/Express0092.lzma.bak
2021-07-14T17:41:30.550Z,1626284490.550 [DataOverHttps](INFO): SBD MOMSN=15748180
2021-07-14T17:41:34.643Z,1626284494.643 [NAL9602](INFO): SBD MO Status=2, MOMSN=5199, MT Status=2, MTMSN=0
2021-07-14T17:41:34.643Z,1626284494.643 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T17:41:50.591Z,1626284510.591 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210714T140512/Courier0094.lzma
2021-07-14T17:41:51.594Z,1626284511.594 [DataOverHttps](INFO): Moved sent file to Logs/20210714T140512/Courier0094.lzma.bak
2021-07-14T17:41:51.594Z,1626284511.594 [DataOverHttps](INFO): SBD MOMSN=15748183
2021-07-14T17:42:03.330Z,1626284523.330 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 5.
2021-07-14T17:42:03.337Z,1626284523.337 [BPC1](INFO): Received data from all battery sticks.
2021-07-14T17:42:07.375Z,1626284527.375 [DataOverHttps](INFO): Sending 107 bytes from file Logs/20210714T140512/Express0095.lzma
2021-07-14T17:42:08.378Z,1626284528.378 [DataOverHttps](INFO): Moved sent file to Logs/20210714T140512/Express0095.lzma.bak
2021-07-14T17:42:08.378Z,1626284528.378 [DataOverHttps](INFO): SBD MOMSN=15748185
2021-07-14T17:42:09.796Z,1626284529.796 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T17:42:09.796Z,1626284529.796 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T17:42:09.796Z,1626284529.796 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T17:43:24.931Z,1626284604.931 [NAL9602](INFO): SBD MO Status=1, MOMSN=5199, MT Status=0, MTMSN=0
2021-07-14T17:43:24.931Z,1626284604.931 [NAL9602](INFO): No messages in MT queue
2021-07-14T17:43:25.730Z,1626284605.730 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=61.832653
2021-07-14T17:43:55.618Z,1626284635.618 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-14T17:44:20.176Z,1626284660.176 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002872
2021-07-14T17:47:10.359Z,1626284830.359 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-14T17:47:10.359Z,1626284830.359 [Default:CheckIn:C.Wait] Stopped
2021-07-14T17:47:10.359Z,1626284830.359 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-14T17:47:10.359Z,1626284830.359 [Default:CheckIn:D] Running Loop=1
2021-07-14T17:47:10.759Z,1626284830.759 [Default:CheckIn:D] Stopped
2021-07-14T17:47:10.759Z,1626284830.759 [Default:CheckIn:E] Running Loop=1
2021-07-14T17:47:11.164Z,1626284831.164 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 18.881093 min 
2021-07-14T17:47:11.165Z,1626284831.165 [Default:CheckIn:E] Stopped
2021-07-14T17:47:11.165Z,1626284831.165 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-14T17:47:11.165Z,1626284831.165 [Default:CheckIn] Stopped
2021-07-14T17:47:11.165Z,1626284831.165 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-14T17:47:11.165Z,1626284831.165 [Default:CheckIn](INFO): Running loop #4
2021-07-14T17:47:11.165Z,1626284831.165 [Default:CheckIn] Running Loop=4
2021-07-14T17:47:11.165Z,1626284831.165 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-14T17:47:11.165Z,1626284831.165 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-14T17:47:13.175Z,1626284833.175 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174712.00,A,3648.50923,N,12147.19562,W,5.832,53.77,140721,,,A*4D
2021-07-14T17:47:13.177Z,1626284833.177 [NAL9602](INFO): GPS fix at 20210714T174712: (36.808487, -121.786594)
2021-07-14T17:47:13.213Z,1626284833.213 [Default:CheckIn:Read_GPS] Stopped
2021-07-14T17:47:13.213Z,1626284833.213 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-14T17:47:20.156Z,1626284840.156 [DataOverHttps](INFO): Sending 309 bytes from file Logs/20210714T174117/Courier0003.lzma
2021-07-14T17:47:21.141Z,1626284841.141 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Courier0003.lzma.bak
2021-07-14T17:47:21.142Z,1626284841.142 [DataOverHttps](INFO): SBD MOMSN=15748190
2021-07-14T17:47:36.980Z,1626284856.980 [DataOverHttps](INFO): Sending 399 bytes from file Logs/20210714T174117/Express0004.lzma
2021-07-14T17:47:37.981Z,1626284857.981 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Express0004.lzma.bak
2021-07-14T17:47:37.982Z,1626284857.982 [DataOverHttps](INFO): SBD MOMSN=15748194
2021-07-14T17:47:39.511Z,1626284859.511 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T17:47:39.512Z,1626284859.512 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T17:47:39.512Z,1626284859.512 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T17:47:45.547Z,1626284865.547 [NAL9602](INFO): SBD MO Status=1, MOMSN=5200, MT Status=0, MTMSN=0
2021-07-14T17:47:45.547Z,1626284865.547 [NAL9602](INFO): No messages in MT queue
2021-07-14T17:48:16.253Z,1626284896.253 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-14T17:52:40.073Z,1626285160.073 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-14T17:52:40.073Z,1626285160.073 [Default:CheckIn:C.Wait] Stopped
2021-07-14T17:52:40.073Z,1626285160.073 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-14T17:52:40.073Z,1626285160.073 [Default:CheckIn:D] Running Loop=1
2021-07-14T17:52:40.489Z,1626285160.489 [Default:CheckIn:D] Stopped
2021-07-14T17:52:40.489Z,1626285160.489 [Default:CheckIn:E] Running Loop=1
2021-07-14T17:52:40.893Z,1626285160.893 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 24.376595 min 
2021-07-14T17:52:40.894Z,1626285160.894 [Default:CheckIn:E] Stopped
2021-07-14T17:52:40.894Z,1626285160.894 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-14T17:52:40.894Z,1626285160.894 [Default:CheckIn] Stopped
2021-07-14T17:52:40.894Z,1626285160.894 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-14T17:52:40.894Z,1626285160.894 [Default:CheckIn](INFO): Running loop #5
2021-07-14T17:52:40.894Z,1626285160.894 [Default:CheckIn] Running Loop=5
2021-07-14T17:52:40.894Z,1626285160.894 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-14T17:52:40.894Z,1626285160.894 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-14T17:52:42.895Z,1626285162.895 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175242.00,A,3648.18109,N,12147.16745,W,4.471,193.04,140721,,,D*7E
2021-07-14T17:52:42.897Z,1626285162.897 [NAL9602](INFO): GPS fix at 20210714T175242: (36.803018, -121.786124)
2021-07-14T17:52:42.908Z,1626285162.908 [Default:CheckIn:Read_GPS] Stopped
2021-07-14T17:52:42.908Z,1626285162.908 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-14T17:52:50.003Z,1626285170.003 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210714T174117/Courier0006.lzma
2021-07-14T17:52:51.006Z,1626285171.006 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Courier0006.lzma.bak
2021-07-14T17:52:51.006Z,1626285171.006 [DataOverHttps](INFO): SBD MOMSN=15748200
2021-07-14T17:53:06.711Z,1626285186.711 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20210714T174117/Express0007.lzma
2021-07-14T17:53:07.714Z,1626285187.714 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Express0007.lzma.bak
2021-07-14T17:53:07.714Z,1626285187.714 [DataOverHttps](INFO): SBD MOMSN=15748203
2021-07-14T17:53:09.177Z,1626285189.177 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T17:53:09.177Z,1626285189.177 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T17:53:09.177Z,1626285189.177 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T17:53:41.501Z,1626285221.501 [NAL9602](INFO): SBD MO Status=2, MOMSN=5201, MT Status=2, MTMSN=0
2021-07-14T17:53:41.501Z,1626285221.501 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T17:54:10.183Z,1626285250.183 [NAL9602](INFO): SBD MO Status=2, MOMSN=5201, MT Status=2, MTMSN=0
2021-07-14T17:54:10.183Z,1626285250.183 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T17:54:32.810Z,1626285272.810 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T17:54:46.542Z,1626285286.542 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T17:54:48.570Z,1626285288.570 [NAL9602](INFO): SBD MO Status=1, MOMSN=5201, MT Status=0, MTMSN=0
2021-07-14T17:54:48.571Z,1626285288.571 [NAL9602](INFO): No messages in MT queue
2021-07-14T17:54:59.873Z,1626285299.873 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T17:55:13.206Z,1626285313.206 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T17:55:19.265Z,1626285319.265 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-14T17:55:26.536Z,1626285326.536 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T17:55:40.278Z,1626285340.278 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T17:55:53.606Z,1626285353.606 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T17:56:06.937Z,1626285366.937 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T17:56:20.673Z,1626285380.673 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T17:56:34.007Z,1626285394.007 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T17:56:47.337Z,1626285407.337 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T17:58:09.769Z,1626285489.769 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-14T17:58:09.769Z,1626285489.769 [Default:CheckIn:C.Wait] Stopped
2021-07-14T17:58:09.769Z,1626285489.769 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-14T17:58:09.769Z,1626285489.769 [Default:CheckIn:D] Running Loop=1
2021-07-14T17:58:10.172Z,1626285490.172 [Default:CheckIn:D] Stopped
2021-07-14T17:58:10.172Z,1626285490.172 [Default:CheckIn:E] Running Loop=1
2021-07-14T17:58:10.588Z,1626285490.588 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 29.871307 min 
2021-07-14T17:58:10.588Z,1626285490.588 [Default:CheckIn:E] Stopped
2021-07-14T17:58:10.589Z,1626285490.589 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-14T17:58:10.589Z,1626285490.589 [Default:CheckIn] Stopped
2021-07-14T17:58:10.589Z,1626285490.589 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-14T17:58:10.589Z,1626285490.589 [Default:CheckIn](INFO): Running loop #6
2021-07-14T17:58:10.589Z,1626285490.589 [Default:CheckIn] Running Loop=6
2021-07-14T17:58:10.589Z,1626285490.589 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-14T17:58:10.589Z,1626285490.589 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-14T17:58:12.587Z,1626285492.587 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175811.00,A,3648.12112,N,12147.22593,W,0.019,278.33,140721,,,D*70
2021-07-14T17:58:12.590Z,1626285492.590 [NAL9602](INFO): GPS fix at 20210714T175811: (36.802019, -121.787099)
2021-07-14T17:58:12.631Z,1626285492.631 [Default:CheckIn:Read_GPS] Stopped
2021-07-14T17:58:12.631Z,1626285492.631 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-14T17:58:19.555Z,1626285499.555 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210714T174117/Courier0009.lzma
2021-07-14T17:58:20.557Z,1626285500.557 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Courier0009.lzma.bak
2021-07-14T17:58:20.558Z,1626285500.558 [DataOverHttps](INFO): SBD MOMSN=15748209
2021-07-14T17:58:39.384Z,1626285519.384 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20210714T174117/Express0010.lzma
2021-07-14T17:58:40.386Z,1626285520.386 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Express0010.lzma.bak
2021-07-14T17:58:40.386Z,1626285520.386 [DataOverHttps](INFO): SBD MOMSN=15748213
2021-07-14T17:58:41.781Z,1626285521.781 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T17:58:41.781Z,1626285521.781 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T17:58:41.781Z,1626285521.781 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T17:58:50.631Z,1626285530.631 [NAL9602](INFO): SBD MO Status=2, MOMSN=5202, MT Status=2, MTMSN=0
2021-07-14T17:58:50.631Z,1626285530.631 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T17:59:27.799Z,1626285567.799 [BPC1](INFO): Calculating totals. Valid battery stick count: 52. Valid reserve battery stick count: 5.
2021-07-14T17:59:27.802Z,1626285567.802 [BPC1](INFO): Received data from all battery sticks.
2021-07-14T18:00:07.792Z,1626285607.792 [NAL9602](INFO): SBD MO Status=2, MOMSN=5202, MT Status=2, MTMSN=0
2021-07-14T18:00:07.792Z,1626285607.792 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T18:00:34.895Z,1626285634.895 [NAL9602](INFO): SBD MO Status=2, MOMSN=5202, MT Status=2, MTMSN=0
2021-07-14T18:00:34.895Z,1626285634.895 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T18:02:36.088Z,1626285756.088 [NAL9602](INFO): SBD MO Status=1, MOMSN=5202, MT Status=0, MTMSN=0
2021-07-14T18:02:36.089Z,1626285756.089 [NAL9602](INFO): No messages in MT queue
2021-07-14T18:03:06.793Z,1626285786.793 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-14T18:03:42.350Z,1626285822.350 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-14T18:03:42.350Z,1626285822.350 [Default:CheckIn:C.Wait] Stopped
2021-07-14T18:03:42.351Z,1626285822.351 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-14T18:03:42.351Z,1626285822.351 [Default:CheckIn:D] Running Loop=1
2021-07-14T18:03:42.760Z,1626285822.760 [Default:CheckIn:D] Stopped
2021-07-14T18:03:42.760Z,1626285822.760 [Default:CheckIn:E] Running Loop=1
2021-07-14T18:03:43.168Z,1626285823.168 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 35.414429 min 
2021-07-14T18:03:43.168Z,1626285823.168 [Default:CheckIn:E] Stopped
2021-07-14T18:03:43.168Z,1626285823.168 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-14T18:03:43.169Z,1626285823.169 [Default:CheckIn] Stopped
2021-07-14T18:03:43.169Z,1626285823.169 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-14T18:03:43.169Z,1626285823.169 [Default:CheckIn](INFO): Running loop #7
2021-07-14T18:03:43.169Z,1626285823.169 [Default:CheckIn] Running Loop=7
2021-07-14T18:03:43.169Z,1626285823.169 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-14T18:03:43.169Z,1626285823.169 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-14T18:03:45.171Z,1626285825.171 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180344.00,A,3648.11944,N,12147.23716,W,0.019,290.56,140721,,,D*72
2021-07-14T18:03:45.173Z,1626285825.173 [NAL9602](INFO): GPS fix at 20210714T180344: (36.801991, -121.787286)
2021-07-14T18:03:45.185Z,1626285825.185 [Default:CheckIn:Read_GPS] Stopped
2021-07-14T18:03:45.185Z,1626285825.185 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-14T18:03:52.887Z,1626285832.887 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20210714T174117/Courier0012.lzma
2021-07-14T18:03:53.889Z,1626285833.889 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Courier0012.lzma.bak
2021-07-14T18:03:53.890Z,1626285833.890 [DataOverHttps](INFO): SBD MOMSN=15748216
2021-07-14T18:04:09.699Z,1626285849.699 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210714T174117/Express0013.lzma
2021-07-14T18:04:10.836Z,1626285850.836 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Express0013.lzma.bak
2021-07-14T18:04:10.837Z,1626285850.837 [DataOverHttps](INFO): SBD MOMSN=15748219
2021-07-14T18:04:12.251Z,1626285852.251 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T18:04:12.251Z,1626285852.251 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T18:04:12.251Z,1626285852.251 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T18:04:16.683Z,1626285856.683 [NAL9602](INFO): SBD MO Status=2, MOMSN=5203, MT Status=2, MTMSN=0
2021-07-14T18:04:16.683Z,1626285856.683 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T18:04:36.882Z,1626285876.882 [NAL9602](INFO): SBD MO Status=1, MOMSN=5203, MT Status=0, MTMSN=0
2021-07-14T18:04:36.883Z,1626285876.883 [NAL9602](INFO): No messages in MT queue
2021-07-14T18:05:07.586Z,1626285907.586 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-14T18:09:12.907Z,1626286152.907 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-14T18:09:12.907Z,1626286152.907 [Default:CheckIn:C.Wait] Stopped
2021-07-14T18:09:12.907Z,1626286152.907 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-14T18:09:12.907Z,1626286152.907 [Default:CheckIn:D] Running Loop=1
2021-07-14T18:09:13.311Z,1626286153.311 [Default:CheckIn:D] Stopped
2021-07-14T18:09:13.311Z,1626286153.311 [Default:CheckIn:E] Running Loop=1
2021-07-14T18:09:13.725Z,1626286153.725 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 40.923617 min 
2021-07-14T18:09:13.725Z,1626286153.725 [Default:CheckIn:E] Stopped
2021-07-14T18:09:13.726Z,1626286153.726 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-14T18:09:13.726Z,1626286153.726 [Default:CheckIn] Stopped
2021-07-14T18:09:13.726Z,1626286153.726 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-14T18:09:13.726Z,1626286153.726 [Default:CheckIn](INFO): Running loop #8
2021-07-14T18:09:13.726Z,1626286153.726 [Default:CheckIn] Running Loop=8
2021-07-14T18:09:13.726Z,1626286153.726 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-14T18:09:13.726Z,1626286153.726 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-14T18:09:15.727Z,1626286155.727 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180915.00,A,3648.17041,N,12147.27899,W,0.117,216.29,140721,,,D*73
2021-07-14T18:09:15.729Z,1626286155.729 [NAL9602](INFO): GPS fix at 20210714T180915: (36.802840, -121.787983)
2021-07-14T18:09:15.761Z,1626286155.761 [Default:CheckIn:Read_GPS] Stopped
2021-07-14T18:09:15.761Z,1626286155.761 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-14T18:09:23.427Z,1626286163.427 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210714T174117/Courier0015.lzma
2021-07-14T18:09:24.429Z,1626286164.429 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Courier0015.lzma.bak
2021-07-14T18:09:24.430Z,1626286164.430 [DataOverHttps](INFO): SBD MOMSN=15748225
2021-07-14T18:09:40.319Z,1626286180.319 [DataOverHttps](INFO): Sending 143 bytes from file Logs/20210714T174117/Express0016.lzma
2021-07-14T18:09:41.321Z,1626286181.321 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Express0016.lzma.bak
2021-07-14T18:09:41.322Z,1626286181.322 [DataOverHttps](INFO): SBD MOMSN=15748228
2021-07-14T18:09:42.821Z,1626286182.821 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T18:09:42.821Z,1626286182.821 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T18:09:42.821Z,1626286182.821 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T18:11:11.686Z,1626286271.686 [NAL9602](INFO): SBD MO Status=2, MOMSN=5204, MT Status=2, MTMSN=0
2021-07-14T18:11:11.687Z,1626286271.687 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T18:11:25.833Z,1626286285.833 [NAL9602](INFO): SBD MO Status=1, MOMSN=5204, MT Status=0, MTMSN=0
2021-07-14T18:11:25.833Z,1626286285.833 [NAL9602](INFO): No messages in MT queue
2021-07-14T18:11:56.585Z,1626286316.585 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-14T18:11:56.993Z,1626286316.993 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:12:10.257Z,1626286330.257 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:12:23.589Z,1626286343.589 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:12:37.326Z,1626286357.326 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:12:51.281Z,1626286371.281 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:13:04.508Z,1626286384.508 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:13:17.841Z,1626286397.841 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:13:31.172Z,1626286411.172 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:13:44.442Z,1626286424.442 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:13:57.773Z,1626286437.773 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:14:11.509Z,1626286451.509 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:14:43.441Z,1626286483.441 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-14T18:14:43.441Z,1626286483.441 [Default:CheckIn:C.Wait] Stopped
2021-07-14T18:14:43.441Z,1626286483.441 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-14T18:14:43.442Z,1626286483.442 [Default:CheckIn:D] Running Loop=1
2021-07-14T18:14:43.857Z,1626286483.857 [Default:CheckIn:D] Stopped
2021-07-14T18:14:43.857Z,1626286483.857 [Default:CheckIn:E] Running Loop=1
2021-07-14T18:14:44.243Z,1626286484.243 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 46.432715 min 
2021-07-14T18:14:44.243Z,1626286484.243 [Default:CheckIn:E] Stopped
2021-07-14T18:14:44.243Z,1626286484.243 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-14T18:14:44.243Z,1626286484.243 [Default:CheckIn] Stopped
2021-07-14T18:14:44.243Z,1626286484.243 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-14T18:14:44.244Z,1626286484.244 [Default:CheckIn](INFO): Running loop #9
2021-07-14T18:14:44.244Z,1626286484.244 [Default:CheckIn] Running Loop=9
2021-07-14T18:14:44.244Z,1626286484.244 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-14T18:14:44.244Z,1626286484.244 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-14T18:14:46.260Z,1626286486.260 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181445.00,A,3648.16682,N,12147.27893,W,0.272,289.37,140721,,,D*71
2021-07-14T18:14:46.263Z,1626286486.263 [NAL9602](INFO): GPS fix at 20210714T181445: (36.802780, -121.787982)
2021-07-14T18:14:46.281Z,1626286486.281 [Default:CheckIn:Read_GPS] Stopped
2021-07-14T18:14:46.281Z,1626286486.281 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-14T18:14:53.567Z,1626286493.567 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210714T174117/Courier0018.lzma
2021-07-14T18:14:54.569Z,1626286494.569 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Courier0018.lzma.bak
2021-07-14T18:14:54.570Z,1626286494.570 [DataOverHttps](INFO): SBD MOMSN=15748232
2021-07-14T18:15:10.740Z,1626286510.740 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210714T174117/Express0019.lzma
2021-07-14T18:15:11.457Z,1626286511.457 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Express0019.lzma.bak
2021-07-14T18:15:11.458Z,1626286511.458 [DataOverHttps](INFO): SBD MOMSN=15748235
2021-07-14T18:15:12.628Z,1626286512.628 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T18:15:12.628Z,1626286512.628 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T18:15:12.628Z,1626286512.628 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T18:16:53.618Z,1626286613.618 [BPC1](INFO): Calculating totals. Valid battery stick count: 52. Valid reserve battery stick count: 5.
2021-07-14T18:16:53.625Z,1626286613.625 [BPC1](INFO): Received data from all battery sticks.
2021-07-14T18:19:48.533Z,1626286788.533 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2021-07-14T18:20:13.196Z,1626286813.196 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-14T18:20:13.196Z,1626286813.196 [Default:CheckIn:C.Wait] Stopped
2021-07-14T18:20:13.196Z,1626286813.196 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-14T18:20:13.197Z,1626286813.197 [Default:CheckIn:D] Running Loop=1
2021-07-14T18:20:13.583Z,1626286813.583 [Default:CheckIn:D] Stopped
2021-07-14T18:20:13.583Z,1626286813.583 [Default:CheckIn:E] Running Loop=1
2021-07-14T18:20:13.991Z,1626286813.991 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 51.928149 min 
2021-07-14T18:20:13.991Z,1626286813.991 [Default:CheckIn:E] Stopped
2021-07-14T18:20:13.991Z,1626286813.991 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-14T18:20:13.991Z,1626286813.991 [Default:CheckIn] Stopped
2021-07-14T18:20:13.991Z,1626286813.991 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-14T18:20:13.992Z,1626286813.992 [Default:CheckIn](INFO): Running loop #10
2021-07-14T18:20:13.992Z,1626286813.992 [Default:CheckIn] Running Loop=10
2021-07-14T18:20:13.992Z,1626286813.992 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-14T18:20:13.992Z,1626286813.992 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-14T18:20:16.001Z,1626286816.001 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182015.00,A,3648.17267,N,12147.28451,W,1.089,193.97,140721,,,A*70
2021-07-14T18:20:16.003Z,1626286816.003 [NAL9602](INFO): GPS fix at 20210714T182015: (36.802878, -121.788075)
2021-07-14T18:20:16.014Z,1626286816.014 [Default:CheckIn:Read_GPS] Stopped
2021-07-14T18:20:16.014Z,1626286816.014 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-14T18:20:22.955Z,1626286822.955 [DataOverHttps](INFO): Sending 86 bytes from file Logs/20210714T174117/Courier0021.lzma
2021-07-14T18:20:23.957Z,1626286823.957 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Courier0021.lzma.bak
2021-07-14T18:20:23.958Z,1626286823.958 [DataOverHttps](INFO): SBD MOMSN=15748238
2021-07-14T18:20:42.348Z,1626286842.348 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20210714T174117/Express0022.lzma
2021-07-14T18:20:43.346Z,1626286843.346 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Express0022.lzma.bak
2021-07-14T18:20:43.346Z,1626286843.346 [DataOverHttps](INFO): SBD MOMSN=15748241
2021-07-14T18:20:44.772Z,1626286844.772 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T18:20:44.772Z,1626286844.772 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T18:20:44.772Z,1626286844.772 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T18:20:48.419Z,1626286848.419 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-14T18:25:45.480Z,1626287145.480 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-14T18:25:45.481Z,1626287145.481 [Default:CheckIn:C.Wait] Stopped
2021-07-14T18:25:45.481Z,1626287145.481 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-14T18:25:45.481Z,1626287145.481 [Default:CheckIn:D] Running Loop=1
2021-07-14T18:25:45.855Z,1626287145.855 [Default:CheckIn:D] Stopped
2021-07-14T18:25:45.855Z,1626287145.855 [Default:CheckIn:E] Running Loop=1
2021-07-14T18:25:46.269Z,1626287146.269 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 57.466020 min 
2021-07-14T18:25:46.269Z,1626287146.269 [Default:CheckIn:E] Stopped
2021-07-14T18:25:46.269Z,1626287146.269 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-14T18:25:46.269Z,1626287146.269 [Default:CheckIn] Stopped
2021-07-14T18:25:46.269Z,1626287146.269 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-14T18:25:46.270Z,1626287146.270 [Default:CheckIn](INFO): Running loop #11
2021-07-14T18:25:46.270Z,1626287146.270 [Default:CheckIn] Running Loop=11
2021-07-14T18:25:46.270Z,1626287146.270 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-14T18:25:46.270Z,1626287146.270 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-14T18:25:48.271Z,1626287148.271 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182547.00,A,3648.16757,N,12147.28150,W,0.117,193.97,140721,,,A*76
2021-07-14T18:25:48.274Z,1626287148.274 [NAL9602](INFO): GPS fix at 20210714T182547: (36.802793, -121.788025)
2021-07-14T18:25:48.309Z,1626287148.309 [Default:CheckIn:Read_GPS] Stopped
2021-07-14T18:25:48.309Z,1626287148.309 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-14T18:25:55.743Z,1626287155.743 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210714T174117/Courier0024.lzma
2021-07-14T18:25:56.746Z,1626287156.746 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Courier0024.lzma.bak
2021-07-14T18:25:56.746Z,1626287156.746 [DataOverHttps](INFO): SBD MOMSN=15748245
2021-07-14T18:26:12.519Z,1626287172.519 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20210714T174117/Express0025.lzma
2021-07-14T18:26:13.522Z,1626287173.522 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Express0025.lzma.bak
2021-07-14T18:26:13.522Z,1626287173.522 [DataOverHttps](INFO): SBD MOMSN=15748248
2021-07-14T18:26:14.949Z,1626287174.949 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T18:26:14.949Z,1626287174.949 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T18:26:14.949Z,1626287174.949 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T18:26:18.973Z,1626287178.973 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2021-07-14T18:26:19.052Z,1626287179.052 [NAL9602](ERROR): received: 
+CSQ:0

OK04, 0, 0, 0, 0

OK
2021-07-14T18:29:22.971Z,1626287362.971 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:29:36.371Z,1626287376.371 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:29:50.022Z,1626287390.022 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:30:03.415Z,1626287403.415 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:30:17.144Z,1626287417.144 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:30:25.167Z,1626287425.167 [NAL9602](INFO): SBD MO Status=1, MOMSN=5205, MT Status=0, MTMSN=0
2021-07-14T18:30:25.167Z,1626287425.167 [NAL9602](INFO): No messages in MT queue
2021-07-14T18:30:30.830Z,1626287430.830 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:30:44.151Z,1626287444.151 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:30:55.865Z,1626287455.865 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-14T18:30:57.885Z,1626287457.885 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:31:11.621Z,1626287471.621 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:31:15.672Z,1626287475.672 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-14T18:31:15.672Z,1626287475.672 [Default:CheckIn:C.Wait] Stopped
2021-07-14T18:31:15.672Z,1626287475.672 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-14T18:31:15.673Z,1626287475.673 [Default:CheckIn:D] Running Loop=1
2021-07-14T18:31:16.085Z,1626287476.085 [Default:CheckIn:D] Stopped
2021-07-14T18:31:16.085Z,1626287476.085 [Default:CheckIn:E] Running Loop=1
2021-07-14T18:31:16.496Z,1626287476.496 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 62.969853 min 
2021-07-14T18:31:16.496Z,1626287476.496 [Default:CheckIn:E] Stopped
2021-07-14T18:31:16.496Z,1626287476.496 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-14T18:31:16.496Z,1626287476.496 [Default:CheckIn] Stopped
2021-07-14T18:31:16.497Z,1626287476.497 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-14T18:31:16.497Z,1626287476.497 [Default:CheckIn](INFO): Running loop #12
2021-07-14T18:31:16.497Z,1626287476.497 [Default:CheckIn] Running Loop=12
2021-07-14T18:31:16.497Z,1626287476.497 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-14T18:31:16.497Z,1626287476.497 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-14T18:31:18.495Z,1626287478.495 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183117.00,A,3648.16911,N,12147.28204,W,0.700,193.97,140721,,,A*78
2021-07-14T18:31:18.497Z,1626287478.497 [NAL9602](INFO): GPS fix at 20210714T183117: (36.802819, -121.788034)
2021-07-14T18:31:18.508Z,1626287478.508 [Default:CheckIn:Read_GPS] Stopped
2021-07-14T18:31:18.508Z,1626287478.508 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-14T18:31:25.425Z,1626287485.425 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:31:25.927Z,1626287485.927 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210714T174117/Courier0027.lzma
2021-07-14T18:31:26.929Z,1626287486.929 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Courier0027.lzma.bak
2021-07-14T18:31:26.930Z,1626287486.930 [DataOverHttps](INFO): SBD MOMSN=15748251
2021-07-14T18:31:39.116Z,1626287499.116 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:31:43.007Z,1626287503.007 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210714T174117/Express0028.lzma
2021-07-14T18:31:44.010Z,1626287504.010 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Express0028.lzma.bak
2021-07-14T18:31:44.010Z,1626287504.010 [DataOverHttps](INFO): SBD MOMSN=15748254
2021-07-14T18:31:45.178Z,1626287505.178 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T18:31:45.178Z,1626287505.178 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T18:31:45.178Z,1626287505.178 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T18:32:13.040Z,1626287533.040 [NAL9602](INFO): SBD MO Status=2, MOMSN=5206, MT Status=2, MTMSN=0
2021-07-14T18:32:13.040Z,1626287533.040 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T18:33:14.843Z,1626287594.843 [NAL9602](INFO): SBD MO Status=2, MOMSN=5206, MT Status=2, MTMSN=0
2021-07-14T18:33:14.843Z,1626287594.843 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T18:34:19.157Z,1626287659.157 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 5.
2021-07-14T18:34:19.159Z,1626287659.159 [BPC1](INFO): Received data from all battery sticks.
2021-07-14T18:36:20.395Z,1626287780.395 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2021-07-14T18:36:45.929Z,1626287805.929 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-14T18:36:45.930Z,1626287805.930 [Default:CheckIn:C.Wait] Stopped
2021-07-14T18:36:45.930Z,1626287805.930 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-14T18:36:45.930Z,1626287805.930 [Default:CheckIn:D] Running Loop=1
2021-07-14T18:36:46.297Z,1626287806.297 [Default:CheckIn:D] Stopped
2021-07-14T18:36:46.297Z,1626287806.297 [Default:CheckIn:E] Running Loop=1
2021-07-14T18:36:46.672Z,1626287806.672 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 68.473389 min 
2021-07-14T18:36:46.672Z,1626287806.672 [Default:CheckIn:E] Stopped
2021-07-14T18:36:46.672Z,1626287806.672 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-14T18:36:46.672Z,1626287806.672 [Default:CheckIn] Stopped
2021-07-14T18:36:46.673Z,1626287806.673 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-14T18:36:46.673Z,1626287806.673 [Default:CheckIn](INFO): Running loop #13
2021-07-14T18:36:46.673Z,1626287806.673 [Default:CheckIn] Running Loop=13
2021-07-14T18:36:46.673Z,1626287806.673 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-14T18:36:46.673Z,1626287806.673 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-14T18:36:48.679Z,1626287808.679 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183647.00,A,3648.16542,N,12147.28484,W,0.097,177.69,140721,,,A*7C
2021-07-14T18:36:48.681Z,1626287808.681 [NAL9602](INFO): GPS fix at 20210714T183647: (36.802757, -121.788081)
2021-07-14T18:36:48.729Z,1626287808.729 [Default:CheckIn:Read_GPS] Stopped
2021-07-14T18:36:48.730Z,1626287808.730 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-14T18:36:58.847Z,1626287818.847 [DataOverHttps](INFO): Sending 84 bytes from file Logs/20210714T174117/Courier0030.lzma
2021-07-14T18:36:59.850Z,1626287819.850 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Courier0030.lzma.bak
2021-07-14T18:36:59.850Z,1626287819.850 [DataOverHttps](INFO): SBD MOMSN=15748258
2021-07-14T18:37:15.678Z,1626287835.678 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20210714T174117/Express0031.lzma
2021-07-14T18:37:16.450Z,1626287836.450 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Express0031.lzma.bak
2021-07-14T18:37:16.450Z,1626287836.450 [DataOverHttps](INFO): SBD MOMSN=15748261
2021-07-14T18:37:17.849Z,1626287837.849 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T18:37:17.849Z,1626287837.849 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T18:37:17.849Z,1626287837.849 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T18:37:21.469Z,1626287841.469 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-14T18:42:18.464Z,1626288138.464 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-14T18:42:18.464Z,1626288138.464 [Default:CheckIn:C.Wait] Stopped
2021-07-14T18:42:18.464Z,1626288138.464 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-14T18:42:18.464Z,1626288138.464 [Default:CheckIn:D] Running Loop=1
2021-07-14T18:42:18.858Z,1626288138.858 [Default:CheckIn:D] Stopped
2021-07-14T18:42:18.858Z,1626288138.858 [Default:CheckIn:E] Running Loop=1
2021-07-14T18:42:19.265Z,1626288139.265 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 74.016064 min 
2021-07-14T18:42:19.265Z,1626288139.265 [Default:CheckIn:E] Stopped
2021-07-14T18:42:19.265Z,1626288139.265 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-14T18:42:19.265Z,1626288139.265 [Default:CheckIn] Stopped
2021-07-14T18:42:19.265Z,1626288139.265 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-14T18:42:19.266Z,1626288139.266 [Default:CheckIn](INFO): Running loop #14
2021-07-14T18:42:19.266Z,1626288139.266 [Default:CheckIn] Running Loop=14
2021-07-14T18:42:19.266Z,1626288139.266 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-14T18:42:19.266Z,1626288139.266 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-14T18:42:21.275Z,1626288141.275 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184220.00,A,3648.16615,N,12147.28074,W,0.233,177.69,140721,,,A*78
2021-07-14T18:42:21.287Z,1626288141.287 [NAL9602](INFO): GPS fix at 20210714T184220: (36.802769, -121.788012)
2021-07-14T18:42:21.298Z,1626288141.298 [Default:CheckIn:Read_GPS] Stopped
2021-07-14T18:42:21.298Z,1626288141.298 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-14T18:42:28.355Z,1626288148.355 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210714T174117/Courier0033.lzma
2021-07-14T18:42:29.357Z,1626288149.357 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Courier0033.lzma.bak
2021-07-14T18:42:29.358Z,1626288149.358 [DataOverHttps](INFO): SBD MOMSN=15748265
2021-07-14T18:42:52.079Z,1626288172.079 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210714T174117/Express0034.lzma
2021-07-14T18:42:53.082Z,1626288173.082 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Express0034.lzma.bak
2021-07-14T18:42:53.082Z,1626288173.082 [DataOverHttps](INFO): SBD MOMSN=15748268
2021-07-14T18:42:54.636Z,1626288174.636 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T18:42:54.636Z,1626288174.636 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T18:42:54.637Z,1626288174.637 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T18:46:27.963Z,1626288387.963 [NAL9602](INFO): SBD MO Status=2, MOMSN=5206, MT Status=2, MTMSN=0
2021-07-14T18:46:27.963Z,1626288387.963 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T18:46:47.842Z,1626288407.842 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:47:00.678Z,1626288420.678 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:47:07.147Z,1626288427.147 [NAL9602](INFO): SBD MO Status=2, MOMSN=5206, MT Status=2, MTMSN=0
2021-07-14T18:47:07.147Z,1626288427.147 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T18:47:14.009Z,1626288434.009 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:47:23.301Z,1626288443.301 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2021-07-14T18:47:27.745Z,1626288447.745 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:47:41.077Z,1626288461.077 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:47:54.069Z,1626288474.069 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-14T18:47:54.410Z,1626288474.410 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:47:55.255Z,1626288475.255 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-14T18:47:55.255Z,1626288475.255 [Default:CheckIn:C.Wait] Stopped
2021-07-14T18:47:55.255Z,1626288475.255 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-14T18:47:55.255Z,1626288475.255 [Default:CheckIn:D] Running Loop=1
2021-07-14T18:47:55.631Z,1626288475.631 [Default:CheckIn:D] Stopped
2021-07-14T18:47:55.631Z,1626288475.631 [Default:CheckIn:E] Running Loop=1
2021-07-14T18:47:56.101Z,1626288476.101 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 79.628963 min 
2021-07-14T18:47:56.101Z,1626288476.101 [Default:CheckIn:E] Stopped
2021-07-14T18:47:56.101Z,1626288476.101 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-14T18:47:56.101Z,1626288476.101 [Default:CheckIn] Stopped
2021-07-14T18:47:56.101Z,1626288476.101 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-14T18:47:56.102Z,1626288476.102 [Default:CheckIn](INFO): Running loop #15
2021-07-14T18:47:56.102Z,1626288476.102 [Default:CheckIn] Running Loop=15
2021-07-14T18:47:56.102Z,1626288476.102 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-14T18:47:56.102Z,1626288476.102 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-14T18:47:58.047Z,1626288478.047 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184757.00,A,3648.16669,N,12147.28200,W,0.311,177.69,140721,,,A*76
2021-07-14T18:47:58.050Z,1626288478.050 [NAL9602](INFO): GPS fix at 20210714T184757: (36.802778, -121.788033)
2021-07-14T18:47:58.091Z,1626288478.091 [Default:CheckIn:Read_GPS] Stopped
2021-07-14T18:47:58.091Z,1626288478.091 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-14T18:48:05.255Z,1626288485.255 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210714T174117/Courier0036.lzma
2021-07-14T18:48:06.258Z,1626288486.258 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Courier0036.lzma.bak
2021-07-14T18:48:06.258Z,1626288486.258 [DataOverHttps](INFO): SBD MOMSN=15748271
2021-07-14T18:48:07.743Z,1626288487.743 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:48:21.073Z,1626288501.073 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:48:22.371Z,1626288502.371 [DataOverHttps](INFO): Sending 206 bytes from file Logs/20210714T174117/Express0037.lzma
2021-07-14T18:48:23.374Z,1626288503.374 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Express0037.lzma.bak
2021-07-14T18:48:23.374Z,1626288503.374 [DataOverHttps](INFO): SBD MOMSN=15748274
2021-07-14T18:48:24.723Z,1626288504.723 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T18:48:24.724Z,1626288504.724 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T18:48:24.724Z,1626288504.724 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T18:48:28.761Z,1626288508.761 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2021-07-14T18:48:28.836Z,1626288508.836 [NAL9602](ERROR): received: 
+CSQ:0

OK06, 2, 0, 0, 0

OK
2021-07-14T18:48:34.406Z,1626288514.406 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:48:47.737Z,1626288527.737 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:48:49.760Z,1626288529.760 [NAL9602](INFO): SBD MO Status=2, MOMSN=5206, MT Status=2, MTMSN=0
2021-07-14T18:48:49.761Z,1626288529.761 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T18:49:01.069Z,1626288541.069 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:49:14.401Z,1626288554.401 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-07-14T18:49:20.063Z,1626288560.063 [NAL9602](INFO): SBD MO Status=2, MOMSN=5206, MT Status=2, MTMSN=0
2021-07-14T18:49:20.063Z,1626288560.063 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T18:49:45.922Z,1626288585.922 [NAL9602](INFO): SBD MO Status=2, MOMSN=5206, MT Status=2, MTMSN=0
2021-07-14T18:49:45.923Z,1626288585.923 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T18:50:22.698Z,1626288622.698 [NAL9602](INFO): SBD MO Status=2, MOMSN=5206, MT Status=2, MTMSN=0
2021-07-14T18:50:22.699Z,1626288622.699 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T18:50:38.441Z,1626288638.441 [NAL9602](INFO): SBD MO Status=2, MOMSN=5206, MT Status=2, MTMSN=0
2021-07-14T18:50:38.441Z,1626288638.441 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-14T18:51:46.333Z,1626288706.333 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 5.
2021-07-14T18:51:46.340Z,1626288706.340 [BPC1](INFO): Received data from all battery sticks.
2021-07-14T18:53:00.393Z,1626288780.393 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2021-07-14T18:53:25.464Z,1626288805.464 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-14T18:53:25.464Z,1626288805.464 [Default:CheckIn:C.Wait] Stopped
2021-07-14T18:53:25.464Z,1626288805.464 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-14T18:53:25.464Z,1626288805.464 [Default:CheckIn:D] Running Loop=1
2021-07-14T18:53:25.851Z,1626288805.851 [Default:CheckIn:D] Stopped
2021-07-14T18:53:25.851Z,1626288805.851 [Default:CheckIn:E] Running Loop=1
2021-07-14T18:53:26.259Z,1626288806.259 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 85.132625 min 
2021-07-14T18:53:26.259Z,1626288806.259 [Default:CheckIn:E] Stopped
2021-07-14T18:53:26.259Z,1626288806.259 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-14T18:53:26.259Z,1626288806.259 [Default:CheckIn] Stopped
2021-07-14T18:53:26.260Z,1626288806.260 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-14T18:53:26.260Z,1626288806.260 [Default:CheckIn](INFO): Running loop #16
2021-07-14T18:53:26.260Z,1626288806.260 [Default:CheckIn] Running Loop=16
2021-07-14T18:53:26.260Z,1626288806.260 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-14T18:53:26.260Z,1626288806.260 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-14T18:53:28.263Z,1626288808.263 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185327.00,A,3648.16750,N,12147.28272,W,0.778,0.00,140721,,,A*7F
2021-07-14T18:53:28.269Z,1626288808.269 [NAL9602](INFO): GPS fix at 20210714T185327: (36.802792, -121.788045)
2021-07-14T18:53:28.311Z,1626288808.311 [Default:CheckIn:Read_GPS] Stopped
2021-07-14T18:53:28.311Z,1626288808.311 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-14T18:53:29.469Z,1626288809.469 [CommandLine](IMPORTANT): got command gfscan
2021-07-14T18:53:29.524Z,1626288809.524 [CBIT](IMPORTANT): Beginning ground fault scan
2021-07-14T18:53:35.563Z,1626288815.563 [DataOverHttps](INFO): Sending 86 bytes from file Logs/20210714T174117/Courier0039.lzma
2021-07-14T18:53:36.565Z,1626288816.565 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Courier0039.lzma.bak
2021-07-14T18:53:36.566Z,1626288816.566 [DataOverHttps](INFO): SBD MOMSN=15748279
2021-07-14T18:53:40.470Z,1626288820.470 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.343337
CHAN A1 (24V): -0.002446
CHAN A2 (12V): 0.240003
CHAN A3 (5V): 0.089557
CHAN B0 (3.3V): 0.059333
CHAN B1 (3.15aV): 0.059616
CHAN B2 (3.15bV): 0.059946
CHAN B3 (GND): -0.006094
OPEN: 0.014781
Full Scale Calc: 4.765 mA, -1.589 mA
2021-07-14T18:53:52.876Z,1626288832.876 [DataOverHttps](INFO): Sending 217 bytes from file Logs/20210714T174117/Express0040.lzma
2021-07-14T18:53:53.878Z,1626288833.878 [DataOverHttps](INFO): Moved sent file to Logs/20210714T174117/Express0040.lzma.bak
2021-07-14T18:53:53.878Z,1626288833.878 [DataOverHttps](INFO): SBD MOMSN=15748282
2021-07-14T18:53:55.355Z,1626288835.355 [Default:CheckIn:Read_Iridium] Stopped
2021-07-14T18:53:55.355Z,1626288835.355 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-14T18:53:55.356Z,1626288835.356 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-14T18:54:00.587Z,1626288840.587 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-14T18:55:06.028Z,1626288906.028 [CommandLine](IMPORTANT): got command ! echo 0 > /dev/loadC0
2021-07-14T18:55:09.517Z,1626288909.517 [CommandLine](IMPORTANT): got command ! echo 0 > /dev/loadC1
2021-07-14T18:55:13.067Z,1626288913.067 [CommandLine](IMPORTANT): got command ! echo 0 > /dev/loadC2
2021-07-14T18:55:15.915Z,1626288915.915 [CommandLine](IMPORTANT): got command ! echo 0 > /dev/loadC3
2021-07-14T18:55:36.390Z,1626288936.390 [CommandLine](IMPORTANT): got command ! echo 0 > /dev/loadC4
2021-07-14T18:55:38.629Z,1626288938.629 [CommandLine](IMPORTANT): got command ! echo 0 > /dev/loadC5
2021-07-14T18:55:41.190Z,1626288941.190 [CommandLine](IMPORTANT): got command ! echo 0 > /dev/loadC6
2021-07-14T18:55:43.750Z,1626288943.750 [CommandLine](IMPORTANT): got command ! echo 0 > /dev/loadC7
2021-07-14T18:55:48.870Z,1626288948.870 [CommandLine](IMPORTANT): got command ! echo 0 > /dev/loadA0
2021-07-14T18:55:48.942Z,162628894