SGP does nothing during 1 hour in sequence

mikaelA · March 28, 2021, 8:36am

Hi Jared, Ken,

I got a rare failure this night, SGP did nothing between 01.59 and 03.00, zero log activity. My Atik 460ex could have hanged of course, it happens but rarely, but then wouldn’t SGP show some kind of activity or try to recover ?

Note that I still run SGP 3.2.0.600 on my Windows 7 PC in the observatory.

Extract from the log:

[03/28/21 01:59:53.828][DEBUG][Sequence Thread][SQ;] Auto guider has settled…
[03/28/21 01:59:53.910][DEBUG][Sequence Thread][SQ;] Handling monitoring event (Email 1, Status): (Thors helmet) Auto guider has settled.
[03/28/21 01:59:53.914][DEBUG][Sequence Thread][SQ;] EventMarker(8) - t:m94 (2); e:1; f:1; o:
[03/28/21 01:59:53.915][DEBUG][Sequence Thread][SQ;] BlockUntilFocuserMovementDone: Focuser reports it is done moving, continuing…
[03/28/21 01:59:53.916][DEBUG][Sequence Thread][SQ;] Set start frame data -> Pos: 6591; Temp: 1.99911111111111 …
[03/28/21 01:59:53.919][DEBUG][Sequence Thread][SQ;] Created base name for frame capture: 2021-03-28_m94_180sec_2x2_R_frame2
[03/28/21 01:59:53.919][DEBUG][Sequence Thread][SQ;] Created directory for frame capture: C:\Users\afzelius\Documents\ASTROPHOTO\2021\m94\Light\Red
[03/28/21 01:59:53.924][DEBUG][Sequence Thread][SQ;] EventMarker(9) - t:m94 (2); e:1; f:1; o:
[03/28/21 01:59:53.925][DEBUG][Sequence Thread][SQ;] EventMarker(10) - t:m94 (2); e:1; f:1; o:
[03/28/21 01:59:53.925][DEBUG][Sequence Thread][SQ;] Finished sending frame capture. Entering wait mode…
[03/28/21 01:59:53.925][DEBUG][Sequence Thread][SQ;] EventMarker(11) - t:m94 (2); e:1; f:1; o:
[03/28/21 01:59:53.925][DEBUG][Sequence Thread][SQ;] EventMarker(12) - t:m94 (2); e:1; f:1; o:
[03/28/21 01:59:53.926][DEBUG][Camera Thread][SQ;] SGM_CAMERA_CAPTURE message received…
[03/28/21 01:59:53.934][DEBUG][Camera Thread][SQ;CC;] SetAscomNormalSpeed…
[03/28/21 01:59:53.934][DEBUG][Camera Thread][SQ;CC;] Readout speed set to NORMAL…
[03/28/21 01:59:53.949][DEBUG][Camera Thread][SQ;CC;] ASCOM Camera: exposure started, waiting…
[03/28/21 01:59:54.016][DEBUG][Sequence Thread][SQ;CC;] Handling monitoring event (Email 1, Status): (Thors helmet) Starting integration of m94; Event 2; Frame 2 for 180s…
[03/28/21 01:59:54.018][DEBUG][Sequence Thread][SQ;CC;] Handling monitoring event (THIS IS NOT AN ACTUAL ERROR) (Email 1, TimedError): (Thors helmet) Failure while integrating m94; Event 2; Frame 2 for 180s. Image has not downloaded in alloted time period.
[03/28/21 01:59:54.028][DEBUG][Sequence Thread][SQ;CC;] EventMarker(13) - t:m94 (2); e:1; f:1; o:
[03/28/21 03:00:00.199][DEBUG][Camera Thread][SQ;CC;] ASCOM Camera: exposure complete, waiting for camera to report image ready…
[03/28/21 03:00:00.272][DEBUG][Sequence Thread][SQ;CC;] EventMarker(15) - t:m94 (2); e:1; f:1; o:
[03/28/21 03:00:00.282][DEBUG][Sequence Thread][SQ;CC;] Waking from exposure time sleep period…
[03/28/21 03:00:00.283][DEBUG][Sequence Thread][SQ;CC;] Checking to see if the CCD has a temp…
[03/28/21 03:00:00.283][DEBUG][Sequence Thread][SQ;CC;] Saving the CCD temp…
[03/28/21 03:00:00.309][DEBUG][Sequence Thread][SQ;CC;] Entering super dangerous loop to await image completion…
[03/28/21 03:00:00.330][DEBUG][Sequence Thread][SQ;CC;] EventMarker(16) - t:m94 (2); e:1; f:1; o:
[03/28/21 03:00:08.555][DEBUG][Main Thread][SQ;CC;] Adding sequence level notification: Shutting down due to Unsafe Conditions.
[03/28/21 03:00:08.626][DEBUG][Safety Thread][SQ;CC;] Sending Notification: Alert - Shutting down due to Unsafe Conditions.
[03/28/21 03:00:08.626][DEBUG][Safety Thread][SQ;CC;] Handling monitoring event (Email 1, Alert): (Thors helmet) Shutting down due to Unsafe Conditions.
[03/28/21 03:00:08.626][DEBUG][Safety Thread][SQ;CC;] Shutting down due to Unsafe Conditions…
[03/28/21 03:00:08.627][DEBUG][Safety Thread][SQ;CC;] Aborting sequence: UNSAFE
[03/28/21 03:00:08.627][DEBUG][Safety Thread][SQ;CC;] Set sequence abort
[03/28/21 03:00:08.673][DEBUG][Sequence Thread][SQ;CC;] Set sequence abort
[03/28/21 03:00:08.685][DEBUG][Sequence Thread][SQ;CC;] Run event requested sequence abort…
[03/28/21 03:00:08.690][DEBUG][Sequence Thread][SQ;CC;] ********* Run post sequence *********

Antother point, I tried to submit this issue twice with the feature in the program, I got an exception. Did you receive it, I guess not ?

Thanks, Mikael

bulrichl · March 28, 2021, 9:25am

Hi Mikael,

perhaps this “issue” relates to the time shift to daylight saving time that was performed last night?

Bernd

mikaelA · March 28, 2021, 10:39am

Hi Bernd,

I suspect you are right. This sequence should have gone from 1h30 to about 5h30. So at 2h maybe the PC time was forwarded to 3h. Then, for some reason SGP sets unsafe condition and everything shuts down:

[03/28/21 03:00:08.626][DEBUG][Safety Thread][SQ;CC;] Sending Notification: Alert - Shutting down due to Unsafe Conditions.

This is a bit suspicious, because I think this was a perfectly cloudless night. Unfortuneately I dont log my AAGCW device, so I cannot prove that. Looking at the PHD2 graph nothing happens either, the starmass is perfectly stable until the shutdown. Curious!

Mikael

mikaelA · March 28, 2021, 10:49am

Update:

Had totally forgotten (embarrasingly) that I do have a second small application I wrote that connects to the AAGCW and plots the Sky temperature! It clearly shows very clear skies all through the night, and the discontinuity at 2h-3h shows when the PC changed time. No reason for an Unsafe condition to appear as I see it, I wonder is this is due to the time skipping, Ken, Jared ?

Mikael

bulrichl · March 28, 2021, 2:35pm

Time shifts are problematic for all applications that depend on exact assignment of events to time, and sometimes this is essential. I experienced the year 2000 hype (a somewhat related case) as assistant plant manager in a chemical production. The software of the process control system was adapted to the millennium change in due time, nevertheless the manufacturers did not guarantee that all processes would work without fail. So all processes had to be shut down at 31. December and started new on 1. January for safety reasons!

Fortunately, our hobby is not as hazardous as chemical reactions.

Bernd

mikaelA · March 28, 2021, 4:44pm

Indeed Bernd! Just some lost imaging time here, and anyway my attempt at imaging m94 with that moon was pretty optimistic, at best!

But it looks like SGP doesnt handle day Daylight saving time, because I had to advance all targets start and stop times by one hour for tonights imaging.

Mikael