2025-06-03T18:46:48.238Z,1748976408.238 [CommandExec](IMPORTANT): got command restart logs 2025-06-03T18:46:58.236Z,1748976418.236 [NAL9602](INFO): SBD MO Status=0, MOMSN=20938, MT Status=0, MTMSN=0 2025-06-03T18:46:58.236Z,1748976418.236 [NAL9602](INFO): No messages in MT queue 2025-06-03T18:47:28.944Z,1748976448.944 [NAL9602](INFO): Not Powering down - fast GPS 2025-06-03T18:50:23.473Z,1748976623.473 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-03T18:50:23.489Z,1748976623.489 [Default:CheckIn:C.Wait] Stopped 2025-06-03T18:50:23.489Z,1748976623.489 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-03T18:50:23.489Z,1748976623.489 [Default:CheckIn:D] Running Loop=1 2025-06-03T18:50:23.882Z,1748976623.882 [Default:CheckIn:D] Stopped 2025-06-03T18:50:23.882Z,1748976623.882 [Default:CheckIn:E] Running Loop=1 2025-06-03T18:50:24.281Z,1748976624.281 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.245229 min 2025-06-03T18:50:24.281Z,1748976624.281 [Default:CheckIn:E] Stopped 2025-06-03T18:50:24.281Z,1748976624.281 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-03T18:50:24.281Z,1748976624.281 [Default:CheckIn] Stopped 2025-06-03T18:50:24.281Z,1748976624.281 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-03T18:50:24.281Z,1748976624.281 [Default:CheckIn](INFO): Running loop #3 2025-06-03T18:50:24.281Z,1748976624.281 [Default:CheckIn] Running Loop=3 2025-06-03T18:50:24.282Z,1748976624.282 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-03T18:50:24.282Z,1748976624.282 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-03T18:50:26.297Z,1748976626.297 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185025.00,A,3648.71089,N,12150.89944,W,29.488,108.18,030625,,,A*4B 2025-06-03T18:50:26.300Z,1748976626.300 [NAL9602](INFO): GPS fix at 20250603T185025: (36.811848, -121.848324) 2025-06-03T18:50:26.310Z,1748976626.310 [Default:CheckIn:Read_GPS] Stopped 2025-06-03T18:50:26.311Z,1748976626.311 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-03T18:50:38.317Z,1748976638.317 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250603T183413/Courier0010.lzma 2025-06-03T18:50:39.319Z,1748976639.319 [DataOverHttps](INFO): Moved sent file to Logs/20250603T183413/Courier0010.lzma.bak 2025-06-03T18:50:39.319Z,1748976639.319 [DataOverHttps](INFO): SBD MOMSN=25085776 2025-06-03T18:50:54.998Z,1748976654.998 [NAL9602](INFO): SBD MO Status=2, MOMSN=20939, MT Status=2, MTMSN=0 2025-06-03T18:50:54.999Z,1748976654.999 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-06-03T18:50:55.910Z,1748976655.910 [DataOverHttps](INFO): Sending 270 bytes from file Logs/20250603T184648/Courier0000.lzma 2025-06-03T18:50:56.911Z,1748976656.911 [DataOverHttps](INFO): Moved sent file to Logs/20250603T184648/Courier0000.lzma.bak 2025-06-03T18:50:56.911Z,1748976656.911 [DataOverHttps](INFO): SBD MOMSN=25085782 2025-06-03T18:51:12.359Z,1748976672.359 [NAL9602](INFO): SBD MO Status=2, MOMSN=20939, MT Status=2, MTMSN=0 2025-06-03T18:51:12.359Z,1748976672.359 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-06-03T18:51:13.090Z,1748976673.090 [DataOverHttps](INFO): Sending 349 bytes from file Logs/20250603T183413/Express0011.lzma 2025-06-03T18:51:14.091Z,1748976674.091 [DataOverHttps](INFO): Moved sent file to Logs/20250603T183413/Express0011.lzma.bak 2025-06-03T18:51:14.091Z,1748976674.091 [DataOverHttps](INFO): SBD MOMSN=25085786 2025-06-03T18:51:24.936Z,1748976684.936 [NAL9602](INFO): SBD MO Status=0, MOMSN=20939, MT Status=0, MTMSN=0 2025-06-03T18:51:24.936Z,1748976684.936 [NAL9602](INFO): No messages in MT queue 2025-06-03T18:51:30.282Z,1748976690.282 [DataOverHttps](INFO): Sending 497 bytes from file Logs/20250603T184648/Express0001.lzma 2025-06-03T18:51:31.283Z,1748976691.283 [DataOverHttps](INFO): Moved sent file to Logs/20250603T184648/Express0001.lzma.bak 2025-06-03T18:51:31.283Z,1748976691.283 [DataOverHttps](INFO): SBD MOMSN=25085793 2025-06-03T18:51:47.953Z,1748976707.953 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20250603T184648/Express0004.lzma 2025-06-03T18:51:48.955Z,1748976708.955 [DataOverHttps](INFO): Moved sent file to Logs/20250603T184648/Express0004.lzma.bak 2025-06-03T18:51:48.955Z,1748976708.955 [DataOverHttps](INFO): SBD MOMSN=25085797 2025-06-03T18:51:50.349Z,1748976710.349 [Default:CheckIn:Read_Iridium] Stopped 2025-06-03T18:51:50.349Z,1748976710.349 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-03T18:51:50.350Z,1748976710.350 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-03T18:51:55.582Z,1748976715.582 [NAL9602](INFO): Not Powering down - fast GPS 2025-06-03T18:51:57.691Z,1748976717.691 [DataOverHttps](IMPORTANT): SBD MTMSN=20250603T185156 2025-06-03T18:52:05.288Z,1748976725.288 [DataOverHttps](INFO): Received command: sched asap "gfscan" 278ef 1 2 2025-06-03T18:52:05.372Z,1748976725.372 [CommandExec](IMPORTANT): got command schedule asap "gfscan" 278ef 1 2.000000 2025-06-03T18:52:05.372Z,1748976725.372 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=278ef 2025-06-03T18:52:05.373Z,1748976725.373 [CommandExec](IMPORTANT): Scheduled #1 (#1 of 2 with id='278ef'): "gfscan", ASAP 2025-06-03T18:52:06.286Z,1748976726.286 [DataOverHttps](IMPORTANT): SBD MTMSN=20250603T185204 2025-06-03T18:52:13.877Z,1748976733.877 [DataOverHttps](INFO): Received command: sched asap "" 278ef 2 2 2025-06-03T18:52:13.907Z,1748976733.907 [CommandExec](IMPORTANT): got command schedule asap "" 278ef 2 2.000000 2025-06-03T18:52:13.908Z,1748976733.908 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=278ef 2025-06-03T18:52:13.909Z,1748976733.909 [CommandExec](IMPORTANT): Scheduled #2 (#2 of 2 with id='278ef'): "", ASAP 2025-06-03T18:52:14.010Z,1748976734.010 [CommandExec](IMPORTANT): got command gfscan 2025-06-03T18:52:14.194Z,1748976734.194 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-03T18:52:14.878Z,1748976734.878 [DataOverHttps](IMPORTANT): SBD MTMSN=20250603T185213 2025-06-03T18:52:18.681Z,1748976738.681 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.095403 CHAN A1 (24V): 0.047930 CHAN A2 (12V): -0.061241 CHAN A3 (5V): -0.082906 CHAN B0 (3.3V): -0.032722 CHAN B1 (3.15aV): -0.014744 CHAN B2 (3.15bV): -0.007382 CHAN B3 (GND): -0.039575 OPEN: 0.009885 Full Scale: +/- 1 mA 2025-06-03T18:52:22.589Z,1748976742.589 [DataOverHttps](INFO): Received command: restart sys 2025-06-03T18:52:22.667Z,1748976742.667 [CommandExec](IMPORTANT): got command restart system 2025-06-03T18:52:24.725Z,1748976744.725 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-03T18:52:24.725Z,1748976744.725 [CommandExec](INFO): Uninitializing the command executive. 2025-06-03T18:52:24.725Z,1748976744.725 [CommandExec](INFO): Uninitializing the command scheduler. 2025-06-03T18:52:24.726Z,1748976744.726 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-06-03T18:52:24.781Z,1748976744.781 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-06-03T18:52:24.781Z,1748976744.781 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-06-03T18:52:24.781Z,1748976744.781 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-03T18:52:24.782Z,1748976744.782 [NavChartDb](INFO): Join timeout helper Thread ID is 1087 2025-06-03T18:52:24.873Z,1748976744.873 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-03T18:52:24.873Z,1748976744.873 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-03T18:52:24.884Z,1748976744.884 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-06-03T18:52:24.884Z,1748976744.884 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-03T18:52:24.884Z,1748976744.884 [Radio_Surface](INFO): Join timeout helper Thread ID is 1088 2025-06-03T18:52:25.281Z,1748976745.281 [Radio_Surface](INFO): Powering down 2025-06-03T18:52:25.282Z,1748976745.282 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-03T18:52:25.282Z,1748976745.283 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-