2022-11-23T22:34:35.821Z,1669242875.821 [CommandExec](IMPORTANT): got command restart logs
2022-11-23T22:35:06.377Z,1669242906.377 [NAL9602](INFO): Not Powering down - fast GPS
2022-11-23T22:35:32.260Z,1669242932.260 [CBIT](FAULT): Could not open coulomb counter log file
2022-11-23T22:39:06.759Z,1669243146.759 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T22:39:06.759Z,1669243146.759 [Default:CheckIn:C.Wait] Stopped
2022-11-23T22:39:06.759Z,1669243146.759 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T22:39:06.759Z,1669243146.759 [Default:CheckIn:D] Running Loop=1
2022-11-23T22:39:07.163Z,1669243147.163 [Default:CheckIn:D] Stopped
2022-11-23T22:39:07.163Z,1669243147.163 [Default:CheckIn:E] Running Loop=1
2022-11-23T22:39:07.572Z,1669243147.572 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 18.491571 min 
2022-11-23T22:39:07.572Z,1669243147.572 [Default:CheckIn:E] Stopped
2022-11-23T22:39:07.572Z,1669243147.572 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T22:39:07.573Z,1669243147.573 [Default:CheckIn] Stopped
2022-11-23T22:39:07.573Z,1669243147.573 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T22:39:07.573Z,1669243147.573 [Default:CheckIn](INFO): Running loop #4
2022-11-23T22:39:07.573Z,1669243147.573 [Default:CheckIn] Running Loop=4
2022-11-23T22:39:07.573Z,1669243147.573 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T22:39:07.573Z,1669243147.573 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T22:39:09.578Z,1669243149.578 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223908.00,A,3648.17168,N,12147.28266,W,0.603,210.01,231122,,,D*74
2022-11-23T22:39:09.580Z,1669243149.580 [NAL9602](INFO): GPS fix at 20221123T223908: (36.802861, -121.788044)
2022-11-23T22:39:09.601Z,1669243149.601 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T22:39:09.601Z,1669243149.601 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T22:39:17.235Z,1669243157.235 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20221122T214443/Courier0220.lzma
2022-11-23T22:39:18.238Z,1669243158.238 [DataOverHttps](INFO): Moved sent file to Logs/20221122T214443/Courier0220.lzma.bak
2022-11-23T22:39:18.238Z,1669243158.238 [DataOverHttps](INFO): SBD MOMSN=17325092
2022-11-23T22:39:33.968Z,1669243173.968 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20221123T223435/Courier0000.lzma
2022-11-23T22:39:34.969Z,1669243174.969 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0000.lzma.bak
2022-11-23T22:39:34.970Z,1669243174.970 [DataOverHttps](INFO): SBD MOMSN=17325094
2022-11-23T22:39:51.135Z,1669243191.135 [DataOverHttps](INFO): Sending 118 bytes from file Logs/20221122T214443/Express0221.lzma
2022-11-23T22:39:52.138Z,1669243192.138 [DataOverHttps](INFO): Moved sent file to Logs/20221122T214443/Express0221.lzma.bak
2022-11-23T22:39:52.138Z,1669243192.138 [DataOverHttps](INFO): SBD MOMSN=17325098
2022-11-23T22:40:07.892Z,1669243207.892 [DataOverHttps](INFO): Sending 426 bytes from file Logs/20221123T223435/Express0001.lzma
2022-11-23T22:40:08.894Z,1669243208.894 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0001.lzma.bak
2022-11-23T22:40:08.894Z,1669243208.894 [DataOverHttps](INFO): SBD MOMSN=17325101
2022-11-23T22:40:10.217Z,1669243210.217 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T22:40:10.217Z,1669243210.217 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T22:40:10.217Z,1669243210.217 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T22:44:11.801Z,1669243451.801 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2022-11-23T22:44:42.504Z,1669243482.504 [NAL9602](INFO): Not Powering down - fast GPS
2022-11-23T22:45:10.791Z,1669243510.791 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T22:45:10.791Z,1669243510.791 [Default:CheckIn:C.Wait] Stopped
2022-11-23T22:45:10.791Z,1669243510.791 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T22:45:10.792Z,1669243510.792 [Default:CheckIn:D] Running Loop=1
2022-11-23T22:45:11.206Z,1669243511.206 [Default:CheckIn:D] Stopped
2022-11-23T22:45:11.206Z,1669243511.206 [Default:CheckIn:E] Running Loop=1
2022-11-23T22:45:11.598Z,1669243511.598 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 24.558952 min 
2022-11-23T22:45:11.598Z,1669243511.598 [Default:CheckIn:E] Stopped
2022-11-23T22:45:11.599Z,1669243511.599 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T22:45:11.599Z,1669243511.599 [Default:CheckIn] Stopped
2022-11-23T22:45:11.599Z,1669243511.599 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T22:45:11.599Z,1669243511.599 [Default:CheckIn](INFO): Running loop #5
2022-11-23T22:45:11.599Z,1669243511.599 [Default:CheckIn] Running Loop=5
2022-11-23T22:45:11.599Z,1669243511.599 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T22:45:11.599Z,1669243511.599 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T22:45:13.611Z,1669243513.611 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,224512.00,A,3648.17231,N,12147.28337,W,0.564,193.83,231122,,,A*7B
2022-11-23T22:45:13.613Z,1669243513.613 [NAL9602](INFO): GPS fix at 20221123T224512: (36.802872, -121.788056)
2022-11-23T22:45:13.665Z,1669243513.665 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T22:45:13.665Z,1669243513.665 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T22:45:21.315Z,1669243521.315 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20221123T223435/Courier0003.lzma
2022-11-23T22:45:22.317Z,1669243522.317 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0003.lzma.bak
2022-11-23T22:45:22.318Z,1669243522.318 [DataOverHttps](INFO): SBD MOMSN=17325107
2022-11-23T22:45:32.631Z,1669243532.631 [CBIT](FAULT): Could not open coulomb counter log file
2022-11-23T22:45:38.496Z,1669243538.496 [DataOverHttps](INFO): Sending 230 bytes from file Logs/20221123T223435/Express0004.lzma
2022-11-23T22:45:39.498Z,1669243539.498 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0004.lzma.bak
2022-11-23T22:45:39.498Z,1669243539.498 [DataOverHttps](INFO): SBD MOMSN=17325110
2022-11-23T22:45:41.092Z,1669243541.092 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T22:45:41.093Z,1669243541.093 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T22:45:41.093Z,1669243541.093 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T22:45:44.311Z,1669243544.311 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2022-11-23T22:45:44.392Z,1669243544.392 [NAL9602](ERROR): received: 
+CSQ:0

OK±XÚæT
2022-11-23T22:50:15.860Z,1669243815.860 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2022-11-23T22:50:41.729Z,1669243841.729 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T22:50:41.729Z,1669243841.729 [Default:CheckIn:C.Wait] Stopped
2022-11-23T22:50:41.729Z,1669243841.729 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T22:50:41.730Z,1669243841.730 [Default:CheckIn:D] Running Loop=1
2022-11-23T22:50:42.161Z,1669243842.161 [Default:CheckIn:D] Stopped
2022-11-23T22:50:42.162Z,1669243842.162 [Default:CheckIn:E] Running Loop=1
2022-11-23T22:50:42.536Z,1669243842.536 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 30.074876 min 
2022-11-23T22:50:42.536Z,1669243842.536 [Default:CheckIn:E] Stopped
2022-11-23T22:50:42.536Z,1669243842.536 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T22:50:42.536Z,1669243842.536 [Default:CheckIn] Stopped
2022-11-23T22:50:42.536Z,1669243842.536 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T22:50:42.537Z,1669243842.537 [Default:CheckIn](INFO): Running loop #6
2022-11-23T22:50:42.537Z,1669243842.537 [Default:CheckIn] Running Loop=6
2022-11-23T22:50:42.537Z,1669243842.537 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T22:50:42.537Z,1669243842.537 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T22:50:44.555Z,1669243844.555 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225043.00,A,3648.16823,N,12147.28545,W,0.855,207.77,231122,,,A*7A
2022-11-23T22:50:44.557Z,1669243844.557 [NAL9602](INFO): GPS fix at 20221123T225043: (36.802804, -121.788091)
2022-11-23T22:50:44.568Z,1669243844.568 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T22:50:44.569Z,1669243844.569 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T22:50:51.535Z,1669243851.535 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20221123T223435/Courier0006.lzma
2022-11-23T22:50:52.537Z,1669243852.537 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0006.lzma.bak
2022-11-23T22:50:52.538Z,1669243852.538 [DataOverHttps](INFO): SBD MOMSN=17325114
2022-11-23T22:51:08.128Z,1669243868.128 [DataOverHttps](INFO): Sending 242 bytes from file Logs/20221123T223435/Express0007.lzma
2022-11-23T22:51:09.130Z,1669243869.130 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0007.lzma.bak
2022-11-23T22:51:09.130Z,1669243869.130 [DataOverHttps](INFO): SBD MOMSN=17325117
2022-11-23T22:51:10.816Z,1669243870.816 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T22:51:10.816Z,1669243870.816 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T22:51:10.816Z,1669243870.816 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T22:51:16.863Z,1669243876.863 [NAL9602](INFO): Not Powering down - fast GPS
2022-11-23T22:55:32.659Z,1669244132.659 [CBIT](FAULT): Could not open coulomb counter log file
2022-11-23T22:56:11.435Z,1669244171.435 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T22:56:11.436Z,1669244171.436 [Default:CheckIn:C.Wait] Stopped
2022-11-23T22:56:11.436Z,1669244171.436 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T22:56:11.436Z,1669244171.436 [Default:CheckIn:D] Running Loop=1
2022-11-23T22:56:11.848Z,1669244171.848 [Default:CheckIn:D] Stopped
2022-11-23T22:56:11.848Z,1669244171.848 [Default:CheckIn:E] Running Loop=1
2022-11-23T22:56:12.258Z,1669244172.258 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 35.569645 min 
2022-11-23T22:56:12.258Z,1669244172.258 [Default:CheckIn:E] Stopped
2022-11-23T22:56:12.258Z,1669244172.258 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T22:56:12.258Z,1669244172.258 [Default:CheckIn] Stopped
2022-11-23T22:56:12.258Z,1669244172.258 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T22:56:12.258Z,1669244172.258 [Default:CheckIn](INFO): Running loop #7
2022-11-23T22:56:12.259Z,1669244172.259 [Default:CheckIn] Running Loop=7
2022-11-23T22:56:12.259Z,1669244172.259 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T22:56:12.259Z,1669244172.259 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T22:56:14.261Z,1669244174.261 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225613.00,A,3648.17379,N,12147.28053,W,0.369,207.77,231122,,,A*7A
2022-11-23T22:56:14.263Z,1669244174.263 [NAL9602](INFO): GPS fix at 20221123T225613: (36.802897, -121.788009)
2022-11-23T22:56:14.291Z,1669244174.291 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T22:56:14.291Z,1669244174.291 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T22:56:21.591Z,1669244181.591 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20221123T223435/Courier0009.lzma
2022-11-23T22:56:22.594Z,1669244182.594 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0009.lzma.bak
2022-11-23T22:56:22.594Z,1669244182.594 [DataOverHttps](INFO): SBD MOMSN=17325122
2022-11-23T22:56:38.639Z,1669244198.639 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20221123T223435/Express0010.lzma
2022-11-23T22:56:39.642Z,1669244199.642 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0010.lzma.bak
2022-11-23T22:56:39.642Z,1669244199.642 [DataOverHttps](INFO): SBD MOMSN=17325125
2022-11-23T22:56:41.001Z,1669244201.001 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T22:56:41.001Z,1669244201.001 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T22:56:41.001Z,1669244201.001 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T22:56:44.957Z,1669244204.957 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2022-11-23T22:56:45.032Z,1669244205.032 [NAL9602](ERROR): received: 
+CSQ:0

OK±XÚæT
2022-11-23T22:59:28.986Z,1669244368.986 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2022-11-23T22:59:29.004Z,1669244369.004 [BPC1](INFO): Received data from all battery sticks.
2022-11-23T23:01:16.451Z,1669244476.451 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2022-11-23T23:01:41.513Z,1669244501.513 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T23:01:41.513Z,1669244501.513 [Default:CheckIn:C.Wait] Stopped
2022-11-23T23:01:41.513Z,1669244501.513 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T23:01:41.513Z,1669244501.513 [Default:CheckIn:D] Running Loop=1
2022-11-23T23:01:41.906Z,1669244501.906 [Default:CheckIn:D] Stopped
2022-11-23T23:01:41.906Z,1669244501.906 [Default:CheckIn:E] Running Loop=1
2022-11-23T23:01:42.311Z,1669244502.311 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.070622 min 
2022-11-23T23:01:42.311Z,1669244502.311 [Default:CheckIn:E] Stopped
2022-11-23T23:01:42.311Z,1669244502.311 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T23:01:42.311Z,1669244502.311 [Default:CheckIn] Stopped
2022-11-23T23:01:42.311Z,1669244502.311 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T23:01:42.311Z,1669244502.311 [Default:CheckIn](INFO): Running loop #8
2022-11-23T23:01:42.311Z,1669244502.311 [Default:CheckIn] Running Loop=8
2022-11-23T23:01:42.311Z,1669244502.311 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T23:01:42.312Z,1669244502.312 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T23:01:44.330Z,1669244504.330 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230143.00,A,3648.16475,N,12147.28224,W,0.875,193.73,231122,,,A*78
2022-11-23T23:01:44.333Z,1669244504.333 [NAL9602](INFO): GPS fix at 20221123T230143: (36.802746, -121.788037)
2022-11-23T23:01:44.347Z,1669244504.347 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T23:01:44.347Z,1669244504.347 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T23:01:52.024Z,1669244512.024 [DataOverHttps](INFO): Sending 201 bytes from file Logs/20221123T223435/Courier0012.lzma
2022-11-23T23:01:53.026Z,1669244513.026 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0012.lzma.bak
2022-11-23T23:01:53.026Z,1669244513.026 [DataOverHttps](INFO): SBD MOMSN=17325129
2022-11-23T23:02:08.683Z,1669244528.683 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20221123T223435/Express0013.lzma
2022-11-23T23:02:09.686Z,1669244529.686 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0013.lzma.bak
2022-11-23T23:02:09.686Z,1669244529.686 [DataOverHttps](INFO): SBD MOMSN=17325132
2022-11-23T23:02:10.999Z,1669244530.999 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T23:02:10.000Z,1669244531.000 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T23:02:10.000Z,1669244531.000 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T23:02:16.654Z,1669244536.654 [NAL9602](INFO): Not Powering down - fast GPS
2022-11-23T23:05:33.001Z,1669244733.001 [CBIT](FAULT): Could not open coulomb counter log file
2022-11-23T23:07:11.579Z,1669244831.579 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T23:07:11.579Z,1669244831.579 [Default:CheckIn:C.Wait] Stopped
2022-11-23T23:07:11.580Z,1669244831.580 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T23:07:11.581Z,1669244831.581 [Default:CheckIn:D] Running Loop=1
2022-11-23T23:07:11.983Z,1669244831.983 [Default:CheckIn:D] Stopped
2022-11-23T23:07:11.983Z,1669244831.983 [Default:CheckIn:E] Running Loop=1
2022-11-23T23:07:12.384Z,1669244832.384 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 46.571895 min 
2022-11-23T23:07:12.384Z,1669244832.384 [Default:CheckIn:E] Stopped
2022-11-23T23:07:12.384Z,1669244832.384 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T23:07:12.384Z,1669244832.384 [Default:CheckIn] Stopped
2022-11-23T23:07:12.384Z,1669244832.384 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T23:07:12.385Z,1669244832.385 [Default:CheckIn](INFO): Running loop #9
2022-11-23T23:07:12.385Z,1669244832.385 [Default:CheckIn] Running Loop=9
2022-11-23T23:07:12.385Z,1669244832.385 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T23:07:12.385Z,1669244832.385 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T23:07:14.391Z,1669244834.391 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230713.00,A,3648.16450,N,12147.28251,W,0.058,336.03,231122,,,A*73
2022-11-23T23:07:14.396Z,1669244834.396 [NAL9602](INFO): GPS fix at 20221123T230713: (36.802742, -121.788042)
2022-11-23T23:07:14.409Z,1669244834.409 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T23:07:14.409Z,1669244834.409 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T23:07:22.031Z,1669244842.031 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20221123T223435/Courier0015.lzma
2022-11-23T23:07:23.034Z,1669244843.034 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0015.lzma.bak
2022-11-23T23:07:23.034Z,1669244843.034 [DataOverHttps](INFO): SBD MOMSN=17325136
2022-11-23T23:07:38.932Z,1669244858.932 [DataOverHttps](INFO): Sending 171 bytes from file Logs/20221123T223435/Express0016.lzma
2022-11-23T23:07:39.934Z,1669244859.934 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0016.lzma.bak
2022-11-23T23:07:39.934Z,1669244859.934 [DataOverHttps](INFO): SBD MOMSN=17325139
2022-11-23T23:07:41.468Z,1669244861.468 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T23:07:41.468Z,1669244861.468 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T23:07:41.469Z,1669244861.469 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T23:07:45.105Z,1669244865.105 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2022-11-23T23:07:45.188Z,1669244865.188 [NAL9602](ERROR): received: 
+CSQ:0

OK±XÚæT
2022-11-23T23:12:16.579Z,1669245136.579 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2022-11-23T23:12:42.047Z,1669245162.047 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T23:12:42.047Z,1669245162.047 [Default:CheckIn:C.Wait] Stopped
2022-11-23T23:12:42.048Z,1669245162.048 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T23:12:42.048Z,1669245162.048 [Default:CheckIn:D] Running Loop=1
2022-11-23T23:12:42.464Z,1669245162.464 [Default:CheckIn:D] Stopped
2022-11-23T23:12:42.464Z,1669245162.464 [Default:CheckIn:E] Running Loop=1
2022-11-23T23:12:42.855Z,1669245162.855 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.079919 min 
2022-11-23T23:12:42.855Z,1669245162.855 [Default:CheckIn:E] Stopped
2022-11-23T23:12:42.855Z,1669245162.855 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T23:12:42.855Z,1669245162.855 [Default:CheckIn] Stopped
2022-11-23T23:12:42.855Z,1669245162.855 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T23:12:42.855Z,1669245162.855 [Default:CheckIn](INFO): Running loop #10
2022-11-23T23:12:42.856Z,1669245162.856 [Default:CheckIn] Running Loop=10
2022-11-23T23:12:42.856Z,1669245162.856 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T23:12:42.856Z,1669245162.856 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T23:12:44.870Z,1669245164.870 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231243.00,A,3648.16793,N,12147.28479,W,0.136,319.03,231122,,,A*76
2022-11-23T23:12:44.873Z,1669245164.873 [NAL9602](INFO): GPS fix at 20221123T231243: (36.802799, -121.788080)
2022-11-23T23:12:44.884Z,1669245164.884 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T23:12:44.884Z,1669245164.884 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T23:12:52.571Z,1669245172.571 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20221123T223435/Courier0018.lzma
2022-11-23T23:12:53.574Z,1669245173.574 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0018.lzma.bak
2022-11-23T23:12:53.574Z,1669245173.574 [DataOverHttps](INFO): SBD MOMSN=17325143
2022-11-23T23:13:09.568Z,1669245189.568 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20221123T223435/Express0019.lzma
2022-11-23T23:13:10.570Z,1669245190.570 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0019.lzma.bak
2022-11-23T23:13:10.570Z,1669245190.570 [DataOverHttps](INFO): SBD MOMSN=17325146
2022-11-23T23:13:11.957Z,1669245191.957 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T23:13:11.957Z,1669245191.957 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T23:13:11.957Z,1669245191.957 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T23:13:16.777Z,1669245196.777 [NAL9602](INFO): Not Powering down - fast GPS
2022-11-23T23:15:33.346Z,1669245333.346 [CBIT](FAULT): Could not open coulomb counter log file
2022-11-23T23:18:12.518Z,1669245492.518 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T23:18:12.518Z,1669245492.518 [Default:CheckIn:C.Wait] Stopped
2022-11-23T23:18:12.518Z,1669245492.518 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T23:18:12.519Z,1669245492.519 [Default:CheckIn:D] Running Loop=1
2022-11-23T23:18:12.927Z,1669245492.927 [Default:CheckIn:D] Stopped
2022-11-23T23:18:12.927Z,1669245492.927 [Default:CheckIn:E] Running Loop=1
2022-11-23T23:18:13.328Z,1669245493.328 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 57.587642 min 
2022-11-23T23:18:13.328Z,1669245493.328 [Default:CheckIn:E] Stopped
2022-11-23T23:18:13.328Z,1669245493.328 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T23:18:13.328Z,1669245493.328 [Default:CheckIn] Stopped
2022-11-23T23:18:13.328Z,1669245493.328 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T23:18:13.329Z,1669245493.329 [Default:CheckIn](INFO): Running loop #11
2022-11-23T23:18:13.329Z,1669245493.329 [Default:CheckIn] Running Loop=11
2022-11-23T23:18:13.329Z,1669245493.329 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T23:18:13.329Z,1669245493.329 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T23:18:15.347Z,1669245495.347 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231814.00,A,3648.15476,N,12147.27865,W,2.644,54.02,231122,,,A*40
2022-11-23T23:18:15.350Z,1669245495.350 [NAL9602](INFO): GPS fix at 20221123T231814: (36.802579, -121.787977)
2022-11-23T23:18:15.362Z,1669245495.362 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T23:18:15.362Z,1669245495.362 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T23:18:22.971Z,1669245502.971 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20221123T223435/Courier0021.lzma
2022-11-23T23:18:23.974Z,1669245503.974 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0021.lzma.bak
2022-11-23T23:18:23.974Z,1669245503.974 [DataOverHttps](INFO): SBD MOMSN=17325150
2022-11-23T23:18:39.639Z,1669245519.639 [DataOverHttps](INFO): Sending 170 bytes from file Logs/20221123T223435/Express0022.lzma
2022-11-23T23:18:40.642Z,1669245520.642 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0022.lzma.bak
2022-11-23T23:18:40.642Z,1669245520.642 [DataOverHttps](INFO): SBD MOMSN=17325153
2022-11-23T23:18:42.017Z,1669245522.017 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T23:18:42.017Z,1669245522.017 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T23:18:42.017Z,1669245522.017 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T23:18:46.043Z,1669245526.043 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2022-11-23T23:18:46.116Z,1669245526.116 [NAL9602](ERROR): received: 
+CSQ:0

OK±XÚæT
2022-11-23T23:23:17.569Z,1669245797.569 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2022-11-23T23:23:42.624Z,1669245822.624 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T23:23:42.625Z,1669245822.625 [Default:CheckIn:C.Wait] Stopped
2022-11-23T23:23:42.625Z,1669245822.625 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T23:23:42.625Z,1669245822.625 [Default:CheckIn:D] Running Loop=1
2022-11-23T23:23:43.033Z,1669245823.033 [Default:CheckIn:D] Stopped
2022-11-23T23:23:43.033Z,1669245823.033 [Default:CheckIn:E] Running Loop=1
2022-11-23T23:23:43.427Z,1669245823.427 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.089400 min 
2022-11-23T23:23:43.427Z,1669245823.427 [Default:CheckIn:E] Stopped
2022-11-23T23:23:43.427Z,1669245823.427 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T23:23:43.427Z,1669245823.427 [Default:CheckIn] Stopped
2022-11-23T23:23:43.427Z,1669245823.427 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T23:23:43.427Z,1669245823.427 [Default:CheckIn](INFO): Running loop #12
2022-11-23T23:23:43.428Z,1669245823.428 [Default:CheckIn] Running Loop=12
2022-11-23T23:23:43.428Z,1669245823.428 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T23:23:43.428Z,1669245823.428 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T23:23:45.442Z,1669245825.442 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232344.00,A,3648.16836,N,12147.27667,W,1.963,25.16,231122,,,A*40
2022-11-23T23:23:45.445Z,1669245825.445 [NAL9602](INFO): GPS fix at 20221123T232344: (36.802806, -121.787944)
2022-11-23T23:23:45.457Z,1669245825.457 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T23:23:45.457Z,1669245825.457 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T23:23:55.015Z,1669245835.015 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20221123T223435/Courier0024.lzma
2022-11-23T23:23:56.018Z,1669245836.018 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0024.lzma.bak
2022-11-23T23:23:56.018Z,1669245836.018 [DataOverHttps](INFO): SBD MOMSN=17325157
2022-11-23T23:24:12.963Z,1669245852.963 [DataOverHttps](INFO): Sending 204 bytes from file Logs/20221123T223435/Express0025.lzma
2022-11-23T23:24:13.966Z,1669245853.966 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0025.lzma.bak
2022-11-23T23:24:13.966Z,1669245853.966 [DataOverHttps](INFO): SBD MOMSN=17325160
2022-11-23T23:24:15.408Z,1669245855.408 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T23:24:15.408Z,1669245855.408 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T23:24:15.409Z,1669245855.409 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T23:24:17.809Z,1669245857.809 [NAL9602](INFO): Not Powering down - fast GPS
2022-11-23T23:25:33.374Z,1669245933.374 [CBIT](FAULT): Could not open coulomb counter log file
2022-11-23T23:29:15.981Z,1669246155.981 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T23:29:15.981Z,1669246155.981 [Default:CheckIn:C.Wait] Stopped
2022-11-23T23:29:15.981Z,1669246155.981 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T23:29:15.981Z,1669246155.981 [Default:CheckIn:D] Running Loop=1
2022-11-23T23:29:16.383Z,1669246156.383 [Default:CheckIn:D] Stopped
2022-11-23T23:29:16.383Z,1669246156.383 [Default:CheckIn:E] Running Loop=1
2022-11-23T23:29:16.785Z,1669246156.785 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 68.645239 min 
2022-11-23T23:29:16.785Z,1669246156.785 [Default:CheckIn:E] Stopped
2022-11-23T23:29:16.785Z,1669246156.785 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T23:29:16.785Z,1669246156.785 [Default:CheckIn] Stopped
2022-11-23T23:29:16.785Z,1669246156.785 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T23:29:16.785Z,1669246156.785 [Default:CheckIn](INFO): Running loop #13
2022-11-23T23:29:16.785Z,1669246156.785 [Default:CheckIn] Running Loop=13
2022-11-23T23:29:16.786Z,1669246156.786 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T23:29:16.786Z,1669246156.786 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T23:29:18.795Z,1669246158.795 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232917.00,A,3648.16312,N,12147.27449,W,0.719,213.28,231122,,,A*77
2022-11-23T23:29:18.797Z,1669246158.797 [NAL9602](INFO): GPS fix at 20221123T232917: (36.802719, -121.787908)
2022-11-23T23:29:18.837Z,1669246158.837 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T23:29:18.837Z,1669246158.837 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T23:29:26.367Z,1669246166.367 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20221123T223435/Courier0027.lzma
2022-11-23T23:29:27.370Z,1669246167.370 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0027.lzma.bak
2022-11-23T23:29:27.370Z,1669246167.370 [DataOverHttps](INFO): SBD MOMSN=17325164
2022-11-23T23:29:43.027Z,1669246183.027 [DataOverHttps](INFO): Sending 170 bytes from file Logs/20221123T223435/Express0028.lzma
2022-11-23T23:29:44.030Z,1669246184.030 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0028.lzma.bak
2022-11-23T23:29:44.030Z,1669246184.030 [DataOverHttps](INFO): SBD MOMSN=17325167
2022-11-23T23:29:45.477Z,1669246185.477 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T23:29:45.477Z,1669246185.477 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T23:29:45.477Z,1669246185.477 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T23:29:49.497Z,1669246189.497 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2022-11-23T23:29:49.576Z,1669246189.576 [NAL9602](ERROR): received: 
+CSQ:0

OK±XÚæT
2022-11-23T23:30:02.444Z,1669246202.444 [CBIT](IMPORTANT): Beginning ground fault scan
2022-11-23T23:30:05.303Z,1669246205.303 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2022-11-23T23:30:13.359Z,1669246213.359 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.003010
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.005437
CHAN A3 (5V): -0.003019
CHAN B0 (3.3V): -0.001216
CHAN B1 (3.15aV): -0.000770
CHAN B2 (3.15bV): -0.001402
CHAN B3 (GND): -0.000391
OPEN: 0.004490
Full Scale: +/- 1 mA
2022-11-23T23:34:20.585Z,1669246460.585 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2022-11-23T23:34:46.048Z,1669246486.048 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T23:34:46.048Z,1669246486.048 [Default:CheckIn:C.Wait] Stopped
2022-11-23T23:34:46.048Z,1669246486.048 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T23:34:46.048Z,1669246486.048 [Default:CheckIn:D] Running Loop=1
2022-11-23T23:34:46.447Z,1669246486.447 [Default:CheckIn:D] Stopped
2022-11-23T23:34:46.447Z,1669246486.447 [Default:CheckIn:E] Running Loop=1
2022-11-23T23:34:46.861Z,1669246486.861 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 74.146297 min 
2022-11-23T23:34:46.861Z,1669246486.861 [Default:CheckIn:E] Stopped
2022-11-23T23:34:46.861Z,1669246486.861 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T23:34:46.861Z,1669246486.861 [Default:CheckIn] Stopped
2022-11-23T23:34:46.861Z,1669246486.861 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T23:34:46.861Z,1669246486.861 [Default:CheckIn](INFO): Running loop #14
2022-11-23T23:34:46.861Z,1669246486.861 [Default:CheckIn] Running Loop=14
2022-11-23T23:34:46.861Z,1669246486.861 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T23:34:46.861Z,1669246486.861 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T23:34:48.867Z,1669246488.867 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233447.00,A,3648.15806,N,12147.28664,W,0.389,164.72,231122,,,A*70
2022-11-23T23:34:48.879Z,1669246488.879 [NAL9602](INFO): GPS fix at 20221123T233447: (36.802634, -121.788111)
2022-11-23T23:34:48.891Z,1669246488.891 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T23:34:48.891Z,1669246488.891 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T23:34:56.011Z,1669246496.011 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20221123T223435/Courier0030.lzma
2022-11-23T23:34:57.014Z,1669246497.014 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0030.lzma.bak
2022-11-23T23:34:57.014Z,1669246497.014 [DataOverHttps](INFO): SBD MOMSN=17325171
2022-11-23T23:35:12.640Z,1669246512.640 [DataOverHttps](INFO): Sending 389 bytes from file Logs/20221123T223435/Express0031.lzma
2022-11-23T23:35:13.642Z,1669246513.642 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0031.lzma.bak
2022-11-23T23:35:13.642Z,1669246513.642 [DataOverHttps](INFO): SBD MOMSN=17325174
2022-11-23T23:35:15.147Z,1669246515.147 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T23:35:15.147Z,1669246515.147 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T23:35:15.147Z,1669246515.147 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T23:35:21.584Z,1669246521.584 [NAL9602](INFO): Not Powering down - fast GPS
2022-11-23T23:35:33.726Z,1669246533.726 [CBIT](FAULT): Could not open coulomb counter log file
2022-11-23T23:40:15.741Z,1669246815.741 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T23:40:15.741Z,1669246815.741 [Default:CheckIn:C.Wait] Stopped
2022-11-23T23:40:15.741Z,1669246815.741 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T23:40:15.741Z,1669246815.741 [Default:CheckIn:D] Running Loop=1
2022-11-23T23:40:16.155Z,1669246816.155 [Default:CheckIn:D] Stopped
2022-11-23T23:40:16.155Z,1669246816.155 [Default:CheckIn:E] Running Loop=1
2022-11-23T23:40:16.549Z,1669246816.549 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 79.641439 min 
2022-11-23T23:40:16.549Z,1669246816.549 [Default:CheckIn:E] Stopped
2022-11-23T23:40:16.549Z,1669246816.549 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T23:40:16.549Z,1669246816.549 [Default:CheckIn] Stopped
2022-11-23T23:40:16.549Z,1669246816.549 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T23:40:16.549Z,1669246816.549 [Default:CheckIn](INFO): Running loop #15
2022-11-23T23:40:16.549Z,1669246816.549 [Default:CheckIn] Running Loop=15
2022-11-23T23:40:16.549Z,1669246816.549 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T23:40:16.549Z,1669246816.549 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T23:40:18.558Z,1669246818.558 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234017.00,A,3648.16713,N,12147.28349,W,0.447,164.72,231122,,,A*71
2022-11-23T23:40:18.560Z,1669246818.560 [NAL9602](INFO): GPS fix at 20221123T234017: (36.802785, -121.788058)
2022-11-23T23:40:18.572Z,1669246818.572 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T23:40:18.572Z,1669246818.572 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T23:40:26.299Z,1669246826.299 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20221123T223435/Courier0033.lzma
2022-11-23T23:40:27.302Z,1669246827.302 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0033.lzma.bak
2022-11-23T23:40:27.302Z,1669246827.302 [DataOverHttps](INFO): SBD MOMSN=17325180
2022-11-23T23:40:43.232Z,1669246843.232 [DataOverHttps](INFO): Sending 170 bytes from file Logs/20221123T223435/Express0034.lzma
2022-11-23T23:40:44.226Z,1669246844.226 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0034.lzma.bak
2022-11-23T23:40:44.226Z,1669246844.226 [DataOverHttps](INFO): SBD MOMSN=17325183
2022-11-23T23:40:45.646Z,1669246845.646 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T23:40:45.646Z,1669246845.646 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T23:40:45.646Z,1669246845.646 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T23:45:20.345Z,1669247120.345 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2022-11-23T23:45:34.122Z,1669247134.122 [CBIT](FAULT): Could not open coulomb counter log file
2022-11-23T23:45:46.221Z,1669247146.221 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T23:45:46.221Z,1669247146.221 [Default:CheckIn:C.Wait] Stopped
2022-11-23T23:45:46.221Z,1669247146.221 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T23:45:46.221Z,1669247146.221 [Default:CheckIn:D] Running Loop=1
2022-11-23T23:45:46.616Z,1669247146.616 [Default:CheckIn:D] Stopped
2022-11-23T23:45:46.616Z,1669247146.616 [Default:CheckIn:E] Running Loop=1
2022-11-23T23:45:47.032Z,1669247147.032 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 85.149121 min 
2022-11-23T23:45:47.032Z,1669247147.032 [Default:CheckIn:E] Stopped
2022-11-23T23:45:47.032Z,1669247147.032 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T23:45:47.033Z,1669247147.033 [Default:CheckIn] Stopped
2022-11-23T23:45:47.033Z,1669247147.033 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T23:45:47.033Z,1669247147.033 [Default:CheckIn](INFO): Running loop #16
2022-11-23T23:45:47.033Z,1669247147.033 [Default:CheckIn] Running Loop=16
2022-11-23T23:45:47.033Z,1669247147.033 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T23:45:47.033Z,1669247147.033 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T23:45:49.030Z,1669247149.030 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234548.00,A,3648.16907,N,12147.28957,W,0.836,35.63,231122,,,A*4F
2022-11-23T23:45:49.033Z,1669247149.033 [NAL9602](INFO): GPS fix at 20221123T234548: (36.802818, -121.788160)
2022-11-23T23:45:49.068Z,1669247149.068 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T23:45:49.068Z,1669247149.068 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T23:45:56.386Z,1669247156.386 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20221123T223435/Courier0036.lzma
2022-11-23T23:45:57.386Z,1669247157.386 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0036.lzma.bak
2022-11-23T23:45:57.386Z,1669247157.386 [DataOverHttps](INFO): SBD MOMSN=17325187
2022-11-23T23:46:13.432Z,1669247173.432 [DataOverHttps](INFO): Sending 243 bytes from file Logs/20221123T223435/Express0037.lzma
2022-11-23T23:46:14.434Z,1669247174.434 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0037.lzma.bak
2022-11-23T23:46:14.434Z,1669247174.434 [DataOverHttps](INFO): SBD MOMSN=17325190
2022-11-23T23:46:16.112Z,1669247176.112 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T23:46:16.112Z,1669247176.112 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T23:46:16.112Z,1669247176.112 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T23:46:21.755Z,1669247181.755 [NAL9602](INFO): Not Powering down - fast GPS
2022-11-23T23:51:16.683Z,1669247476.683 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-11-23T23:51:16.683Z,1669247476.683 [Default:CheckIn:C.Wait] Stopped
2022-11-23T23:51:16.683Z,1669247476.683 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T23:51:16.683Z,1669247476.683 [Default:CheckIn:D] Running Loop=1
2022-11-23T23:51:17.092Z,1669247477.092 [Default:CheckIn:D] Stopped
2022-11-23T23:51:17.092Z,1669247477.092 [Default:CheckIn:E] Running Loop=1
2022-11-23T23:51:17.509Z,1669247477.509 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 90.657048 min 
2022-11-23T23:51:17.509Z,1669247477.509 [Default:CheckIn:E] Stopped
2022-11-23T23:51:17.509Z,1669247477.509 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-11-23T23:51:17.509Z,1669247477.509 [Default:CheckIn] Stopped
2022-11-23T23:51:17.510Z,1669247477.510 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T23:51:17.510Z,1669247477.510 [Default:CheckIn](INFO): Running loop #17
2022-11-23T23:51:17.510Z,1669247477.510 [Default:CheckIn] Running Loop=17
2022-11-23T23:51:17.510Z,1669247477.510 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-23T23:51:17.510Z,1669247477.510 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-23T23:51:19.507Z,1669247479.507 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235118.00,A,3648.16513,N,12147.28407,W,0.836,312.43,231122,,,A*7A
2022-11-23T23:51:19.509Z,1669247479.509 [NAL9602](INFO): GPS fix at 20221123T235118: (36.802752, -121.788068)
2022-11-23T23:51:19.545Z,1669247479.545 [Default:CheckIn:Read_GPS] Stopped
2022-11-23T23:51:19.545Z,1669247479.545 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-11-23T23:51:26.911Z,1669247486.911 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20221123T223435/Courier0039.lzma
2022-11-23T23:51:27.914Z,1669247487.914 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Courier0039.lzma.bak
2022-11-23T23:51:27.914Z,1669247487.914 [DataOverHttps](INFO): SBD MOMSN=17325195
2022-11-23T23:51:48.044Z,1669247508.044 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20221123T223435/Express0040.lzma
2022-11-23T23:51:49.046Z,1669247509.046 [DataOverHttps](INFO): Moved sent file to Logs/20221123T223435/Express0040.lzma.bak
2022-11-23T23:51:49.046Z,1669247509.046 [DataOverHttps](INFO): SBD MOMSN=17325198
2022-11-23T23:51:51.165Z,1669247511.165 [Default:CheckIn:Read_Iridium] Stopped
2022-11-23T23:51:51.165Z,1669247511.165 [Default:CheckIn:C.Wait] Running Loop=1
2022-11-23T23:51:51.165Z,1669247511.165 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-11-23T23:52:32.437Z,1669247552.437 [CommandExec](IMPORTANT): got command quit
2022-11-23T23:52:33.444Z,1669247553.444 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2022-11-23T23:52:33.444Z,1669247553.444 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-23T23:52:33.445Z,1669247553.445 [CommandExec](INFO): Uninitializing the command executive.
2022-11-23T23:52:33.445Z,1669247553.445 [CommandExec](INFO): Uninitializing the command scheduler.
2022-11-23T23:52:33.445Z,1669247553.445 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:33.500Z,1669247553.500 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2022-11-23T23:52:33.500Z,1669247553.500 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2022-11-23T23:52:33.500Z,1669247553.500 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:33.500Z,1669247553.500 [NavChartDb](INFO): Join timeout helper Thread ID is 8640
2022-11-23T23:52:33.660Z,1669247553.660 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-23T23:52:33.660Z,1669247553.660 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:33.664Z,1669247553.664 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2022-11-23T23:52:33.664Z,1669247553.664 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:33.665Z,1669247553.665 [Radio_Surface](INFO): Join timeout helper Thread ID is 8641
2022-11-23T23:52:33.708Z,1669247553.708 [Radio_Surface](INFO): Powering down
2022-11-23T23:52:33.709Z,1669247553.709 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-23T23:52:33.709Z,1669247553.709 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:33.732Z,1669247553.732 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2022-11-23T23:52:33.732Z,1669247553.732 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:33.733Z,1669247553.733 [Onboard](INFO): Join timeout helper Thread ID is 8642
2022-11-23T23:52:34.224Z,1669247554.224 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2022-11-23T23:52:36.980Z,1669247556.980 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-23T23:52:36.980Z,1669247556.980 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:36.000Z,1669247557.000 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2022-11-23T23:52:36.000Z,1669247557.000 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.000Z,1669247557.000 [DataOverHttps](INFO): Join timeout helper Thread ID is 8643
2022-11-23T23:52:37.236Z,1669247557.236 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-23T23:52:37.236Z,1669247557.236 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.248Z,1669247557.248 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2022-11-23T23:52:37.248Z,1669247557.248 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.248Z,1669247557.248 [BackseatComponent](INFO): Join timeout helper Thread ID is 8644
2022-11-23T23:52:37.444Z,1669247557.444 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-23T23:52:37.444Z,1669247557.444 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.465Z,1669247557.465 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2022-11-23T23:52:37.465Z,1669247557.465 [logger ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.465Z,1669247557.465 [logger](INFO): Join timeout helper Thread ID is 8645
2022-11-23T23:52:37.472Z,1669247557.472 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-23T23:52:37.472Z,1669247557.472 [logger ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.484Z,1669247557.484 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2022-11-23T23:52:37.485Z,1669247557.485 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.485Z,1669247557.485 [CommandLine](INFO): Join timeout helper Thread ID is 8646
2022-11-23T23:52:37.540Z,1669247557.540 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-23T23:52:37.540Z,1669247557.540 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.545Z,1669247557.545 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2022-11-23T23:52:37.545Z,1669247557.545 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.545Z,1669247557.545 [CommandExec](INFO): Join timeout helper Thread ID is 8647
2022-11-23T23:52:37.553Z,1669247557.553 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2022-11-23T23:52:37.553Z,1669247557.553 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.553Z,1669247557.553 [controlThread](INFO): Join timeout helper Thread ID is 8648
2022-11-23T23:52:37.574Z,1669247557.574 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-23T23:52:37.575Z,1669247557.575 [controlThread](DEBUG): Uninitializing ControlThread
2022-11-23T23:52:37.575Z,1669247557.575 [AHRS_M2](INFO): Powering down
2022-11-23T23:52:37.649Z,1669247557.649 [NAL9602](INFO): Powering down
2022-11-23T23:52:37.650Z,1669247557.650 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2022-11-23T23:52:37.651Z,1669247557.651 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2022-11-23T23:52:37.652Z,1669247557.652 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2022-11-23T23:52:37.653Z,1669247557.653 [MissionManager](INFO): Uninitializing Mission Default
2022-11-23T23:52:37.653Z,1669247557.653 [Default] Stopped
2022-11-23T23:52:37.653Z,1669247557.653 [Default](DEBUG): Aggregate::uninitialize Default
2022-11-23T23:52:37.653Z,1669247557.653 [Default:B.GoToSurface] Stopped
2022-11-23T23:52:37.653Z,1669247557.653 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-11-23T23:52:37.653Z,1669247557.653 [Default:CheckIn] Stopped
2022-11-23T23:52:37.653Z,1669247557.653 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-23T23:52:37.653Z,1669247557.653 [Default:CheckIn:C.Wait] Stopped
2022-11-23T23:52:37.653Z,1669247557.653 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-23T23:52:37.656Z,1669247557.656 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2022-11-23T23:52:37.656Z,1669247557.656 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2022-11-23T23:52:37.657Z,1669247557.657 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2022-11-23T23:52:37.657Z,1669247557.657 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2022-11-23T23:52:37.657Z,1669247557.657 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2022-11-23T23:52:37.657Z,1669247557.657 [BuoyancyServo](INFO): Powering down
2022-11-23T23:52:37.672Z,1669247557.672 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2022-11-23T23:52:37.672Z,1669247557.672 [ElevatorServo](INFO): Powering down
2022-11-23T23:52:37.673Z,1669247557.673 [MassServo](DEBUG): Uninitialize Mass Servo.
2022-11-23T23:52:37.673Z,1669247557.673 [MassServo](INFO): Powering down
2022-11-23T23:52:37.674Z,1669247557.674 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-11-23T23:52:37.674Z,1669247557.674 [RudderServo](INFO): Powering down
2022-11-23T23:52:37.675Z,1669247557.675 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2022-11-23T23:52:37.675Z,1669247557.675 [ThrusterHE](INFO): Powering down
2022-11-23T23:52:37.676Z,1669247557.676 [SBIT](DEBUG): Uninitialize SBIT Component.
2022-11-23T23:52:37.676Z,1669247557.676 [IBIT](DEBUG): Uninitialize IBIT Component.
2022-11-23T23:52:37.676Z,1669247557.676 [CBIT](DEBUG): Uninitialize CBIT Component.
2022-11-23T23:52:37.676Z,1669247557.676 [CBIT](DEBUG): Powering off loads.
2022-11-23T23:52:37.688Z,1669247557.688 [CBIT](DEBUG): Disabling WDT.
2022-11-23T23:52:37.700Z,1669247557.700 [CBIT](DEBUG): Opening all GF detection circuits.
2022-11-23T23:52:37.701Z,1669247557.701 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.736Z,1669247557.736 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.740Z,1669247557.740 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.746Z,1669247557.746 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.788Z,1669247557.788 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.883Z,1669247557.883 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-11-23T23:52:37.928Z,1669247557.928 [logger ThreadHandler](INFO): Thread cancelled.