[11/18/17 23:34:12.167][DEBUG] [Main Thread] Licensing: Machine ID found... [11/18/17 23:34:12.183][DEBUG] [Main Thread] Checking for valid internet connection... [11/18/17 23:34:13.849][DEBUG] [Main Thread] Valid internet connection detected... [11/18/17 23:34:15.100][DEBUG] [Main Thread] Licensing: Request for licenses successful, writing cookie... [11/18/17 23:34:15.110][DEBUG] [Main Thread] Licensing: Applying licenses.. [11/18/17 23:34:15.111][DEBUG] [Main Thread] Licensing: Licenses applied.. [11/18/17 23:34:16.102][DEBUG] [Main Thread] API successfully started on port 59590... [11/18/17 23:34:17.144][DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\Admin\AppData\Local\SequenceGenerator\Sequence Generator Pro\3-emailEndpointAddresses.sgd'. [11/18/17 23:34:17.147][DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Admin\AppData\Local\SequenceGenerator\Sequence Generator Pro\2-textFileEndpointSettings.sgd'. [11/18/17 23:34:17.147][DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Admin\AppData\Local\SequenceGenerator\Sequence Generator Pro\3-textFileEndpointSettings.sgd'. [11/18/17 23:34:17.256][DEBUG] [Main Thread] ===== S E Q U E N C E G E N E R A T O R (v3.0.0.3) ===== [11/18/17 23:34:17.330][DEBUG] [Main Thread] OS: Microsoft Windows 7 Professional [11/18/17 23:34:17.761][DEBUG] [Focuser Thread] Entering Fouser message dispatch loop... [11/18/17 23:34:17.821][DEBUG] [Camera Thread] Entering camera message dispatch loop... [11/18/17 23:34:17.850][DEBUG] [TEC Thread] Entering TEC message dispatch loop... [11/18/17 23:34:17.869][DEBUG] [Filter Wheel Thread] Entering Filter Wheel message dispatch loop... [11/18/17 23:34:17.930][DEBUG] [Telescope Thread] Entering Telescope message dispatch loop... [11/18/17 23:34:17.943][DEBUG] [Rotator Thread] Entering Rotator message dispatch loop... [11/18/17 23:34:17.958][DEBUG] [Auto Guider Thread] Entering Auto Guider message dispatch loop... [11/18/17 23:34:17.974][DEBUG] [Auto Guider Error Thread] Entering Auto Guider message dispatch loop... [11/18/17 23:34:17.980][DEBUG] [Dome Thread] Entering Dome message dispatch loop... [11/18/17 23:34:17.988][DEBUG] [Safety Thread] Starting safety monitor... [11/18/17 23:34:17.994][DEBUG] [Environment Device Thread] Starting environment device monitor... [11/18/17 23:34:18.071][DEBUG] [Main Thread] Settings changed (or loaded)... [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingMdiAutoStretch = False [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingIgLastFileFolder = [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingFormScaleWarning = False [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingRecoveryDuration = 90 [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingDelayBetween = 0 [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingFliFlushLow = 0 [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingSBIGLpt2Address = 278 [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingMdiMouseAction = Stretch [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingLastAscomCamera = [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingAutoRecoveryActive = False [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingTemperhumInterval = 300 [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingASCOMWarningShown = False [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingPlateCamScale = 0 [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingCanonMirrorSettle = 0 [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingInterface = [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingLastAscomFilterWheel = [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingAstroArtDisplayInstructions = True [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingSBIGLpt1Address = 378 [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingTrialQuestionsAsked = False [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingCheckForUpdatesOnStart = True [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingMdiLastImageDir = [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingTemperHumUserTempComp = 0 [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingCaptureCalFramesAlways = False [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingDelayFirst = 0 [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingFliNormalSpeedMode = 0 [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingFliHighSpeedMode = 0 [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingMfPosition = {X=0,Y=0} [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingSoundAttention = [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingPinpointCatalog = [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingCameraOverhead = [11/18/17 23:34:18.076][DEBUG] [Main Thread] * SETTING: settingPlateSolveOn = False [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingAstrometryNetEndpointList = System.Collections.Specialized.StringCollection [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingSBIGGuider = None [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingQSIFanSpeed = 2 [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingNaggerText = [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingMdiPhdDisplay = RA/Dec [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingMdiShowToolStrip = True [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingMdiShowCrosshairs = True [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: WindowGeometry = [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingIgRenameStringLocation = 2 [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingIgSubFolders = False [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: WindowGeometrySearch = [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingOffset = -1 [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingAutoStretchLevel = Low [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingTemperHumUnits = C [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingProfileDirectory = [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingBasename = [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingHfrColor = Color [RoyalBlue] [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingNikonAfBinning = 1 [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingSBIGFanOffWithTec = False [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingLastAscomSafetyMonitor = [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingMdiSize = {Width=800, Height=600} [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingIgCopyAndRenameFiles = False [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingSimDownloadTimesAf = False [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingNagger = False [11/18/17 23:34:18.099][DEBUG] [Main Thread] * SETTING: settingImportFromCfw = True [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingMdiShowStatusTrip = True [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingShowTooltipHelp = True [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingLastUpdateCheck = 01/01/2012 00:00:00 [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingEventSuffixes = null [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingCpPosition = {X=0,Y=0} [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingSBIGCfwPort = [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingMdiLocation = {X=0,Y=0} [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingIgLastCsvFolder = [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingSBIGFilterWheel = Auto Detect [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingSBIGConnection = USB [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingDSLRSoftwareBinForAf = False [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingAutoSave = True [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingFirstTime = True [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingFliFlushHigh = 0 [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingMdiState = maximized [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingUseSequenceOptions = False [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingSoundCompleted = [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingTrialExpiredShown = False [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingTemperHumColor = Grey [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingDataDirectory = [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingCanonFileFormat = Single Image (CFA FITS) [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingAlnitakComPort = [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingIgRenameFiles = False [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingSubFolder = True [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingLastSGSaveFolder = [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingFindStars = Normal (recommended) [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingNikonDataFormat = FITS [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingPlaySounds = False [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingPlateSolve3Catalogs = [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingLastNikonType = Auto Connect [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingLastSequenceStart = 01/01/0001 00:00:00 [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingLastAscomTelescope = [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingMdiPhdScale = 100 [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingIgRenameType = 0 [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingHelpLanguage = English [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingTemperHumUserHumidityComp = 0 [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingMdiPhdRaColor = Color [Blue] [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingLastImageSaveFolder = [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingEnableImageHistory = False [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingFinishFullEvent = True [11/18/17 23:34:18.100][DEBUG] [Main Thread] * SETTING: settingMosaicOverlap = 20 [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingQSIFanOffWithTec = False [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingRecentSequences = [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingDefaultDirectory = [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingMdiPhdDecColor = Color [Red] [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingAstrometryNetEndpoint = Astrometry.NET (Remote) [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingSBIGCfwUseRS232 = False [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingStarsColor = Color [OrangeRed] [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingPhd2InstallPath = [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingIgOverwriteExisting = False [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingLastAscomFocuser = [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingIgLastFolder = [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: WindowGeometryOpen = [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingNumEvents = 5 [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingCanonAfBinning = 1 [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingPlateCamBlank = [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingLogApiCalls = False [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingNikonUseBulbModeAlways = False [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingTempFiles = C:\Temp [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingFliHighSpeedDesc = [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingRecoveryInterval = 10 [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingDefaultMfwFov = 4.0 [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingSBIGEthernetIP = 0.0.0.0 [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingSBIGLpt3Address = 3BC [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingFliNormalSpeedDesc = [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingIgCopyLocation = [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingSBIGAutoDetectIp = True [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingAstroArtStartApp = True [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingSimDownloadTimesPlate = False [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingMicroTouchLocation = [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingMdiPhdZoom = 40 [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingMdiNewWindow = False [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingEventAlwaysVisible = False [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingFliRbiMitigation = False [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingGain = -1 [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingLastAscomDome = [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingLookForTemperDevices = False [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingLastAscomRotator = [11/18/17 23:34:18.101][DEBUG] [Main Thread] * SETTING: settingAfTestPackPath = [11/18/17 23:34:19.057][DEBUG] [Main Thread] ASCOM Boltwood Observing Conditions [11/18/17 23:34:19.057][DEBUG] [Main Thread] ASCOM Observing Conditions Hub (OCH) [11/18/17 23:34:19.057][DEBUG] [Main Thread] ASCOM Observing Conditions Simulator [11/18/17 23:34:19.057][DEBUG] [Main Thread] Blue Astro Stickstation [11/18/17 23:34:19.057][DEBUG] [Main Thread] OpenWeatherMap ObservingConditions [11/18/17 23:34:19.057][DEBUG] [Main Thread] Serial SQM ObservingConditions [11/18/17 23:34:19.057][DEBUG] [Main Thread] TEMPerHUM [11/18/17 23:34:19.060][DEBUG] [Main Thread] Performing initialization... [11/18/17 23:34:19.061][DEBUG] [Main Thread] Creating new sequence with default profile: WO Star 71+Atik 460+Lodestar MyFocuser [11/18/17 23:34:19.115][DEBUG] [Main Thread] Performing full form reset (with profile WO Star 71+Atik 460+Lodestar MyFocuser)... [11/18/17 23:34:19.123][DEBUG] [Main Thread] Retreiving new equipment objects... [11/18/17 23:34:19.123][DEBUG] [Main Thread] New camera object (Atik Camera 2) dispatched... [11/18/17 23:34:19.198][DEBUG] [Main Thread] New filter wheel object (SupaSlim Filter Wheel) dispatched... [11/18/17 23:34:19.199][DEBUG] [Main Thread] New environment device object (ASCOM Observing Conditions Hub (OCH)) dispatched... [11/18/17 23:34:19.202][DEBUG] [Main Thread] New focuser object (myFocuserASCOM1) dispatched... [11/18/17 23:34:19.204][DEBUG] [Main Thread] New telescope object (EQMOD ASCOM HEQ5/6) dispatched... [11/18/17 23:34:19.206][DEBUG] [Main Thread] New rotator object (No Rotator) dispatched... [11/18/17 23:34:19.207][DEBUG] [Main Thread] New dome object (No Observatory) dispatched... [11/18/17 23:34:19.207][DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched... [11/18/17 23:34:19.208][DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched... [11/18/17 23:34:19.208][DEBUG] [Main Thread] New auto guider object (PHD2) dispatched... [11/18/17 23:34:19.208][DEBUG] [Main Thread] New plate solver object (Pinpoint) dispatched... [11/18/17 23:34:19.326][DEBUG] [Main Thread] Populating the form controls... [11/18/17 23:34:19.390][DEBUG] [Main Thread] Added row 0... [11/18/17 23:34:19.414][DEBUG] [Main Thread] Added row 1... [11/18/17 23:34:19.489][DEBUG] [Main Thread] Added row 2... [11/18/17 23:34:19.567][DEBUG] [Main Thread] Added row 3... [11/18/17 23:34:19.634][DEBUG] [Main Thread] Added row 4... [11/18/17 23:34:19.718][DEBUG] [Main Thread] Loading custom filter names... [11/18/17 23:34:19.725][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [11/18/17 23:34:19.818][DEBUG] [Sequence Thread] Entering sequence message dispatch loop... [11/18/17 23:34:19.819][DEBUG] [Main Thread] Retreiving new equipment objects... [11/18/17 23:34:19.819][DEBUG] [Main Thread] No change in camera object... [11/18/17 23:34:19.819][DEBUG] [Main Thread] No change in filter wheel object... [11/18/17 23:34:19.819][DEBUG] [Main Thread] No change in environment device object... [11/18/17 23:34:19.819][DEBUG] [Main Thread] No change in focuser object... [11/18/17 23:34:19.820][DEBUG] [Main Thread] MoveFocuserAbs: Error! The focuser is no longer connected! [11/18/17 23:34:19.820][DEBUG] [Main Thread] No change in telescope object... [11/18/17 23:34:19.820][DEBUG] [Main Thread] New rotator object (No Rotator) dispatched... [11/18/17 23:34:19.822][DEBUG] [Main Thread] New dome object (No Observatory) dispatched... [11/18/17 23:34:19.824][DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched... [11/18/17 23:34:19.825][DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched... [11/18/17 23:34:19.826][DEBUG] [Main Thread] New auto guider object (PHD2) dispatched... [11/18/17 23:34:19.826][DEBUG] [Main Thread] No change in plate solver object... [11/18/17 23:34:19.830][DEBUG] [Main Thread] Checking if version check is required... [11/18/17 23:34:20.506][DEBUG] [Main Thread] UI layout found, loading layout at C:\Users\Admin\AppData\Local\SequenceGenerator\sg_ui_config.xml [11/18/17 23:34:20.510][DEBUG] [Cleaner Thread] Running cleanup... [11/18/17 23:34:20.511][DEBUG] [Cleaner Thread] Cleaning 0 files in directory C:\Users\Admin\AppData\Local\SequenceGenerator\Temp\... [11/18/17 23:34:20.511][DEBUG] [Cleaner Thread] Cleaning multi camera registration file... [11/18/17 23:34:20.511][DEBUG] [Cleaner Thread] Cleaning finished... [11/18/17 23:35:32.095][DEBUG] [Main Thread] Performing deserialize... [11/18/17 23:35:32.128][DEBUG] [Main Thread] Loading custom filter names... [11/18/17 23:35:32.141][DEBUG] [Main Thread] ReflectDataModel: Transferring data model to the view... [11/18/17 23:35:32.155][DEBUG] [Main Thread] Retreiving new equipment objects... [11/18/17 23:35:32.155][DEBUG] [Main Thread] No change in camera object... [11/18/17 23:35:32.155][DEBUG] [Main Thread] New filter wheel object (Starlight Xpress Filter Wheels) dispatched... [11/18/17 23:35:32.157][DEBUG] [Main Thread] No change in environment device object... [11/18/17 23:35:32.157][DEBUG] [Main Thread] New focuser object (myFocuserPro2ASCOM) dispatched... [11/18/17 23:35:32.159][DEBUG] [Main Thread] New telescope object (POTH Hub) dispatched... [11/18/17 23:35:32.160][DEBUG] [Main Thread] New rotator object (No Rotator) dispatched... [11/18/17 23:35:32.161][DEBUG] [Main Thread] New dome object (POTH Hub) dispatched... [11/18/17 23:35:32.163][DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched... [11/18/17 23:35:32.164][DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched... [11/18/17 23:35:32.165][DEBUG] [Main Thread] New auto guider object (PHD2) dispatched... [11/18/17 23:35:32.165][DEBUG] [Main Thread] No change in plate solver object... [11/18/17 23:35:32.240][DEBUG] [Main Thread] Populating the form controls... [11/18/17 23:35:32.260][DEBUG] [Main Thread] Added row 0... [11/18/17 23:35:32.285][DEBUG] [Main Thread] Added row 1... [11/18/17 23:35:32.319][DEBUG] [Main Thread] Added row 2... [11/18/17 23:35:32.361][DEBUG] [Main Thread] Added row 3... [11/18/17 23:35:32.410][DEBUG] [Main Thread] Added row 4... [11/18/17 23:35:32.758][DEBUG] [Main Thread] Display image preview using asynch task... [11/18/17 23:35:37.684][DEBUG] [Main Thread] Connecting camera in main thread... [11/18/17 23:35:37.696][DEBUG] [Main Thread] Connecting ASCOM camera: ASCOM.Atik2.Camera... [11/18/17 23:35:38.105][DEBUG] [Main Thread] Camera does not implement ASCOM gain. [11/18/17 23:35:38.139][DEBUG] [Main Thread] Camera cooler detected... [11/18/17 23:35:38.142][DEBUG] [Main Thread] Camera cooler is OFF... [11/18/17 23:35:38.142][DEBUG] [Main Thread] Camera cooldown on connect is selected... [11/18/17 23:35:38.142][DEBUG] [Main Thread] Camera cooldown is starting... [11/18/17 23:35:38.149][DEBUG] [TEC Thread] SGM_CHANGE_COOLER_TEMP message received... [11/18/17 23:35:38.151][DEBUG] [TEC Thread] TEC Change: Starting... [11/18/17 23:35:38.151][DEBUG] [TEC Thread] TEC Change: After camera connect change, waiting ~5 seconds... [11/18/17 23:35:43.151][DEBUG] [TEC Thread] TEC Change: Attempting to turn the camera cooler on... [11/18/17 23:35:43.151][DEBUG] [TEC Thread] Turning camera cooler on... [11/18/17 23:35:43.612][DEBUG] [Main Thread] Turning camera cooler on... [11/18/17 23:35:43.863][DEBUG] [Main Thread] Connecting ASCOM focuser... [11/18/17 23:35:46.205][DEBUG] [Main Thread] Focuser supports temperature [11/18/17 23:35:46.205][DEBUG] [Main Thread] Current temperature reports: 20 [11/18/17 23:35:46.233][DEBUG] [Main Thread] Focuser reports Max Increment as: 1024 [11/18/17 23:35:46.233][DEBUG] [Main Thread] Focuser reports max steps as: 10000 [11/18/17 23:35:48.166][DEBUG] [TEC Thread] TEC Change: Changing temp from 8.01 to -10.00 in 300 seconds... [11/18/17 23:36:03.836][DEBUG] [Main Thread] Connecting ASCOM dome... [11/18/17 23:36:05.661][DEBUG] [Main Thread] Dome: CanSetAzimuth is true [11/18/17 23:36:18.002][DEBUG] [Telescope Thread] Telescope Dispatch loop: Received SGM_TELESCOPE_CONNECT... [11/18/17 23:36:18.041][DEBUG] [Telescope Thread] Telescope can slewing supported... [11/18/17 23:36:18.059][DEBUG] [Telescope Thread] Telescope: Implements MoveAxis... [11/18/17 23:36:18.101][DEBUG] [Telescope Thread] RA Move Rate Range: Min->0 Max->3.34245933333333 [11/18/17 23:36:18.102][DEBUG] [Telescope Thread] DEC Move Rate Range: Min->0 Max->3.34245933333333 [11/18/17 23:36:18.104][DEBUG] [Telescope Thread] Telescope: CanSetSideOfPier returned False [11/18/17 23:36:18.104][DEBUG] [Telescope Thread] Telescope: CanPark returned True [11/18/17 23:36:18.105][DEBUG] [Telescope Thread] Telescope equatorial system is J2000... [11/18/17 23:36:18.105][DEBUG] [Telescope Thread] SGM_TELESCOPE_CONNECT complete... [11/18/17 23:36:18.232][DEBUG] [Main Thread] Telescope: Setting sync behavior to: Sync [11/18/17 23:36:26.452][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Connected to ASCOM Observing Conditions Hub (OCH) [11/18/17 23:36:26.456][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Device Name - ASCOM Observing Conditions Hub (OCH) [11/18/17 23:36:26.458][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Description - ASCOM Observing Conditions Hub (OCH) [11/18/17 23:36:26.461][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Driver Info ASCOM Observing Conditions Hub (OCH). Version: 6.2.0.0 [11/18/17 23:36:26.464][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Driver Version 6.2 [11/18/17 23:36:27.236][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get Seeing! : Property read ASCOM.OCH.ObservingConditions StarFWHM is not implemented in this driver. (System.Reflection.TargetInvocationException: Exception has been thrown by the target of an invocation. ---> System.Runtime.InteropServices.COMException: Property read ASCOM.Boltwood.ObservingConditions StarFWHM is not implemented in this driver. --- End of inner exception stack trace --- at System.RuntimeType.InvokeDispMethod(String name, BindingFlags invokeAttr, Object target, Object[] args, Boolean[] byrefModifiers, Int32 culture, String[] namedParameters) at System.RuntimeType.InvokeMember(String name, BindingFlags bindingFlags, Binder binder, Object target, Object[] providedArgs, ParameterModifier[] modifiers, CultureInfo culture, String[] namedParams) at System.Type.InvokeMember(String name, BindingFlags invokeAttr, Binder binder, Object target, Object[] args, CultureInfo culture) at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 243) at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 279 at ASCOM.DriverAccess.ObservingConditions.get_StarFWHM() in c:\ASCOM Build\Export\ASCOM.DriverAccess\ObservingConditions.cs:line 232 at jn.br() [11/18/17 23:36:27.243][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get SkyBrightness! : Property read ASCOM.OCH.ObservingConditions SkyBrightness is not implemented in this driver. (System.Reflection.TargetInvocationException: Exception has been thrown by the target of an invocation. ---> System.Runtime.InteropServices.COMException: Property read SkyBrightness is not implemented in this driver. --- End of inner exception stack trace --- at System.RuntimeType.InvokeDispMethod(String name, BindingFlags invokeAttr, Object target, Object[] args, Boolean[] byrefModifiers, Int32 culture, String[] namedParameters) at System.RuntimeType.InvokeMember(String name, BindingFlags bindingFlags, Binder binder, Object target, Object[] providedArgs, ParameterModifier[] modifiers, CultureInfo culture, String[] namedParams) at System.Type.InvokeMember(String name, BindingFlags invokeAttr, Binder binder, Object target, Object[] args, CultureInfo culture) at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 243) at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 279 at ASCOM.DriverAccess.ObservingConditions.get_SkyBrightness() in c:\ASCOM Build\Export\ASCOM.DriverAccess\ObservingConditions.cs:line 204 at jn.br() [11/18/17 23:36:27.262][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get WindGust! : Property read ASCOM.OCH.ObservingConditions WindGust is not implemented in this driver. (System.Reflection.TargetInvocationException: Exception has been thrown by the target of an invocation. ---> System.Runtime.InteropServices.COMException: Property read ASCOM.Boltwood.ObservingConditions WindGust is not implemented in this driver. --- End of inner exception stack trace --- at System.RuntimeType.InvokeDispMethod(String name, BindingFlags invokeAttr, Object target, Object[] args, Boolean[] byrefModifiers, Int32 culture, String[] namedParameters) at System.RuntimeType.InvokeMember(String name, BindingFlags bindingFlags, Binder binder, Object target, Object[] providedArgs, ParameterModifier[] modifiers, CultureInfo culture, String[] namedParams) at System.Type.InvokeMember(String name, BindingFlags invokeAttr, Binder binder, Object target, Object[] args, CultureInfo culture) at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 243) at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 279 at ASCOM.DriverAccess.ObservingConditions.get_WindGust() in c:\ASCOM Build\Export\ASCOM.DriverAccess\ObservingConditions.cs:line 298 at jn.br() [11/18/17 23:37:55.720][DEBUG] [Main Thread] Slewing to target... [11/18/17 23:37:55.727][DEBUG] [Telescope Thread] Slew telescope message received... [11/18/17 23:37:55.730][DEBUG] [Telescope Thread] Telescope: Slewing to J2000 RA: 2.37498333333333 (02h22m29.94s) Dec: 42.3606638888889 (42°21'38.39") [11/18/17 23:37:55.730][DEBUG] [Telescope Thread] Telescope: Calling Observatory Slave Slew [11/18/17 23:37:55.732][DEBUG] [Slew Monitor] Waiting for slew to complete... [11/18/17 23:37:55.737][DEBUG] [Telescope Thread] ASCOM Telescope: Error in Slew : Wrong tracking state (System.Reflection.TargetInvocationException: Exception has been thrown by the target of an invocation. ---> System.Runtime.InteropServices.COMException: Wrong tracking state --- End of inner exception stack trace --- at System.RuntimeType.InvokeDispMethod(String name, BindingFlags invokeAttr, Object target, Object[] args, Boolean[] byrefModifiers, Int32 culture, String[] namedParameters) at System.RuntimeType.InvokeMember(String name, BindingFlags bindingFlags, Binder binder, Object target, Object[] providedArgs, ParameterModifier[] modifiers, CultureInfo culture, String[] namedParams) at System.Type.InvokeMember(String name, BindingFlags invokeAttr, Binder binder, Object target, Object[] args, CultureInfo culture) at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 443) at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 483 at ASCOM.DriverAccess.Telescope.SlewToCoordinates(Double RightAscension, Double Declination) in c:\ASCOM Build\Export\ASCOM.DriverAccess\Telescope.cs:line 1030 at ql.ju(TelescopeInformation A_0, String& A_1) [11/18/17 23:37:55.737][DEBUG] [Telescope Thread] Slew complete... [11/18/17 23:37:55.789][DEBUG] [CP Update Thread] Error in control panel UI updater: Object reference not set to an instance of an object. [11/18/17 23:38:20.248][DEBUG] [Main Thread] Slewing to target... [11/18/17 23:38:20.252][DEBUG] [Telescope Thread] Slew telescope message received... [11/18/17 23:38:20.253][DEBUG] [Telescope Thread] Telescope: Slewing to J2000 RA: 2.37498333333333 (02h22m29.94s) Dec: 42.3606638888889 (42°21'38.39") [11/18/17 23:38:20.253][DEBUG] [Telescope Thread] Telescope: Calling Observatory Slave Slew [11/18/17 23:38:20.255][DEBUG] [Telescope Thread] ASCOM Telescope: Error in Slew : Wrong tracking state (System.Reflection.TargetInvocationException: Exception has been thrown by the target of an invocation. ---> System.Runtime.InteropServices.COMException: Wrong tracking state --- End of inner exception stack trace --- at System.RuntimeType.InvokeDispMethod(String name, BindingFlags invokeAttr, Object target, Object[] args, Boolean[] byrefModifiers, Int32 culture, String[] namedParameters) at System.RuntimeType.InvokeMember(String name, BindingFlags bindingFlags, Binder binder, Object target, Object[] providedArgs, ParameterModifier[] modifiers, CultureInfo culture, String[] namedParams) at System.Type.InvokeMember(String name, BindingFlags invokeAttr, Binder binder, Object target, Object[] args, CultureInfo culture) at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 443) at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 483 at ASCOM.DriverAccess.Telescope.SlewToCoordinates(Double RightAscension, Double Declination) in c:\ASCOM Build\Export\ASCOM.DriverAccess\Telescope.cs:line 1030 at ql.ju(TelescopeInformation A_0, String& A_1) [11/18/17 23:38:20.255][DEBUG] [Telescope Thread] Slew complete... [11/18/17 23:38:20.362][DEBUG] [Slew Monitor] Waiting for slew to complete... [11/18/17 23:38:20.363][DEBUG] [CP Update Thread] Error in control panel UI updater: Object reference not set to an instance of an object. [11/18/17 23:38:22.250][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [11/18/17 23:38:22.254][DEBUG] [MF Update Thread] Performing serialize... [11/18/17 23:38:49.211][DEBUG] [Main Thread] Filter wheel is required... [11/18/17 23:38:49.211][DEBUG] [Main Thread] Filter wheel is still connected. Ignoring connect step... [11/18/17 23:38:49.212][DEBUG] [Main Thread] Focuser is required... [11/18/17 23:38:49.212][DEBUG] [Main Thread] Focuser is still connected. Ignoring connect step... [11/18/17 23:38:49.212][DEBUG] [Main Thread] Telescope is required... [11/18/17 23:38:49.212][DEBUG] [Main Thread] Telescope is still connected. Ignoring connect step... [11/18/17 23:38:49.216][DEBUG] [Main Thread] Observatory connection might be required... [11/18/17 23:38:49.216][DEBUG] [Main Thread] Observatory is still connected. Ignoring connect step... [11/18/17 23:38:49.217][DEBUG] [Main Thread] Environment device required... [11/18/17 23:38:49.217][DEBUG] [Main Thread] Environment device is still connected. Ignoring connect step... [11/18/17 23:38:53.244][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [11/18/17 23:38:53.246][DEBUG] [Main Thread] GNS Startup... [11/18/17 23:38:53.247][DEBUG] [Main Thread] Starting email endpoint 1... [11/18/17 23:38:53.261][DEBUG] [Sequence Thread] Dispatch loop: Received SGM_RUN_SEQUENCE... [11/18/17 23:38:53.275][DEBUG] [Sequence Thread] GuiderCheck: Checking auto guider status... [11/18/17 23:38:53.275][DEBUG] [Sequence Thread] GuiderCheck: Auto guider is not connected, attempting to connect... [11/18/17 23:38:53.277][DEBUG] [Sequence Thread] Connecting to PHD2... [11/18/17 23:38:53.278][DEBUG] [Sequence Thread] Waiting for socket connection to PHD2... [11/18/17 23:38:53.281][DEBUG] [PHD2 Listener Thread] Attempting to connect to PHD2... [11/18/17 23:38:54.278][DEBUG] [Sequence Thread] Successfully connected to PHD2... [11/18/17 23:38:54.279][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [11/18/17 23:38:54.280][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:38:54.380][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [11/18/17 23:38:54.384][DEBUG] [Sequence Thread] PHD2: PHD2 is already open... [11/18/17 23:38:54.384][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_profiles", "id": 1009} [11/18/17 23:38:54.884][DEBUG] [Sequence Thread] GuiderCheck: Auto guider reports connected... [11/18/17 23:38:54.884][DEBUG] [Sequence Thread] Checking auto guider version... [11/18/17 23:38:54.885][DEBUG] [Sequence Thread] PHD2: Performing version check... [11/18/17 23:38:54.885][DEBUG] [Sequence Thread] PHD2: Min version is 2.6.0 [11/18/17 23:38:54.885][DEBUG] [Sequence Thread] PHD2: User version is 2.6.3dev2 [11/18/17 23:38:54.887][DEBUG] [Sequence Thread] Finding first active group... [11/18/17 23:38:54.887][DEBUG] [Sequence Thread] Looking at target NGC 891... [11/18/17 23:38:54.887][DEBUG] [Sequence Thread] Target is active: True [11/18/17 23:38:54.887][DEBUG] [Sequence Thread] Target is complete: False [11/18/17 23:38:54.887][DEBUG] [Sequence Thread] Target marked as past end time: False [11/18/17 23:38:54.887][DEBUG] [Sequence Thread] Target has end time: False [11/18/17 23:38:54.887][DEBUG] [Sequence Thread] Target end time: 18/11/2017 22:39:00 [11/18/17 23:38:54.888][DEBUG] [Sequence Thread] Active group found... [11/18/17 23:38:54.888][DEBUG] [Sequence Thread] Sequence should find starting target; Found target: 0 [11/18/17 23:38:54.895][DEBUG] [Sequence Thread] ************** SEQUENCE DUMP ************** [11/18/17 23:38:54.895][DEBUG] [Sequence Thread] sDirectory: C:\ [11/18/17 23:38:54.895][DEBUG] [Sequence Thread] sBaseName: [11/18/17 23:38:54.895][DEBUG] [Sequence Thread] nDelayFirst: 0 [11/18/17 23:38:54.895][DEBUG] [Sequence Thread] nDelayBetween: 0 [11/18/17 23:38:54.895][DEBUG] [Sequence Thread] bFinishFullEventFirst: False [11/18/17 23:38:54.895][DEBUG] [Sequence Thread] arEventGroups: System.Collections.Generic.List`1[SequenceGenerator.EventGroup] [11/18/17 23:38:54.895][DEBUG] [Sequence Thread] nCurrentEventIndex: 0 [11/18/17 23:38:54.895][DEBUG] [Sequence Thread] dtElapsedTime: 01/01/0001 00:00:00 +00:00 [11/18/17 23:38:54.895][DEBUG] [Sequence Thread] bStarted: False [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] bIsSequenceRunning: False [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] sFileNamePattern: %dt\%ft\%tn_%el_%bi_%su_%fn [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] sVersion: 3.0.0.3 [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] tsElapsedTime: 00:00:00 [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] bCaptureUntil: False [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] dtCaptureUntil: 18/11/2017 12:45:00 [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] userProfile: SequenceGenerator.UserProfile [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] nAfNebulosityRejection: 0.85 [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] sequenceFiles: System.Collections.Generic.Dictionary`2[System.String,System.String] [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] sequenceFileList: System.Collections.Generic.List`1[SequenceGenerator.SequenceFile] [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] imageHistory: SequenceGenerator.ImageHistoryManager [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] nAfSampleSize: 100 [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] bCaptureCalFramesIfSequenceFails: False [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] notificationsList: System.Collections.Generic.List`1[SequenceGenerator.NotoficationInfo] [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] bRunEndOfSequenceScript: False [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] sEndOfSequenceScript: [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] bDisconnectAllGearOnSequenceEnd: False [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] ************** PROFILE DUMP ************** [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] sForImagingInstance: Sequence Generator Pro [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] sProfileName: WO Star 71+Atik 460+Lodestar MyFocuser [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] bDefault: False [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] sCameraName: Atik Camera 2 [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] nGain1x1: 0 [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] nOffset1x1: 100 [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] nGain2x2: 0 [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] nOffset2x2: 100 [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] nGain3x3: 0 [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] nOffset3x3: 100 [11/18/17 23:38:54.896][DEBUG] [Sequence Thread] nGain4x4: 0 [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] nOffset4x4: 100 [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] nCooldownTemp: -10 [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] nCooldownTime: 5 [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] nWarmupTemp: 10 [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] nWarmupTime: 10 [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bAutoCoolDown: True [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bAutoWarmUp: True [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] sFilterWheelName: Starlight Xpress Filter Wheels [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] nFilterDelay: 0 [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] sFocuserName: myFocuserPro2ASCOM [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bReverseFocuser: False [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] nFineFocusStepSize: 10 [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] nCoarseFocusStepSize: 50 [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bAutoAdjustFocusPerFilter: False [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bAutoFocusForFilterChangeOnly: True [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bUseAutoFocus: True [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bAutoFocusPerFrame: False [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bAutoFocusOverTime: False [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] nAutoFocusFramerInterval: 1 [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] nAutoFocusTimerInterval: 10 [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bAutoFocusForceForFilter: False [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bAutoFocusBeforeFirstFrame: True [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bAutoFocusManualStar: False [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bAutoManualFocusForFilterChangeOnly: True [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bUseAutoManualFocus: False [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bAutoManualFocusPerFrame: False [11/18/17 23:38:54.897][DEBUG] [Sequence Thread] bAutoManualFocusOverTime: False [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] nAutoManualFocusFramerInterval: 1 [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] nAutoManualFocusTimerInterval: 10 [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] bAutoManualFocusForceForFilter: False [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] bAutoManualFocusBeforeFirstFrame: True [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] bOverrideMaxSteps: False [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] nOverrideMaxSteps: 1 [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] bTempComp: False [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] nStepsPerDegree: 0 [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] bPhdDither: True [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] nPhdDitherIndex: 0 [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] nPhdSettleValue: 0.3 [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] bRecalGuiderOnSlew: False [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] nDecRecalValue: 0 [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] sTelescopeName: POTH Hub [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] bAutoSlew: False [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] tpFocusFrame: [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] tpTargetFrame: [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] bPausePhdDuringDownload: False [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] bShutdownPhdWhenDone: True [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] bParkTelescopeWhenDone: True [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] sReferenceImagePath: [11/18/17 23:38:54.898][DEBUG] [Sequence Thread] bAutoCenterFrame: False [11/18/17 23:38:54.899][DEBUG] [Sequence Thread] siReference: nEstRa: 0 nEstDec: 0 nRightAscention: 0 nDeclination: 0 nArcsecPerPixel: 0 nAngle: -500 bFlipped: False sSearchType: sBinning: nExposureLength: 0 sImagePath: bFailed: False sInfo: bDoneSolving: True nSides: 100 nMaxSolveTime: 60 [11/18/17 23:38:54.899][DEBUG] [Sequence Thread] siScope: nEstRa: 0 nEstDec: 0 nRightAscention: 0 nDeclination: 0 nArcsecPerPixel: 0 nAngle: 72.3107833014177 bFlipped: False sSearchType: Use up to magnitude 15 stars sBinning: 2x2 nExposureLength: 0 sImagePath: bFailed: True sInfo: bDoneSolving: True nSides: 0 nMaxSolveTime: 60 [11/18/17 23:38:54.899][DEBUG] [Sequence Thread] nSolverExposure1x1: 3 [11/18/17 23:38:54.899][DEBUG] [Sequence Thread] nSolverExposure2x2: 1 [11/18/17 23:38:54.899][DEBUG] [Sequence Thread] nSolverExposure3x3: 1 [11/18/17 23:38:54.899][DEBUG] [Sequence Thread] nSolverExposure4x4: 1 [11/18/17 23:38:54.899][DEBUG] [Sequence Thread] nArcsec1x1: 0.544482026109479 [11/18/17 23:38:54.899][DEBUG] [Sequence Thread] nArcsec2x2: 0 [11/18/17 23:38:54.899][DEBUG] [Sequence Thread] nArcsec3x3: 0 [11/18/17 23:38:54.899][DEBUG] [Sequence Thread] nArcsec4x4: 0 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] sDithertext: Small Dither [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] sAutoGuider: PHD2 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] nFFBinning: 3 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] nFFExposure: 1 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] nAFExposure: 3 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] nAFBinning: 0 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] nAFStepSize: 10 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] nAFDataPoints: 7 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] sPlateSolver: Pinpoint [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] sAutoFocuser: Half Flux Radius [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] nAutoFocusDialogCloseDelay: 30 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] bAutoFocusDegree: True [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] bAutoManualFocusDegree: False [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] nAutoFocusDegreeInterval: 1 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] nAutoManualFocusDegreeInterval: 1 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] bAutoFocusAutoContinue: False [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] nNudgeSpeed: 0 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] bReverseNs: False [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] bReverseEw: False [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] nHiSpeedRate: 1 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] nLoSpeedRate: 0.5 [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] sCameraGain1x1: NA [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] sCameraGain2x2: NA [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] sCameraGain3x3: NA [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] sCameraGain4x4: NA [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] sCameraOffset1x1: [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] sCameraOffset2x2: [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] sCameraOffset3x3: [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] sCameraOffset4x4: [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] bPauseAutoGuiderDuringAutoFocus: True [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] bUseSameStarsForAf: False [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] bSaveAfData: False [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] sSaveAfDataPath: C:\ [11/18/17 23:38:54.900][DEBUG] [Sequence Thread] bAllowExternalScopeControl: False [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] sFFBinning: 2x2 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] sAFBinning: 2x2 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] nMountSettling: 0 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] ffExposure: 3 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] noFilter: SequenceGenerator.Filter [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] bAutoFocusOnResume: False [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] sFlatBoxName: No Flat Box [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] flatBoxBrightness: 0 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] bFocuserBacklash: True [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] nFocuserBacklashStepSize: 50 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] bFocuserBacklashMovesIn: True [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] nGuiderSettlingTime: 3 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] nAutoCenterAttempts: 1 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] nAutoCenterError: 50 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] bFrameRestart: False [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] nFrameRestartError: 0 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] bDoAutoMeridianFlip: True [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] autoMeridianFlipVals: SequenceGenerator.AutoMeridianFlipValues [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] bUseAfDarks: False [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] sAfDarksPath: [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] bUseAutoCenterFilter: False [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] sAutoCenterFilter: Lum [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] bUseAutoFocusFilter: False [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] sAutoFocusFilter: Lum [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] bSettleAgBeforeAf: False [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] bUseHighSpeedDl: False [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] bBlindSolveFailover: True [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] nReadoutNoise: 7 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] ccdArraySize: {Width=2750, Height=2200} [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] nCameraGain1x1: 0.45 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] nCameraGain2x2: 0 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] nCameraGain3x3: 0 [11/18/17 23:38:54.901][DEBUG] [Sequence Thread] nCameraGain4x4: 0 [11/18/17 23:38:54.902][DEBUG] [Sequence Thread] sRotatorName: No Rotator [11/18/17 23:38:54.902][DEBUG] [Sequence Thread] nRotationError: 3 [11/18/17 23:38:54.902][DEBUG] [Sequence Thread] bUseTemperDevice: True [11/18/17 23:38:54.902][DEBUG] [Sequence Thread] bAutoFocusAfterFlip: False [11/18/17 23:38:54.902][DEBUG] [Sequence Thread] bReverseManualRotatorCorrections: False [11/18/17 23:38:54.902][DEBUG] [Sequence Thread] sObservatoryName: POTH Hub [11/18/17 23:38:54.902][DEBUG] [Sequence Thread] sObsType: Dome [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] SlavingVals: Radius: 0 NorthOffset: 0 VerticalOffset: 0 GemOffset: 0 SlavingFrequency: 60 SlavingAngleAllowance: 0 SlaveOnSeqStart: False UnparkWithMount: False ParkMountFirst: False OpenShutterFirst: False UnparkOpensShutter: False ParkClosesShutter: False [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] bSlaveObsToScope: False [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] bPromptToPlaceLightBox: False [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] nDownloadTime1x1: 15 [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] nDownloadTime2x2: 8 [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] nDownloadTime3x3: 4 [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] nDownloadTime4x4: 2 [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] bAfCropFrames: False [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] nAfCropFramesPercent: 0 [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] sFilePattern: [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] sWeatherStationName: No Safety Monitor [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] nScopeFocalLength: 1700 [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] bCameraCooldownOnSequenceStart: False [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] sRtfNotes: {\rtf1\ansi\ansicpg1252\deff0\deflang2057{\fonttbl{\f0\fnil\fcharset204 Microsoft Sans Serif;}} \viewkind4\uc1\pard\f0\fs18\par } [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] bStopTracking: False [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] bHasCentralObstruction: False [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] sCustomVariables: [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] sPhd2Profile: No profile selected [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] bAutoConnectPhd2Gear: False [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] bAutoDisconnectPhd2Gear: False [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] bPauseGuiderDuringBacklashComp: False [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] bSetAbsPositiononFirstFilterChange: False [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] sEnvironmentDeviceName: ASCOM Observing Conditions Hub (OCH) [11/18/17 23:38:54.903][DEBUG] [Sequence Thread] bSettleGuiderTime: True [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] equipmentData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.EquipmentData] [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nMinStarSize: 6 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] telescopeSyncOption: Sync [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nAutoguiderDitherEveryXFrameCount: 1 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] ************** FILTER DUMP ************** [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] >> FILTER 1: [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] bActive: True [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] sName: None [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nAfExposureTime: 1 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nFocusPosition: 0 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nFocusTemp: 0 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nFlat1: 0 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nFlat2: 0 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nFlat3: 0 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nFlat4: 0 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nNumFlats: 0 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] sFocusWith: Default [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] >> FILTER 2: [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] bActive: True [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] sName: Lum [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nAfExposureTime: 3 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nFocusPosition: 3000 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nFocusTemp: 0 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nFlat1: 0 [11/18/17 23:38:54.904][DEBUG] [Sequence Thread] nFlat2: 0 [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] nFlat3: 0 [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] nFlat4: 0 [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] nNumFlats: 0 [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] sFocusWith: Default [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] arFocPositions: [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] >> FILTER 3: [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] bActive: True [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] sName: Red [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] nAfExposureTime: 3 [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] nFocusPosition: 3000 [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] nFocusTemp: 0 [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] nFlat1: 0 [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] nFlat2: 0 [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] nFlat3: 0 [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] nFlat4: 0 [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] nNumFlats: 0 [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] sFocusWith: Default [11/18/17 23:38:54.905][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] >> FILTER 4: [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] bActive: True [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] sName: Green [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nAfExposureTime: 3 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nFocusPosition: 3000 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nFocusTemp: 0 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nFlat1: 0 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nFlat2: 0 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nFlat3: 0 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nFlat4: 0 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nNumFlats: 0 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] sFocusWith: Default [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] arFocPositions: [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] >> FILTER 5: [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] bActive: True [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] sName: Blue [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nAfExposureTime: 3 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nFocusPosition: 3000 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nFocusTemp: 0 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nFlat1: 0 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nFlat2: 0 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nFlat3: 0 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nFlat4: 0 [11/18/17 23:38:54.906][DEBUG] [Sequence Thread] nNumFlats: 0 [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] sFocusWith: Default [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] arFocPositions: [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] >> FILTER 6: [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] bActive: True [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] sName: Ha [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] nAfExposureTime: 10 [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] nFocusPosition: 3000 [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] nFocusTemp: 0 [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] nFlat1: 0 [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] nFlat2: 0 [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] nFlat3: 0 [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] nFlat4: 0 [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] nNumFlats: 0 [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] sFocusWith: Default [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] arFocPositions: [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] >> FILTER 7: [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] bActive: False [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] sName: [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] nAfExposureTime: 1 [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] nFocusPosition: 0 [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] nFocusTemp: 0 [11/18/17 23:38:54.907][DEBUG] [Sequence Thread] nFlat1: 0 [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] nFlat2: 0 [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] nFlat3: 0 [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] nFlat4: 0 [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] nNumFlats: 0 [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] sFocusWith: Default [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] arFocPositions: [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] >> FILTER 8: [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] bActive: False [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] sName: [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] nAfExposureTime: 1 [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] nFocusPosition: 0 [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] nFocusTemp: 0 [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] nFlat1: 0 [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] nFlat2: 0 [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] nFlat3: 0 [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] nFlat4: 0 [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] nNumFlats: 0 [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.908][DEBUG] [Sequence Thread] sFocusWith: Default [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] arFocPositions: [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] >> FILTER 9: [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] bActive: False [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] sName: [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nAfExposureTime: 1 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nFocusPosition: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nFocusTemp: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nFlat1: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nFlat2: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nFlat3: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nFlat4: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nNumFlats: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] sFocusWith: Default [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] arFocPositions: [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] >> FILTER 10: [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] bActive: False [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] sName: [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nAfExposureTime: 1 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nFocusPosition: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nFocusTemp: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nFlat1: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nFlat2: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nFlat3: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nFlat4: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] nNumFlats: 0 [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.909][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] sFocusWith: Default [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] arFocPositions: [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] >> FILTER 11: [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] bActive: False [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] sName: [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] nAfExposureTime: 1 [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] nFocusPosition: 0 [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] nFocusTemp: 0 [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] nFlat1: 0 [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] nFlat2: 0 [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] nFlat3: 0 [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] nFlat4: 0 [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] nNumFlats: 0 [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] sFocusWith: Default [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] arFocPositions: [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] >> FILTER 12: [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] bActive: False [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] sName: [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] nAfExposureTime: 1 [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] nFocusPosition: 0 [11/18/17 23:38:54.910][DEBUG] [Sequence Thread] nFocusTemp: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] nFlat1: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] nFlat2: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] nFlat3: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] nFlat4: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] nNumFlats: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] sFocusWith: Default [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] arFocPositions: [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] >> FILTER 13: [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] bActive: False [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] sName: [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] nAfExposureTime: 1 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] nFocusPosition: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] nFocusTemp: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] nFlat1: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] nFlat2: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] nFlat3: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] nFlat4: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] nNumFlats: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] sFocusWith: Default [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] arFocPositions: [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] ************** EVENT DUMP ************** [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] * Target NGC 891 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -Active: True [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -Start Time: False [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -Start: 18/11/2017 22:39:00 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -End Time: False [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -End: 18/11/2017 22:39:00 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -Auto Rotate: False [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -Auto Center: True [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -Location set: False [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -RA: 2.37498333333333 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -DEC: 42.3606638888889 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -Finish Full Event: True [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -Completed: False [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -After End Time: False [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -Rotate Camera: False [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] -Rotation: 0 [11/18/17 23:38:54.911][DEBUG] [Sequence Thread] ** Event 1 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Active: True [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Frame Type: Light [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Filter: 2 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Suffix: R [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Exposure Time: 180 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Binning: 2x2 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Repeat: 15 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Gain: 0 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Offset: 100 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Num Complete: 1 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] ** Event 2 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Active: True [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Frame Type: Light [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Filter: 3 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Suffix: G [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Exposure Time: 180 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Binning: 2x2 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Repeat: 15 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Gain: 0 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Offset: 100 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Num Complete: 0 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] ** Event 3 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Active: True [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Frame Type: Light [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Filter: 4 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Suffix: B [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Exposure Time: 180 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Binning: 2x2 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Repeat: 15 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Gain: 0 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Offset: 100 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Num Complete: 0 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] ** Event 4 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Active: True [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Frame Type: Light [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Filter: 1 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Suffix: L [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Exposure Time: 180 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Binning: 2x2 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Repeat: 15 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Gain: 0 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Offset: 100 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Num Complete: 0 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] ** Event 5 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Active: True [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Frame Type: Light [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Filter: 5 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Suffix: Ha [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Exposure Time: 600 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Binning: 2x2 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Repeat: 15 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Gain: 0 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Offset: 100 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] -Num Complete: 0 [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] ************** END SEQUENCE DUMP ************** [11/18/17 23:38:54.912][DEBUG] [Sequence Thread] ********** Run sequence started ********** [11/18/17 23:38:54.972][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Sequence has started... [11/18/17 23:38:57.302][DEBUG] [Sequence Thread] GNS: Sent status message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Sequence has started...)... [11/18/17 23:38:57.302][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Sequence has started... [11/18/17 23:38:57.316][DEBUG] [Sequence Thread] Checking if observatory requires auto slaving... [11/18/17 23:38:57.316][DEBUG] [Sequence Thread] Observatory does not require auto slave... [11/18/17 23:38:57.323][DEBUG] [Sequence Thread] DoEventGroupChange: Changing to event group: NGC 891 [11/18/17 23:38:57.323][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Starting target "NGC 891"... [11/18/17 23:38:57.323][DEBUG] [Sequence Thread] GNS: Sent status message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Starting target "NGC 891"...)... [11/18/17 23:38:57.323][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Starting target "NGC 891"... [11/18/17 23:38:57.325][DEBUG] [Sequence Thread] Checking for start delay... [11/18/17 23:38:57.326][DEBUG] [Sequence Thread] DoEventGroupChange: Stopping Autoguider [11/18/17 23:38:57.327][DEBUG] [Sequence Thread] Attempting to stop PHD2 guiding... [11/18/17 23:38:57.327][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:38:57.327][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [11/18/17 23:38:57.327][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:38:57.427][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [11/18/17 23:38:57.427][DEBUG] [Sequence Thread] PHD2 Guider is already stopped. [11/18/17 23:38:57.428][DEBUG] [Sequence Thread] DoEventGroupChange: Centering on target [11/18/17 23:38:57.448][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Centering on target "NGC 891"... [11/18/17 23:38:57.448][DEBUG] [Sequence Thread] GNS: Sent status message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Centering on target "NGC 891"...)... [11/18/17 23:38:57.448][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Centering on target "NGC 891"... [11/18/17 23:38:57.523][DEBUG] [Telescope Thread] Center telescope message received... [11/18/17 23:38:57.523][DEBUG] [Telescope Thread] Solving with Plate Solver Pinpoint... [11/18/17 23:38:57.531][DEBUG] [Telescope Thread] Performing auto center step 1... [11/18/17 23:38:57.531][DEBUG] [Telescope Thread] Skipping step 1... [11/18/17 23:38:57.531][DEBUG] [Telescope Thread] Auto center reference frame solved successfully... [11/18/17 23:38:57.531][DEBUG] [Telescope Thread] Performing auto center step 3 (scope)... [11/18/17 23:38:57.531][DEBUG] [Telescope Thread] Auto center slewing scope to match reference... [11/18/17 23:38:57.533][DEBUG] [Telescope Thread] Telescope: Slewing to J2000 RA: 2.37498333333333 (02h22m29.94s) Dec: 42.3606638888889 (42°21'38.39") [11/18/17 23:38:57.533][DEBUG] [Telescope Thread] Telescope: Calling Observatory Slave Slew [11/18/17 23:39:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:39:26.070][DEBUG] [Telescope Thread] Scope reports it is done with synchronous slew, verifying... [11/18/17 23:39:26.070][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:26.072][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:27.073][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:27.076][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:28.077][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:28.081][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:29.082][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:29.082][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:30.083][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:30.086][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:31.087][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:31.091][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:32.092][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:32.096][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:33.097][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:33.102][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:34.103][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:34.107][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:35.108][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:35.108][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:36.109][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:36.113][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:37.114][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:37.118][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:38.119][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:38.122][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:39.123][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:39.127][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:40.129][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:40.133][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:41.134][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:41.138][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:42.139][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:42.143][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:43.144][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:39:43.148][DEBUG] [Telescope Thread] Telescope: Telescope is reporting slewing [11/18/17 23:39:44.149][DEBUG] [Telescope Thread] Telescope: Slewing has completed [11/18/17 23:39:44.149][DEBUG] [Telescope Thread] Auto center slew complete... [11/18/17 23:39:44.149][DEBUG] [Telescope Thread] Performing auto center step 4... [11/18/17 23:39:44.151][DEBUG] [Telescope Thread] Created full file name (file does not exist): C:\Users\Admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [11/18/17 23:39:44.166][DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE message received... [11/18/17 23:39:44.168][DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [11/18/17 23:39:44.171][DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [11/18/17 23:39:44.196][DEBUG] [Camera Thread] SetAscomNormalSpeed... [11/18/17 23:39:44.197][DEBUG] [Camera Thread] Readout speed set to NORMAL... [11/18/17 23:39:50.669][DEBUG] [Camera Thread] Created full file name (file does not exist): C:\Users\Admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [11/18/17 23:39:50.670][DEBUG] [Camera Thread] SaveFileAscom: Start... [11/18/17 23:39:50.670][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [11/18/17 23:39:50.670][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [11/18/17 23:39:50.671][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [11/18/17 23:39:50.671][DEBUG] [Camera Thread] SaveFileAscom: Validating file name... [11/18/17 23:39:50.671][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [11/18/17 23:39:50.694][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [11/18/17 23:39:50.694][DEBUG] [Camera Thread] SaveFileAscom: Saving preview bitmap to disk... [11/18/17 23:39:50.695][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [11/18/17 23:39:50.695][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [11/18/17 23:39:50.696][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [11/18/17 23:39:50.700][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [11/18/17 23:39:50.735][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [11/18/17 23:39:50.735][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [11/18/17 23:39:50.735][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [11/18/17 23:39:50.740][DEBUG] [Camera Thread] Internal Interface: Set Preview... [11/18/17 23:39:50.740][DEBUG] [Camera Thread] Display image preview using asynch task... [11/18/17 23:39:51.022][DEBUG] [Camera Thread] SaveFileAscom: Done [11/18/17 23:39:51.022][DEBUG] [Camera Thread] =========== Save file took 354 ms [11/18/17 23:39:51.022][DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE complete... [11/18/17 23:39:51.034][DEBUG] [Telescope Thread] Auto center verification frame complete. Plate solving image C:\Users\Admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [11/18/17 23:39:51.045][DEBUG] [Telescope Thread] ************* SOLVE HINTS **************** [11/18/17 23:39:51.045][DEBUG] [Telescope Thread] SOLVER: Pinpoint [11/18/17 23:39:51.045][DEBUG] [Telescope Thread] BLIND: False [11/18/17 23:39:51.045][DEBUG] [Telescope Thread] METHOD: Use up to magnitude 15 stars [11/18/17 23:39:51.045][DEBUG] [Telescope Thread] RA: 2.37512726292474 [11/18/17 23:39:51.045][DEBUG] [Telescope Thread] DEC: 42.3606781914894 [11/18/17 23:39:51.045][DEBUG] [Telescope Thread] SCALE: 1.08896405221896 [11/18/17 23:39:51.045][DEBUG] [Telescope Thread] ****************************************** [11/18/17 23:39:51.090][DEBUG] [Telescope Thread] Plate Solve Hint RA: 2.37512726292474 [11/18/17 23:39:51.090][DEBUG] [Telescope Thread] Plate Solve Hint DEC: 42.3606781914894 [11/18/17 23:39:51.090][DEBUG] [Telescope Thread] Plate Solve Hint Scale: 1.08896405221896 [11/18/17 23:39:51.090][DEBUG] [Telescope Thread] Plate Solve Hint Angle: 72.3107833014177 [11/18/17 23:39:51.090][DEBUG] [Telescope Thread] Plate Solve Search: Use up to magnitude 15 stars [11/18/17 23:39:51.090][DEBUG] [Telescope Thread] Plate solve binning: 2x2 [11/18/17 23:39:51.090][DEBUG] [Telescope Thread] Plate solve exp len: 3 [11/18/17 23:39:51.458][DEBUG] [Telescope Thread] *********** SUCCESSFUL SOLVE ************* [11/18/17 23:39:51.458][DEBUG] [Telescope Thread] SOLVER: False [11/18/17 23:39:51.458][DEBUG] [Telescope Thread] SUCCESS: True [11/18/17 23:39:51.458][DEBUG] [Telescope Thread] CONF: 22 [11/18/17 23:39:51.458][DEBUG] [Telescope Thread] BLIND: False [11/18/17 23:39:51.458][DEBUG] [Telescope Thread] RA: 2.37740354150643 [11/18/17 23:39:51.458][DEBUG] [Telescope Thread] DEC: 42.3594962981472 [11/18/17 23:39:51.458][DEBUG] [Telescope Thread] SCALE: 1.08802949538159 [11/18/17 23:39:51.458][DEBUG] [Telescope Thread] FLIPPED: False [11/18/17 23:39:51.458][DEBUG] [Telescope Thread] ANGLE (EON): 72.3076840944578 [11/18/17 23:39:51.458][DEBUG] [Telescope Thread] MSG: Matched 22 Stars. [11/18/17 23:39:51.458][DEBUG] [Telescope Thread] ****************************************** [11/18/17 23:39:51.459][DEBUG] [Telescope Thread] Checking to see if solve might be bad... [11/18/17 23:39:51.463][DEBUG] [Telescope Thread] Solve appears to be good... [11/18/17 23:39:51.463][DEBUG] [Telescope Thread] Auto center validation frame solved successfully... [11/18/17 23:39:51.464][DEBUG] [Telescope Thread] Telescope: Syncing to J2000 RA: 2.37740354150643 Dec: 42.3594962981472 [11/18/17 23:39:51.464][DEBUG] [Telescope Thread] Telescope: Sync behavior set to "Sync"... [11/18/17 23:39:51.501][DEBUG] [Telescope Thread] Attempting to write fits header info for C:\Users\Admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [11/18/17 23:39:51.502][DEBUG] [Telescope Thread] Opening fits file... [11/18/17 23:39:51.522][DEBUG] [Telescope Thread] Successfully opened fits file... [11/18/17 23:39:51.522][DEBUG] [Telescope Thread] Writing fits headers... [11/18/17 23:39:51.526][DEBUG] [Telescope Thread] Closing fits file [11/18/17 23:39:51.527][DEBUG] [Telescope Thread] Could not sync the rotator to 72.30769 degrees (not connected)! [11/18/17 23:39:51.527][DEBUG] [Telescope Thread] Auto center complete... [11/18/17 23:39:51.660][DEBUG] [Center Scope Thread] Unable to achieve results below allowable error (50 px) in 1 attempts! [11/18/17 23:39:51.660][DEBUG] [Center Scope Thread] RA Error: -240.2 [11/18/17 23:39:51.660][DEBUG] [Center Scope Thread] DEC Error: 7.7 [11/18/17 23:39:57.411][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [11/18/17 23:39:57.411][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [11/18/17 23:39:57.411][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [11/18/17 23:39:57.411][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:39:57.411][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [11/18/17 23:40:03.064][DEBUG] [Sequence Thread] Recovering the sequence (when centering the target) [11/18/17 23:40:03.064][DEBUG] [Sequence Thread] Adding sequence level notification: Something has gone wrong when centering the target [11/18/17 23:40:03.066][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, Warning): (NGC 891 Tal 200K-Atik460-QHY5L-II) Something has gone wrong when centering the target [11/18/17 23:40:03.066][DEBUG] [Sequence Thread] GNS: Sent warning message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Something has gone wrong when centering the target)... [11/18/17 23:40:03.067][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, Warning): (NGC 891 Tal 200K-Atik460-QHY5L-II) Something has gone wrong when centering the target [11/18/17 23:40:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:40:48.331][DEBUG] [TEC Thread] TEC Change: Complete... [11/18/17 23:40:48.343][DEBUG] [TEC Thread] SGM_CHANGE_COOLER_TEMP complete... [11/18/17 23:40:57.520][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [11/18/17 23:40:57.520][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [11/18/17 23:40:57.520][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [11/18/17 23:40:57.520][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:40:57.520][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [11/18/17 23:40:58.339][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [11/18/17 23:40:58.340][DEBUG] [MF Update Thread] Performing serialize... [11/18/17 23:41:03.153][DEBUG] [Recovery Sequence Thread] Something bad has happened... attempting to recover the sequence (attempt 1)... [11/18/17 23:41:03.154][DEBUG] [Recovery Sequence Thread] Recovery method using auto center (only) has started... [11/18/17 23:41:03.204][DEBUG] [Telescope Thread] Center telescope message received... [11/18/17 23:41:03.204][DEBUG] [Telescope Thread] Solving with Plate Solver Pinpoint... [11/18/17 23:41:03.267][DEBUG] [Telescope Thread] Performing auto center step 1... [11/18/17 23:41:03.267][DEBUG] [Telescope Thread] Skipping step 1... [11/18/17 23:41:03.267][DEBUG] [Telescope Thread] Auto center reference frame solved successfully... [11/18/17 23:41:03.267][DEBUG] [Telescope Thread] Performing auto center step 3 (scope)... [11/18/17 23:41:03.267][DEBUG] [Telescope Thread] Auto center slewing scope to match reference... [11/18/17 23:41:03.267][DEBUG] [Telescope Thread] Telescope: Slewing to J2000 RA: 2.37498333333333 (02h22m29.94s) Dec: 42.3606638888889 (42°21'38.39") [11/18/17 23:41:03.267][DEBUG] [Telescope Thread] Telescope: Calling Observatory Slave Slew [11/18/17 23:41:04.077][DEBUG] [Telescope Thread] Scope reports it is done with synchronous slew, verifying... [11/18/17 23:41:04.078][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [11/18/17 23:41:05.078][DEBUG] [Telescope Thread] Telescope: Slewing has completed [11/18/17 23:41:05.078][DEBUG] [Telescope Thread] Auto center slew complete... [11/18/17 23:41:05.078][DEBUG] [Telescope Thread] Performing auto center step 4... [11/18/17 23:41:05.078][DEBUG] [Telescope Thread] Created full file name (file does not exist): C:\Users\Admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [11/18/17 23:41:05.087][DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE message received... [11/18/17 23:41:05.087][DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [11/18/17 23:41:05.087][DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [11/18/17 23:41:05.120][DEBUG] [Camera Thread] SetAscomNormalSpeed... [11/18/17 23:41:05.121][DEBUG] [Camera Thread] Readout speed set to NORMAL... [11/18/17 23:41:14.566][DEBUG] [Camera Thread] Created full file name (file does not exist): C:\Users\Admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [11/18/17 23:41:14.566][DEBUG] [Camera Thread] SaveFileAscom: Start... [11/18/17 23:41:14.566][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [11/18/17 23:41:14.566][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [11/18/17 23:41:14.567][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [11/18/17 23:41:14.567][DEBUG] [Camera Thread] SaveFileAscom: Validating file name... [11/18/17 23:41:14.567][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [11/18/17 23:41:14.588][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [11/18/17 23:41:14.588][DEBUG] [Camera Thread] SaveFileAscom: Saving preview bitmap to disk... [11/18/17 23:41:14.588][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [11/18/17 23:41:14.588][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [11/18/17 23:41:14.588][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [11/18/17 23:41:14.588][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [11/18/17 23:41:14.623][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [11/18/17 23:41:14.623][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [11/18/17 23:41:14.623][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [11/18/17 23:41:14.625][DEBUG] [Camera Thread] Internal Interface: Set Preview... [11/18/17 23:41:14.625][DEBUG] [Camera Thread] Display image preview using asynch task... [11/18/17 23:41:15.113][DEBUG] [Camera Thread] SaveFileAscom: Done [11/18/17 23:41:15.113][DEBUG] [Camera Thread] =========== Save file took 557 ms [11/18/17 23:41:15.113][DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE complete... [11/18/17 23:41:15.213][DEBUG] [Telescope Thread] Auto center verification frame complete. Plate solving image C:\Users\Admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [11/18/17 23:41:15.220][DEBUG] [Telescope Thread] ************* SOLVE HINTS **************** [11/18/17 23:41:15.220][DEBUG] [Telescope Thread] SOLVER: Pinpoint [11/18/17 23:41:15.220][DEBUG] [Telescope Thread] BLIND: False [11/18/17 23:41:15.220][DEBUG] [Telescope Thread] METHOD: Use up to magnitude 15 stars [11/18/17 23:41:15.220][DEBUG] [Telescope Thread] RA: 2.37500151587576 [11/18/17 23:41:15.220][DEBUG] [Telescope Thread] DEC: 42.3606781914894 [11/18/17 23:41:15.220][DEBUG] [Telescope Thread] SCALE: 1.08802949538159 [11/18/17 23:41:15.220][DEBUG] [Telescope Thread] ****************************************** [11/18/17 23:41:15.246][DEBUG] [Telescope Thread] Plate Solve Hint RA: 2.37500151587576 [11/18/17 23:41:15.246][DEBUG] [Telescope Thread] Plate Solve Hint DEC: 42.3606781914894 [11/18/17 23:41:15.246][DEBUG] [Telescope Thread] Plate Solve Hint Scale: 1.08802949538159 [11/18/17 23:41:15.246][DEBUG] [Telescope Thread] Plate Solve Hint Angle: 72.3076840944578 [11/18/17 23:41:15.246][DEBUG] [Telescope Thread] Plate Solve Search: Use up to magnitude 15 stars [11/18/17 23:41:15.246][DEBUG] [Telescope Thread] Plate solve binning: 2x2 [11/18/17 23:41:15.246][DEBUG] [Telescope Thread] Plate solve exp len: 3 [11/18/17 23:41:15.743][DEBUG] [Telescope Thread] *********** SUCCESSFUL SOLVE ************* [11/18/17 23:41:15.743][DEBUG] [Telescope Thread] SOLVER: False [11/18/17 23:41:15.743][DEBUG] [Telescope Thread] SUCCESS: True [11/18/17 23:41:15.743][DEBUG] [Telescope Thread] CONF: 90 [11/18/17 23:41:15.743][DEBUG] [Telescope Thread] BLIND: False [11/18/17 23:41:15.744][DEBUG] [Telescope Thread] RA: 2.37497422800723 [11/18/17 23:41:15.744][DEBUG] [Telescope Thread] DEC: 42.360608982085 [11/18/17 23:41:15.744][DEBUG] [Telescope Thread] SCALE: 1.09069434648887 [11/18/17 23:41:15.744][DEBUG] [Telescope Thread] FLIPPED: False [11/18/17 23:41:15.744][DEBUG] [Telescope Thread] ANGLE (EON): 72.3331799014232 [11/18/17 23:41:15.744][DEBUG] [Telescope Thread] MSG: Matched 90 Stars. [11/18/17 23:41:15.744][DEBUG] [Telescope Thread] ****************************************** [11/18/17 23:41:15.744][DEBUG] [Telescope Thread] Checking to see if solve might be bad... [11/18/17 23:41:15.747][DEBUG] [Telescope Thread] Solve appears to be good... [11/18/17 23:41:15.747][DEBUG] [Telescope Thread] Auto center validation frame solved successfully... [11/18/17 23:41:15.747][DEBUG] [Telescope Thread] Telescope: Syncing to J2000 RA: 2.37497422800723 Dec: 42.360608982085 [11/18/17 23:41:15.747][DEBUG] [Telescope Thread] Telescope: Sync behavior set to "Sync"... [11/18/17 23:41:15.784][DEBUG] [Telescope Thread] Attempting to write fits header info for C:\Users\Admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [11/18/17 23:41:15.784][DEBUG] [Telescope Thread] Opening fits file... [11/18/17 23:41:15.785][DEBUG] [Telescope Thread] Successfully opened fits file... [11/18/17 23:41:15.785][DEBUG] [Telescope Thread] Writing fits headers... [11/18/17 23:41:15.785][DEBUG] [Telescope Thread] Closing fits file [11/18/17 23:41:15.785][DEBUG] [Telescope Thread] Could not sync the rotator to 72.33318 degrees (not connected)! [11/18/17 23:41:15.785][DEBUG] [Telescope Thread] Auto center complete... [11/18/17 23:41:15.900][DEBUG] [Center Scope Thread] Automatic Auto Center Success - Total Error <= Allowable error: 1.0 <= 50.0 [11/18/17 23:41:15.900][DEBUG] [Center Scope Thread] RA Error: 0.9 [11/18/17 23:41:15.900][DEBUG] [Center Scope Thread] DEC Error: 0.4 [11/18/17 23:41:16.070][DEBUG] [Recovery Sequence Thread] Recovery: Centering is successful... [11/18/17 23:41:16.073][DEBUG] [Recovery Sequence Thread] Sequence recovery was successful! [11/18/17 23:41:16.073][DEBUG] [Recovery Sequence Thread] Closing recovery dialog... [11/18/17 23:41:16.209][DEBUG] [Sequence Thread] Sequence recovery was successful (Centering)! [11/18/17 23:41:16.210][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Sequence recovery was successful (Centering)! [11/18/17 23:41:16.210][DEBUG] [Sequence Thread] GNS: Sent status message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Sequence recovery was successful (Centering)!)... [11/18/17 23:41:16.210][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Sequence recovery was successful (Centering)! [11/18/17 23:41:16.210][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Successfully centered on target "NGC 891"... [11/18/17 23:41:16.210][DEBUG] [Sequence Thread] GNS: Sent status message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Successfully centered on target "NGC 891"...)... [11/18/17 23:41:16.210][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Successfully centered on target "NGC 891"... [11/18/17 23:41:16.210][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Attempting to resume the auto guider (post slew / center)... [11/18/17 23:41:16.210][DEBUG] [Sequence Thread] GNS: Sent status message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Attempting to resume the auto guider (post slew / center)...)... [11/18/17 23:41:16.210][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Attempting to resume the auto guider (post slew / center)... [11/18/17 23:41:16.210][DEBUG] [Sequence Thread] DoEventGroupChange: Slewed or Centered, attempting to start guiding. [11/18/17 23:41:16.221][DEBUG] [Sequence Thread] DoEventGroupChange: Pier flipped, flipping Cal data [11/18/17 23:41:16.222][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "flip_calibration", "id": 1005} [11/18/17 23:41:16.286][DEBUG] [PHD2 Listener Thread] Error received from RPC: could not flip calibration [11/18/17 23:41:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:41:47.223][DEBUG] [Sequence Thread] PHD2: Auto Resume [11/18/17 23:41:47.223][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:41:47.223][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [11/18/17 23:41:47.223][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:41:47.324][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [11/18/17 23:41:48.324][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:41:48.324][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [11/18/17 23:41:48.324][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:41:48.424][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [11/18/17 23:41:49.424][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:41:49.424][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [11/18/17 23:41:49.424][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:41:49.525][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [11/18/17 23:41:50.525][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:41:50.525][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [11/18/17 23:41:50.525][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:41:50.625][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [11/18/17 23:41:51.625][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:41:51.625][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [11/18/17 23:41:51.625][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:41:51.726][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [11/18/17 23:41:51.727][DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 0.3, "time": 3, "timeout": 600}, false ], "id": 1003} [11/18/17 23:41:51.727][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 0.3, "time": 3, "timeout": 600}, false ], "id": 1003} [11/18/17 23:41:51.728][DEBUG] [Sequence Thread] PHD2: Attempting to start guiding, waiting for PHD2 settle done message... [11/18/17 23:42:16.528][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [11/18/17 23:42:16.533][DEBUG] [MF Update Thread] Performing serialize... [11/18/17 23:42:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:42:59.537][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [11/18/17 23:42:59.537][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [11/18/17 23:42:59.537][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [11/18/17 23:42:59.537][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:42:59.537][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [11/18/17 23:43:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:43:59.645][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [11/18/17 23:43:59.645][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [11/18/17 23:43:59.645][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Calibrating [11/18/17 23:43:59.645][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:43:59.645][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Calibrating [11/18/17 23:44:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:44:59.759][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [11/18/17 23:44:59.759][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [11/18/17 23:44:59.759][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Calibrating [11/18/17 23:44:59.759][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:44:59.759][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Calibrating [11/18/17 23:45:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:45:59.904][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [11/18/17 23:45:59.904][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [11/18/17 23:45:59.904][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Calibrating [11/18/17 23:45:59.904][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:45:59.904][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Calibrating [11/18/17 23:46:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:47:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:48:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:48:30.875][DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: GOOD [11/18/17 23:48:31.758][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:48:31.758][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Calibrating [11/18/17 23:48:31.758][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:48:31.859][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:48:31.859][DEBUG] [Sequence Thread] PHD2 settle successful... [11/18/17 23:48:31.869][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Auto guider has resumed (post slew / center)... [11/18/17 23:48:31.869][DEBUG] [Sequence Thread] GNS: Sent status message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Auto guider has resumed (post slew / center)...)... [11/18/17 23:48:31.869][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Auto guider has resumed (post slew / center)... [11/18/17 23:48:31.920][DEBUG] [Sequence Thread] DoEventGroupChange: Complete [11/18/17 23:48:31.921][DEBUG] [Sequence Thread] Attempting to find next event... [11/18/17 23:48:31.922][DEBUG] [Sequence Thread] Current event[0] frame count: 1/15... [11/18/17 23:48:31.923][DEBUG] [Sequence Thread] Looking at event[0]... [11/18/17 23:48:31.923][DEBUG] [Sequence Thread] Found event event[0] with remaining frames. [11/18/17 23:48:31.923][DEBUG] [Sequence Thread] Event[0] frame count: 1/15... [11/18/17 23:48:31.923][DEBUG] [Sequence Thread] Getting first event (0)... [11/18/17 23:48:31.923][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [11/18/17 23:48:31.930][DEBUG] [Sequence Thread] Running pre event... [11/18/17 23:48:31.951][DEBUG] [Sequence Thread] Running capture event... [11/18/17 23:48:31.954][DEBUG] [Sequence Thread] SetStartTemp: Using focuser for temperature... [11/18/17 23:48:31.954][DEBUG] [Sequence Thread] Set start frame temp to 7.93333333333333... [11/18/17 23:48:31.958][DEBUG] [Sequence Thread] ------------- Starting capture frame for event[0] ------------- [11/18/17 23:48:31.959][DEBUG] [Sequence Thread] Sending commands... [11/18/17 23:48:31.961][DEBUG] [Sequence Thread] SetFlatBox: Frame Type is Light [11/18/17 23:48:31.963][DEBUG] [Sequence Thread] EventMarker 2 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:48:31.964][DEBUG] [Sequence Thread] Checking if Meridian Flip is needed [11/18/17 23:48:31.965][DEBUG] [Sequence Thread] Meridian flip not needed, telescope on East side [11/18/17 23:48:31.965][DEBUG] [Sequence Thread] EventMarker 3 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:48:31.966][DEBUG] [Sequence Thread] Waiting for AF to complete... [11/18/17 23:48:31.970][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [11/18/17 23:48:31.974][DEBUG] [Camera Thread] Checking for auto focus... [11/18/17 23:48:31.974][DEBUG] [Camera Thread] Auto focus required (focus before first frame)... [11/18/17 23:48:31.974][DEBUG] [Camera Thread] Handling monitoring event (Good Night System, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Running auto focus... [11/18/17 23:48:31.974][DEBUG] [Camera Thread] GNS: Sent status message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Running auto focus...)... [11/18/17 23:48:31.974][DEBUG] [Camera Thread] Handling monitoring event (Email 1, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Running auto focus... [11/18/17 23:48:31.975][DEBUG] [Camera Thread] Pause guiding while AF is active, pause command sent, waiting for guider to pause... [11/18/17 23:48:31.975][DEBUG] [Camera Thread] Checking PHD2 state... [11/18/17 23:48:31.975][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:48:31.975][DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:48:31.981][DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE message received... [11/18/17 23:48:31.981][DEBUG] [Auto Guider Thread] Pausing auto guider... [11/18/17 23:48:31.982][DEBUG] [Auto Guider Thread] Checking PHD2 state... [11/18/17 23:48:31.982][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:48:31.982][DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:48:32.076][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:48:32.083][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:48:32.083][DEBUG] [Auto Guider Thread] Sending to PHD2: {"method":"set_paused","params":[true,"full"],"id":42} [11/18/17 23:48:32.083][DEBUG] [Auto Guider Thread] Checking PHD2 state... [11/18/17 23:48:32.083][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:48:32.083][DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:48:32.183][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:48:33.076][DEBUG] [Camera Thread] Checking PHD2 state... [11/18/17 23:48:33.076][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [11/18/17 23:48:33.076][DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:48:33.176][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [11/18/17 23:48:33.183][DEBUG] [Auto Guider Thread] Checking PHD2 state... [11/18/17 23:48:33.183][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [11/18/17 23:48:33.183][DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:48:33.285][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Paused [11/18/17 23:48:33.285][DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE complete... [11/18/17 23:48:34.177][DEBUG] [Camera Thread] Checking PHD2 state... [11/18/17 23:48:34.177][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [11/18/17 23:48:34.177][DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:48:34.278][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [11/18/17 23:48:35.278][DEBUG] [Camera Thread] Checking PHD2 state... [11/18/17 23:48:35.278][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [11/18/17 23:48:35.278][DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:48:35.378][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [11/18/17 23:48:36.378][DEBUG] [Camera Thread] Checking PHD2 state... [11/18/17 23:48:36.378][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [11/18/17 23:48:36.378][DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:48:36.479][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [11/18/17 23:48:37.479][DEBUG] [Camera Thread] Checking PHD2 state... [11/18/17 23:48:37.479][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [11/18/17 23:48:37.479][DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:48:37.580][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [11/18/17 23:48:37.589][DEBUG] [Camera Thread] Auto focus: setting filter Red [11/18/17 23:48:37.591][DEBUG] [Camera Thread] Setting filter position 2... [11/18/17 23:48:37.591][DEBUG] [Camera Thread] Filter position 2 is already set. Skipping... [11/18/17 23:48:37.593][DEBUG] [Camera Thread] Auto focus running... [11/18/17 23:48:37.609][DEBUG] [Camera Thread] Turning temp comp off.. [11/18/17 23:48:37.625][DEBUG] [Camera Thread] ASCOM Focuser: Temp comp is avaialble, setting to False [11/18/17 23:48:37.641][DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE message received... [11/18/17 23:48:37.641][DEBUG] [Auto Guider Thread] Pausing auto guider... [11/18/17 23:48:37.641][DEBUG] [Auto Guider Thread] Checking PHD2 state... [11/18/17 23:48:37.641][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [11/18/17 23:48:37.641][DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:48:37.648][DEBUG] [Camera Thread] Performing Sequence Generator auto focus using Half Flux Radius. AFID: 0 [11/18/17 23:48:37.678][DEBUG] [AfChartThread] Showing AF chart dialog... [11/18/17 23:48:37.705][DEBUG] [Camera Thread] Auto focus data [11/18/17 23:48:37.705][DEBUG] [Camera Thread] - Data Points: 7 [11/18/17 23:48:37.705][DEBUG] [Camera Thread] - Step Size: 25 [11/18/17 23:48:37.705][DEBUG] [Camera Thread] - Current Position: 9871 [11/18/17 23:48:37.705][DEBUG] [Camera Thread] - Initial Move Position: 9946 [11/18/17 23:48:37.714][DEBUG] [Camera Thread] AF Darks exception: The path is not of a legal form. [11/18/17 23:48:37.715][DEBUG] [Camera Thread] Moving focuser to next position (9946)... [11/18/17 23:48:37.718][DEBUG] [Focuser Move Thread] Focuser moving to 9946 [11/18/17 23:48:37.730][DEBUG] [Focuser Move Thread] Focuser backlash active, modified move to 9996 [11/18/17 23:48:37.731][DEBUG] [Focuser Move Thread] Focuser move call complete [11/18/17 23:48:37.742][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Paused [11/18/17 23:48:37.742][DEBUG] [Auto Guider Thread] PHD2: Requested pause, but PHD2 reports it is not guiding [11/18/17 23:48:37.742][DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE complete... [11/18/17 23:48:37.744][DEBUG] [Focuser Backlash Thread] Focuser backlash thread has started... [11/18/17 23:48:39.754][DEBUG] [Focuser Backlash Thread] Backlash thread has detected that movement to modified position (9996) is complete... [11/18/17 23:48:39.754][DEBUG] [Focuser Backlash Thread] Moving focuser to original requested position (9946)... [11/18/17 23:48:39.754][DEBUG] [Focuser Backlash Thread] Focuser backlash compensation needed. Steps: 50 Direction:IN [11/18/17 23:48:39.754][DEBUG] [Focuser Backlash Thread] Focuser moving to 9946 [11/18/17 23:48:39.765][DEBUG] [Focuser Backlash Thread] Focuser move call complete [11/18/17 23:48:40.806][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 9946 matches requested position 9946 [11/18/17 23:48:40.807][DEBUG] [Camera Thread] Focuser move complete... [11/18/17 23:48:41.789][DEBUG] [Focuser Backlash Thread] Focuser backlash completed. Focuser is at original request position (9946)... [11/18/17 23:48:41.789][DEBUG] [Focuser Backlash Thread] Focuser backlash thread has ended... [11/18/17 23:48:41.807][DEBUG] [Camera Thread] Focuser position matches requested position (9946), continuing... [11/18/17 23:48:41.820][DEBUG] [Camera Thread] Calculating step metric... [11/18/17 23:48:41.822][DEBUG] [Camera Thread] Taking auto focus frame(s)... [11/18/17 23:48:41.831][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [11/18/17 23:48:41.831][DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [11/18/17 23:48:41.831][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 3 seconds... [11/18/17 23:48:41.831][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [11/18/17 23:48:41.835][DEBUG] [Camera Thread] SetAscomNormalSpeed... [11/18/17 23:48:41.835][DEBUG] [Camera Thread] Readout speed set to NORMAL... [11/18/17 23:48:46.326][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [11/18/17 23:48:46.330][DEBUG] [MF Update Thread] Performing serialize... [11/18/17 23:48:48.250][DEBUG] [Camera Thread] SaveFileAscom: Start... [11/18/17 23:48:48.250][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [11/18/17 23:48:48.250][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [11/18/17 23:48:48.251][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [11/18/17 23:48:48.251][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [11/18/17 23:48:48.274][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [11/18/17 23:48:48.274][DEBUG] [Camera Thread] SaveFileAscom: Done [11/18/17 23:48:48.274][DEBUG] [Camera Thread] Internal Interface: Set Preview... [11/18/17 23:48:48.274][DEBUG] [Camera Thread] Display image preview using asynch task... [11/18/17 23:48:48.425][DEBUG] [Main Thread] --> Find stars (normal) [11/18/17 23:48:49.403][DEBUG] [Main Thread] Star detection using min star size of 3px... [11/18/17 23:48:49.403][DEBUG] [Main Thread] Star detection using max star size of 60px... [11/18/17 23:48:49.449][DEBUG] [Main Thread] Find stars took: 1022 ms... [11/18/17 23:48:49.450][DEBUG] [Main Thread] Star list contains 87 stars... [11/18/17 23:48:49.450][DEBUG] [Main Thread] Calculating HFR with sample size: 3 [11/18/17 23:48:49.897][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.75 [11/18/17 23:48:50.925][DEBUG] [Camera Thread] Moving focuser to next position (9921)... [11/18/17 23:48:50.929][DEBUG] [Focuser Move Thread] Focuser moving to 9921 [11/18/17 23:48:50.948][DEBUG] [Focuser Move Thread] Focuser move call complete [11/18/17 23:48:51.959][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 9921 matches requested position 9921 [11/18/17 23:48:51.959][DEBUG] [Camera Thread] Focuser move complete... [11/18/17 23:48:51.972][DEBUG] [Camera Thread] Focuser position matches requested position (9921), continuing... [11/18/17 23:48:51.985][DEBUG] [Camera Thread] Calculating step metric... [11/18/17 23:48:51.985][DEBUG] [Camera Thread] Taking auto focus frame(s)... [11/18/17 23:48:51.987][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [11/18/17 23:48:51.987][DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [11/18/17 23:48:51.987][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 3 seconds... [11/18/17 23:48:51.987][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [11/18/17 23:48:51.990][DEBUG] [Camera Thread] SetAscomNormalSpeed... [11/18/17 23:48:51.990][DEBUG] [Camera Thread] Readout speed set to NORMAL... [11/18/17 23:48:58.458][DEBUG] [Camera Thread] SaveFileAscom: Start... [11/18/17 23:48:58.458][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [11/18/17 23:48:58.458][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [11/18/17 23:48:58.459][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [11/18/17 23:48:58.459][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [11/18/17 23:48:58.481][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [11/18/17 23:48:58.481][DEBUG] [Camera Thread] SaveFileAscom: Done [11/18/17 23:48:58.481][DEBUG] [Camera Thread] Internal Interface: Set Preview... [11/18/17 23:48:58.481][DEBUG] [Camera Thread] Display image preview using asynch task... [11/18/17 23:48:58.666][DEBUG] [Main Thread] --> Find stars (normal) [11/18/17 23:48:59.508][DEBUG] [Main Thread] Star detection using min star size of 3px... [11/18/17 23:48:59.508][DEBUG] [Main Thread] Star detection using max star size of 60px... [11/18/17 23:48:59.536][DEBUG] [Main Thread] Find stars took: 870 ms... [11/18/17 23:48:59.536][DEBUG] [Main Thread] Star list contains 83 stars... [11/18/17 23:48:59.536][DEBUG] [Main Thread] Calculating HFR with sample size: 3 [11/18/17 23:48:59.785][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.79 [11/18/17 23:49:00.791][DEBUG] [Camera Thread] Moving focuser to next position (9896)... [11/18/17 23:49:00.791][DEBUG] [Focuser Move Thread] Focuser moving to 9896 [11/18/17 23:49:00.802][DEBUG] [Focuser Move Thread] Focuser move call complete [11/18/17 23:49:01.814][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 9896 matches requested position 9896 [11/18/17 23:49:01.814][DEBUG] [Camera Thread] Focuser move complete... [11/18/17 23:49:01.827][DEBUG] [Camera Thread] Focuser position matches requested position (9896), continuing... [11/18/17 23:49:01.839][DEBUG] [Camera Thread] Calculating step metric... [11/18/17 23:49:01.839][DEBUG] [Camera Thread] Taking auto focus frame(s)... [11/18/17 23:49:01.840][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [11/18/17 23:49:01.840][DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [11/18/17 23:49:01.840][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 3 seconds... [11/18/17 23:49:01.840][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [11/18/17 23:49:01.843][DEBUG] [Camera Thread] SetAscomNormalSpeed... [11/18/17 23:49:01.844][DEBUG] [Camera Thread] Readout speed set to NORMAL... [11/18/17 23:49:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:49:37.726][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [11/18/17 23:49:37.726][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [11/18/17 23:49:37.726][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [11/18/17 23:49:37.726][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:49:37.726][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Paused [11/18/17 23:50:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:50:37.862][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [11/18/17 23:50:37.862][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [11/18/17 23:50:37.862][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [11/18/17 23:50:37.862][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:50:37.862][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Paused [11/18/17 23:51:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:51:37.993][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [11/18/17 23:51:37.993][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [11/18/17 23:51:37.993][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [11/18/17 23:51:37.993][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:51:37.993][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Paused [11/18/17 23:51:58.041][DEBUG] [Camera Thread] ASCOM Camera: abort message received in download... [11/18/17 23:51:58.041][DEBUG] [Camera Thread] ASCOM Camera: Attempting to abort exposure... [11/18/17 23:51:58.041][DEBUG] [Camera Thread] ASCOM Camera: Asking camera to abort... [11/18/17 23:51:58.047][DEBUG] [Camera Thread] ASCOM Camera: Camera has acknowledged abort request... [11/18/17 23:51:58.047][DEBUG] [Camera Thread] ASCOM Camera: Blocking until image is aborted... [11/18/17 23:51:58.047][DEBUG] [Camera Thread] ASCOM Camera: Image is aborted... [11/18/17 23:51:58.049][DEBUG] [Camera Thread] HFR value from auto focuser is 0!, trying again... [11/18/17 23:51:58.049][DEBUG] [Camera Thread] AF abort requested [11/18/17 23:51:58.050][DEBUG] [Camera Thread] Auto focus (finally): closing dialog... [11/18/17 23:51:58.055][DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_ABS message received... [11/18/17 23:51:58.055][DEBUG] [Focuser Thread] Focuser moving to 9871 [11/18/17 23:51:58.061][DEBUG] [AfChartThread] AF chart dialog is closed... [11/18/17 23:51:58.070][DEBUG] [Focuser Thread] Focuser move call complete [11/18/17 23:51:58.113][DEBUG] [Camera Thread] Auto focus complete... [11/18/17 23:51:58.120][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [11/18/17 23:51:58.280][DEBUG] [Sequence Thread] AF is complete, continuing sequence... [11/18/17 23:51:58.281][DEBUG] [Sequence Thread] EventMarker 4 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:51:58.281][DEBUG] [Sequence Thread] Setting filter position 2... [11/18/17 23:51:58.281][DEBUG] [Sequence Thread] Filter position 2 is already set. Skipping... [11/18/17 23:51:58.281][DEBUG] [Sequence Thread] EventMarker 5 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:51:58.282][DEBUG] [Sequence Thread] Checking for auto manual focus (pre)... [11/18/17 23:51:58.282][DEBUG] [Sequence Thread] EventMarker 6 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:51:58.301][DEBUG] [Sequence Thread] Created base name for frame capture: NGC 891_180sec_2x2_R_frame2 [11/18/17 23:51:58.302][DEBUG] [Sequence Thread] Created directory for frame capture: C:\\2017-11-18\Light\ [11/18/17 23:51:58.302][DEBUG] [Sequence Thread] EventMarker 1 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:51:58.302][DEBUG] [Sequence Thread] EventMarker 7 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:51:58.305][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [11/18/17 23:51:58.305][DEBUG] [Sequence Thread] EventMarker 170 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:51:58.305][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:51:58.305][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [11/18/17 23:51:58.305][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:51:58.406][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Paused [11/18/17 23:51:58.406][DEBUG] [Sequence Thread] Sending to PHD2: {"method":"set_paused","params":[false],"id":42} [11/18/17 23:51:58.406][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:51:58.406][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [11/18/17 23:51:58.406][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:51:58.607][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:51:59.230][DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_ABS complete... [11/18/17 23:51:59.607][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:51:59.607][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:51:59.607][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:51:59.708][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:52:00.708][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:52:00.708][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:52:00.708][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:52:00.808][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:52:01.808][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:52:01.808][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:52:01.808][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:52:01.909][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:52:02.909][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:52:02.909][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:52:02.909][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:52:03.009][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:52:03.009][DEBUG] [Sequence Thread] EventMarker 171 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:52:03.009][DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 0.3, "time": 3, "timeout": 600}, false ], "id": 1003} [11/18/17 23:52:03.012][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 0.3, "time": 3, "timeout": 600}, false ], "id": 1003} [11/18/17 23:52:03.012][DEBUG] [Sequence Thread] EventMarker 172 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:52:03.012][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:52:03.012][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:52:03.012][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:52:03.113][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:52:03.113][DEBUG] [Sequence Thread] EventMarker 173 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:52:03.113][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Attempting to settle the auto guider... [11/18/17 23:52:03.113][DEBUG] [Sequence Thread] GNS: Sent status message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Attempting to settle the auto guider...)... [11/18/17 23:52:03.113][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Attempting to settle the auto guider... [11/18/17 23:52:03.113][DEBUG] [Sequence Thread] Waiting for Auto Guider distance to fall below 0.3 [11/18/17 23:52:03.114][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:52:03.114][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:52:03.123][DEBUG] [Sequence Thread] Distance is below 0.3, starting timer... [11/18/17 23:52:03.623][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:52:03.623][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:52:04.135][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:52:04.135][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:52:04.646][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:52:04.646][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:52:05.163][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:52:05.163][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:52:05.669][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:52:05.669][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:52:06.177][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:52:06.177][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:52:06.196][DEBUG] [Sequence Thread] Distance stayed below 0.3 for 3 seconds, done settling... [11/18/17 23:52:06.196][DEBUG] [Sequence Thread] SGPro settle criteria have been met, but the guider reports it is not ready to resume, waiting... [11/18/17 23:52:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:52:48.666][DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: GOOD [11/18/17 23:52:48.708][DEBUG] [Sequence Thread] Auto guider has settled... [11/18/17 23:52:48.710][DEBUG] [Sequence Thread] EventMarker 8 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:52:48.710][DEBUG] [Sequence Thread] EventMarker 9 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:52:48.710][DEBUG] [Sequence Thread] EventMarker 10 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:52:48.710][DEBUG] [Sequence Thread] Finished sending frame capture. Entering wait mode... [11/18/17 23:52:48.710][DEBUG] [Sequence Thread] EventMarker 11 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:52:48.710][DEBUG] [Sequence Thread] EventMarker 12 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:52:48.710][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Starting integration of NGC 891; Event 1; Frame 2 for 180s... [11/18/17 23:52:48.710][DEBUG] [Sequence Thread] GNS: Sent status message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Starting integration of NGC 891; Event 1; Frame 2 for 180s...)... [11/18/17 23:52:48.710][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Starting integration of NGC 891; Event 1; Frame 2 for 180s... [11/18/17 23:52:48.711][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, TimedError): (NGC 891 Tal 200K-Atik460-QHY5L-II) Failure while integrating NGC 891; Event 1; Frame 2 for 180s. Image has not downloaded in alloted time period. [11/18/17 23:52:48.712][DEBUG] [Sequence Thread] GNS: Sent timed event to GNS... [11/18/17 23:52:48.712][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, TimedError): (NGC 891 Tal 200K-Atik460-QHY5L-II) Failure while integrating NGC 891; Event 1; Frame 2 for 180s. Image has not downloaded in alloted time period. [11/18/17 23:52:48.712][DEBUG] [Sequence Thread] EventMarker 13 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:52:48.713][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE message received... [11/18/17 23:52:48.713][DEBUG] [Camera Thread] ASCOM Camera: Attempting to abort exposure... [11/18/17 23:52:48.714][DEBUG] [Camera Thread] ASCOM Camera: Asking camera to abort... [11/18/17 23:52:48.716][DEBUG] [Camera Thread] ASCOM Camera: Camera has acknowledged abort request... [11/18/17 23:52:48.716][DEBUG] [Camera Thread] ASCOM Camera: Blocking until image is aborted... [11/18/17 23:52:48.716][DEBUG] [Camera Thread] ASCOM Camera: Image is aborted... [11/18/17 23:52:48.718][DEBUG] [Camera Thread] SetAscomNormalSpeed... [11/18/17 23:52:48.719][DEBUG] [Camera Thread] Readout speed set to NORMAL... [11/18/17 23:52:48.728][DEBUG] [Camera Thread] ASCOM Camera Error : CheckDotNetExceptions ASCOM.Atik2.Camera StartExposure System.ApplicationException: StartExposure - Camera not idle (See Inner Exception for details) (System.ApplicationException: StartExposure - Camera not idle) at ASCOM.DriverAccess.MemberFactory.CheckDotNetExceptions(String memberName, Exception e) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 630 at ASCOM.DriverAccess.MemberFactory.MethodTargetInvocationExceptionHandler(String memberName, Exception e) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 678 at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 487 at ASCOM.DriverAccess.Camera.StartExposure(Double Duration, Boolean Light) in c:\ASCOM Build\Export\ASCOM.DriverAccess\Camera.cs:line 595 at q3.h9(pe A_0, rd& A_1) [11/18/17 23:52:48.728][DEBUG] [Camera Thread] ASCOM Camera: Attempting to abort exposure... [11/18/17 23:52:48.729][DEBUG] [Camera Thread] ASCOM Camera: Asking camera to abort... [11/18/17 23:52:48.731][DEBUG] [Camera Thread] ASCOM Camera: Camera has acknowledged abort request... [11/18/17 23:52:48.731][DEBUG] [Camera Thread] ASCOM Camera: Blocking until image is aborted... [11/18/17 23:53:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:54:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:55:22.472][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:55:48.799][DEBUG] [Sequence Thread] EventMarker 15 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:55:48.799][DEBUG] [Sequence Thread] Waking from exposure time sleep period... [11/18/17 23:55:48.800][DEBUG] [Sequence Thread] Checking to see if the CCD has a temp... [11/18/17 23:55:48.800][DEBUG] [Sequence Thread] Saving the CCD temp... [11/18/17 23:55:48.814][DEBUG] [Sequence Thread] Entering super dangerous loop to await image completion... [11/18/17 23:55:48.823][DEBUG] [Sequence Thread] EventMarker 16 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:56:22.473][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:56:48.793][DEBUG] [Camera Thread] ASCOM Camera: Error when requesting abort. Timeout! Camera is not reporting READY... [11/18/17 23:56:48.793][DEBUG] [Camera Thread] ASCOM Camera: Image is aborted... [11/18/17 23:56:48.793][DEBUG] [Camera Thread] Error while attempting to capture frame... [11/18/17 23:56:48.797][DEBUG] [Camera Thread] Adding sequence level notification: Error attempting to capture image (see logs for more information). [11/18/17 23:56:48.798][DEBUG] [Camera Thread] Handling monitoring event (Good Night System, Warning): (NGC 891 Tal 200K-Atik460-QHY5L-II) Error attempting to capture image (see logs for more information). [11/18/17 23:56:48.798][DEBUG] [Camera Thread] GNS: Sent warning message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Error attempting to capture image (see logs for more information).)... [11/18/17 23:56:48.798][DEBUG] [Camera Thread] Handling monitoring event (Email 1, Warning): (NGC 891 Tal 200K-Atik460-QHY5L-II) Error attempting to capture image (see logs for more information). [11/18/17 23:56:48.976][DEBUG] [Sequence Thread] EventMarker 17 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:56:48.976][DEBUG] [Sequence Thread] Image reported as complete. Continuing... [11/18/17 23:56:48.987][DEBUG] [Sequence Thread] Collecting FITs headers... [11/18/17 23:56:49.001][DEBUG] [Sequence Thread] ASCOM Camera: Could not get last exposure start time. Reported as (unknown) [11/18/17 23:56:49.001][DEBUG] [Sequence Thread] DATE-LOC time provided by SGPro (failed to retrieve valid entry from camera)... [11/18/17 23:56:49.053][DEBUG] [Sequence Thread] GatherFitsHeaders: Writing header info for last solve... [11/18/17 23:56:49.053][DEBUG] [Sequence Thread] GatherFitsHeaders: Writing header info from UI... [11/18/17 23:56:49.317][DEBUG] [Sequence Thread] Clearing timed monitoring events... [11/18/17 23:56:49.320][DEBUG] [Sequence Thread] Error saving ASCOM image. : Object reference not set to an instance of an object. at q3.gn(pl A_0, List`1 A_1) [11/18/17 23:56:49.320][DEBUG] [Sequence Thread] Failed to save image to disk! [11/18/17 23:56:49.320][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Failed to save image to disk! [11/18/17 23:56:49.320][DEBUG] [Sequence Thread] GNS: Sent status message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Failed to save image to disk!)... [11/18/17 23:56:49.320][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Failed to save image to disk! [11/18/17 23:56:54.582][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [11/18/17 23:56:54.582][DEBUG] [Sequence Thread] EventMarker 170 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:56:54.582][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:56:54.582][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:56:54.582][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:56:54.682][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:56:54.682][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [11/18/17 23:56:54.682][DEBUG] [Sequence Thread] EventMarker 171 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:56:54.682][DEBUG] [Sequence Thread] EventMarker 18 - t:NGC 891 (0); e:0; f:1; o: [11/18/17 23:56:54.697][DEBUG] [Sequence Thread] EventMarker 19 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:56:54.697][DEBUG] [Sequence Thread] EventMarker 20 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:56:54.700][DEBUG] [Sequence Thread] Running post event... [11/18/17 23:56:54.700][DEBUG] [Sequence Thread] EventMarker 21 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:56:54.704][DEBUG] [Sequence Thread] Incremented numComplete (2) for event[0]... [11/18/17 23:56:54.708][DEBUG] [Sequence Thread] Attempting to find next event... [11/18/17 23:56:54.708][DEBUG] [Sequence Thread] Current event[0] frame count: 2/15... [11/18/17 23:56:54.709][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [11/18/17 23:56:54.710][DEBUG] [Sequence Thread] Checking for auto manual focus (post)... [11/18/17 23:56:54.710][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [11/18/17 23:56:54.718][DEBUG] [Sequence Thread] Attempting to move to next event... [11/18/17 23:56:54.718][DEBUG] [Sequence Thread] Attempting to find next event... [11/18/17 23:56:54.718][DEBUG] [Sequence Thread] Current event[0] frame count: 2/15... [11/18/17 23:56:54.718][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [11/18/17 23:56:54.718][DEBUG] [Sequence Thread] Running pre event... [11/18/17 23:56:54.740][DEBUG] [Sequence Thread] Running capture event... [11/18/17 23:56:54.743][DEBUG] [Sequence Thread] SetStartTemp: Using focuser for temperature... [11/18/17 23:56:54.743][DEBUG] [Sequence Thread] Set start frame temp to 7.38... [11/18/17 23:56:54.743][DEBUG] [Sequence Thread] ------------- Starting capture frame for event[0] ------------- [11/18/17 23:56:54.746][DEBUG] [Sequence Thread] Sending commands... [11/18/17 23:56:54.746][DEBUG] [Sequence Thread] SetFlatBox: Frame Type is Light [11/18/17 23:56:54.746][DEBUG] [Sequence Thread] EventMarker 2 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:56:54.746][DEBUG] [Sequence Thread] Checking if Meridian Flip is needed [11/18/17 23:56:54.747][DEBUG] [Sequence Thread] Meridian flip not needed, telescope on East side [11/18/17 23:56:54.748][DEBUG] [Sequence Thread] EventMarker 3 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:56:54.748][DEBUG] [Sequence Thread] Waiting for AF to complete... [11/18/17 23:57:02.385][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE complete... [11/18/17 23:57:02.385][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [11/18/17 23:57:02.388][DEBUG] [Camera Thread] Checking for auto focus... [11/18/17 23:57:02.388][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [11/18/17 23:57:02.568][DEBUG] [Sequence Thread] AF is complete, continuing sequence... [11/18/17 23:57:02.568][DEBUG] [Sequence Thread] EventMarker 4 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:02.568][DEBUG] [Sequence Thread] Setting filter position 2... [11/18/17 23:57:02.568][DEBUG] [Sequence Thread] Filter position 2 is already set. Skipping... [11/18/17 23:57:02.568][DEBUG] [Sequence Thread] EventMarker 5 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:02.568][DEBUG] [Sequence Thread] Checking for auto manual focus (pre)... [11/18/17 23:57:02.568][DEBUG] [Sequence Thread] EventMarker 6 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:02.594][DEBUG] [Sequence Thread] Running dither... [11/18/17 23:57:02.620][DEBUG] [Sequence Thread] PHD2 dither request: 0.5... [11/18/17 23:57:02.620][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:57:02.620][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:57:02.620][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:57:02.720][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:57:03.720][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:57:03.720][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:57:03.720][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:57:03.821][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:57:04.821][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:57:04.821][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:57:04.821][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:57:04.921][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:57:05.921][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:57:05.921][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:57:05.921][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:57:06.022][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:57:07.022][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:57:07.022][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:57:07.022][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:57:07.123][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:57:07.123][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:57:07.123][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:57:07.123][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:57:07.223][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:57:07.223][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "dither", "params": [0.5, false, {"pixels": 0.3, "time": 3, "timeout": 600}], "id": 1002} [11/18/17 23:57:12.232][DEBUG] [Sequence Thread] Created base name for frame capture: NGC 891_180sec_2x2_R_frame3 [11/18/17 23:57:12.232][DEBUG] [Sequence Thread] Created directory for frame capture: C:\\2017-11-18\Light\ [11/18/17 23:57:12.232][DEBUG] [Sequence Thread] EventMarker 1 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:12.232][DEBUG] [Sequence Thread] EventMarker 7 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:12.232][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [11/18/17 23:57:12.232][DEBUG] [Sequence Thread] EventMarker 170 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:12.232][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:57:12.233][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:57:12.233][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:57:12.333][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:57:12.333][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [11/18/17 23:57:12.333][DEBUG] [Sequence Thread] EventMarker 171 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:12.333][DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 0.3, "time": 3, "timeout": 600}, false ], "id": 1003} [11/18/17 23:57:12.333][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 0.3, "time": 3, "timeout": 600}, false ], "id": 1003} [11/18/17 23:57:12.333][DEBUG] [Sequence Thread] EventMarker 172 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:12.333][DEBUG] [Sequence Thread] Checking PHD2 state... [11/18/17 23:57:12.333][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [11/18/17 23:57:12.333][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [11/18/17 23:57:12.407][DEBUG] [PHD2 Listener Thread] Error received from RPC: Cannot initiate guide while dither is in progress [11/18/17 23:57:12.434][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [11/18/17 23:57:12.434][DEBUG] [Sequence Thread] EventMarker 173 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:12.434][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Attempting to settle the auto guider... [11/18/17 23:57:12.434][DEBUG] [Sequence Thread] GNS: Sent status message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Attempting to settle the auto guider...)... [11/18/17 23:57:12.434][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Attempting to settle the auto guider... [11/18/17 23:57:12.434][DEBUG] [Sequence Thread] Waiting for Auto Guider distance to fall below 0.3 [11/18/17 23:57:12.434][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:12.434][DEBUG] [Sequence Thread] PHD2 distance request returned 0.7... [11/18/17 23:57:12.948][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:12.948][DEBUG] [Sequence Thread] PHD2 distance request returned 0.7... [11/18/17 23:57:13.458][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:13.458][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:13.992][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:13.992][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:14.508][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:14.508][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:15.030][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:15.030][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:15.547][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:15.547][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:16.064][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:16.064][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:16.582][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:16.582][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:17.103][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:17.103][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:17.619][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:17.619][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:18.141][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:18.141][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:18.653][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:18.653][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:19.175][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:19.175][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:19.685][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:19.685][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:20.204][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:20.204][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [11/18/17 23:57:20.713][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:20.713][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:57:20.722][DEBUG] [Sequence Thread] Distance is below 0.3, starting timer... [11/18/17 23:57:21.222][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:21.222][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:57:21.728][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:21.728][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:57:22.237][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:22.237][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:57:22.473][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:57:22.742][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:22.742][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:57:23.250][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:23.250][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:57:23.755][DEBUG] [Sequence Thread] PHD2 distance request... [11/18/17 23:57:23.755][DEBUG] [Sequence Thread] PHD2 distance request returned 0.3... [11/18/17 23:57:23.762][DEBUG] [Sequence Thread] Distance stayed below 0.3 for 3 seconds, done settling... [11/18/17 23:57:23.763][DEBUG] [Sequence Thread] SGPro settle criteria have been met, but the guider reports it is not ready to resume, waiting... [11/18/17 23:57:42.659][DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: GOOD [11/18/17 23:57:42.770][DEBUG] [Sequence Thread] Auto guider has settled... [11/18/17 23:57:42.772][DEBUG] [Sequence Thread] EventMarker 8 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:42.772][DEBUG] [Sequence Thread] EventMarker 9 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:42.773][DEBUG] [Sequence Thread] EventMarker 10 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:42.773][DEBUG] [Sequence Thread] Finished sending frame capture. Entering wait mode... [11/18/17 23:57:42.773][DEBUG] [Sequence Thread] EventMarker 11 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:42.773][DEBUG] [Sequence Thread] EventMarker 12 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:42.773][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Starting integration of NGC 891; Event 1; Frame 3 for 180s... [11/18/17 23:57:42.773][DEBUG] [Sequence Thread] GNS: Sent status message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Starting integration of NGC 891; Event 1; Frame 3 for 180s...)... [11/18/17 23:57:42.773][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, Status): (NGC 891 Tal 200K-Atik460-QHY5L-II) Starting integration of NGC 891; Event 1; Frame 3 for 180s... [11/18/17 23:57:42.774][DEBUG] [Sequence Thread] Handling monitoring event (Good Night System, TimedError): (NGC 891 Tal 200K-Atik460-QHY5L-II) Failure while integrating NGC 891; Event 1; Frame 3 for 180s. Image has not downloaded in alloted time period. [11/18/17 23:57:42.774][DEBUG] [Sequence Thread] GNS: Sent timed event to GNS... [11/18/17 23:57:42.774][DEBUG] [Sequence Thread] Handling monitoring event (Email 1, TimedError): (NGC 891 Tal 200K-Atik460-QHY5L-II) Failure while integrating NGC 891; Event 1; Frame 3 for 180s. Image has not downloaded in alloted time period. [11/18/17 23:57:42.776][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE message received... [11/18/17 23:57:42.776][DEBUG] [Camera Thread] ASCOM Camera: Attempting to abort exposure... [11/18/17 23:57:42.776][DEBUG] [Camera Thread] ASCOM Camera: Asking camera to abort... [11/18/17 23:57:42.777][DEBUG] [Sequence Thread] EventMarker 13 - t:NGC 891 (0); e:0; f:2; o: [11/18/17 23:57:42.779][DEBUG] [Camera Thread] ASCOM Camera: Camera has acknowledged abort request... [11/18/17 23:57:42.779][DEBUG] [Camera Thread] ASCOM Camera: Blocking until image is aborted... [11/18/17 23:58:03.165][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [11/18/17 23:58:03.168][DEBUG] [MF Update Thread] Performing serialize... [11/18/17 23:58:22.473][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/18/17 23:59:22.473][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/19/17 00:00:22.473][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/19/17 00:00:42.872][DEBUG] [Sequence Thread] EventMarker 15 - t:NGC 891 (0); e:0; f:2; o: [11/19/17 00:00:42.872][DEBUG] [Sequence Thread] Waking from exposure time sleep period... [11/19/17 00:00:42.872][DEBUG] [Sequence Thread] Checking to see if the CCD has a temp... [11/19/17 00:00:42.872][DEBUG] [Sequence Thread] Saving the CCD temp... [11/19/17 00:00:42.876][DEBUG] [Sequence Thread] Entering super dangerous loop to await image completion... [11/19/17 00:00:42.880][DEBUG] [Sequence Thread] EventMarker 16 - t:NGC 891 (0); e:0; f:2; o: [11/19/17 00:01:22.473][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/19/17 00:01:42.833][DEBUG] [Camera Thread] ASCOM Camera: Error when requesting abort. Timeout! Camera is not reporting READY... [11/19/17 00:01:42.833][DEBUG] [Camera Thread] ASCOM Camera: Image is aborted... [11/19/17 00:01:42.834][DEBUG] [Camera Thread] SetAscomNormalSpeed... [11/19/17 00:01:42.834][DEBUG] [Camera Thread] Readout speed set to NORMAL... [11/19/17 00:01:42.839][DEBUG] [Camera Thread] ASCOM Camera Error : CheckDotNetExceptions ASCOM.Atik2.Camera StartExposure System.ApplicationException: StartExposure - Camera not idle (See Inner Exception for details) (System.ApplicationException: StartExposure - Camera not idle) at ASCOM.DriverAccess.MemberFactory.CheckDotNetExceptions(String memberName, Exception e) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 630 at ASCOM.DriverAccess.MemberFactory.MethodTargetInvocationExceptionHandler(String memberName, Exception e) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 678 at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in c:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 487 at ASCOM.DriverAccess.Camera.StartExposure(Double Duration, Boolean Light) in c:\ASCOM Build\Export\ASCOM.DriverAccess\Camera.cs:line 595 at q3.h9(pe A_0, rd& A_1) [11/19/17 00:01:42.841][DEBUG] [Camera Thread] ASCOM Camera: Attempting to abort exposure... [11/19/17 00:01:42.841][DEBUG] [Camera Thread] ASCOM Camera: Asking camera to abort... [11/19/17 00:01:42.843][DEBUG] [Camera Thread] ASCOM Camera: Camera has acknowledged abort request... [11/19/17 00:01:42.843][DEBUG] [Camera Thread] ASCOM Camera: Blocking until image is aborted... [11/19/17 00:02:22.473][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/19/17 00:03:22.473][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/19/17 00:03:42.879][DEBUG] [Monitoring System Timed Message Thread] Adding sequence level notification: (NGC 891 Tal 200K-Atik460-QHY5L-II) Failure while integrating NGC 891; Event 1; Frame 3 for 180s. Image has not downloaded in alloted time period. [11/19/17 00:04:22.473][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/19/17 00:05:22.473][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/19/17 00:05:42.892][DEBUG] [Camera Thread] ASCOM Camera: Error when requesting abort. Timeout! Camera is not reporting READY... [11/19/17 00:05:42.892][DEBUG] [Camera Thread] ASCOM Camera: Image is aborted... [11/19/17 00:05:42.892][DEBUG] [Camera Thread] Error while attempting to capture frame... [11/19/17 00:05:42.893][DEBUG] [Camera Thread] Adding sequence level notification: Error attempting to capture image (see logs for more information). [11/19/17 00:05:42.895][DEBUG] [Camera Thread] Handling monitoring event (Good Night System, Warning): (NGC 891 Tal 200K-Atik460-QHY5L-II) Error attempting to capture image (see logs for more information). [11/19/17 00:05:42.895][DEBUG] [Camera Thread] GNS: Sent warning message to GNS ((NGC 891 Tal 200K-Atik460-QHY5L-II) Error attempting to capture image (see logs for more information).)... [11/19/17 00:05:42.895][DEBUG] [Camera Thread] Handling monitoring event (Email 1, Warning): (NGC 891 Tal 200K-Atik460-QHY5L-II) Error attempting to capture image (see logs for more information). [11/19/17 00:05:49.165][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE complete... [11/19/17 00:06:10.727][DEBUG] [Main Thread] Turning camera cooler off... [11/19/17 00:06:22.473][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)... [11/19/17 00:07:21.587][DEBUG] [Main Thread] Disconnecting ASCOM Filter Wheel: ASCOM.Ascom_SxUFW.FilterWheel [11/19/17 00:07:21.594][DEBUG] [Main Thread] Disconnecting ASCOM Focuser: ASCOM.myFocuser2ASCOM.Focuser [11/19/17 00:07:21.608][DEBUG] [Main Thread] Disconnecting ASCOM camera: Atik Camera 2... [11/19/17 00:07:22.473][DEBUG] [Heartbeat Thread] Handling monitoring event (Email 1, Heartbeat): (NGC 891 Tal 200K-Atik460-QHY5L-II) SGPro is running (uncheck "Heartbeat" to supress this message)...