2021-08-02T18:20:47.768Z,1627928447.768 [CommandLine](IMPORTANT): got command restart logs
2021-08-02T18:21:49.529Z,1627928509.529 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T18:21:49.529Z,1627928509.529 [Default:CheckIn:C.Wait] Stopped
2021-08-02T18:21:49.529Z,1627928509.529 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T18:21:49.529Z,1627928509.529 [Default:CheckIn:D] Running Loop=1
2021-08-02T18:21:49.933Z,1627928509.933 [Default:CheckIn:D] Stopped
2021-08-02T18:21:49.933Z,1627928509.933 [Default:CheckIn:E] Running Loop=1
2021-08-02T18:21:50.329Z,1627928510.329 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 149.803792 min 
2021-08-02T18:21:50.329Z,1627928510.329 [Default:CheckIn:E] Stopped
2021-08-02T18:21:50.329Z,1627928510.329 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T18:21:50.329Z,1627928510.329 [Default:CheckIn] Stopped
2021-08-02T18:21:50.329Z,1627928510.329 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T18:21:50.330Z,1627928510.330 [Default:CheckIn](INFO): Running loop #27
2021-08-02T18:21:50.330Z,1627928510.330 [Default:CheckIn] Running Loop=27
2021-08-02T18:21:50.330Z,1627928510.330 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T18:21:50.330Z,1627928510.330 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T18:21:52.342Z,1627928512.342 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182151.00,A,3648.17595,N,12147.28722,W,0.039,0.00,020821,,,A*7B
2021-08-02T18:21:52.345Z,1627928512.345 [NAL9602](INFO): GPS fix at 20210802T182151: (36.802932, -121.788120)
2021-08-02T18:21:52.356Z,1627928512.356 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T18:21:52.357Z,1627928512.357 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T18:22:01.278Z,1627928521.278 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210802T154729/Courier0082.lzma
2021-08-02T18:22:02.281Z,1627928522.281 [DataOverHttps](INFO): Moved sent file to Logs/20210802T154729/Courier0082.lzma.bak
2021-08-02T18:22:02.281Z,1627928522.281 [DataOverHttps](INFO): SBD MOMSN=15790083
2021-08-02T18:22:09.354Z,1627928529.354 [NAL9602](INFO): SBD MO Status=0, MOMSN=28629, MT Status=0, MTMSN=0
2021-08-02T18:22:09.355Z,1627928529.355 [NAL9602](INFO): No messages in MT queue
2021-08-02T18:22:22.823Z,1627928542.823 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20210802T182047/Courier0000.lzma
2021-08-02T18:22:23.825Z,1627928543.825 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0000.lzma.bak
2021-08-02T18:22:23.825Z,1627928543.825 [DataOverHttps](INFO): SBD MOMSN=15790088
2021-08-02T18:22:39.780Z,1627928559.780 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T18:22:46.587Z,1627928566.587 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210802T182047/Courier0003.lzma
2021-08-02T18:22:47.589Z,1627928567.589 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0003.lzma.bak
2021-08-02T18:22:47.589Z,1627928567.589 [DataOverHttps](INFO): SBD MOMSN=15790094
2021-08-02T18:23:05.995Z,1627928585.995 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20210802T154729/Express0083.lzma
2021-08-02T18:23:06.997Z,1627928586.997 [DataOverHttps](INFO): Moved sent file to Logs/20210802T154729/Express0083.lzma.bak
2021-08-02T18:23:06.997Z,1627928586.997 [DataOverHttps](INFO): SBD MOMSN=15790096
2021-08-02T18:23:25.975Z,1627928605.975 [DataOverHttps](INFO): Sending 379 bytes from file Logs/20210802T182047/Express0001.lzma
2021-08-02T18:23:26.977Z,1627928606.977 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0001.lzma.bak
2021-08-02T18:23:26.977Z,1627928606.977 [DataOverHttps](INFO): SBD MOMSN=15790120
2021-08-02T18:23:30.717Z,1627928610.717 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T18:23:30.717Z,1627928610.717 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T18:23:30.717Z,1627928610.717 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T18:28:31.401Z,1627928911.401 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T18:28:31.401Z,1627928911.401 [Default:CheckIn:C.Wait] Stopped
2021-08-02T18:28:31.401Z,1627928911.401 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T18:28:31.401Z,1627928911.401 [Default:CheckIn:D] Running Loop=1
2021-08-02T18:28:31.892Z,1627928911.892 [Default:CheckIn:D] Stopped
2021-08-02T18:28:31.892Z,1627928911.892 [Default:CheckIn:E] Running Loop=1
2021-08-02T18:28:32.210Z,1627928912.210 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 156.503109 min 
2021-08-02T18:28:32.210Z,1627928912.210 [Default:CheckIn:E] Stopped
2021-08-02T18:28:32.210Z,1627928912.210 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T18:28:32.210Z,1627928912.210 [Default:CheckIn] Stopped
2021-08-02T18:28:32.210Z,1627928912.210 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T18:28:32.210Z,1627928912.210 [Default:CheckIn](INFO): Running loop #28
2021-08-02T18:28:32.210Z,1627928912.210 [Default:CheckIn] Running Loop=28
2021-08-02T18:28:32.210Z,1627928912.210 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T18:28:32.211Z,1627928912.211 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T18:28:34.218Z,1627928914.218 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182833.00,A,3648.17552,N,12147.28777,W,0.039,0.00,020821,,,A*7D
2021-08-02T18:28:34.221Z,1627928914.221 [NAL9602](INFO): GPS fix at 20210802T182833: (36.802925, -121.788129)
2021-08-02T18:28:34.237Z,1627928914.237 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T18:28:34.237Z,1627928914.237 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T18:28:45.507Z,1627928925.507 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210802T182047/Courier0005.lzma
2021-08-02T18:28:46.509Z,1627928926.509 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0005.lzma.bak
2021-08-02T18:28:46.509Z,1627928926.509 [DataOverHttps](INFO): SBD MOMSN=15790210
2021-08-02T18:28:47.154Z,1627928927.154 [NAL9602](INFO): SBD MO Status=0, MOMSN=28630, MT Status=0, MTMSN=0
2021-08-02T18:28:47.154Z,1627928927.154 [NAL9602](INFO): No messages in MT queue
2021-08-02T18:29:06.439Z,1627928946.439 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210802T182047/Express0004.lzma
2021-08-02T18:29:07.441Z,1627928947.441 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0004.lzma.bak
2021-08-02T18:29:07.441Z,1627928947.441 [DataOverHttps](INFO): SBD MOMSN=15790214
2021-08-02T18:29:11.406Z,1627928951.406 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T18:29:11.406Z,1627928951.406 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T18:29:11.406Z,1627928951.406 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T18:29:17.836Z,1627928957.836 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T18:33:28.041Z,1627929208.041 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-08-02T18:33:33.997Z,1627929213.997 [DataOverHttps](IMPORTANT): SBD MTMSN=20210802T183333
2021-08-02T18:33:41.447Z,1627929221.447 [DataOverHttps](INFO): Received command:failComponent hardware Radio_Surface
2021-08-02T18:33:41.532Z,1627929221.532 [CommandLine](IMPORTANT): got command failComponent hardware Radio_Surface
2021-08-02T18:33:41.532Z,1627929221.532 [Radio_Surface] Hardware Fault, FailCount= 1
2021-08-02T18:33:41.532Z,1627929221.532 [Radio_Surface](ERROR): Hardware Fault
2021-08-02T18:33:41.532Z,1627929221.532 [CommandLine](IMPORTANT): Radio_Surface failureMode is Hardware Fault
2021-08-02T18:33:41.659Z,1627929221.659 [Radio_Surface](INFO): Powering down
2021-08-02T18:33:41.885Z,1627929221.885 [CBIT](ERROR): Hardware Fault in component: Radio_Surface
2021-08-02T18:33:42.621Z,1627929222.621 [CBIT](INFO): Clearing failed state for component Radio_Surface
2021-08-02T18:33:42.621Z,1627929222.621 [Radio_Surface] No Fault, FailCount= 1
2021-08-02T18:33:42.871Z,1627929222.871 [Radio_Surface](INFO): Powering up
2021-08-02T18:33:43.452Z,1627929223.452 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2021-08-02T18:33:48.487Z,1627929228.487 [DataOverHttps](INFO): Radio surface powered ON.
2021-08-02T18:34:11.267Z,1627929251.267 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2021-08-02T18:34:11.270Z,1627929251.270 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle.
2021-08-02T18:34:12.086Z,1627929252.086 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T18:34:12.087Z,1627929252.087 [Default:CheckIn:C.Wait] Stopped
2021-08-02T18:34:12.087Z,1627929252.087 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T18:34:12.087Z,1627929252.087 [Default:CheckIn:D] Running Loop=1
2021-08-02T18:34:12.495Z,1627929252.495 [Default:CheckIn:D] Stopped
2021-08-02T18:34:12.495Z,1627929252.495 [Default:CheckIn:E] Running Loop=1
2021-08-02T18:34:12.896Z,1627929252.896 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 162.179818 min 
2021-08-02T18:34:12.896Z,1627929252.896 [Default:CheckIn:E] Stopped
2021-08-02T18:34:12.896Z,1627929252.896 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T18:34:12.896Z,1627929252.896 [Default:CheckIn] Stopped
2021-08-02T18:34:12.896Z,1627929252.896 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T18:34:12.897Z,1627929252.897 [Default:CheckIn](INFO): Running loop #29
2021-08-02T18:34:12.897Z,1627929252.897 [Default:CheckIn] Running Loop=29
2021-08-02T18:34:12.897Z,1627929252.897 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T18:34:12.897Z,1627929252.897 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T18:34:14.915Z,1627929254.915 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183414.00,A,3648.17649,N,12147.28845,W,0.039,0.00,020821,,,A*72
2021-08-02T18:34:14.917Z,1627929254.917 [NAL9602](INFO): GPS fix at 20210802T183414: (36.802942, -121.788141)
2021-08-02T18:34:14.928Z,1627929254.928 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T18:34:14.928Z,1627929254.928 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T18:34:36.352Z,1627929276.352 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-08-02T18:35:07.476Z,1627929307.476 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-08-02T18:35:33.286Z,1627929333.286 [NAL9602](INFO): SBD MO Status=0, MOMSN=28631, MT Status=0, MTMSN=0
2021-08-02T18:35:33.286Z,1627929333.286 [NAL9602](INFO): No messages in MT queue
2021-08-02T18:35:38.600Z,1627929338.600 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-08-02T18:36:03.988Z,1627929363.988 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T18:36:09.736Z,1627929369.736 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-08-02T18:36:40.860Z,1627929400.860 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-08-02T18:36:42.868Z,1627929402.868 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.419495
2021-08-02T18:37:03.034Z,1627929423.034 [NAL9602](INFO): SBD MO Status=1, MOMSN=28632, MT Status=0, MTMSN=0
2021-08-02T18:37:03.084Z,1627929423.084 [NAL9602](INFO): Sent 201 bytes from file Logs/20210802T182047/Courier0009.lzma
2021-08-02T18:37:03.084Z,1627929423.084 [NAL9602](INFO): Packets left to send: 0
2021-08-02T18:37:13.991Z,1627929433.991 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2021-08-02T18:37:17.070Z,1627929437.070 [NAL9602](INFO): SBD MO Status=1, MOMSN=28633, MT Status=0, MTMSN=0
2021-08-02T18:37:17.120Z,1627929437.120 [NAL9602](INFO): Sent 268 bytes from file Logs/20210802T182047/Express0010.lzma
2021-08-02T18:37:17.120Z,1627929437.120 [NAL9602](INFO): Packets left to send: 0
2021-08-02T18:37:24.245Z,1627929444.245 [DataOverHttps](IMPORTANT): SBD MTMSN=20210802T183723
2021-08-02T18:37:24.248Z,1627929444.248 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003231
2021-08-02T18:37:34.427Z,1627929454.427 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20210802T182047/Express0013.lzma
2021-08-02T18:37:34.429Z,1627929454.429 [DataOverHttps](INFO): Received command:failComponent
2021-08-02T18:37:34.436Z,1627929454.436 [CommandLine](IMPORTANT): got command failComponent
2021-08-02T18:37:34.436Z,1627929454.436 [CommandLine](IMPORTANT): Failed components:
2021-08-02T18:37:34.437Z,1627929454.437 [CommandLine](IMPORTANT): No failed Components.
2021-08-02T18:37:35.695Z,1627929455.695 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0013.lzma.bak
2021-08-02T18:37:35.696Z,1627929455.696 [DataOverHttps](IMPORTANT): SBD MOMSN=15790329, MTMSN=20210802T183734
2021-08-02T18:37:36.286Z,1627929456.286 [NAL9602](INFO): SBD MO Status=1, MOMSN=28634, MT Status=0, MTMSN=0
2021-08-02T18:37:36.352Z,1627929456.352 [NAL9602](INFO): Sent 52 bytes from file Logs/20210802T182047/Express0013.lzma
2021-08-02T18:37:36.352Z,1627929456.352 [NAL9602](INFO): Packets left to send: 0
2021-08-02T18:37:43.963Z,1627929463.963 [DataOverHttps](INFO): Received command:sched "failComponent"
2021-08-02T18:37:44.052Z,1627929464.052 [CommandLine](IMPORTANT): got command schedule "failComponent"
2021-08-02T18:37:44.053Z,1627929464.053 [CommandLine](IMPORTANT): Scheduled #1: "failComponent"
2021-08-02T18:37:44.237Z,1627929464.237 [CommandLine](IMPORTANT): got command failComponent
2021-08-02T18:37:44.237Z,1627929464.237 [CommandLine](IMPORTANT): Failed components:
2021-08-02T18:37:44.237Z,1627929464.237 [CommandLine](IMPORTANT): No failed Components.
2021-08-02T18:37:52.427Z,1627929472.427 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210802T182047/Courier0015.lzma
2021-08-02T18:37:53.429Z,1627929473.429 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0015.lzma.bak
2021-08-02T18:37:53.429Z,1627929473.429 [DataOverHttps](INFO): SBD MOMSN=15790336
2021-08-02T18:38:07.000Z,1627929487.000 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T18:38:11.923Z,1627929491.923 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210802T182047/Courier0018.lzma
2021-08-02T18:38:12.925Z,1627929492.925 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0018.lzma.bak
2021-08-02T18:38:12.925Z,1627929492.925 [DataOverHttps](INFO): SBD MOMSN=15790341
2021-08-02T18:38:36.952Z,1627929516.952 [DataOverHttps](INFO): Sending 161 bytes from file Logs/20210802T182047/Express0016.lzma
2021-08-02T18:38:37.953Z,1627929517.953 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0016.lzma.bak
2021-08-02T18:38:37.953Z,1627929517.953 [DataOverHttps](INFO): SBD MOMSN=15790353
2021-08-02T18:38:58.491Z,1627929538.491 [DataOverHttps](INFO): Sending 204 bytes from file Logs/20210802T182047/Express0019.lzma
2021-08-02T18:38:59.493Z,1627929539.493 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0019.lzma.bak
2021-08-02T18:38:59.493Z,1627929539.493 [DataOverHttps](INFO): SBD MOMSN=15790406
2021-08-02T18:39:03.303Z,1627929543.303 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T18:39:03.303Z,1627929543.303 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T18:39:03.303Z,1627929543.303 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T18:44:03.973Z,1627929843.973 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T18:44:03.973Z,1627929843.973 [Default:CheckIn:C.Wait] Stopped
2021-08-02T18:44:03.974Z,1627929843.974 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T18:44:03.974Z,1627929843.974 [Default:CheckIn:D] Running Loop=1
2021-08-02T18:44:04.397Z,1627929844.397 [Default:CheckIn:D] Stopped
2021-08-02T18:44:04.397Z,1627929844.397 [Default:CheckIn:E] Running Loop=1
2021-08-02T18:44:04.784Z,1627929844.784 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 172.044873 min 
2021-08-02T18:44:04.784Z,1627929844.784 [Default:CheckIn:E] Stopped
2021-08-02T18:44:04.785Z,1627929844.785 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T18:44:04.785Z,1627929844.785 [Default:CheckIn] Stopped
2021-08-02T18:44:04.785Z,1627929844.785 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T18:44:04.786Z,1627929844.786 [Default:CheckIn](INFO): Running loop #30
2021-08-02T18:44:04.786Z,1627929844.786 [Default:CheckIn] Running Loop=30
2021-08-02T18:44:04.786Z,1627929844.786 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T18:44:04.786Z,1627929844.786 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T18:44:06.793Z,1627929846.793 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184406.00,A,3648.17623,N,12147.28870,W,0.019,0.00,020821,,,A*7E
2021-08-02T18:44:06.796Z,1627929846.796 [NAL9602](INFO): GPS fix at 20210802T184406: (36.802937, -121.788145)
2021-08-02T18:44:06.808Z,1627929846.808 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T18:44:06.808Z,1627929846.808 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T18:44:15.463Z,1627929855.463 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210802T182047/Courier0021.lzma
2021-08-02T18:44:16.465Z,1627929856.465 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0021.lzma.bak
2021-08-02T18:44:16.465Z,1627929856.465 [DataOverHttps](INFO): SBD MOMSN=15790506
2021-08-02T18:44:44.459Z,1627929884.459 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210802T182047/Express0022.lzma
2021-08-02T18:44:45.461Z,1627929885.461 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0022.lzma.bak
2021-08-02T18:44:45.461Z,1627929885.461 [DataOverHttps](INFO): SBD MOMSN=15790509
2021-08-02T18:44:46.614Z,1627929886.614 [NAL9602](INFO): SBD MO Status=0, MOMSN=28635, MT Status=0, MTMSN=0
2021-08-02T18:44:46.614Z,1627929886.614 [NAL9602](INFO): No messages in MT queue
2021-08-02T18:44:49.471Z,1627929889.471 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T18:44:49.471Z,1627929889.471 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T18:44:49.472Z,1627929889.472 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T18:45:17.316Z,1627929917.316 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T18:49:50.035Z,1627930190.035 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T18:49:50.035Z,1627930190.035 [Default:CheckIn:C.Wait] Stopped
2021-08-02T18:49:50.035Z,1627930190.035 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T18:49:50.035Z,1627930190.035 [Default:CheckIn:D] Running Loop=1
2021-08-02T18:49:50.443Z,1627930190.443 [Default:CheckIn:D] Stopped
2021-08-02T18:49:50.443Z,1627930190.443 [Default:CheckIn:E] Running Loop=1
2021-08-02T18:49:50.846Z,1627930190.846 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 177.812288 min 
2021-08-02T18:49:50.846Z,1627930190.846 [Default:CheckIn:E] Stopped
2021-08-02T18:49:50.846Z,1627930190.846 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T18:49:50.846Z,1627930190.846 [Default:CheckIn] Stopped
2021-08-02T18:49:50.846Z,1627930190.846 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T18:49:50.846Z,1627930190.846 [Default:CheckIn](INFO): Running loop #31
2021-08-02T18:49:50.846Z,1627930190.846 [Default:CheckIn] Running Loop=31
2021-08-02T18:49:50.846Z,1627930190.846 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T18:49:50.847Z,1627930190.847 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T18:49:52.862Z,1627930192.862 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184952.00,A,3648.17616,N,12147.28842,W,0.058,0.00,020821,,,A*70
2021-08-02T18:49:52.865Z,1627930192.865 [NAL9602](INFO): GPS fix at 20210802T184952: (36.802936, -121.788140)
2021-08-02T18:49:52.900Z,1627930192.900 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T18:49:52.900Z,1627930192.900 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T18:50:01.951Z,1627930201.951 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20210802T182047/Courier0024.lzma
2021-08-02T18:50:02.953Z,1627930202.953 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0024.lzma.bak
2021-08-02T18:50:02.953Z,1627930202.953 [DataOverHttps](INFO): SBD MOMSN=15790609
2021-08-02T18:50:06.994Z,1627930206.994 [NAL9602](INFO): SBD MO Status=0, MOMSN=28636, MT Status=0, MTMSN=0
2021-08-02T18:50:06.994Z,1627930206.994 [NAL9602](INFO): No messages in MT queue
2021-08-02T18:50:24.135Z,1627930224.135 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210802T182047/Express0025.lzma
2021-08-02T18:50:26.508Z,1627930226.508 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0025.lzma.bak
2021-08-02T18:50:26.508Z,1627930226.508 [DataOverHttps](INFO): SBD MOMSN=15790614
2021-08-02T18:50:31.863Z,1627930231.863 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T18:50:31.863Z,1627930231.863 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T18:50:31.863Z,1627930231.863 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T18:50:37.472Z,1627930237.472 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T18:55:32.585Z,1627930532.585 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T18:55:32.585Z,1627930532.585 [Default:CheckIn:C.Wait] Stopped
2021-08-02T18:55:32.585Z,1627930532.585 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T18:55:32.585Z,1627930532.585 [Default:CheckIn:D] Running Loop=1
2021-08-02T18:55:33.002Z,1627930533.002 [Default:CheckIn:D] Stopped
2021-08-02T18:55:33.002Z,1627930533.002 [Default:CheckIn:E] Running Loop=1
2021-08-02T18:55:33.387Z,1627930533.387 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 183.521615 min 
2021-08-02T18:55:33.387Z,1627930533.387 [Default:CheckIn:E] Stopped
2021-08-02T18:55:33.388Z,1627930533.388 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T18:55:33.388Z,1627930533.388 [Default:CheckIn] Stopped
2021-08-02T18:55:33.388Z,1627930533.388 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T18:55:33.388Z,1627930533.388 [Default:CheckIn](INFO): Running loop #32
2021-08-02T18:55:33.388Z,1627930533.388 [Default:CheckIn] Running Loop=32
2021-08-02T18:55:33.388Z,1627930533.388 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T18:55:33.388Z,1627930533.388 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T18:55:35.402Z,1627930535.402 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185534.00,A,3648.17619,N,12147.28787,W,0.019,0.00,020821,,,A*71
2021-08-02T18:55:35.405Z,1627930535.405 [NAL9602](INFO): GPS fix at 20210802T185534: (36.802937, -121.788131)
2021-08-02T18:55:35.416Z,1627930535.416 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T18:55:35.416Z,1627930535.416 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T18:55:44.051Z,1627930544.051 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210802T182047/Courier0027.lzma
2021-08-02T18:55:45.053Z,1627930545.053 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0027.lzma.bak
2021-08-02T18:55:45.053Z,1627930545.053 [DataOverHttps](INFO): SBD MOMSN=15790718
2021-08-02T18:55:50.756Z,1627930550.756 [NAL9602](INFO): SBD MO Status=0, MOMSN=28637, MT Status=0, MTMSN=0
2021-08-02T18:55:50.757Z,1627930550.757 [NAL9602](INFO): No messages in MT queue
2021-08-02T18:56:03.519Z,1627930563.519 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210802T182047/Express0028.lzma
2021-08-02T18:56:04.521Z,1627930564.521 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0028.lzma.bak
2021-08-02T18:56:04.521Z,1627930564.521 [DataOverHttps](INFO): SBD MOMSN=15790721
2021-08-02T18:56:08.557Z,1627930568.557 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T18:56:08.557Z,1627930568.557 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T18:56:08.557Z,1627930568.557 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T18:56:21.468Z,1627930581.468 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T19:01:09.314Z,1627930869.314 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T19:01:09.314Z,1627930869.314 [Default:CheckIn:C.Wait] Stopped
2021-08-02T19:01:09.314Z,1627930869.314 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T19:01:09.314Z,1627930869.314 [Default:CheckIn:D] Running Loop=1
2021-08-02T19:01:09.707Z,1627930869.707 [Default:CheckIn:D] Stopped
2021-08-02T19:01:09.707Z,1627930869.707 [Default:CheckIn:E] Running Loop=1
2021-08-02T19:01:10.111Z,1627930870.111 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 189.133366 min 
2021-08-02T19:01:10.111Z,1627930870.111 [Default:CheckIn:E] Stopped
2021-08-02T19:01:10.111Z,1627930870.111 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T19:01:10.111Z,1627930870.111 [Default:CheckIn] Stopped
2021-08-02T19:01:10.111Z,1627930870.111 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T19:01:10.112Z,1627930870.112 [Default:CheckIn](INFO): Running loop #33
2021-08-02T19:01:10.112Z,1627930870.112 [Default:CheckIn] Running Loop=33
2021-08-02T19:01:10.112Z,1627930870.112 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T19:01:10.112Z,1627930870.112 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T19:01:12.116Z,1627930872.116 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190111.00,A,3648.17624,N,12147.28736,W,0.039,0.00,020821,,,A*70
2021-08-02T19:01:12.118Z,1627930872.118 [NAL9602](INFO): GPS fix at 20210802T190111: (36.802937, -121.788123)
2021-08-02T19:01:12.129Z,1627930872.129 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T19:01:12.129Z,1627930872.129 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T19:01:20.843Z,1627930880.843 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210802T182047/Courier0030.lzma
2021-08-02T19:01:21.845Z,1627930881.845 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0030.lzma.bak
2021-08-02T19:01:21.845Z,1627930881.845 [DataOverHttps](INFO): SBD MOMSN=15790827
2021-08-02T19:01:40.307Z,1627930900.307 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210802T182047/Express0031.lzma
2021-08-02T19:01:41.309Z,1627930901.309 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0031.lzma.bak
2021-08-02T19:01:41.309Z,1627930901.309 [DataOverHttps](INFO): SBD MOMSN=15790831
2021-08-02T19:01:44.888Z,1627930904.888 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T19:01:44.888Z,1627930904.888 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T19:01:44.888Z,1627930904.888 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T19:02:00.190Z,1627930920.190 [NAL9602](INFO): SBD MO Status=2, MOMSN=28638, MT Status=2, MTMSN=0
2021-08-02T19:02:00.190Z,1627930920.190 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-08-02T19:03:20.242Z,1627931000.242 [NAL9602](INFO): SBD MO Status=2, MOMSN=28638, MT Status=2, MTMSN=0
2021-08-02T19:03:20.242Z,1627931000.242 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-08-02T19:04:05.890Z,1627931045.890 [NAL9602](INFO): SBD MO Status=0, MOMSN=28638, MT Status=0, MTMSN=0
2021-08-02T19:04:05.890Z,1627931045.890 [NAL9602](INFO): No messages in MT queue
2021-08-02T19:04:36.636Z,1627931076.636 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T19:06:45.536Z,1627931205.536 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T19:06:45.536Z,1627931205.536 [Default:CheckIn:C.Wait] Stopped
2021-08-02T19:06:45.536Z,1627931205.536 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T19:06:45.536Z,1627931205.536 [Default:CheckIn:D] Running Loop=1
2021-08-02T19:06:45.930Z,1627931205.930 [Default:CheckIn:D] Stopped
2021-08-02T19:06:45.930Z,1627931205.930 [Default:CheckIn:E] Running Loop=1
2021-08-02T19:06:46.340Z,1627931206.340 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 194.737093 min 
2021-08-02T19:06:46.340Z,1627931206.340 [Default:CheckIn:E] Stopped
2021-08-02T19:06:46.340Z,1627931206.340 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T19:06:46.340Z,1627931206.340 [Default:CheckIn] Stopped
2021-08-02T19:06:46.340Z,1627931206.340 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T19:06:46.340Z,1627931206.340 [Default:CheckIn](INFO): Running loop #34
2021-08-02T19:06:46.340Z,1627931206.340 [Default:CheckIn] Running Loop=34
2021-08-02T19:06:46.340Z,1627931206.340 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T19:06:46.341Z,1627931206.341 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T19:06:48.354Z,1627931208.354 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190647.00,A,3648.17631,N,12147.28847,W,0.019,0.00,020821,,,A*7B
2021-08-02T19:06:48.357Z,1627931208.357 [NAL9602](INFO): GPS fix at 20210802T190647: (36.802939, -121.788141)
2021-08-02T19:06:48.368Z,1627931208.368 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T19:06:48.368Z,1627931208.368 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T19:06:57.111Z,1627931217.111 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210802T182047/Courier0033.lzma
2021-08-02T19:06:58.113Z,1627931218.113 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0033.lzma.bak
2021-08-02T19:06:58.113Z,1627931218.113 [DataOverHttps](INFO): SBD MOMSN=15790940
2021-08-02T19:07:05.338Z,1627931225.338 [NAL9602](INFO): SBD MO Status=0, MOMSN=28639, MT Status=0, MTMSN=0
2021-08-02T19:07:05.338Z,1627931225.338 [NAL9602](INFO): No messages in MT queue
2021-08-02T19:07:16.620Z,1627931236.620 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210802T182047/Express0034.lzma
2021-08-02T19:07:17.621Z,1627931237.621 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0034.lzma.bak
2021-08-02T19:07:17.622Z,1627931237.622 [DataOverHttps](INFO): SBD MOMSN=15790944
2021-08-02T19:07:21.496Z,1627931241.496 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T19:07:21.496Z,1627931241.496 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T19:07:21.496Z,1627931241.496 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T19:07:36.020Z,1627931256.020 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T19:12:22.084Z,1627931542.084 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T19:12:22.084Z,1627931542.084 [Default:CheckIn:C.Wait] Stopped
2021-08-02T19:12:22.084Z,1627931542.084 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T19:12:22.084Z,1627931542.084 [Default:CheckIn:D] Running Loop=1
2021-08-02T19:12:22.473Z,1627931542.473 [Default:CheckIn:D] Stopped
2021-08-02T19:12:22.473Z,1627931542.473 [Default:CheckIn:E] Running Loop=1
2021-08-02T19:12:22.875Z,1627931542.875 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 200.346143 min 
2021-08-02T19:12:22.875Z,1627931542.875 [Default:CheckIn:E] Stopped
2021-08-02T19:12:22.875Z,1627931542.875 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T19:12:22.875Z,1627931542.875 [Default:CheckIn] Stopped
2021-08-02T19:12:22.876Z,1627931542.876 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T19:12:22.876Z,1627931542.876 [Default:CheckIn](INFO): Running loop #35
2021-08-02T19:12:22.876Z,1627931542.876 [Default:CheckIn] Running Loop=35
2021-08-02T19:12:22.876Z,1627931542.876 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T19:12:22.876Z,1627931542.876 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T19:12:24.886Z,1627931544.886 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191224.00,A,3648.17621,N,12147.28869,W,0.039,0.00,020821,,,A*74
2021-08-02T19:12:24.889Z,1627931544.889 [NAL9602](INFO): GPS fix at 20210802T191224: (36.802937, -121.788145)
2021-08-02T19:12:24.937Z,1627931544.937 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T19:12:24.937Z,1627931544.937 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T19:12:38.567Z,1627931558.567 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20210802T182047/Courier0036.lzma
2021-08-02T19:12:39.569Z,1627931559.569 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0036.lzma.bak
2021-08-02T19:12:39.569Z,1627931559.569 [DataOverHttps](INFO): SBD MOMSN=15791061
2021-08-02T19:12:58.643Z,1627931578.643 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210802T182047/Express0037.lzma
2021-08-02T19:12:59.646Z,1627931579.646 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0037.lzma.bak
2021-08-02T19:12:59.646Z,1627931579.646 [DataOverHttps](INFO): SBD MOMSN=15791064
2021-08-02T19:13:00.114Z,1627931580.114 [NAL9602](INFO): SBD MO Status=0, MOMSN=28640, MT Status=0, MTMSN=0
2021-08-02T19:13:00.114Z,1627931580.114 [NAL9602](INFO): No messages in MT queue
2021-08-02T19:13:03.389Z,1627931583.389 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T19:13:03.389Z,1627931583.389 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T19:13:03.389Z,1627931583.389 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T19:13:30.812Z,1627931610.812 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T19:18:04.134Z,1627931884.134 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T19:18:04.134Z,1627931884.134 [Default:CheckIn:C.Wait] Stopped
2021-08-02T19:18:04.134Z,1627931884.134 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T19:18:04.135Z,1627931884.135 [Default:CheckIn:D] Running Loop=1
2021-08-02T19:18:04.553Z,1627931884.553 [Default:CheckIn:D] Stopped
2021-08-02T19:18:04.553Z,1627931884.553 [Default:CheckIn:E] Running Loop=1
2021-08-02T19:18:04.960Z,1627931884.960 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 206.047461 min 
2021-08-02T19:18:04.960Z,1627931884.960 [Default:CheckIn:E] Stopped
2021-08-02T19:18:04.960Z,1627931884.960 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T19:18:04.960Z,1627931884.960 [Default:CheckIn] Stopped
2021-08-02T19:18:04.960Z,1627931884.960 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T19:18:04.960Z,1627931884.960 [Default:CheckIn](INFO): Running loop #36
2021-08-02T19:18:04.961Z,1627931884.961 [Default:CheckIn] Running Loop=36
2021-08-02T19:18:04.961Z,1627931884.961 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T19:18:04.961Z,1627931884.961 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T19:18:06.961Z,1627931886.961 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191806.00,A,3648.17689,N,12147.28737,W,0.000,0.00,020821,,,A*72
2021-08-02T19:18:06.964Z,1627931886.964 [NAL9602](INFO): GPS fix at 20210802T191806: (36.802948, -121.788123)
2021-08-02T19:18:06.000Z,1627931887.000 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T19:18:07.000Z,1627931887.000 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T19:18:15.871Z,1627931895.871 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210802T182047/Courier0039.lzma
2021-08-02T19:18:16.873Z,1627931896.873 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0039.lzma.bak
2021-08-02T19:18:16.873Z,1627931896.873 [DataOverHttps](INFO): SBD MOMSN=15791196
2021-08-02T19:18:43.923Z,1627931923.923 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210802T182047/Express0040.lzma
2021-08-02T19:18:44.925Z,1627931924.925 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0040.lzma.bak
2021-08-02T19:18:44.925Z,1627931924.925 [DataOverHttps](INFO): SBD MOMSN=15791199
2021-08-02T19:18:48.733Z,1627931928.733 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T19:18:48.733Z,1627931928.733 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T19:18:48.733Z,1627931928.733 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T19:19:27.490Z,1627931967.490 [NAL9602](INFO): SBD MO Status=0, MOMSN=28641, MT Status=0, MTMSN=0
2021-08-02T19:19:27.490Z,1627931967.490 [NAL9602](INFO): No messages in MT queue
2021-08-02T19:19:58.192Z,1627931998.192 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T19:23:49.305Z,1627932229.305 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T19:23:49.305Z,1627932229.305 [Default:CheckIn:C.Wait] Stopped
2021-08-02T19:23:49.306Z,1627932229.306 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T19:23:49.306Z,1627932229.306 [Default:CheckIn:D] Running Loop=1
2021-08-02T19:23:49.699Z,1627932229.699 [Default:CheckIn:D] Stopped
2021-08-02T19:23:49.699Z,1627932229.699 [Default:CheckIn:E] Running Loop=1
2021-08-02T19:23:50.100Z,1627932230.100 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 211.799902 min 
2021-08-02T19:23:50.100Z,1627932230.100 [Default:CheckIn:E] Stopped
2021-08-02T19:23:50.100Z,1627932230.100 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T19:23:50.100Z,1627932230.100 [Default:CheckIn] Stopped
2021-08-02T19:23:50.100Z,1627932230.100 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T19:23:50.100Z,1627932230.100 [Default:CheckIn](INFO): Running loop #37
2021-08-02T19:23:50.100Z,1627932230.100 [Default:CheckIn] Running Loop=37
2021-08-02T19:23:50.101Z,1627932230.101 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T19:23:50.101Z,1627932230.101 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T19:23:52.118Z,1627932232.118 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192351.00,A,3648.17717,N,12147.28832,W,0.039,0.00,020821,,,A*7E
2021-08-02T19:23:52.120Z,1627932232.120 [NAL9602](INFO): GPS fix at 20210802T192351: (36.802953, -121.788139)
2021-08-02T19:23:52.136Z,1627932232.136 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T19:23:52.136Z,1627932232.136 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T19:24:01.719Z,1627932241.719 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210802T182047/Courier0042.lzma
2021-08-02T19:24:02.721Z,1627932242.721 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0042.lzma.bak
2021-08-02T19:24:02.721Z,1627932242.721 [DataOverHttps](INFO): SBD MOMSN=15791401
2021-08-02T19:24:05.902Z,1627932245.902 [NAL9602](INFO): SBD MO Status=0, MOMSN=28642, MT Status=0, MTMSN=0
2021-08-02T19:24:05.902Z,1627932245.902 [NAL9602](INFO): No messages in MT queue
2021-08-02T19:24:23.884Z,1627932263.884 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210802T182047/Express0043.lzma
2021-08-02T19:24:24.885Z,1627932264.885 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0043.lzma.bak
2021-08-02T19:24:24.885Z,1627932264.885 [DataOverHttps](INFO): SBD MOMSN=15791436
2021-08-02T19:24:31.089Z,1627932271.089 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T19:24:31.089Z,1627932271.089 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T19:24:31.089Z,1627932271.089 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T19:24:36.346Z,1627932276.346 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T19:29:31.859Z,1627932571.859 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T19:29:31.859Z,1627932571.859 [Default:CheckIn:C.Wait] Stopped
2021-08-02T19:29:31.859Z,1627932571.859 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T19:29:31.859Z,1627932571.859 [Default:CheckIn:D] Running Loop=1
2021-08-02T19:29:32.271Z,1627932572.271 [Default:CheckIn:D] Stopped
2021-08-02T19:29:32.271Z,1627932572.271 [Default:CheckIn:E] Running Loop=1
2021-08-02T19:29:32.680Z,1627932572.680 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 217.509440 min 
2021-08-02T19:29:32.681Z,1627932572.681 [Default:CheckIn:E] Stopped
2021-08-02T19:29:32.681Z,1627932572.681 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T19:29:32.681Z,1627932572.681 [Default:CheckIn] Stopped
2021-08-02T19:29:32.681Z,1627932572.681 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T19:29:32.681Z,1627932572.681 [Default:CheckIn](INFO): Running loop #38
2021-08-02T19:29:32.681Z,1627932572.681 [Default:CheckIn] Running Loop=38
2021-08-02T19:29:32.681Z,1627932572.681 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T19:29:32.681Z,1627932572.681 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T19:29:34.682Z,1627932574.682 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192933.00,A,3648.17691,N,12147.28805,W,0.097,0.00,020821,,,A*7F
2021-08-02T19:29:34.685Z,1627932574.685 [NAL9602](INFO): GPS fix at 20210802T192933: (36.802948, -121.788134)
2021-08-02T19:29:34.696Z,1627932574.696 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T19:29:34.697Z,1627932574.697 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T19:29:43.855Z,1627932583.855 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210802T182047/Courier0045.lzma
2021-08-02T19:29:44.857Z,1627932584.857 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0045.lzma.bak
2021-08-02T19:29:44.857Z,1627932584.857 [DataOverHttps](INFO): SBD MOMSN=15791525
2021-08-02T19:29:48.418Z,1627932588.418 [NAL9602](INFO): SBD MO Status=0, MOMSN=28643, MT Status=0, MTMSN=0
2021-08-02T19:29:48.418Z,1627932588.418 [NAL9602](INFO): No messages in MT queue
2021-08-02T19:30:03.255Z,1627932603.255 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210802T182047/Express0046.lzma
2021-08-02T19:30:04.257Z,1627932604.257 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0046.lzma.bak
2021-08-02T19:30:04.258Z,1627932604.258 [DataOverHttps](INFO): SBD MOMSN=15791533
2021-08-02T19:30:08.263Z,1627932608.263 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T19:30:08.280Z,1627932608.280 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T19:30:08.280Z,1627932608.280 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T19:30:19.124Z,1627932619.124 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T19:35:09.018Z,1627932909.018 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T19:35:09.018Z,1627932909.018 [Default:CheckIn:C.Wait] Stopped
2021-08-02T19:35:09.018Z,1627932909.018 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T19:35:09.018Z,1627932909.018 [Default:CheckIn:D] Running Loop=1
2021-08-02T19:35:09.434Z,1627932909.434 [Default:CheckIn:D] Stopped
2021-08-02T19:35:09.434Z,1627932909.434 [Default:CheckIn:E] Running Loop=1
2021-08-02T19:35:09.825Z,1627932909.825 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 223.128809 min 
2021-08-02T19:35:09.825Z,1627932909.825 [Default:CheckIn:E] Stopped
2021-08-02T19:35:09.825Z,1627932909.825 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T19:35:09.825Z,1627932909.825 [Default:CheckIn] Stopped
2021-08-02T19:35:09.825Z,1627932909.825 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T19:35:09.825Z,1627932909.825 [Default:CheckIn](INFO): Running loop #39
2021-08-02T19:35:09.825Z,1627932909.825 [Default:CheckIn] Running Loop=39
2021-08-02T19:35:09.826Z,1627932909.826 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T19:35:09.826Z,1627932909.826 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T19:35:11.830Z,1627932911.830 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193511.00,A,3648.17635,N,12147.28787,W,0.019,0.00,020821,,,A*7F
2021-08-02T19:35:11.832Z,1627932911.832 [NAL9602](INFO): GPS fix at 20210802T193511: (36.802939, -121.788131)
2021-08-02T19:35:11.844Z,1627932911.844 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T19:35:11.844Z,1627932911.844 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T19:35:20.895Z,1627932920.895 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20210802T182047/Courier0048.lzma
2021-08-02T19:35:21.897Z,1627932921.897 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0048.lzma.bak
2021-08-02T19:35:21.897Z,1627932921.897 [DataOverHttps](INFO): SBD MOMSN=15791687
2021-08-02T19:35:40.535Z,1627932940.535 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210802T182047/Express0049.lzma
2021-08-02T19:35:41.537Z,1627932941.537 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0049.lzma.bak
2021-08-02T19:35:41.537Z,1627932941.537 [DataOverHttps](INFO): SBD MOMSN=15791692
2021-08-02T19:35:45.491Z,1627932945.491 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T19:35:45.491Z,1627932945.491 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T19:35:45.491Z,1627932945.491 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T19:36:10.007Z,1627932970.007 [NAL9602](INFO): SBD MO Status=0, MOMSN=28644, MT Status=0, MTMSN=0
2021-08-02T19:36:10.007Z,1627932970.007 [NAL9602](INFO): No messages in MT queue
2021-08-02T19:36:40.412Z,1627933000.412 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T19:40:46.089Z,1627933246.089 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T19:40:46.089Z,1627933246.089 [Default:CheckIn:C.Wait] Stopped
2021-08-02T19:40:46.089Z,1627933246.089 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T19:40:46.089Z,1627933246.089 [Default:CheckIn:D] Running Loop=1
2021-08-02T19:40:46.499Z,1627933246.499 [Default:CheckIn:D] Stopped
2021-08-02T19:40:46.499Z,1627933246.499 [Default:CheckIn:E] Running Loop=1
2021-08-02T19:40:46.887Z,1627933246.887 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 228.746305 min 
2021-08-02T19:40:46.887Z,1627933246.887 [Default:CheckIn:E] Stopped
2021-08-02T19:40:46.887Z,1627933246.887 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T19:40:46.888Z,1627933246.888 [Default:CheckIn] Stopped
2021-08-02T19:40:46.888Z,1627933246.888 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T19:40:46.888Z,1627933246.888 [Default:CheckIn](INFO): Running loop #40
2021-08-02T19:40:46.888Z,1627933246.888 [Default:CheckIn] Running Loop=40
2021-08-02T19:40:46.888Z,1627933246.888 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-02T19:40:46.888Z,1627933246.888 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-02T19:40:48.899Z,1627933248.899 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194048.00,A,3648.17665,N,12147.28786,W,0.019,0.00,020821,,,A*75
2021-08-02T19:40:48.901Z,1627933248.901 [NAL9602](INFO): GPS fix at 20210802T194048: (36.802944, -121.788131)
2021-08-02T19:40:48.913Z,1627933248.913 [Default:CheckIn:Read_GPS] Stopped
2021-08-02T19:40:48.913Z,1627933248.913 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-08-02T19:40:58.359Z,1627933258.359 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20210802T182047/Courier0051.lzma
2021-08-02T19:40:59.361Z,1627933259.361 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Courier0051.lzma.bak
2021-08-02T19:40:59.362Z,1627933259.362 [DataOverHttps](INFO): SBD MOMSN=15791760
2021-08-02T19:41:03.038Z,1627933263.038 [NAL9602](INFO): SBD MO Status=0, MOMSN=28645, MT Status=0, MTMSN=0
2021-08-02T19:41:03.038Z,1627933263.038 [NAL9602](INFO): No messages in MT queue
2021-08-02T19:41:17.844Z,1627933277.844 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210802T182047/Express0052.lzma
2021-08-02T19:41:18.845Z,1627933278.845 [DataOverHttps](INFO): Moved sent file to Logs/20210802T182047/Express0052.lzma.bak
2021-08-02T19:41:18.845Z,1627933278.845 [DataOverHttps](INFO): SBD MOMSN=15791809
2021-08-02T19:41:22.468Z,1627933282.468 [Default:CheckIn:Read_Iridium] Stopped
2021-08-02T19:41:22.468Z,1627933282.468 [Default:CheckIn:C.Wait] Running Loop=1
2021-08-02T19:41:22.468Z,1627933282.468 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-08-02T19:41:33.744Z,1627933293.744 [NAL9602](INFO): Not Powering down - fast GPS
2021-08-02T19:41:35.770Z,1627933295.770 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2021-08-02T19:41:35.773Z,1627933295.773 [BPC1](INFO): Received data from all battery sticks.
2021-08-02T19:46:23.022Z,1627933583.022 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-08-02T19:46:23.022Z,1627933583.022 [Default:CheckIn:C.Wait] Stopped
2021-08-02T19:46:23.022Z,1627933583.022 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-08-02T19:46:23.023Z,1627933583.023 [Default:CheckIn:D] Running Loop=1
2021-08-02T19:46:23.433Z,1627933583.433 [Default:CheckIn:D] Stopped
2021-08-02T19:46:23.433Z,1627933583.433 [Default:CheckIn:E] Running Loop=1
2021-08-02T19:46:23.844Z,1627933583.844 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 234.362142 min 
2021-08-02T19:46:23.844Z,1627933583.844 [Default:CheckIn:E] Stopped
2021-08-02T19:46:23.845Z,1627933583.845 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-08-02T19:46:23.845Z,1627933583.845 [Default:CheckIn] Stopped
2021-08-02T19:46:23.845Z,1627933583.845 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-02T19:46:23.845Z,1627933583.845 [Default:CheckIn](INFO): Running loop #41
2021-08-02T19:46:23.845Z,1627933583.845 [Default:CheckIn] Running Loop=41
2021-08-02T19:46:23.845Z,1627933583.845 [Default:CheckIn](