2022-10-27T18:14:30.124Z,1666894470.124 [CommandExec](IMPORTANT): got command restart logs 2022-10-27T18:14:46.672Z,1666894486.672 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2022-10-27T18:14:47.070Z,1666894487.070 [SBIT](IMPORTANT): SBIT PASSED 2022-10-27T18:14:47.070Z,1666894487.070 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2022-10-27T18:14:47.072Z,1666894487.072 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count; 2022-10-27T18:14:47.072Z,1666894487.072 [SBIT](IMPORTANT): CBIT.gf24Offset=143 microampere; 2022-10-27T18:14:47.072Z,1666894487.072 [SBIT](IMPORTANT): CBIT.gfScanTimeout=2 hour; 2022-10-27T18:14:47.072Z,1666894487.072 [SBIT](IMPORTANT): DAT.baud=115200 bit_per_second; 2022-10-27T18:14:47.072Z,1666894487.072 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool; 2022-10-27T18:14:47.072Z,1666894487.072 [SBIT](IMPORTANT): DAT.surfaceThreshold=0 meter; 2022-10-27T18:14:47.073Z,1666894487.073 [SBIT](IMPORTANT): DAT.verbosity=2 count; 2022-10-27T18:14:47.073Z,1666894487.073 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 0.300000 liter_per_second; 2022-10-27T18:14:47.073Z,1666894487.073 [SBIT](IMPORTANT): Express none _.adinos; 2022-10-27T18:14:47.073Z,1666894487.073 [SBIT](IMPORTANT): Express none _.aother; 2022-10-27T18:14:47.073Z,1666894487.073 [SBIT](IMPORTANT): Express linearApproximation _.dinoflagellates 10000000000.000000 none; 2022-10-27T18:14:47.073Z,1666894487.073 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=24 ampere_hour; 2022-10-27T18:14:47.073Z,1666894487.073 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=13 volt; 2022-10-27T18:14:47.073Z,1666894487.073 [SBIT](IMPORTANT): Power24vConverter.simulateHardware=0 bool; 2022-10-27T18:14:47.074Z,1666894487.074 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=1 bool; 2022-10-27T18:14:47.074Z,1666894487.074 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=220.217773 cubic_centimeter; 2022-10-27T18:14:47.074Z,1666894487.074 [SBIT](IMPORTANT): VerticalControl.massDefault=6.834666 millimeter; 2022-10-27T18:14:47.470Z,1666894487.470 [MissionManager](IMPORTANT): Started mission Startup 2022-10-27T18:14:47.470Z,1666894487.470 [Startup] Running Loop=1 2022-10-27T18:14:47.470Z,1666894487.470 [Startup](DEBUG): Aggregate::initialize Startup 2022-10-27T18:14:47.470Z,1666894487.470 [Startup:A.GoToSurface] Running Loop=1 2022-10-27T18:14:47.470Z,1666894487.470 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-10-27T18:14:47.471Z,1666894487.471 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2022-10-27T18:14:47.488Z,1666894487.488 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2022-10-27T18:14:47.488Z,1666894487.488 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2022-10-27T18:14:47.489Z,1666894487.489 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2022-10-27T18:14:47.489Z,1666894487.489 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-10-27T18:14:47.490Z,1666894487.490 [Startup:StartupSatComms] Running Loop=1 2022-10-27T18:14:47.490Z,1666894487.490 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2022-10-27T18:14:47.491Z,1666894487.491 [Startup:StartupSatComms:A] Running Loop=1 2022-10-27T18:14:47.886Z,1666894487.886 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2022-10-27T18:14:52.696Z,1666894492.696 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.655350 2022-10-27T18:15:47.714Z,1666894547.714 [Startup:StartupSatComms:A](INFO): Timed out from 2022-10-27T18:14:47.5Z 2022-10-27T18:15:47.714Z,1666894547.714 [Startup:StartupSatComms:A] Stopped 2022-10-27T18:15:47.714Z,1666894547.714 [Startup:StartupSatComms:B] Running Loop=1 2022-10-27T18:15:48.105Z,1666894548.105 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2022-10-27T18:15:56.952Z,1666894556.952 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:16:05.864Z,1666894565.864 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2022-10-27T18:16:05.864Z,1666894565.864 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2022-10-27T18:16:05.875Z,1666894565.875 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2022-10-27T18:16:06.274Z,1666894566.274 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2022-10-27T18:16:06.274Z,1666894566.274 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2022-10-27T18:16:32.112Z,1666894592.112 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:16:47.883Z,1666894607.883 [Startup:StartupSatComms:B](INFO): Timed out from 2022-10-27T18:15:47.7Z 2022-10-27T18:16:47.883Z,1666894607.883 [Startup:StartupSatComms:B] Stopped 2022-10-27T18:16:47.883Z,1666894607.883 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2022-10-27T18:16:47.883Z,1666894607.883 [Startup:StartupSatComms] Stopped 2022-10-27T18:16:47.883Z,1666894607.883 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2022-10-27T18:16:47.884Z,1666894607.884 [Startup](INFO): Completed Startup 2022-10-27T18:16:47.884Z,1666894607.884 [MissionManager](INFO): Startup is completed. 2022-10-27T18:16:47.884Z,1666894607.884 [MissionManager](INFO): Uninitializing Mission Startup 2022-10-27T18:16:47.884Z,1666894607.884 [Startup] Stopped 2022-10-27T18:16:47.884Z,1666894607.884 [Startup](DEBUG): Aggregate::uninitialize Startup 2022-10-27T18:16:47.885Z,1666894607.885 [Startup:A.GoToSurface] Stopped 2022-10-27T18:16:47.885Z,1666894607.885 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-10-27T18:16:48.262Z,1666894608.262 [MissionManager](IMPORTANT): Started mission Default 2022-10-27T18:16:48.262Z,1666894608.262 [Default] Running Loop=1 2022-10-27T18:16:48.262Z,1666894608.262 [Default](DEBUG): Aggregate::initialize Default 2022-10-27T18:16:48.262Z,1666894608.262 [Default:B.GoToSurface] Running Loop=1 2022-10-27T18:16:48.262Z,1666894608.262 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-10-27T18:16:48.262Z,1666894608.262 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2022-10-27T18:16:48.263Z,1666894608.263 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2022-10-27T18:16:48.263Z,1666894608.263 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2022-10-27T18:16:48.288Z,1666894608.288 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2022-10-27T18:16:48.289Z,1666894608.289 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-10-27T18:16:48.289Z,1666894608.289 [Default:A.Wait] Running Loop=1 2022-10-27T18:16:48.289Z,1666894608.289 [Default:A.Wait](DEBUG): Initialize Wait Component. 2022-10-27T18:17:01.638Z,1666894621.638 [Default:A.Wait](INFO): Done Waiting. 2022-10-27T18:17:01.638Z,1666894621.638 [Default:A.Wait] Stopped 2022-10-27T18:17:01.638Z,1666894621.638 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T18:17:02.036Z,1666894622.036 [Default:CheckIn] Running Loop=1 2022-10-27T18:17:02.036Z,1666894622.036 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T18:17:02.036Z,1666894622.036 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T18:17:02.421Z,1666894622.421 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2022-10-27T18:17:07.260Z,1666894627.260 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:17:42.400Z,1666894662.400 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:18:17.540Z,1666894697.540 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:18:48.237Z,1666894728.237 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2022-10-27T18:18:52.688Z,1666894732.688 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:19:06.876Z,1666894746.876 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2022-10-27T18:19:06.876Z,1666894746.876 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2022-10-27T18:19:06.899Z,1666894746.899 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2022-10-27T18:19:07.291Z,1666894747.291 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2022-10-27T18:19:07.291Z,1666894747.291 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2022-10-27T18:19:27.828Z,1666894767.828 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:20:02.975Z,1666894802.975 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:20:37.319Z,1666894837.319 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2022-10-27T18:20:37.322Z,1666894837.322 [BPC1](INFO): Received data from all battery sticks. 2022-10-27T18:20:38.127Z,1666894838.127 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:21:03.993Z,1666894863.993 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182102.00,A,3648.17300,N,12147.28525,W,0.311,0.00,271022,,,A*76 2022-10-27T18:21:04.009Z,1666894864.009 [NAL9602](INFO): GPS fix at 20221027T182102: (36.802883, -121.788088) 2022-10-27T18:21:04.057Z,1666894864.057 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T18:21:04.057Z,1666894864.057 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T18:21:04.424Z,1666894864.424 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2022-10-27T18:21:13.272Z,1666894873.272 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:21:34.688Z,1666894894.688 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response. 2022-10-27T18:21:34.767Z,1666894894.767 [NAL9602](ERROR): received: +CSQ:0 OK 2022-10-27T18:21:48.420Z,1666894908.420 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:21:54.966Z,1666894914.966 [NAL9602](INFO): SBD MO Status=1, MOMSN=21950, MT Status=0, MTMSN=0 2022-10-27T18:21:55.016Z,1666894915.016 [NAL9602](INFO): Sent 158 bytes from file Logs/20221020T195334/Courier0045.lzma 2022-10-27T18:21:55.016Z,1666894915.016 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:22:03.155Z,1666894923.155 [NAL9602](INFO): SBD MO Status=1, MOMSN=21951, MT Status=0, MTMSN=0 2022-10-27T18:22:03.210Z,1666894923.210 [NAL9602](INFO): Sent 245 bytes from file Logs/20221027T181254/Courier0000.lzma 2022-10-27T18:22:03.210Z,1666894923.210 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:22:08.894Z,1666894928.894 [NAL9602](INFO): SBD MO Status=1, MOMSN=21952, MT Status=0, MTMSN=0 2022-10-27T18:22:08.953Z,1666894928.953 [NAL9602](INFO): Sent 151 bytes from file Logs/20221027T181430/Courier0000.lzma 2022-10-27T18:22:08.953Z,1666894928.953 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:22:21.105Z,1666894941.105 [NAL9602](INFO): SBD MO Status=1, MOMSN=21953, MT Status=0, MTMSN=0 2022-10-27T18:22:21.168Z,1666894941.168 [NAL9602](INFO): Sent 284 bytes from file Logs/20221027T181430/Courier0003.lzma 2022-10-27T18:22:21.168Z,1666894941.168 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:22:23.560Z,1666894943.560 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:22:33.706Z,1666894953.706 [NAL9602](INFO): SBD MO Status=1, MOMSN=21954, MT Status=0, MTMSN=0 2022-10-27T18:22:33.764Z,1666894953.764 [NAL9602](INFO): Sent 332 bytes from file Logs/20221020T195334/Express0046.lzma 2022-10-27T18:22:33.764Z,1666894953.764 [NAL9602](INFO): Packets left to send: 1 2022-10-27T18:22:41.478Z,1666894961.478 [NAL9602](INFO): SBD MO Status=1, MOMSN=21955, MT Status=0, MTMSN=0 2022-10-27T18:22:41.540Z,1666894961.540 [NAL9602](INFO): Sent 5 bytes from file Logs/20221020T195334/Express0046.lzma 2022-10-27T18:22:41.540Z,1666894961.540 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:22:53.674Z,1666894973.674 [NAL9602](INFO): SBD MO Status=1, MOMSN=21956, MT Status=0, MTMSN=0 2022-10-27T18:22:53.732Z,1666894973.732 [NAL9602](INFO): Sent 332 bytes from file Logs/20221027T181254/Express0001.lzma 2022-10-27T18:22:53.732Z,1666894973.732 [NAL9602](INFO): Packets left to send: 1 2022-10-27T18:22:58.708Z,1666894978.708 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:23:05.038Z,1666894985.038 [NAL9602](INFO): SBD MO Status=1, MOMSN=21957, MT Status=0, MTMSN=0 2022-10-27T18:23:05.096Z,1666894985.096 [NAL9602](INFO): Sent 248 bytes from file Logs/20221027T181254/Express0001.lzma 2022-10-27T18:23:05.096Z,1666894985.096 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:23:19.670Z,1666894999.670 [NAL9602](INFO): SBD MO Status=1, MOMSN=21958, MT Status=0, MTMSN=0 2022-10-27T18:23:19.728Z,1666894999.728 [NAL9602](INFO): Sent 332 bytes from file Logs/20221027T181430/Express0001.lzma 2022-10-27T18:23:19.728Z,1666894999.728 [NAL9602](INFO): Packets left to send: 2 2022-10-27T18:23:32.234Z,1666895012.234 [NAL9602](INFO): SBD MO Status=1, MOMSN=21959, MT Status=0, MTMSN=0 2022-10-27T18:23:32.292Z,1666895012.292 [NAL9602](INFO): Sent 332 bytes from file Logs/20221027T181430/Express0001.lzma 2022-10-27T18:23:32.292Z,1666895012.292 [NAL9602](INFO): Packets left to send: 1 2022-10-27T18:23:33.848Z,1666895013.848 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:23:52.494Z,1666895032.494 [NAL9602](INFO): SBD MO Status=2, MOMSN=21960, MT Status=2, MTMSN=0 2022-10-27T18:23:52.494Z,1666895032.494 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-27T18:24:08.988Z,1666895048.988 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:24:16.022Z,1666895056.022 [NAL9602](INFO): SBD MO Status=2, MOMSN=21960, MT Status=2, MTMSN=0 2022-10-27T18:24:16.022Z,1666895056.022 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-27T18:24:40.747Z,1666895080.747 [NAL9602](INFO): SBD MO Status=2, MOMSN=21960, MT Status=2, MTMSN=0 2022-10-27T18:24:40.747Z,1666895080.747 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-27T18:24:44.132Z,1666895084.132 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:24:58.174Z,1666895098.174 [NAL9602](INFO): SBD MO Status=2, MOMSN=21960, MT Status=2, MTMSN=0 2022-10-27T18:24:58.174Z,1666895098.174 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-27T18:25:19.280Z,1666895119.280 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:25:21.690Z,1666895121.690 [NAL9602](INFO): SBD MO Status=1, MOMSN=21960, MT Status=0, MTMSN=0 2022-10-27T18:25:21.740Z,1666895121.740 [NAL9602](INFO): Sent 94 bytes from file Logs/20221027T181430/Express0001.lzma 2022-10-27T18:25:21.740Z,1666895121.740 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:25:30.658Z,1666895130.658 [NAL9602](INFO): SBD MO Status=1, MOMSN=21961, MT Status=0, MTMSN=0 2022-10-27T18:25:30.720Z,1666895130.720 [NAL9602](INFO): Sent 312 bytes from file Logs/20221027T181430/Express0004.lzma 2022-10-27T18:25:30.720Z,1666895130.720 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:25:37.123Z,1666895137.123 [NAL9602](INFO): SBD MO Status=0, MOMSN=21962, MT Status=0, MTMSN=0 2022-10-27T18:25:37.212Z,1666895137.212 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T18:25:37.212Z,1666895137.212 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T18:25:37.212Z,1666895137.212 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T18:25:54.420Z,1666895154.420 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:26:07.824Z,1666895167.824 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T18:26:29.568Z,1666895189.568 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:27:04.708Z,1666895224.708 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:27:39.888Z,1666895259.888 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:28:06.620Z,1666895286.620 [CBIT](INFO): Clearing failed state for component DropWeight 2022-10-27T18:28:06.620Z,1666895286.620 [DropWeight] No Fault, FailCount= 1 2022-10-27T18:28:15.036Z,1666895295.036 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:28:50.191Z,1666895330.191 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:29:25.332Z,1666895365.332 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:30:00.487Z,1666895400.487 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:30:35.630Z,1666895435.630 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:30:37.731Z,1666895437.731 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T18:30:37.731Z,1666895437.731 [Default:CheckIn:C.Wait] Stopped 2022-10-27T18:30:37.731Z,1666895437.731 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T18:30:37.731Z,1666895437.731 [Default:CheckIn:D] Running Loop=1 2022-10-27T18:30:38.108Z,1666895438.108 [Default:CheckIn:D] Stopped 2022-10-27T18:30:38.108Z,1666895438.108 [Default:CheckIn:E] Running Loop=1 2022-10-27T18:30:38.518Z,1666895438.518 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.830768 min 2022-10-27T18:30:38.518Z,1666895438.518 [Default:CheckIn:E] Stopped 2022-10-27T18:30:38.518Z,1666895438.518 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T18:30:38.518Z,1666895438.518 [Default:CheckIn] Stopped 2022-10-27T18:30:38.518Z,1666895438.518 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T18:30:38.518Z,1666895438.518 [Default:CheckIn](INFO): Running loop #2 2022-10-27T18:30:38.518Z,1666895438.518 [Default:CheckIn] Running Loop=2 2022-10-27T18:30:38.519Z,1666895438.519 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T18:30:38.519Z,1666895438.519 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T18:30:40.521Z,1666895440.521 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183038.00,A,3648.17756,N,12147.28275,W,0.039,15.96,271022,,,A*48 2022-10-27T18:30:40.524Z,1666895440.524 [NAL9602](INFO): GPS fix at 20221027T183038: (36.802959, -121.788046) 2022-10-27T18:30:40.560Z,1666895440.560 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T18:30:40.560Z,1666895440.560 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T18:30:55.942Z,1666895455.942 [NAL9602](INFO): SBD MO Status=1, MOMSN=21963, MT Status=0, MTMSN=0 2022-10-27T18:30:55.992Z,1666895455.992 [NAL9602](INFO): Sent 74 bytes from file Logs/20221027T181430/Courier0006.lzma 2022-10-27T18:30:55.992Z,1666895455.992 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:31:08.527Z,1666895468.527 [NAL9602](INFO): SBD MO Status=1, MOMSN=21964, MT Status=0, MTMSN=0 2022-10-27T18:31:08.575Z,1666895468.575 [NAL9602](INFO): Sent 161 bytes from file Logs/20221027T181430/Express0007.lzma 2022-10-27T18:31:08.576Z,1666895468.576 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:31:10.776Z,1666895470.776 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:31:14.182Z,1666895474.182 [NAL9602](INFO): SBD MO Status=0, MOMSN=21965, MT Status=0, MTMSN=0 2022-10-27T18:31:14.292Z,1666895474.292 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T18:31:14.292Z,1666895474.292 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T18:31:14.292Z,1666895474.292 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T18:31:44.888Z,1666895504.888 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T18:31:45.916Z,1666895505.916 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:32:21.064Z,1666895541.064 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:32:56.212Z,1666895576.212 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:33:31.364Z,1666895611.364 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:34:06.504Z,1666895646.504 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:34:41.645Z,1666895681.645 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:35:16.784Z,1666895716.784 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:35:51.940Z,1666895751.940 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:36:14.778Z,1666895774.778 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T18:36:14.778Z,1666895774.778 [Default:CheckIn:C.Wait] Stopped 2022-10-27T18:36:14.779Z,1666895774.779 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T18:36:14.779Z,1666895774.779 [Default:CheckIn:D] Running Loop=1 2022-10-27T18:36:15.178Z,1666895775.178 [Default:CheckIn:D] Stopped 2022-10-27T18:36:15.179Z,1666895775.179 [Default:CheckIn:E] Running Loop=1 2022-10-27T18:36:15.580Z,1666895775.580 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 19.448610 min 2022-10-27T18:36:15.581Z,1666895775.581 [Default:CheckIn:E] Stopped 2022-10-27T18:36:15.581Z,1666895775.581 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T18:36:15.581Z,1666895775.581 [Default:CheckIn] Stopped 2022-10-27T18:36:15.582Z,1666895775.582 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T18:36:15.582Z,1666895775.582 [Default:CheckIn](INFO): Running loop #3 2022-10-27T18:36:15.582Z,1666895775.582 [Default:CheckIn] Running Loop=3 2022-10-27T18:36:15.583Z,1666895775.583 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T18:36:15.583Z,1666895775.583 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T18:36:17.589Z,1666895777.589 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183616.00,A,3648.17532,N,12147.28350,W,0.078,15.96,271022,,,A*41 2022-10-27T18:36:17.602Z,1666895777.602 [NAL9602](INFO): GPS fix at 20221027T183616: (36.802922, -121.788058) 2022-10-27T18:36:17.673Z,1666895777.673 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T18:36:17.673Z,1666895777.673 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T18:36:27.080Z,1666895787.080 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:36:33.009Z,1666895793.009 [NAL9602](INFO): SBD MO Status=1, MOMSN=21966, MT Status=0, MTMSN=0 2022-10-27T18:36:33.064Z,1666895793.064 [NAL9602](INFO): Sent 73 bytes from file Logs/20221027T181430/Courier0009.lzma 2022-10-27T18:36:33.064Z,1666895793.064 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:36:44.810Z,1666895804.810 [NAL9602](INFO): SBD MO Status=1, MOMSN=21967, MT Status=0, MTMSN=0 2022-10-27T18:36:44.868Z,1666895804.868 [NAL9602](INFO): Sent 130 bytes from file Logs/20221027T181430/Express0010.lzma 2022-10-27T18:36:44.868Z,1666895804.868 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:36:52.082Z,1666895812.082 [NAL9602](INFO): SBD MO Status=0, MOMSN=21968, MT Status=0, MTMSN=0 2022-10-27T18:36:52.161Z,1666895812.161 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T18:36:52.161Z,1666895812.161 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T18:36:52.161Z,1666895812.161 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T18:37:02.220Z,1666895822.220 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:37:22.780Z,1666895842.780 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T18:37:37.380Z,1666895857.380 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:38:12.520Z,1666895892.520 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:38:47.661Z,1666895927.661 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:39:22.804Z,1666895962.804 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:39:57.943Z,1666895997.943 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:40:33.084Z,1666896033.084 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:41:08.224Z,1666896068.224 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:41:43.364Z,1666896103.364 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:41:52.668Z,1666896112.668 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T18:41:52.668Z,1666896112.668 [Default:CheckIn:C.Wait] Stopped 2022-10-27T18:41:52.668Z,1666896112.668 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T18:41:52.668Z,1666896112.668 [Default:CheckIn:D] Running Loop=1 2022-10-27T18:41:53.071Z,1666896113.071 [Default:CheckIn:D] Stopped 2022-10-27T18:41:53.071Z,1666896113.071 [Default:CheckIn:E] Running Loop=1 2022-10-27T18:41:53.477Z,1666896113.477 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.080153 min 2022-10-27T18:41:53.477Z,1666896113.477 [Default:CheckIn:E] Stopped 2022-10-27T18:41:53.477Z,1666896113.477 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T18:41:53.477Z,1666896113.477 [Default:CheckIn] Stopped 2022-10-27T18:41:53.477Z,1666896113.477 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T18:41:53.477Z,1666896113.477 [Default:CheckIn](INFO): Running loop #4 2022-10-27T18:41:53.477Z,1666896113.477 [Default:CheckIn] Running Loop=4 2022-10-27T18:41:53.477Z,1666896113.477 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T18:41:53.477Z,1666896113.477 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T18:41:55.494Z,1666896115.494 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184154.00,A,3648.17794,N,12147.28281,W,0.058,15.96,271022,,,A*46 2022-10-27T18:41:55.497Z,1666896115.497 [NAL9602](INFO): GPS fix at 20221027T184154: (36.802966, -121.788047) 2022-10-27T18:41:55.508Z,1666896115.508 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T18:41:55.508Z,1666896115.508 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T18:42:18.504Z,1666896138.504 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:42:21.042Z,1666896141.042 [NAL9602](INFO): SBD MO Status=1, MOMSN=21969, MT Status=0, MTMSN=0 2022-10-27T18:42:21.092Z,1666896141.092 [NAL9602](INFO): Sent 74 bytes from file Logs/20221027T181430/Courier0012.lzma 2022-10-27T18:42:21.092Z,1666896141.092 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:42:38.100Z,1666896158.100 [NAL9602](INFO): SBD MO Status=2, MOMSN=21970, MT Status=2, MTMSN=0 2022-10-27T18:42:38.100Z,1666896158.100 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-27T18:42:53.644Z,1666896173.644 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:43:07.262Z,1666896187.262 [NAL9602](INFO): SBD MO Status=1, MOMSN=21970, MT Status=0, MTMSN=0 2022-10-27T18:43:07.312Z,1666896187.312 [NAL9602](INFO): Sent 130 bytes from file Logs/20221027T181430/Express0013.lzma 2022-10-27T18:43:07.312Z,1666896187.312 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:43:27.850Z,1666896207.850 [NAL9602](INFO): SBD MO Status=2, MOMSN=21971, MT Status=2, MTMSN=0 2022-10-27T18:43:27.851Z,1666896207.851 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-27T18:43:28.788Z,1666896208.788 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:43:32.789Z,1666896212.789 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2022-10-27T18:43:36.028Z,1666896216.028 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2022-10-27T18:43:44.095Z,1666896224.095 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2022-10-27T18:44:03.928Z,1666896243.928 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:44:07.846Z,1666896247.846 [NAL9602](INFO): SBD MO Status=2, MOMSN=21971, MT Status=2, MTMSN=0 2022-10-27T18:44:07.846Z,1666896247.846 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-27T18:44:28.454Z,1666896268.454 [NAL9602](INFO): SBD MO Status=2, MOMSN=21971, MT Status=2, MTMSN=0 2022-10-27T18:44:28.454Z,1666896268.454 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-27T18:44:39.088Z,1666896279.088 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:44:39.367Z,1666896279.367 [NAL9602](INFO): SBD MO Status=0, MOMSN=21971, MT Status=0, MTMSN=0 2022-10-27T18:44:39.449Z,1666896279.449 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T18:44:39.449Z,1666896279.449 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T18:44:39.449Z,1666896279.449 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T18:45:10.060Z,1666896310.060 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T18:45:14.228Z,1666896314.228 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:45:49.368Z,1666896349.368 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:46:24.508Z,1666896384.508 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:46:59.653Z,1666896419.653 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:47:34.796Z,1666896454.796 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:48:09.944Z,1666896489.944 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:48:45.088Z,1666896525.088 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:49:20.228Z,1666896560.228 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:49:39.974Z,1666896579.974 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T18:49:39.974Z,1666896579.974 [Default:CheckIn:C.Wait] Stopped 2022-10-27T18:49:39.974Z,1666896579.974 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T18:49:39.974Z,1666896579.974 [Default:CheckIn:D] Running Loop=1 2022-10-27T18:49:40.351Z,1666896580.351 [Default:CheckIn:D] Stopped 2022-10-27T18:49:40.351Z,1666896580.351 [Default:CheckIn:E] Running Loop=1 2022-10-27T18:49:40.752Z,1666896580.752 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.868158 min 2022-10-27T18:49:40.752Z,1666896580.752 [Default:CheckIn:E] Stopped 2022-10-27T18:49:40.753Z,1666896580.753 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T18:49:40.753Z,1666896580.753 [Default:CheckIn] Stopped 2022-10-27T18:49:40.753Z,1666896580.753 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T18:49:40.753Z,1666896580.753 [Default:CheckIn](INFO): Running loop #5 2022-10-27T18:49:40.753Z,1666896580.753 [Default:CheckIn] Running Loop=5 2022-10-27T18:49:40.753Z,1666896580.753 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T18:49:40.753Z,1666896580.753 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T18:49:42.772Z,1666896582.772 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184942.00,A,3648.17579,N,12147.28256,W,0.019,0.00,271022,,,A*7C 2022-10-27T18:49:42.774Z,1666896582.774 [NAL9602](INFO): GPS fix at 20221027T184942: (36.802930, -121.788043) 2022-10-27T18:49:42.786Z,1666896582.786 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T18:49:42.786Z,1666896582.786 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T18:49:55.384Z,1666896595.384 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:49:59.794Z,1666896599.794 [NAL9602](INFO): SBD MO Status=1, MOMSN=21972, MT Status=0, MTMSN=0 2022-10-27T18:49:59.852Z,1666896599.852 [NAL9602](INFO): Sent 74 bytes from file Logs/20221027T181430/Courier0015.lzma 2022-10-27T18:49:59.852Z,1666896599.852 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:50:07.546Z,1666896607.546 [NAL9602](INFO): SBD MO Status=1, MOMSN=21973, MT Status=0, MTMSN=0 2022-10-27T18:50:07.604Z,1666896607.604 [NAL9602](INFO): Sent 129 bytes from file Logs/20221027T181430/Express0016.lzma 2022-10-27T18:50:07.605Z,1666896607.605 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:50:11.186Z,1666896611.186 [NAL9602](INFO): SBD MO Status=0, MOMSN=21974, MT Status=0, MTMSN=0 2022-10-27T18:50:11.278Z,1666896611.278 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T18:50:11.278Z,1666896611.278 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T18:50:11.278Z,1666896611.278 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T18:50:30.524Z,1666896630.524 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:50:41.883Z,1666896641.883 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T18:51:05.665Z,1666896665.665 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:51:40.820Z,1666896700.820 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:52:15.984Z,1666896735.984 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:52:47.949Z,1666896767.949 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-27T18:52:51.124Z,1666896771.124 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:53:26.272Z,1666896806.272 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:54:01.412Z,1666896841.412 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:54:36.552Z,1666896876.552 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:55:11.692Z,1666896911.692 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:55:11.796Z,1666896911.796 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T18:55:11.796Z,1666896911.796 [Default:CheckIn:C.Wait] Stopped 2022-10-27T18:55:11.796Z,1666896911.796 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T18:55:11.796Z,1666896911.796 [Default:CheckIn:D] Running Loop=1 2022-10-27T18:55:12.173Z,1666896912.173 [Default:CheckIn:D] Stopped 2022-10-27T18:55:12.173Z,1666896912.173 [Default:CheckIn:E] Running Loop=1 2022-10-27T18:55:12.577Z,1666896912.577 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 38.398523 min 2022-10-27T18:55:12.577Z,1666896912.577 [Default:CheckIn:E] Stopped 2022-10-27T18:55:12.577Z,1666896912.577 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T18:55:12.577Z,1666896912.577 [Default:CheckIn] Stopped 2022-10-27T18:55:12.578Z,1666896912.578 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T18:55:12.578Z,1666896912.578 [Default:CheckIn](INFO): Running loop #6 2022-10-27T18:55:12.578Z,1666896912.578 [Default:CheckIn] Running Loop=6 2022-10-27T18:55:12.578Z,1666896912.578 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T18:55:12.578Z,1666896912.578 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T18:55:14.586Z,1666896914.586 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185513.00,A,3648.17638,N,12147.28284,W,0.019,0.00,271022,,,A*7C 2022-10-27T18:55:14.597Z,1666896914.597 [NAL9602](INFO): GPS fix at 20221027T185513: (36.802940, -121.788047) 2022-10-27T18:55:14.608Z,1666896914.608 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T18:55:14.608Z,1666896914.608 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T18:55:43.346Z,1666896943.346 [NAL9602](INFO): SBD MO Status=1, MOMSN=21975, MT Status=0, MTMSN=0 2022-10-27T18:55:43.404Z,1666896943.404 [NAL9602](INFO): Sent 74 bytes from file Logs/20221027T181430/Courier0018.lzma 2022-10-27T18:55:43.404Z,1666896943.404 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:55:46.836Z,1666896946.836 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:55:59.565Z,1666896959.565 [NAL9602](INFO): SBD MO Status=2, MOMSN=21976, MT Status=2, MTMSN=0 2022-10-27T18:55:59.565Z,1666896959.565 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-27T18:56:17.398Z,1666896977.398 [NAL9602](INFO): SBD MO Status=1, MOMSN=21976, MT Status=0, MTMSN=0 2022-10-27T18:56:17.456Z,1666896977.456 [NAL9602](INFO): Sent 129 bytes from file Logs/20221027T181430/Express0019.lzma 2022-10-27T18:56:17.456Z,1666896977.456 [NAL9602](INFO): Packets left to send: 0 2022-10-27T18:56:21.976Z,1666896981.976 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:56:37.600Z,1666896997.600 [NAL9602](INFO): SBD MO Status=0, MOMSN=21977, MT Status=0, MTMSN=0 2022-10-27T18:56:37.724Z,1666896997.724 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T18:56:37.724Z,1666896997.724 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T18:56:37.724Z,1666896997.724 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T18:56:57.116Z,1666897017.116 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:57:08.300Z,1666897028.300 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T18:57:32.256Z,1666897052.256 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:58:07.396Z,1666897087.396 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:58:08.092Z,1666897088.092 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2022-10-27T18:58:08.092Z,1666897088.092 [DropWeight] Hardware Fault, FailCount= 1 2022-10-27T18:58:08.092Z,1666897088.092 [DropWeight](ERROR): Hardware Fault 2022-10-27T18:58:08.110Z,1666897088.110 [CBIT](INFO): Critical error at 20221027T185808 2022-10-27T18:58:08.113Z,1666897088.113 [CBIT](ERROR): Hardware Fault in component: DropWeight 2022-10-27T18:58:08.113Z,1666897088.113 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2022-10-27T18:58:08.517Z,1666897088.517 [CBIT](INFO): Critical error at 20221027T185808 2022-10-27T18:58:42.536Z,1666897122.536 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:59:17.684Z,1666897157.684 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T18:59:52.824Z,1666897192.824 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:00:27.964Z,1666897227.964 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:01:03.108Z,1666897263.108 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:01:38.186Z,1666897298.186 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T19:01:38.186Z,1666897298.186 [Default:CheckIn:C.Wait] Stopped 2022-10-27T19:01:38.186Z,1666897298.186 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T19:01:38.186Z,1666897298.186 [Default:CheckIn:D] Running Loop=1 2022-10-27T19:01:38.248Z,1666897298.248 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:01:38.587Z,1666897298.587 [Default:CheckIn:D] Stopped 2022-10-27T19:01:38.587Z,1666897298.587 [Default:CheckIn:E] Running Loop=1 2022-10-27T19:01:38.991Z,1666897298.991 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.838749 min 2022-10-27T19:01:38.991Z,1666897298.991 [Default:CheckIn:E] Stopped 2022-10-27T19:01:38.992Z,1666897298.992 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T19:01:38.992Z,1666897298.992 [Default:CheckIn] Stopped 2022-10-27T19:01:38.992Z,1666897298.992 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T19:01:38.992Z,1666897298.992 [Default:CheckIn](INFO): Running loop #7 2022-10-27T19:01:38.992Z,1666897298.992 [Default:CheckIn] Running Loop=7 2022-10-27T19:01:38.992Z,1666897298.992 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T19:01:38.992Z,1666897298.992 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T19:01:41.008Z,1666897301.008 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190140.00,A,3648.17708,N,12147.28274,W,0.019,0.00,271022,,,A*77 2022-10-27T19:01:41.010Z,1666897301.010 [NAL9602](INFO): GPS fix at 20221027T190140: (36.802951, -121.788046) 2022-10-27T19:01:41.022Z,1666897301.022 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T19:01:41.022Z,1666897301.022 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T19:02:03.308Z,1666897323.308 [NAL9602](INFO): SBD MO Status=1, MOMSN=21978, MT Status=0, MTMSN=0 2022-10-27T19:02:03.358Z,1666897323.358 [NAL9602](INFO): Sent 181 bytes from file Logs/20221027T181430/Courier0021.lzma 2022-10-27T19:02:03.358Z,1666897323.358 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:02:13.388Z,1666897333.388 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:02:13.490Z,1666897333.490 [NAL9602](INFO): SBD MO Status=1, MOMSN=21979, MT Status=0, MTMSN=0 2022-10-27T19:02:13.544Z,1666897333.544 [NAL9602](INFO): Sent 129 bytes from file Logs/20221027T181430/Express0022.lzma 2022-10-27T19:02:13.544Z,1666897333.544 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:02:31.266Z,1666897351.266 [NAL9602](INFO): SBD MO Status=2, MOMSN=21980, MT Status=2, MTMSN=0 2022-10-27T19:02:31.266Z,1666897351.266 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-27T19:02:45.008Z,1666897365.008 [NAL9602](INFO): SBD MO Status=0, MOMSN=21980, MT Status=0, MTMSN=0 2022-10-27T19:02:45.092Z,1666897365.092 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T19:02:45.092Z,1666897365.092 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T19:02:45.092Z,1666897365.092 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T19:02:48.528Z,1666897368.528 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:03:15.698Z,1666897395.698 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T19:03:23.668Z,1666897403.668 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:03:58.816Z,1666897438.816 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:04:33.972Z,1666897473.972 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:05:09.116Z,1666897509.116 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:05:44.256Z,1666897544.256 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:06:19.404Z,1666897579.404 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:06:54.544Z,1666897614.544 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:07:29.684Z,1666897649.684 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:07:45.605Z,1666897665.605 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T19:07:45.605Z,1666897665.605 [Default:CheckIn:C.Wait] Stopped 2022-10-27T19:07:45.605Z,1666897665.605 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T19:07:45.605Z,1666897665.605 [Default:CheckIn:D] Running Loop=1 2022-10-27T19:07:46.020Z,1666897666.020 [Default:CheckIn:D] Stopped 2022-10-27T19:07:46.020Z,1666897666.020 [Default:CheckIn:E] Running Loop=1 2022-10-27T19:07:46.403Z,1666897666.403 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.962630 min 2022-10-27T19:07:46.403Z,1666897666.403 [Default:CheckIn:E] Stopped 2022-10-27T19:07:46.403Z,1666897666.403 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T19:07:46.403Z,1666897666.403 [Default:CheckIn] Stopped 2022-10-27T19:07:46.403Z,1666897666.403 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T19:07:46.403Z,1666897666.403 [Default:CheckIn](INFO): Running loop #8 2022-10-27T19:07:46.404Z,1666897666.404 [Default:CheckIn] Running Loop=8 2022-10-27T19:07:46.404Z,1666897666.404 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T19:07:46.404Z,1666897666.404 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T19:07:48.419Z,1666897668.419 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190747.00,A,3648.17524,N,12147.28246,W,0.058,0.00,271022,,,A*7E 2022-10-27T19:07:48.421Z,1666897668.421 [NAL9602](INFO): GPS fix at 20221027T190747: (36.802921, -121.788041) 2022-10-27T19:07:48.433Z,1666897668.433 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T19:07:48.433Z,1666897668.433 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T19:08:04.270Z,1666897684.270 [NAL9602](INFO): SBD MO Status=1, MOMSN=21981, MT Status=0, MTMSN=0 2022-10-27T19:08:04.320Z,1666897684.320 [NAL9602](INFO): Sent 73 bytes from file Logs/20221027T181430/Courier0024.lzma 2022-10-27T19:08:04.320Z,1666897684.320 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:08:04.824Z,1666897684.824 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:08:14.839Z,1666897694.839 [NAL9602](INFO): SBD MO Status=1, MOMSN=21982, MT Status=0, MTMSN=0 2022-10-27T19:08:14.892Z,1666897694.892 [NAL9602](INFO): Sent 131 bytes from file Logs/20221027T181430/Express0025.lzma 2022-10-27T19:08:14.892Z,1666897694.892 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:08:21.711Z,1666897701.711 [NAL9602](INFO): SBD MO Status=0, MOMSN=21983, MT Status=0, MTMSN=0 2022-10-27T19:08:21.809Z,1666897701.809 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T19:08:21.809Z,1666897701.809 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T19:08:21.810Z,1666897701.810 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T19:08:39.980Z,1666897719.980 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:08:52.408Z,1666897732.408 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T19:09:15.120Z,1666897755.120 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:09:50.268Z,1666897790.268 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:10:25.408Z,1666897825.408 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:11:00.548Z,1666897860.548 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:11:35.688Z,1666897895.688 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:12:10.827Z,1666897930.827 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:12:45.968Z,1666897965.968 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:13:08.178Z,1666897988.178 [CBIT](INFO): Clearing failed state for component DropWeight 2022-10-27T19:13:08.178Z,1666897988.178 [DropWeight] No Fault, FailCount= 1 2022-10-27T19:13:21.120Z,1666898001.120 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:13:22.305Z,1666898002.305 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T19:13:22.305Z,1666898002.305 [Default:CheckIn:C.Wait] Stopped 2022-10-27T19:13:22.305Z,1666898002.305 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T19:13:22.305Z,1666898002.305 [Default:CheckIn:D] Running Loop=1 2022-10-27T19:13:22.695Z,1666898002.695 [Default:CheckIn:D] Stopped 2022-10-27T19:13:22.695Z,1666898002.695 [Default:CheckIn:E] Running Loop=1 2022-10-27T19:13:23.100Z,1666898003.100 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 56.573877 min 2022-10-27T19:13:23.100Z,1666898003.100 [Default:CheckIn:E] Stopped 2022-10-27T19:13:23.100Z,1666898003.100 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T19:13:23.100Z,1666898003.100 [Default:CheckIn] Stopped 2022-10-27T19:13:23.100Z,1666898003.100 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T19:13:23.101Z,1666898003.101 [Default:CheckIn](INFO): Running loop #9 2022-10-27T19:13:23.101Z,1666898003.101 [Default:CheckIn] Running Loop=9 2022-10-27T19:13:23.101Z,1666898003.101 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T19:13:23.101Z,1666898003.101 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T19:13:25.110Z,1666898005.110 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191324.00,A,3648.17596,N,12147.28456,W,0.019,0.00,271022,,,A*75 2022-10-27T19:13:25.113Z,1666898005.113 [NAL9602](INFO): GPS fix at 20221027T191324: (36.802933, -121.788076) 2022-10-27T19:13:25.123Z,1666898005.123 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T19:13:25.123Z,1666898005.123 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T19:13:40.141Z,1666898020.141 [NAL9602](INFO): SBD MO Status=1, MOMSN=21984, MT Status=0, MTMSN=0 2022-10-27T19:13:40.192Z,1666898020.192 [NAL9602](INFO): Sent 73 bytes from file Logs/20221027T181430/Courier0027.lzma 2022-10-27T19:13:40.192Z,1666898020.192 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:13:49.909Z,1666898029.909 [NAL9602](INFO): SBD MO Status=1, MOMSN=21985, MT Status=0, MTMSN=0 2022-10-27T19:13:49.960Z,1666898029.960 [NAL9602](INFO): Sent 129 bytes from file Logs/20221027T181430/Express0028.lzma 2022-10-27T19:13:49.960Z,1666898029.960 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:13:56.268Z,1666898036.268 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:14:10.114Z,1666898050.114 [NAL9602](INFO): SBD MO Status=0, MOMSN=21986, MT Status=0, MTMSN=0 2022-10-27T19:14:10.234Z,1666898050.234 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T19:14:10.234Z,1666898050.234 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T19:14:10.234Z,1666898050.234 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T19:14:31.427Z,1666898071.427 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:14:40.816Z,1666898080.816 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T19:15:06.575Z,1666898106.575 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:15:41.715Z,1666898141.715 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:16:16.856Z,1666898176.856 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:16:51.995Z,1666898211.995 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:17:27.156Z,1666898247.156 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:18:02.296Z,1666898282.296 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:18:37.436Z,1666898317.436 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:19:10.708Z,1666898350.708 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T19:19:10.708Z,1666898350.708 [Default:CheckIn:C.Wait] Stopped 2022-10-27T19:19:10.708Z,1666898350.708 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T19:19:10.708Z,1666898350.708 [Default:CheckIn:D] Running Loop=1 2022-10-27T19:19:11.118Z,1666898351.118 [Default:CheckIn:D] Stopped 2022-10-27T19:19:11.118Z,1666898351.118 [Default:CheckIn:E] Running Loop=1 2022-10-27T19:19:11.526Z,1666898351.526 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 62.380933 min 2022-10-27T19:19:11.526Z,1666898351.526 [Default:CheckIn:E] Stopped 2022-10-27T19:19:11.526Z,1666898351.526 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T19:19:11.526Z,1666898351.526 [Default:CheckIn] Stopped 2022-10-27T19:19:11.526Z,1666898351.526 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T19:19:11.526Z,1666898351.526 [Default:CheckIn](INFO): Running loop #10 2022-10-27T19:19:11.527Z,1666898351.527 [Default:CheckIn] Running Loop=10 2022-10-27T19:19:11.527Z,1666898351.527 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T19:19:11.527Z,1666898351.527 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T19:19:12.576Z,1666898352.576 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:19:13.518Z,1666898353.518 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191912.00,A,3648.17639,N,12147.28424,W,0.000,0.00,271022,,,A*71 2022-10-27T19:19:13.521Z,1666898353.521 [NAL9602](INFO): GPS fix at 20221027T191912: (36.802940, -121.788071) 2022-10-27T19:19:13.532Z,1666898353.532 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T19:19:13.532Z,1666898353.532 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T19:19:26.923Z,1666898366.923 [NAL9602](INFO): SBD MO Status=1, MOMSN=21987, MT Status=0, MTMSN=0 2022-10-27T19:19:26.980Z,1666898366.980 [NAL9602](INFO): Sent 73 bytes from file Logs/20221027T181430/Courier0030.lzma 2022-10-27T19:19:26.980Z,1666898366.980 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:19:36.314Z,1666898376.314 [NAL9602](INFO): SBD MO Status=1, MOMSN=21988, MT Status=0, MTMSN=0 2022-10-27T19:19:36.375Z,1666898376.375 [NAL9602](INFO): Sent 129 bytes from file Logs/20221027T181430/Express0031.lzma 2022-10-27T19:19:36.375Z,1666898376.375 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:19:44.395Z,1666898384.395 [NAL9602](INFO): SBD MO Status=0, MOMSN=21989, MT Status=0, MTMSN=0 2022-10-27T19:19:44.477Z,1666898384.477 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T19:19:44.477Z,1666898384.477 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T19:19:44.477Z,1666898384.477 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T19:19:47.716Z,1666898387.716 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:20:15.105Z,1666898415.105 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T19:20:22.860Z,1666898422.860 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:20:58.000Z,1666898458.000 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:21:33.152Z,1666898493.152 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:22:08.296Z,1666898528.296 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:22:43.448Z,1666898563.448 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:23:18.604Z,1666898598.604 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:23:53.760Z,1666898633.760 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:24:28.904Z,1666898668.904 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:24:44.991Z,1666898684.991 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T19:24:44.991Z,1666898684.991 [Default:CheckIn:C.Wait] Stopped 2022-10-27T19:24:44.991Z,1666898684.991 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T19:24:44.991Z,1666898684.991 [Default:CheckIn:D] Running Loop=1 2022-10-27T19:24:45.395Z,1666898685.395 [Default:CheckIn:D] Stopped 2022-10-27T19:24:45.395Z,1666898685.395 [Default:CheckIn:E] Running Loop=1 2022-10-27T19:24:45.820Z,1666898685.820 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 67.952218 min 2022-10-27T19:24:45.821Z,1666898685.821 [Default:CheckIn:E] Stopped 2022-10-27T19:24:45.821Z,1666898685.821 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T19:24:45.821Z,1666898685.821 [Default:CheckIn] Stopped 2022-10-27T19:24:45.821Z,1666898685.821 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T19:24:45.821Z,1666898685.821 [Default:CheckIn](INFO): Running loop #11 2022-10-27T19:24:45.821Z,1666898685.821 [Default:CheckIn] Running Loop=11 2022-10-27T19:24:45.821Z,1666898685.821 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T19:24:45.821Z,1666898685.821 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T19:24:47.810Z,1666898687.810 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192447.00,A,3648.17686,N,12147.28346,W,0.019,0.00,271022,,,A*70 2022-10-27T19:24:47.813Z,1666898687.813 [NAL9602](INFO): GPS fix at 20221027T192447: (36.802948, -121.788058) 2022-10-27T19:24:47.860Z,1666898687.860 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T19:24:47.860Z,1666898687.860 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T19:25:02.432Z,1666898702.432 [NAL9602](INFO): SBD MO Status=1, MOMSN=21990, MT Status=0, MTMSN=0 2022-10-27T19:25:02.492Z,1666898702.492 [NAL9602](INFO): Sent 74 bytes from file Logs/20221027T181430/Courier0033.lzma 2022-10-27T19:25:02.492Z,1666898702.492 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:25:04.052Z,1666898704.052 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:25:13.422Z,1666898713.422 [NAL9602](INFO): SBD MO Status=1, MOMSN=21991, MT Status=0, MTMSN=0 2022-10-27T19:25:13.472Z,1666898713.472 [NAL9602](INFO): Sent 131 bytes from file Logs/20221027T181430/Express0034.lzma 2022-10-27T19:25:13.472Z,1666898713.472 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:25:31.200Z,1666898731.200 [NAL9602](INFO): SBD MO Status=2, MOMSN=21992, MT Status=2, MTMSN=0 2022-10-27T19:25:31.201Z,1666898731.201 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-27T19:25:36.162Z,1666898736.162 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2022-10-27T19:25:38.166Z,1666898738.166 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2022-10-27T19:25:39.208Z,1666898739.208 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:25:42.280Z,1666898742.280 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2022-10-27T19:25:56.666Z,1666898756.666 [NAL9602](INFO): SBD MO Status=0, MOMSN=21992, MT Status=0, MTMSN=0 2022-10-27T19:25:56.745Z,1666898756.745 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T19:25:56.745Z,1666898756.745 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T19:25:56.745Z,1666898756.745 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T19:26:14.352Z,1666898774.352 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:26:27.361Z,1666898787.361 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T19:26:49.492Z,1666898809.492 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:26:56.853Z,1666898816.853 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2022-10-27T19:27:24.640Z,1666898844.640 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:27:59.792Z,1666898879.792 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:28:05.127Z,1666898885.127 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6. 2022-10-27T19:28:05.129Z,1666898885.129 [BPC1](INFO): Received data from all battery sticks. 2022-10-27T19:28:34.931Z,1666898914.931 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:29:10.088Z,1666898950.088 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:29:45.228Z,1666898985.228 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:30:20.368Z,1666899020.368 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:30:55.516Z,1666899055.516 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:30:57.235Z,1666899057.235 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T19:30:57.235Z,1666899057.235 [Default:CheckIn:C.Wait] Stopped 2022-10-27T19:30:57.235Z,1666899057.235 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T19:30:57.235Z,1666899057.235 [Default:CheckIn:D] Running Loop=1 2022-10-27T19:30:57.785Z,1666899057.785 [Default:CheckIn:D] Stopped 2022-10-27T19:30:57.785Z,1666899057.785 [Default:CheckIn:E] Running Loop=1 2022-10-27T19:30:58.053Z,1666899058.053 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 74.158724 min 2022-10-27T19:30:58.053Z,1666899058.053 [Default:CheckIn:E] Stopped 2022-10-27T19:30:58.053Z,1666899058.053 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T19:30:58.053Z,1666899058.053 [Default:CheckIn] Stopped 2022-10-27T19:30:58.053Z,1666899058.053 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T19:30:58.054Z,1666899058.054 [Default:CheckIn](INFO): Running loop #12 2022-10-27T19:30:58.054Z,1666899058.054 [Default:CheckIn] Running Loop=12 2022-10-27T19:30:58.054Z,1666899058.054 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T19:30:58.054Z,1666899058.054 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T19:31:00.092Z,1666899060.092 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193059.00,A,3648.17539,N,12147.28264,W,0.019,0.00,271022,,,A*7C 2022-10-27T19:31:00.094Z,1666899060.094 [NAL9602](INFO): GPS fix at 20221027T193059: (36.802923, -121.788044) 2022-10-27T19:31:00.114Z,1666899060.114 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T19:31:00.114Z,1666899060.114 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T19:31:24.398Z,1666899084.398 [NAL9602](INFO): SBD MO Status=1, MOMSN=21993, MT Status=0, MTMSN=0 2022-10-27T19:31:24.448Z,1666899084.448 [NAL9602](INFO): Sent 85 bytes from file Logs/20221027T181430/Courier0036.lzma 2022-10-27T19:31:24.448Z,1666899084.448 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:31:30.660Z,1666899090.660 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:31:42.642Z,1666899102.642 [NAL9602](INFO): SBD MO Status=1, MOMSN=21994, MT Status=0, MTMSN=0 2022-10-27T19:31:42.700Z,1666899102.700 [NAL9602](INFO): Sent 129 bytes from file Logs/20221027T181430/Express0037.lzma 2022-10-27T19:31:42.700Z,1666899102.700 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:31:50.718Z,1666899110.718 [NAL9602](INFO): SBD MO Status=0, MOMSN=21995, MT Status=0, MTMSN=0 2022-10-27T19:31:50.803Z,1666899110.803 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T19:31:50.803Z,1666899110.803 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T19:31:50.803Z,1666899110.803 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T19:32:05.800Z,1666899125.800 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:32:21.430Z,1666899141.430 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T19:32:40.940Z,1666899160.940 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:33:16.080Z,1666899196.080 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:33:51.228Z,1666899231.228 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:34:26.368Z,1666899266.368 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:35:01.507Z,1666899301.507 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:35:36.648Z,1666899336.648 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:36:11.788Z,1666899371.788 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:36:46.927Z,1666899406.927 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:36:51.303Z,1666899411.303 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T19:36:51.303Z,1666899411.303 [Default:CheckIn:C.Wait] Stopped 2022-10-27T19:36:51.303Z,1666899411.303 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T19:36:51.303Z,1666899411.303 [Default:CheckIn:D] Running Loop=1 2022-10-27T19:36:51.741Z,1666899411.741 [Default:CheckIn:D] Stopped 2022-10-27T19:36:51.741Z,1666899411.741 [Default:CheckIn:E] Running Loop=1 2022-10-27T19:36:52.115Z,1666899412.115 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 80.057992 min 2022-10-27T19:36:52.116Z,1666899412.116 [Default:CheckIn:E] Stopped 2022-10-27T19:36:52.116Z,1666899412.116 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T19:36:52.116Z,1666899412.116 [Default:CheckIn] Stopped 2022-10-27T19:36:52.116Z,1666899412.116 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T19:36:52.116Z,1666899412.116 [Default:CheckIn](INFO): Running loop #13 2022-10-27T19:36:52.116Z,1666899412.116 [Default:CheckIn] Running Loop=13 2022-10-27T19:36:52.116Z,1666899412.116 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T19:36:52.116Z,1666899412.116 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T19:36:54.126Z,1666899414.126 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193653.00,A,3648.17566,N,12147.28381,W,0.019,0.00,271022,,,A*70 2022-10-27T19:36:54.128Z,1666899414.128 [NAL9602](INFO): GPS fix at 20221027T193653: (36.802928, -121.788064) 2022-10-27T19:36:54.139Z,1666899414.139 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T19:36:54.139Z,1666899414.139 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T19:37:09.945Z,1666899429.945 [NAL9602](INFO): SBD MO Status=1, MOMSN=21996, MT Status=0, MTMSN=0 2022-10-27T19:37:10.004Z,1666899430.004 [NAL9602](INFO): Sent 74 bytes from file Logs/20221027T181430/Courier0039.lzma 2022-10-27T19:37:10.004Z,1666899430.004 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:37:19.278Z,1666899439.278 [NAL9602](INFO): SBD MO Status=1, MOMSN=21997, MT Status=0, MTMSN=0 2022-10-27T19:37:19.340Z,1666899439.340 [NAL9602](INFO): Sent 128 bytes from file Logs/20221027T181430/Express0040.lzma 2022-10-27T19:37:19.340Z,1666899439.340 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:37:22.080Z,1666899442.080 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:37:26.948Z,1666899446.948 [NAL9602](INFO): SBD MO Status=0, MOMSN=21998, MT Status=0, MTMSN=0 2022-10-27T19:37:27.044Z,1666899447.044 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T19:37:27.045Z,1666899447.045 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T19:37:27.045Z,1666899447.045 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T19:37:57.220Z,1666899477.220 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:37:57.742Z,1666899477.742 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T19:38:32.360Z,1666899512.360 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:39:07.500Z,1666899547.500 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:39:11.990Z,1666899551.990 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-27T19:39:42.640Z,1666899582.640 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:40:17.788Z,1666899617.788 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:40:52.928Z,1666899652.928 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:41:28.088Z,1666899688.088 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:42:03.243Z,1666899723.243 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:42:27.548Z,1666899747.548 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T19:42:27.549Z,1666899747.549 [Default:CheckIn:C.Wait] Stopped 2022-10-27T19:42:27.549Z,1666899747.549 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T19:42:27.549Z,1666899747.549 [Default:CheckIn:D] Running Loop=1 2022-10-27T19:42:27.968Z,1666899747.968 [Default:CheckIn:D] Stopped 2022-10-27T19:42:27.968Z,1666899747.968 [Default:CheckIn:E] Running Loop=1 2022-10-27T19:42:28.348Z,1666899748.348 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 85.661776 min 2022-10-27T19:42:28.348Z,1666899748.348 [Default:CheckIn:E] Stopped 2022-10-27T19:42:28.348Z,1666899748.348 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T19:42:28.348Z,1666899748.348 [Default:CheckIn] Stopped 2022-10-27T19:42:28.348Z,1666899748.348 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T19:42:28.348Z,1666899748.348 [Default:CheckIn](INFO): Running loop #14 2022-10-27T19:42:28.348Z,1666899748.348 [Default:CheckIn] Running Loop=14 2022-10-27T19:42:28.348Z,1666899748.348 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T19:42:28.349Z,1666899748.349 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T19:42:30.359Z,1666899750.359 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194229.00,A,3648.17590,N,12147.28382,W,0.039,0.00,271022,,,A*76 2022-10-27T19:42:30.361Z,1666899750.361 [NAL9602](INFO): GPS fix at 20221027T194229: (36.802932, -121.788064) 2022-10-27T19:42:30.373Z,1666899750.373 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T19:42:30.373Z,1666899750.373 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T19:42:38.396Z,1666899758.396 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:42:55.866Z,1666899775.866 [NAL9602](INFO): SBD MO Status=1, MOMSN=21999, MT Status=0, MTMSN=0 2022-10-27T19:42:55.920Z,1666899775.920 [NAL9602](INFO): Sent 74 bytes from file Logs/20221027T181430/Courier0042.lzma 2022-10-27T19:42:55.920Z,1666899775.920 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:43:06.034Z,1666899786.034 [NAL9602](INFO): SBD MO Status=1, MOMSN=22000, MT Status=0, MTMSN=0 2022-10-27T19:43:06.082Z,1666899786.082 [NAL9602](INFO): Sent 130 bytes from file Logs/20221027T181430/Express0043.lzma 2022-10-27T19:43:06.082Z,1666899786.082 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:43:09.681Z,1666899789.681 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2022-10-27T19:43:09.682Z,1666899789.682 [DropWeight] Hardware Fault, FailCount= 1 2022-10-27T19:43:09.682Z,1666899789.682 [DropWeight](ERROR): Hardware Fault 2022-10-27T19:43:09.722Z,1666899789.722 [CBIT](INFO): Critical error at 20221027T194309 2022-10-27T19:43:09.748Z,1666899789.748 [CBIT](ERROR): Hardware Fault in component: DropWeight 2022-10-27T19:43:09.749Z,1666899789.749 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2022-10-27T19:43:10.110Z,1666899790.110 [CBIT](INFO): Critical error at 20221027T194309 2022-10-27T19:43:13.536Z,1666899793.536 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:43:16.530Z,1666899796.530 [NAL9602](INFO): SBD MO Status=0, MOMSN=22001, MT Status=0, MTMSN=0 2022-10-27T19:43:16.611Z,1666899796.611 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T19:43:16.611Z,1666899796.611 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T19:43:16.611Z,1666899796.611 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T19:43:47.236Z,1666899827.236 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T19:43:48.684Z,1666899828.684 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:44:23.828Z,1666899863.828 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:44:58.968Z,1666899898.968 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:45:34.108Z,1666899934.108 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:46:09.296Z,1666899969.296 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:46:44.436Z,1666900004.436 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:47:19.576Z,1666900039.576 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:47:54.716Z,1666900074.716 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:48:17.115Z,1666900097.115 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T19:48:17.115Z,1666900097.115 [Default:CheckIn:C.Wait] Stopped 2022-10-27T19:48:17.116Z,1666900097.116 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T19:48:17.116Z,1666900097.116 [Default:CheckIn:D] Running Loop=1 2022-10-27T19:48:17.527Z,1666900097.527 [Default:CheckIn:D] Stopped 2022-10-27T19:48:17.527Z,1666900097.527 [Default:CheckIn:E] Running Loop=1 2022-10-27T19:48:17.954Z,1666900097.954 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 91.487752 min 2022-10-27T19:48:17.954Z,1666900097.954 [Default:CheckIn:E] Stopped 2022-10-27T19:48:17.954Z,1666900097.954 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T19:48:17.954Z,1666900097.954 [Default:CheckIn] Stopped 2022-10-27T19:48:17.954Z,1666900097.954 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T19:48:17.955Z,1666900097.955 [Default:CheckIn](INFO): Running loop #15 2022-10-27T19:48:17.955Z,1666900097.955 [Default:CheckIn] Running Loop=15 2022-10-27T19:48:17.955Z,1666900097.955 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T19:48:17.955Z,1666900097.955 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T19:48:19.938Z,1666900099.938 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194819.00,A,3648.17546,N,12147.28290,W,0.039,0.00,271022,,,A*76 2022-10-27T19:48:19.940Z,1666900099.940 [NAL9602](INFO): GPS fix at 20221027T194819: (36.802924, -121.788048) 2022-10-27T19:48:19.990Z,1666900099.990 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T19:48:19.990Z,1666900099.990 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T19:48:29.855Z,1666900109.855 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:48:33.368Z,1666900113.368 [NAL9602](INFO): SBD MO Status=1, MOMSN=22002, MT Status=0, MTMSN=0 2022-10-27T19:48:33.421Z,1666900113.421 [NAL9602](INFO): Sent 150 bytes from file Logs/20221027T181430/Courier0045.lzma 2022-10-27T19:48:33.421Z,1666900113.421 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:48:45.170Z,1666900125.170 [NAL9602](INFO): SBD MO Status=1, MOMSN=22003, MT Status=0, MTMSN=0 2022-10-27T19:48:45.232Z,1666900125.232 [NAL9602](INFO): Sent 128 bytes from file Logs/20221027T181430/Express0046.lzma 2022-10-27T19:48:45.232Z,1666900125.232 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:48:52.845Z,1666900132.845 [NAL9602](INFO): SBD MO Status=0, MOMSN=22004, MT Status=0, MTMSN=0 2022-10-27T19:48:52.930Z,1666900132.930 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T19:48:52.930Z,1666900132.930 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T19:48:52.930Z,1666900132.930 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T19:49:04.996Z,1666900144.996 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:49:23.552Z,1666900163.552 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T19:49:40.136Z,1666900180.136 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:50:15.276Z,1666900215.276 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:50:50.448Z,1666900250.448 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:51:25.596Z,1666900285.596 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:52:00.736Z,1666900320.736 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:52:35.875Z,1666900355.875 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:53:11.016Z,1666900391.016 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:53:46.156Z,1666900426.156 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:53:53.434Z,1666900433.434 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T19:53:53.435Z,1666900433.435 [Default:CheckIn:C.Wait] Stopped 2022-10-27T19:53:53.435Z,1666900433.435 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T19:53:53.435Z,1666900433.435 [Default:CheckIn:D] Running Loop=1 2022-10-27T19:53:53.856Z,1666900433.856 [Default:CheckIn:D] Stopped 2022-10-27T19:53:53.856Z,1666900433.856 [Default:CheckIn:E] Running Loop=1 2022-10-27T19:53:54.250Z,1666900434.250 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 97.093229 min 2022-10-27T19:53:54.251Z,1666900434.251 [Default:CheckIn:E] Stopped 2022-10-27T19:53:54.251Z,1666900434.251 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T19:53:54.251Z,1666900434.251 [Default:CheckIn] Stopped 2022-10-27T19:53:54.251Z,1666900434.251 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T19:53:54.251Z,1666900434.251 [Default:CheckIn](INFO): Running loop #16 2022-10-27T19:53:54.251Z,1666900434.251 [Default:CheckIn] Running Loop=16 2022-10-27T19:53:54.251Z,1666900434.251 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T19:53:54.252Z,1666900434.252 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T19:53:56.250Z,1666900436.250 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195355.00,A,3648.17508,N,12147.28254,W,0.019,0.00,271022,,,A*74 2022-10-27T19:53:56.253Z,1666900436.253 [NAL9602](INFO): GPS fix at 20221027T195355: (36.802918, -121.788042) 2022-10-27T19:53:56.277Z,1666900436.277 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T19:53:56.277Z,1666900436.277 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T19:54:20.989Z,1666900460.989 [NAL9602](INFO): SBD MO Status=1, MOMSN=22005, MT Status=0, MTMSN=0 2022-10-27T19:54:21.048Z,1666900461.048 [NAL9602](INFO): Sent 74 bytes from file Logs/20221027T181430/Courier0048.lzma 2022-10-27T19:54:21.048Z,1666900461.048 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:54:21.296Z,1666900461.296 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:54:33.995Z,1666900473.995 [NAL9602](INFO): SBD MO Status=1, MOMSN=22006, MT Status=0, MTMSN=0 2022-10-27T19:54:34.044Z,1666900474.044 [NAL9602](INFO): Sent 129 bytes from file Logs/20221027T181430/Express0049.lzma 2022-10-27T19:54:34.044Z,1666900474.044 [NAL9602](INFO): Packets left to send: 0 2022-10-27T19:54:44.094Z,1666900484.094 [NAL9602](INFO): SBD MO Status=0, MOMSN=22007, MT Status=0, MTMSN=0 2022-10-27T19:54:44.183Z,1666900484.183 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T19:54:44.183Z,1666900484.183 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T19:54:44.183Z,1666900484.183 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T19:54:56.436Z,1666900496.436 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:55:14.802Z,1666900514.802 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T19:55:31.576Z,1666900531.576 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:56:06.716Z,1666900566.716 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:56:41.856Z,1666900601.856 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:57:16.997Z,1666900636.997 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:57:52.135Z,1666900672.135 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:58:03.744Z,1666900683.744 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2022-10-27T19:58:09.779Z,1666900689.779 [CBIT](INFO): Clearing failed state for component DropWeight 2022-10-27T19:58:09.779Z,1666900689.779 [DropWeight] No Fault, FailCount= 1 2022-10-27T19:58:27.276Z,1666900707.276 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:59:02.419Z,1666900742.419 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:59:37.560Z,1666900777.560 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T19:59:44.683Z,1666900784.683 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T19:59:44.683Z,1666900784.683 [Default:CheckIn:C.Wait] Stopped 2022-10-27T19:59:44.683Z,1666900784.683 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T19:59:44.699Z,1666900784.699 [Default:CheckIn:D] Running Loop=1 2022-10-27T19:59:45.087Z,1666900785.087 [Default:CheckIn:D] Stopped 2022-10-27T19:59:45.087Z,1666900785.087 [Default:CheckIn:E] Running Loop=1 2022-10-27T19:59:45.495Z,1666900785.495 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 102.947078 min 2022-10-27T19:59:45.495Z,1666900785.495 [Default:CheckIn:E] Stopped 2022-10-27T19:59:45.495Z,1666900785.495 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T19:59:45.495Z,1666900785.495 [Default:CheckIn] Stopped 2022-10-27T19:59:45.495Z,1666900785.495 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T19:59:45.496Z,1666900785.496 [Default:CheckIn](INFO): Running loop #17 2022-10-27T19:59:45.496Z,1666900785.496 [Default:CheckIn] Running Loop=17 2022-10-27T19:59:45.496Z,1666900785.496 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T19:59:45.496Z,1666900785.496 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T19:59:47.502Z,1666900787.502 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195946.00,A,3648.17382,N,12147.28295,W,0.058,0.00,271022,,,A*70 2022-10-27T19:59:47.520Z,1666900787.520 [NAL9602](INFO): GPS fix at 20221027T195946: (36.802897, -121.788049) 2022-10-27T19:59:47.531Z,1666900787.531 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T19:59:47.531Z,1666900787.531 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T20:00:06.633Z,1666900806.633 [NAL9602](INFO): SBD MO Status=1, MOMSN=22008, MT Status=0, MTMSN=0 2022-10-27T20:00:06.684Z,1666900806.684 [NAL9602](INFO): Sent 74 bytes from file Logs/20221027T181430/Courier0051.lzma 2022-10-27T20:00:06.684Z,1666900806.684 [NAL9602](INFO): Packets left to send: 0 2022-10-27T20:00:12.700Z,1666900812.700 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:00:15.241Z,1666900815.241 [NAL9602](INFO): SBD MO Status=1, MOMSN=22009, MT Status=0, MTMSN=0 2022-10-27T20:00:15.292Z,1666900815.292 [NAL9602](INFO): Sent 131 bytes from file Logs/20221027T181430/Express0052.lzma 2022-10-27T20:00:15.292Z,1666900815.292 [NAL9602](INFO): Packets left to send: 0 2022-10-27T20:00:25.746Z,1666900825.746 [NAL9602](INFO): SBD MO Status=0, MOMSN=22010, MT Status=0, MTMSN=0 2022-10-27T20:00:25.850Z,1666900825.850 [Default:CheckIn:Read_Iridium] Stopped 2022-10-27T20:00:25.850Z,1666900825.850 [Default:CheckIn:C.Wait] Running Loop=1 2022-10-27T20:00:25.850Z,1666900825.850 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-10-27T20:00:47.848Z,1666900847.848 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:00:56.453Z,1666900856.453 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-27T20:01:23.008Z,1666900883.008 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:01:58.168Z,1666900918.168 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:02:33.332Z,1666900953.332 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:03:08.487Z,1666900988.487 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:03:43.629Z,1666901023.629 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:04:18.776Z,1666901058.776 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:04:53.915Z,1666901093.915 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:05:26.383Z,1666901126.383 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2022-10-27T20:05:26.383Z,1666901126.383 [Default:CheckIn:C.Wait] Stopped 2022-10-27T20:05:26.383Z,1666901126.383 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-10-27T20:05:26.383Z,1666901126.383 [Default:CheckIn:D] Running Loop=1 2022-10-27T20:05:26.750Z,1666901126.750 [Default:CheckIn:D] Stopped 2022-10-27T20:05:26.750Z,1666901126.750 [Default:CheckIn:E] Running Loop=1 2022-10-27T20:05:27.143Z,1666901127.143 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 108.641463 min 2022-10-27T20:05:27.143Z,1666901127.143 [Default:CheckIn:E] Stopped 2022-10-27T20:05:27.143Z,1666901127.143 [Default:CheckIn](INFO): Completed Default:CheckIn 2022-10-27T20:05:27.143Z,1666901127.143 [Default:CheckIn] Stopped 2022-10-27T20:05:27.144Z,1666901127.144 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-27T20:05:27.144Z,1666901127.144 [Default:CheckIn](INFO): Running loop #18 2022-10-27T20:05:27.144Z,1666901127.144 [Default:CheckIn] Running Loop=18 2022-10-27T20:05:27.144Z,1666901127.144 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-10-27T20:05:27.144Z,1666901127.144 [Default:CheckIn:Read_GPS] Running Loop=1 2022-10-27T20:05:29.056Z,1666901129.056 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:05:29.158Z,1666901129.158 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200528.00,A,3648.16638,N,12147.28383,W,1.147,164.53,271022,,,A*73 2022-10-27T20:05:29.161Z,1666901129.161 [NAL9602](INFO): GPS fix at 20221027T200528: (36.802773, -121.788064) 2022-10-27T20:05:29.172Z,1666901129.172 [Default:CheckIn:Read_GPS] Stopped 2022-10-27T20:05:29.172Z,1666901129.172 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-10-27T20:06:04.221Z,1666901164.221 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:06:39.360Z,1666901199.360 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:07:14.500Z,1666901234.500 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:07:49.661Z,1666901269.661 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:08:24.800Z,1666901304.800 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:08:59.948Z,1666901339.948 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:09:35.097Z,1666901375.097 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:10:10.256Z,1666901410.256 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:10:45.404Z,1666901445.404 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:11:20.544Z,1666901480.544 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-27T20:11:55.684Z,1666901515.684 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.