[09/25/17 20:10:45.036][DEBUG] [Main Thread] Licensing: Machine ID found... [09/25/17 20:10:45.046][DEBUG] [Main Thread] Checking for valid internet connection... [09/25/17 20:10:45.256][DEBUG] [Main Thread] Valid internet connection detected... [09/25/17 20:10:46.031][DEBUG] [Main Thread] Licensing: Request for licenses successful, writing cookie... [09/25/17 20:10:46.041][DEBUG] [Main Thread] Licensing: Applying licenses.. [09/25/17 20:10:46.041][DEBUG] [Main Thread] Licensing: Licenses applied.. [09/25/17 20:10:46.046][DEBUG] [Main Thread] SGPro trial license... [09/25/17 20:10:47.056][DEBUG] [Main Thread] API successfully started on port 59590... [09/25/17 20:10:47.785][DEBUG] [Main Thread] Error loading notification settings! Could not find file 'C:\Users\Wes\AppData\Local\SequenceGenerator\Sequence Generator Pro\notifications.sgd'. [09/25/17 20:10:47.792][DEBUG] [Main Thread] Error loading GNS endpoint settings! Could not find file 'C:\Users\Wes\AppData\Local\SequenceGenerator\Sequence Generator Pro\gnsSettings.sgd'. [09/25/17 20:10:47.794][DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\Wes\AppData\Local\SequenceGenerator\Sequence Generator Pro\1-emailEndpointAddresses.sgd'. [09/25/17 20:10:47.794][DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\Wes\AppData\Local\SequenceGenerator\Sequence Generator Pro\2-emailEndpointAddresses.sgd'. [09/25/17 20:10:47.794][DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\Wes\AppData\Local\SequenceGenerator\Sequence Generator Pro\3-emailEndpointAddresses.sgd'. [09/25/17 20:10:47.796][DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Wes\AppData\Local\SequenceGenerator\Sequence Generator Pro\1-textFileEndpointSettings.sgd'. [09/25/17 20:10:47.796][DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Wes\AppData\Local\SequenceGenerator\Sequence Generator Pro\2-textFileEndpointSettings.sgd'. [09/25/17 20:10:47.796][DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Wes\AppData\Local\SequenceGenerator\Sequence Generator Pro\3-textFileEndpointSettings.sgd'. [09/25/17 20:10:47.938][DEBUG] [Main Thread] ===== S E Q U E N C E G E N E R A T O R (v2.6.0.23) ===== [09/25/17 20:10:48.043][DEBUG] [Main Thread] OS: Microsoft Windows 7 Home Premium [09/25/17 20:10:48.494][DEBUG] [Focuser Thread] Entering Fouser message dispatch loop... [09/25/17 20:10:48.495][DEBUG] [Camera Thread] Entering camera message dispatch loop... [09/25/17 20:10:48.496][DEBUG] [Filter Wheel Thread] Entering Filter Wheel message dispatch loop... [09/25/17 20:10:48.497][DEBUG] [TEC Thread] Entering TEC message dispatch loop... [09/25/17 20:10:48.498][DEBUG] [Rotator Thread] Entering Rotator message dispatch loop... [09/25/17 20:10:48.511][DEBUG] [Auto Guider Thread] Entering Auto Guider message dispatch loop... [09/25/17 20:10:48.511][DEBUG] [Auto Guider Error Thread] Entering Auto Guider message dispatch loop... [09/25/17 20:10:48.513][DEBUG] [Dome Thread] Entering Dome message dispatch loop... [09/25/17 20:10:48.513][DEBUG] [Safety Thread] Starting safety monitor... [09/25/17 20:10:48.515][DEBUG] [Environment Device Thread] Starting environment device monitor... [09/25/17 20:10:48.521][DEBUG] [Telescope Thread] Entering Telescope message dispatch loop... [09/25/17 20:10:48.547][DEBUG] [Main Thread] Settings changed (or loaded)... [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingMdiAutoStretch = False [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingIgLastFileFolder = [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingFormScaleWarning = False [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingRecoveryDuration = 90 [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingDelayBetween = 0 [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingFliFlushLow = 0 [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingSBIGLpt2Address = 278 [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingMdiMouseAction = Stretch [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingLastAscomCamera = [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingAutoRecoveryActive = False [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingTemperhumInterval = 300 [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingASCOMWarningShown = False [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingPlateCamScale = 0 [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingCanonMirrorSettle = 0 [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingInterface = [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingLastAscomFilterWheel = [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingAstroArtDisplayInstructions = True [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingSBIGLpt1Address = 378 [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingTrialQuestionsAsked = False [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingCheckForUpdatesOnStart = True [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingMdiLastImageDir = [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingTemperHumUserTempComp = 0 [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingCaptureCalFramesAlways = False [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingDelayFirst = 0 [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingFliNormalSpeedMode = 0 [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingFliHighSpeedMode = 0 [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingMfPosition = {X=0,Y=0} [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingSoundAttention = [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingPinpointCatalog = [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingCameraOverhead = [09/25/17 20:10:48.548][DEBUG] [Main Thread] * SETTING: settingPlateSolveOn = False [09/25/17 20:10:48.564][DEBUG] [Main Thread] * SETTING: settingAstrometryNetEndpointList = System.Collections.Specialized.StringCollection [09/25/17 20:10:48.564][DEBUG] [Main Thread] * SETTING: settingSBIGGuider = None [09/25/17 20:10:48.564][DEBUG] [Main Thread] * SETTING: settingQSIFanSpeed = 2 [09/25/17 20:10:48.564][DEBUG] [Main Thread] * SETTING: settingNaggerText = [09/25/17 20:10:48.564][DEBUG] [Main Thread] * SETTING: settingMdiPhdDisplay = RA/Dec [09/25/17 20:10:48.564][DEBUG] [Main Thread] * SETTING: settingMdiShowToolStrip = True [09/25/17 20:10:48.564][DEBUG] [Main Thread] * SETTING: settingMdiShowCrosshairs = True [09/25/17 20:10:48.564][DEBUG] [Main Thread] * SETTING: WindowGeometry = [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingIgRenameStringLocation = 2 [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingIgSubFolders = False [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: WindowGeometrySearch = [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingOffset = -1 [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingAutoStretchLevel = Low [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingTemperHumUnits = C [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingProfileDirectory = [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingBasename = [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingHfrColor = Color [RoyalBlue] [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingNikonAfBinning = 1 [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingSBIGFanOffWithTec = False [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingLastAscomSafetyMonitor = [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingMdiSize = {Width=800, Height=600} [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingIgCopyAndRenameFiles = False [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingSimDownloadTimesAf = False [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingNagger = False [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingImportFromCfw = True [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingMdiShowStatusTrip = True [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingShowTooltipHelp = True [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingLastUpdateCheck = 1/1/2012 12:00:00 AM [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingEventSuffixes = null [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingCpPosition = {X=0,Y=0} [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingSBIGCfwPort = [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingMdiLocation = {X=0,Y=0} [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingIgLastCsvFolder = [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingSBIGFilterWheel = Auto Detect [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingSBIGConnection = USB [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingDSLRSoftwareBinForAf = False [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingAutoSave = True [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingFirstTime = True [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingFliFlushHigh = 0 [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingMdiState = maximized [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingUseSequenceOptions = False [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingSoundCompleted = [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingTrialExpiredShown = False [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingTemperHumColor = Grey [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingDataDirectory = [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingCanonFileFormat = Single Image (CFA FITS) [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingAlnitakComPort = [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingIgRenameFiles = False [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingSubFolder = True [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingLastSGSaveFolder = [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingFindStars = Normal (recommended) [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingNikonDataFormat = FITS [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingPlaySounds = False [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingPlateSolve3Catalogs = [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingLastNikonType = Auto Connect [09/25/17 20:10:48.565][DEBUG] [Main Thread] * SETTING: settingLastSequenceStart = 1/1/0001 12:00:00 AM [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingLastAscomTelescope = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingMdiPhdScale = 100 [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingIgRenameType = 0 [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingHelpLanguage = English [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingTemperHumUserHumidityComp = 0 [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingMdiPhdRaColor = Color [Blue] [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingLastImageSaveFolder = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingEnableImageHistory = False [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingFinishFullEvent = True [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingMosaicOverlap = 20 [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingQSIFanOffWithTec = False [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingRecentSequences = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingDefaultDirectory = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingMdiPhdDecColor = Color [Red] [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingAstrometryNetEndpoint = Astrometry.NET (Remote) [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingSBIGCfwUseRS232 = False [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingStarsColor = Color [OrangeRed] [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingPhd2InstallPath = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingIgOverwriteExisting = False [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingLastAscomFocuser = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingIgLastFolder = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: WindowGeometryOpen = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingNumEvents = 5 [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingCanonAfBinning = 1 [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingPlateCamBlank = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingLogApiCalls = False [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingNikonUseBulbModeAlways = False [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingTempFiles = C:\Temp [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingFliHighSpeedDesc = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingRecoveryInterval = 10 [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingDefaultMfwFov = 4.0 [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingSBIGEthernetIP = 0.0.0.0 [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingSBIGLpt3Address = 3BC [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingFliNormalSpeedDesc = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingIgCopyLocation = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingSBIGAutoDetectIp = True [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingAstroArtStartApp = True [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingSimDownloadTimesPlate = False [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingMicroTouchLocation = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingMdiPhdZoom = 40 [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingMdiNewWindow = False [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingEventAlwaysVisible = False [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingFliRbiMitigation = False [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingGain = -1 [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingLastAscomDome = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingLookForTemperDevices = False [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingLastAscomRotator = [09/25/17 20:10:48.566][DEBUG] [Main Thread] * SETTING: settingAfTestPackPath = [09/25/17 20:10:48.706][DEBUG] [Main Thread] ASCOM Boltwood Observing Conditions [09/25/17 20:10:48.706][DEBUG] [Main Thread] ASCOM Observing Conditions Hub (OCH) [09/25/17 20:10:48.706][DEBUG] [Main Thread] ASCOM Observing Conditions Simulator [09/25/17 20:10:48.706][DEBUG] [Main Thread] OpenWeatherMap ObservingConditions [09/25/17 20:10:48.706][DEBUG] [Main Thread] TEMPerHUM [09/25/17 20:10:48.710][DEBUG] [Main Thread] Performing initialization... [09/25/17 20:10:48.710][DEBUG] [Main Thread] Creating new sequence with default profile: Takahashi [09/25/17 20:10:48.731][DEBUG] [Main Thread] Performing full form reset (with profile Takahashi)... [09/25/17 20:10:48.740][DEBUG] [Main Thread] Retreiving new equipment objects... [09/25/17 20:10:48.740][DEBUG] [Main Thread] New camera object (QSI CCD Camera) dispatched... [09/25/17 20:10:48.748][DEBUG] [Main Thread] New filter wheel object (QSI Internal Filter Wheel) dispatched... [09/25/17 20:10:48.749][DEBUG] [Main Thread] New environment device object (ASCOM Boltwood Observing Conditions) dispatched... [09/25/17 20:10:48.753][DEBUG] [Main Thread] New focuser object (RoboFocus) dispatched... [09/25/17 20:10:48.755][DEBUG] [Main Thread] New telescope object (POTH Hub) dispatched... [09/25/17 20:10:48.758][DEBUG] [Main Thread] New rotator object (No Rotator) dispatched... [09/25/17 20:10:48.759][DEBUG] [Main Thread] New dome object (POTH Hub) dispatched... [09/25/17 20:10:48.761][DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched... [09/25/17 20:10:48.762][DEBUG] [Main Thread] New safety monitor object (ASCOM Boltwood OK to Image) dispatched... [09/25/17 20:10:48.764][DEBUG] [Main Thread] New auto guider object (PHD2) dispatched... [09/25/17 20:10:48.764][DEBUG] [Main Thread] New plate solver object (No Plate Solver) dispatched... [09/25/17 20:10:48.790][DEBUG] [Main Thread] Populating the form controls... [09/25/17 20:10:48.851][DEBUG] [Main Thread] Added row 0... [09/25/17 20:10:48.898][DEBUG] [Main Thread] Added row 1... [09/25/17 20:10:48.954][DEBUG] [Main Thread] Added row 2... [09/25/17 20:10:49.022][DEBUG] [Main Thread] Added row 3... [09/25/17 20:10:49.100][DEBUG] [Main Thread] Added row 4... [09/25/17 20:10:49.127][DEBUG] [Main Thread] Loading custom filter names... [09/25/17 20:10:49.137][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [09/25/17 20:10:49.225][DEBUG] [Main Thread] Retreiving new equipment objects... [09/25/17 20:10:49.227][DEBUG] [Main Thread] No change in camera object... [09/25/17 20:10:49.227][DEBUG] [Main Thread] No change in filter wheel object... [09/25/17 20:10:49.227][DEBUG] [Main Thread] No change in environment device object... [09/25/17 20:10:49.227][DEBUG] [Main Thread] No change in focuser object... [09/25/17 20:10:49.227][DEBUG] [Sequence Thread] Entering sequence message dispatch loop... [09/25/17 20:10:49.229][DEBUG] [Main Thread] MoveFocuserAbs: Error! The focuser is no longer connected! [09/25/17 20:10:49.229][DEBUG] [Main Thread] No change in telescope object... [09/25/17 20:10:49.229][DEBUG] [Main Thread] New rotator object (No Rotator) dispatched... [09/25/17 20:10:49.230][DEBUG] [Main Thread] No change in dome object... [09/25/17 20:10:49.230][DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched... [09/25/17 20:10:49.232][DEBUG] [Main Thread] No change in safety monitor object... [09/25/17 20:10:49.232][DEBUG] [Main Thread] New auto guider object (PHD2) dispatched... [09/25/17 20:10:49.233][DEBUG] [Main Thread] New plate solver object (No Plate Solver) dispatched... [09/25/17 20:10:49.239][DEBUG] [Main Thread] Checking if version check is required... [09/25/17 20:10:49.407][DEBUG] [Main Thread] UI layout found, loading layout at C:\Users\Wes\AppData\Local\SequenceGenerator\sg_ui_config.xml [09/25/17 20:10:49.407][DEBUG] [Cleaner Thread] Running cleanup... [09/25/17 20:10:49.408][DEBUG] [Cleaner Thread] Cleaning 0 files in directory C:\Users\Wes\AppData\Local\SequenceGenerator\Temp\... [09/25/17 20:10:49.408][DEBUG] [Cleaner Thread] Cleaning multi camera registration file... [09/25/17 20:10:49.408][DEBUG] [Cleaner Thread] Cleaning finished... [09/25/17 20:13:01.951][DEBUG] [Main Thread] Connecting camera in camera thread... [09/25/17 20:13:01.958][DEBUG] [Camera Thread] SGM_CAMERA_CONNECT message received... [09/25/17 20:13:01.959][DEBUG] [Camera Thread] Connecting QSI camera... [09/25/17 20:13:01.971][DEBUG] [Camera Thread] QSI Camera: version check... [09/25/17 20:13:02.076][DEBUG] [Camera Thread] QSI Driver Version: 7.4.1824.0(QSI - Camera not connected) [09/25/17 20:13:03.818][DEBUG] [Camera Thread] Connected to 683ws [09/25/17 20:13:03.818][DEBUG] [Camera Thread] SGM_CAMERA_CONNECT complete... [09/25/17 20:13:03.922][DEBUG] [Main Thread] Camera cooler detected... [09/25/17 20:13:03.961][DEBUG] [Main Thread] Camera cooler is OFF... [09/25/17 20:13:03.962][DEBUG] [Main Thread] Camera cooldown on connect is selected... [09/25/17 20:13:03.962][DEBUG] [Main Thread] Camera cooldown is starting... [09/25/17 20:13:03.964][DEBUG] [TEC Thread] SGM_CHANGE_COOLER_TEMP message received... [09/25/17 20:13:03.966][DEBUG] [TEC Thread] TEC Change: Starting... [09/25/17 20:13:05.488][DEBUG] [Main Thread] Connecting ASCOM focuser... [09/25/17 20:13:05.595][DEBUG] [Main Thread] Focuser supports temperature [09/25/17 20:13:05.596][DEBUG] [Main Thread] Current temperature reports: 100 [09/25/17 20:13:05.597][DEBUG] [Main Thread] Focuser reports Max Increment as: 10000 [09/25/17 20:13:05.597][DEBUG] [Main Thread] Focuser reports max steps as: 10000 [09/25/17 20:13:05.821][DEBUG] [Telescope Thread] Telescope Dispatch loop: Received SGM_TELESCOPE_CONNECT... [09/25/17 20:13:12.719][DEBUG] [Telescope Thread] Telescope can slewing supported... [09/25/17 20:13:12.722][DEBUG] [Telescope Thread] Telescope: Does not implement MoveAxis... [09/25/17 20:13:12.734][DEBUG] [Telescope Thread] Telescope: Exception thrown while querying SideOfPier, setting to false. : Property read POTH.Telescope SideOfPier is not implemented in this driver. (System.Reflection.TargetInvocationException: Exception has been thrown by the target of an invocation. ---> System.Runtime.InteropServices.COMException: Property SideOfPier is not implemented by 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.Telescope.get_SideOfPier() in c:\ASCOM Build\Export\ASCOM.DriverAccess\Telescope.cs:line 895 at p6.jo() [09/25/17 20:13:12.736][DEBUG] [Telescope Thread] Telescope: CanSetSideOfPier returned False [09/25/17 20:13:12.737][DEBUG] [Telescope Thread] Telescope: CanPark returned True [09/25/17 20:13:12.740][DEBUG] [Telescope Thread] Telescope equatorial system is JNOW... [09/25/17 20:13:12.740][DEBUG] [Telescope Thread] SGM_TELESCOPE_CONNECT complete... [09/25/17 20:13:13.011][DEBUG] [Main Thread] Telescope: Setting sync behavior to: Sync [09/25/17 20:13:13.033][DEBUG] [Main Thread] Connecting ASCOM Safety Monitor... [09/25/17 20:13:13.351][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Connected to ASCOM Boltwood Observing Conditions [09/25/17 20:13:13.354][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Device Name - Boltwood ObservingConditions [09/25/17 20:13:13.357][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Description - ASCOM Boltwood Observing Conditions [09/25/17 20:13:13.360][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Driver Info Boltwood obseving conditions driver. Version: 6.2.5823.16903 [09/25/17 20:13:13.364][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Driver Version 6.2 [09/25/17 20:13:13.382][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get Pressure! : Property read ASCOM.Boltwood.ObservingConditions Pressure 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 Pressure 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_Pressure() in c:\ASCOM Build\Export\ASCOM.DriverAccess\ObservingConditions.cs:line 147 at jd.br() [09/25/17 20:13:13.388][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get Seeing! : Property read ASCOM.Boltwood.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 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 jd.br() [09/25/17 20:13:13.391][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get SkyBrightness! : Property read ASCOM.Boltwood.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 jd.br() [09/25/17 20:13:13.394][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get SkyQuality! : Property read ASCOM.Boltwood.ObservingConditions SkyQuality 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 SkyQuality 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_SkyQuality() in c:\ASCOM Build\Export\ASCOM.DriverAccess\ObservingConditions.cs:line 218 at jd.br() [09/25/17 20:13:13.404][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get WindDirection! : Property read ASCOM.Boltwood.ObservingConditions WindDirection 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 WindDirection 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_WindDirection() in c:\ASCOM Build\Export\ASCOM.DriverAccess\ObservingConditions.cs:line 282 at jd.br() [09/25/17 20:13:13.407][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get WindGust! : Property read ASCOM.Boltwood.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 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 jd.br() [09/25/17 20:13:13.477][DEBUG] [TEC Thread] TEC Change: After camera connect change, waiting ~5 seconds... [09/25/17 20:13:14.469][DEBUG] [Auto Guider Equipment Connection Thread] Connecting to PHD2... [09/25/17 20:13:14.470][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [09/25/17 20:13:14.476][DEBUG] [PHD2 Listener Thread] Attempting to connect to PHD2... [09/25/17 20:13:15.470][DEBUG] [Auto Guider Equipment Connection Thread] Successfully connected to PHD2... [09/25/17 20:13:15.472][DEBUG] [Auto Guider Equipment Connection Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:13:15.473][DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:13:15.573][DEBUG] [Auto Guider Equipment Connection Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:13:15.575][DEBUG] [Auto Guider Equipment Connection Thread] PHD2: PHD2 is already open... [09/25/17 20:13:15.575][DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method": "get_profiles", "id": 1009} [09/25/17 20:13:16.075][DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method":"set_connected","params":[false],"id":1007} [09/25/17 20:13:16.075][DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method":"set_profile","params":[2],"id":1008} [09/25/17 20:13:16.075][DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method":"set_connected","params":[true],"id":1007} [09/25/17 20:13:18.484][DEBUG] [TEC Thread] TEC Change: Attempting to turn the camera cooler on... [09/25/17 20:13:18.487][DEBUG] [Main Thread] Turning camera cooler on... [09/25/17 20:13:18.984][DEBUG] [Main Thread] Turning camera cooler on... [09/25/17 20:13:23.568][DEBUG] [TEC Thread] TEC Change: Changing temp from 20.00 to -10.00 in 360 seconds... [09/25/17 20:14:17.074][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:14:17.074][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:14:17.075][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:14:17.075][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:14:17.075][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:15:17.184][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:15:17.184][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:15:17.184][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:15:17.184][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:15:17.184][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:16:17.316][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:16:17.316][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:16:17.316][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:16:17.316][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:16:17.316][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:16:46.999][DEBUG] [Filter Wheel Thread] SGM_FW_SET_POSITION message received... [09/25/17 20:16:49.223][DEBUG] [Filter Wheel Thread] SGM_FW_SET_POSITION complete... [09/25/17 20:17:02.666][DEBUG] [Camera Thread] SGM_FRAME_AND_FOCUS message received... [09/25/17 20:17:02.681][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:17:02.714][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:17:02.714][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:17:17.421][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:17:17.421][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:17:17.421][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:17:17.421][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:17:17.421][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:17:28.531][DEBUG] [Camera Thread] QSI expose and download: 25.753473s [09/25/17 20:17:28.752][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:17:28.752][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:17:29.645][DEBUG] [Camera Thread] SGM_FRAME_AND_FOCUS complete... [09/25/17 20:17:42.388][DEBUG] [Main Thread] FitsFileHeaderData: Angle - 0 [09/25/17 20:17:42.388][DEBUG] [Main Thread] FitsFileHeaderData: Scale - 0 [09/25/17 20:17:42.389][DEBUG] [Main Thread] FitsFileHeaderData: RA - 20.1943948128482 [09/25/17 20:17:42.391][DEBUG] [Main Thread] FitsFileHeaderData: DEC - 23.2942687508249 [09/25/17 20:17:42.835][DEBUG] [Main Thread] Display image preview using asynch task... [09/25/17 20:18:17.525][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:18:17.525][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:18:17.525][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:18:17.525][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:18:17.525][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:19:17.645][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:19:17.645][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:19:17.645][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:19:17.645][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:19:17.645][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:19:23.781][DEBUG] [TEC Thread] TEC Change: Complete... [09/25/17 20:19:23.824][DEBUG] [TEC Thread] SGM_CHANGE_COOLER_TEMP complete... [09/25/17 20:19:32.961][DEBUG] [Camera Thread] SGM_FRAME_AND_FOCUS message received... [09/25/17 20:19:32.964][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:19:32.988][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:19:32.988][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:19:37.878][DEBUG] [Camera Thread] QSI expose and download: 4.825276s [09/25/17 20:19:37.957][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:19:37.957][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:19:38.044][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:19:38.067][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:19:38.067][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:19:42.958][DEBUG] [Camera Thread] QSI expose and download: 4.8282762s [09/25/17 20:19:43.068][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:19:43.068][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:19:43.139][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:19:43.161][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:19:43.161][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:19:48.053][DEBUG] [Camera Thread] QSI expose and download: 4.8282762s [09/25/17 20:19:48.129][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:19:48.129][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:19:48.204][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:19:48.238][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:19:48.239][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:19:53.128][DEBUG] [Camera Thread] QSI expose and download: 4.825276s [09/25/17 20:19:53.207][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:19:53.207][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:19:53.283][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:19:53.316][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:19:53.316][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:19:58.209][DEBUG] [Camera Thread] QSI expose and download: 4.8282762s [09/25/17 20:19:58.290][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:19:58.290][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:19:58.363][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:19:58.395][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:19:58.396][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:20:03.289][DEBUG] [Camera Thread] QSI expose and download: 4.8292762s [09/25/17 20:20:03.367][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:20:03.367][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:20:03.456][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:20:03.491][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:20:03.491][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:20:08.382][DEBUG] [Camera Thread] QSI expose and download: 4.8272762s [09/25/17 20:20:08.492][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:20:08.492][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:20:08.580][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:20:08.601][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:20:08.601][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:20:13.491][DEBUG] [Camera Thread] QSI expose and download: 4.825276s [09/25/17 20:20:13.576][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:20:13.576][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:20:13.650][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:20:13.679][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:20:13.679][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:20:17.771][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:20:17.771][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:20:17.771][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:20:17.771][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:20:17.771][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:20:18.568][DEBUG] [Camera Thread] QSI expose and download: 4.825276s [09/25/17 20:20:18.651][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:20:18.651][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:20:18.744][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:20:18.772][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:20:18.772][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:20:23.661][DEBUG] [Camera Thread] QSI expose and download: 4.825276s [09/25/17 20:20:23.741][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:20:23.741][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:20:23.819][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:20:23.849][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:20:23.849][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:20:28.740][DEBUG] [Camera Thread] QSI expose and download: 4.8272761s [09/25/17 20:20:28.853][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:20:28.853][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:20:28.931][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:20:28.959][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:20:28.959][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:20:33.853][DEBUG] [Camera Thread] QSI expose and download: 4.8292762s [09/25/17 20:20:33.932][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:20:33.932][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:20:34.021][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:20:34.054][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:20:34.055][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:20:38.947][DEBUG] [Camera Thread] QSI expose and download: 4.8292763s [09/25/17 20:20:39.060][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:20:39.060][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:20:39.215][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:20:39.244][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:20:39.244][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:20:44.141][DEBUG] [Camera Thread] QSI expose and download: 4.8332765s [09/25/17 20:20:44.215][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:20:44.215][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:20:44.308][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:20:44.339][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:20:44.339][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:20:49.238][DEBUG] [Camera Thread] QSI expose and download: 4.8342765s [09/25/17 20:20:49.348][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:20:49.348][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:20:49.435][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:20:49.468][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:20:49.468][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:20:54.363][DEBUG] [Camera Thread] QSI expose and download: 4.8312763s [09/25/17 20:20:54.480][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:20:54.480][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:20:54.559][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:20:54.594][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:20:54.594][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:20:59.499][DEBUG] [Camera Thread] QSI expose and download: 4.8312763s [09/25/17 20:20:59.572][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:20:59.572][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:20:59.647][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:20:59.671][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:20:59.671][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:21:04.562][DEBUG] [Camera Thread] QSI expose and download: 4.826276s [09/25/17 20:21:04.649][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:21:04.649][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:21:04.724][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:21:04.749][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:21:04.749][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:21:09.647][DEBUG] [Camera Thread] QSI expose and download: 4.8342765s [09/25/17 20:21:09.721][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:21:09.721][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:21:09.801][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:21:09.830][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:21:09.830][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:21:14.723][DEBUG] [Camera Thread] QSI expose and download: 4.8292762s [09/25/17 20:21:14.833][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:21:14.833][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:21:14.924][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:21:14.958][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:21:14.958][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:21:17.884][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:21:17.884][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:21:17.884][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:21:17.884][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:21:17.884][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:21:19.851][DEBUG] [Camera Thread] QSI expose and download: 4.8282761s [09/25/17 20:21:19.928][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:21:19.928][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:21:19.996][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:21:20.021][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:21:20.021][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:21:24.919][DEBUG] [Camera Thread] QSI expose and download: 4.8332765s [09/25/17 20:21:24.996][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:21:24.996][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:21:25.084][DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [09/25/17 20:21:25.116][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:21:25.116][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:21:30.007][DEBUG] [Camera Thread] QSI expose and download: 4.8272761s [09/25/17 20:21:30.079][DEBUG] [Camera Thread] SGM_FRAME_AND_FOCUS complete... [09/25/17 20:21:41.748][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [09/25/17 20:21:41.755][DEBUG] [Camera Thread] Checking for auto focus... [09/25/17 20:21:41.755][DEBUG] [Camera Thread] Auto focus required (frame count trigger)... [09/25/17 20:21:41.765][DEBUG] [Camera Thread] Auto focus: setting filter O3 [09/25/17 20:21:41.768][DEBUG] [Camera Thread] Setting filter position 6... [09/25/17 20:21:41.768][DEBUG] [Camera Thread] Filter position 6 is already set. Skipping... [09/25/17 20:21:41.770][DEBUG] [Camera Thread] Auto focus running... [09/25/17 20:21:41.777][DEBUG] [Camera Thread] Turning temp comp off.. [09/25/17 20:21:41.797][DEBUG] [Camera Thread] Performing Sequence Generator auto focus using Half Flux Radius. AFID: 0 [09/25/17 20:21:41.871][DEBUG] [AfChartThread] Showing AF chart dialog... [09/25/17 20:21:41.989][DEBUG] [Camera Thread] Auto focus data [09/25/17 20:21:41.989][DEBUG] [Camera Thread] - Data Points: 7 [09/25/17 20:21:41.989][DEBUG] [Camera Thread] - Step Size: 10 [09/25/17 20:21:41.989][DEBUG] [Camera Thread] - Current Position: 7788 [09/25/17 20:21:41.989][DEBUG] [Camera Thread] - Initial Move Position: 7818 [09/25/17 20:21:42.006][DEBUG] [Camera Thread] AF Darks exception: The path is not of a legal form. [09/25/17 20:21:42.007][DEBUG] [Camera Thread] Moving focuser to next position (7818)... [09/25/17 20:21:42.013][DEBUG] [Focuser Move Thread] Focuser moving to 7818 [09/25/17 20:21:42.073][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:21:43.127][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7818 matches requested position 7818 [09/25/17 20:21:43.127][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:21:43.182][DEBUG] [Camera Thread] Focuser position matches requested position (7818), continuing... [09/25/17 20:21:43.245][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:21:43.248][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:21:43.254][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:21:43.254][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:21:43.254][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:21:43.254][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:21:43.282][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:21:43.282][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:21:59.998][DEBUG] [Camera Thread] QSI expose and download: 16.6519525s [09/25/17 20:22:00.187][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:22:00.187][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:22:00.515][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:22:00.649][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:22:06.230][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:22:06.230][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:22:06.358][DEBUG] [Main Thread] Find stars took: 5843 ms... [09/25/17 20:22:06.360][DEBUG] [Main Thread] Star list contains 25 stars... [09/25/17 20:22:06.360][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:22:06.886][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.27 [09/25/17 20:22:07.921][DEBUG] [Camera Thread] Moving focuser to next position (7808)... [09/25/17 20:22:07.928][DEBUG] [Focuser Move Thread] Focuser moving to 7808 [09/25/17 20:22:07.984][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:22:09.053][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7808 matches requested position 7808 [09/25/17 20:22:09.053][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:22:09.112][DEBUG] [Camera Thread] Focuser position matches requested position (7808), continuing... [09/25/17 20:22:09.172][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:22:09.172][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:22:09.176][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:22:09.176][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:22:09.176][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:22:09.176][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:22:09.204][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:22:09.204][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:22:18.024][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:22:18.024][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:22:18.024][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:22:18.024][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:22:18.024][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:22:25.907][DEBUG] [Camera Thread] QSI expose and download: 16.6389517s [09/25/17 20:22:26.112][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:22:26.112][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:22:26.706][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:22:26.882][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:22:32.531][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:22:32.531][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:22:32.823][DEBUG] [Main Thread] Find stars took: 6115 ms... [09/25/17 20:22:32.823][DEBUG] [Main Thread] Star list contains 14 stars... [09/25/17 20:22:32.823][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:22:33.109][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.79 [09/25/17 20:22:34.129][DEBUG] [Camera Thread] Moving focuser to next position (7798)... [09/25/17 20:22:34.130][DEBUG] [Focuser Move Thread] Focuser moving to 7798 [09/25/17 20:22:34.191][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:22:35.247][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7798 matches requested position 7798 [09/25/17 20:22:35.248][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:22:35.303][DEBUG] [Camera Thread] Focuser position matches requested position (7798), continuing... [09/25/17 20:22:35.364][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:22:35.364][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:22:35.371][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:22:35.371][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:22:35.371][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:22:35.371][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:22:35.398][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:22:35.398][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:22:52.126][DEBUG] [Camera Thread] QSI expose and download: 16.6639531s [09/25/17 20:22:52.314][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:22:52.314][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:22:52.970][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:22:53.205][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:22:58.727][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:22:58.727][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:22:58.939][DEBUG] [Main Thread] Find stars took: 5969 ms... [09/25/17 20:22:58.939][DEBUG] [Main Thread] Star list contains 9 stars... [09/25/17 20:22:58.939][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:22:59.227][DEBUG] [Camera Thread] Auto focus HFR calculated at: 3.75 [09/25/17 20:23:00.245][DEBUG] [Camera Thread] Moving focuser to next position (7788)... [09/25/17 20:23:00.248][DEBUG] [Focuser Move Thread] Focuser moving to 7788 [09/25/17 20:23:00.307][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:23:01.399][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7788 matches requested position 7788 [09/25/17 20:23:01.399][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:23:01.458][DEBUG] [Camera Thread] Focuser position matches requested position (7788), continuing... [09/25/17 20:23:01.519][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:23:01.519][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:23:01.525][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:23:01.525][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:23:01.526][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:23:01.526][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:23:01.561][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:23:01.561][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:23:18.164][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:23:18.164][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:23:18.164][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:23:18.164][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:23:18.164][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:23:18.283][DEBUG] [Camera Thread] QSI expose and download: 16.6579528s [09/25/17 20:23:18.482][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:23:18.482][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:23:19.115][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:23:19.258][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:23:24.974][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:23:24.974][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:23:25.065][DEBUG] [Main Thread] Find stars took: 5949 ms... [09/25/17 20:23:25.065][DEBUG] [Main Thread] Star list contains 6 stars... [09/25/17 20:23:25.065][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:23:25.345][DEBUG] [Camera Thread] Auto focus HFR calculated at: 3.76 [09/25/17 20:23:26.373][DEBUG] [Camera Thread] Detected focus getting worse! Shifting auto focus range [09/25/17 20:23:26.374][DEBUG] [Focuser Move Thread] Focuser moving to 7833 [09/25/17 20:23:26.437][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:23:27.498][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7833 matches requested position 7833 [09/25/17 20:23:27.498][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:23:27.556][DEBUG] [Camera Thread] Auto focus data [09/25/17 20:23:27.556][DEBUG] [Camera Thread] - Data Points: 7 [09/25/17 20:23:27.556][DEBUG] [Camera Thread] - Step Size: 10 [09/25/17 20:23:27.556][DEBUG] [Camera Thread] - Current Position: 7833 [09/25/17 20:23:27.556][DEBUG] [Camera Thread] - Initial Move Position: 7863 [09/25/17 20:23:27.563][DEBUG] [Camera Thread] AF Darks exception: The path is not of a legal form. [09/25/17 20:23:27.618][DEBUG] [Camera Thread] Moving focuser to next position (7863)... [09/25/17 20:23:27.618][DEBUG] [Focuser Move Thread] Focuser moving to 7863 [09/25/17 20:23:27.730][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:23:28.784][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7863 matches requested position 7863 [09/25/17 20:23:28.785][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:23:28.844][DEBUG] [Camera Thread] Focuser position matches requested position (7863), continuing... [09/25/17 20:23:28.905][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:23:28.905][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:23:28.909][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:23:28.909][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:23:28.909][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:23:28.909][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:23:28.954][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:23:28.954][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:23:45.681][DEBUG] [Camera Thread] QSI expose and download: 16.6629531s [09/25/17 20:23:45.857][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:23:45.857][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:23:46.517][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:23:46.661][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:23:52.529][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:23:52.529][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:23:52.628][DEBUG] [Main Thread] Find stars took: 6110 ms... [09/25/17 20:23:52.628][DEBUG] [Main Thread] Star list contains 14 stars... [09/25/17 20:23:52.628][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:23:52.909][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.73 [09/25/17 20:23:53.938][DEBUG] [Camera Thread] Moving focuser to next position (7853)... [09/25/17 20:23:53.939][DEBUG] [Focuser Move Thread] Focuser moving to 7853 [09/25/17 20:23:54.001][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:23:55.060][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7853 matches requested position 7853 [09/25/17 20:23:55.060][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:23:55.116][DEBUG] [Camera Thread] Focuser position matches requested position (7853), continuing... [09/25/17 20:23:55.171][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:23:55.171][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:23:55.174][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:23:55.175][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:23:55.175][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:23:55.175][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:23:55.196][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:23:55.196][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:24:11.906][DEBUG] [Camera Thread] QSI expose and download: 16.6459521s [09/25/17 20:24:12.096][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:24:12.096][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:24:12.834][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:24:12.967][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:24:18.268][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:24:18.268][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:24:18.268][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:24:18.268][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:24:18.268][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:24:18.778][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:24:18.778][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:24:18.874][DEBUG] [Main Thread] Find stars took: 6038 ms... [09/25/17 20:24:18.874][DEBUG] [Main Thread] Star list contains 24 stars... [09/25/17 20:24:18.874][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:24:19.231][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.23 [09/25/17 20:24:20.240][DEBUG] [Camera Thread] Moving focuser to next position (7843)... [09/25/17 20:24:20.241][DEBUG] [Focuser Move Thread] Focuser moving to 7843 [09/25/17 20:24:20.297][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:24:21.353][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7843 matches requested position 7843 [09/25/17 20:24:21.354][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:24:21.412][DEBUG] [Camera Thread] Focuser position matches requested position (7843), continuing... [09/25/17 20:24:21.468][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:24:21.468][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:24:21.470][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:24:21.470][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:24:21.470][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:24:21.470][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:24:21.504][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:24:21.504][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:24:38.217][DEBUG] [Camera Thread] QSI expose and download: 16.6499523s [09/25/17 20:24:38.387][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:24:38.387][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:24:38.976][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:24:39.094][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:24:44.701][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:24:44.701][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:24:44.852][DEBUG] [Main Thread] Find stars took: 5876 ms... [09/25/17 20:24:44.853][DEBUG] [Main Thread] Star list contains 36 stars... [09/25/17 20:24:44.853][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:24:45.161][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.90 [09/25/17 20:24:46.175][DEBUG] [Camera Thread] Moving focuser to next position (7833)... [09/25/17 20:24:46.178][DEBUG] [Focuser Move Thread] Focuser moving to 7833 [09/25/17 20:24:46.238][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:24:47.304][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7833 matches requested position 7833 [09/25/17 20:24:47.304][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:24:47.359][DEBUG] [Camera Thread] Focuser position matches requested position (7833), continuing... [09/25/17 20:24:47.427][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:24:47.427][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:24:47.431][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:24:47.432][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:24:47.432][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:24:47.432][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:24:47.457][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:24:47.457][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:25:04.181][DEBUG] [Camera Thread] QSI expose and download: 16.6599529s [09/25/17 20:25:04.363][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:25:04.363][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:25:05.062][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:25:05.197][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:25:10.849][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:25:10.849][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:25:10.999][DEBUG] [Main Thread] Find stars took: 5936 ms... [09/25/17 20:25:10.999][DEBUG] [Main Thread] Star list contains 37 stars... [09/25/17 20:25:10.999][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:25:11.294][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.79 [09/25/17 20:25:12.315][DEBUG] [Camera Thread] Moving focuser to next position (7823)... [09/25/17 20:25:12.315][DEBUG] [Focuser Move Thread] Focuser moving to 7823 [09/25/17 20:25:12.373][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:25:13.436][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7823 matches requested position 7823 [09/25/17 20:25:13.436][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:25:13.492][DEBUG] [Camera Thread] Focuser position matches requested position (7823), continuing... [09/25/17 20:25:13.548][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:25:13.548][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:25:13.560][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:25:13.560][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:25:13.560][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:25:13.560][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:25:13.588][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:25:13.588][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:25:18.369][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:25:18.369][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:25:18.369][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:25:18.369][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:25:18.369][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:25:30.317][DEBUG] [Camera Thread] QSI expose and download: 16.6649531s [09/25/17 20:25:30.504][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:25:30.504][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:25:31.200][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:25:31.327][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:25:36.795][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:25:36.795][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:25:37.023][DEBUG] [Main Thread] Find stars took: 5823 ms... [09/25/17 20:25:37.023][DEBUG] [Main Thread] Star list contains 37 stars... [09/25/17 20:25:37.023][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:25:37.287][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.86 [09/25/17 20:25:38.298][DEBUG] [Camera Thread] Moving focuser to next position (7813)... [09/25/17 20:25:38.299][DEBUG] [Focuser Move Thread] Focuser moving to 7813 [09/25/17 20:25:38.357][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:25:39.411][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7813 matches requested position 7813 [09/25/17 20:25:39.411][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:25:39.470][DEBUG] [Camera Thread] Focuser position matches requested position (7813), continuing... [09/25/17 20:25:39.525][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:25:39.525][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:25:39.581][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:25:39.581][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:25:39.581][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:25:39.582][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:25:39.606][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:25:39.606][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:25:56.328][DEBUG] [Camera Thread] QSI expose and download: 16.6579528s [09/25/17 20:25:56.502][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:25:56.502][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:25:57.151][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:25:57.274][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:26:02.625][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:26:02.625][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:26:02.711][DEBUG] [Main Thread] Find stars took: 5559 ms... [09/25/17 20:26:02.711][DEBUG] [Main Thread] Star list contains 21 stars... [09/25/17 20:26:02.711][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:26:02.990][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.20 [09/25/17 20:26:04.005][DEBUG] [Camera Thread] Moving focuser to next position (7803)... [09/25/17 20:26:04.007][DEBUG] [Focuser Move Thread] Focuser moving to 7803 [09/25/17 20:26:04.120][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:26:05.174][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7803 matches requested position 7803 [09/25/17 20:26:05.174][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:26:05.236][DEBUG] [Camera Thread] Focuser position matches requested position (7803), continuing... [09/25/17 20:26:05.295][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:26:05.295][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:26:05.301][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:26:05.301][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:26:05.301][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:26:05.301][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:26:05.335][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:26:05.335][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:26:18.508][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:26:18.508][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:26:18.508][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:26:18.508][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:26:18.508][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:26:22.032][DEBUG] [Camera Thread] QSI expose and download: 16.6329514s [09/25/17 20:26:22.249][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:26:22.249][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:26:22.942][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:26:23.066][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:26:28.829][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:26:28.829][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:26:28.933][DEBUG] [Main Thread] Find stars took: 5990 ms... [09/25/17 20:26:28.933][DEBUG] [Main Thread] Star list contains 13 stars... [09/25/17 20:26:28.933][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:26:29.270][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.65 [09/25/17 20:26:30.281][DEBUG] [Camera Thread] New auto focus method calculated focus at: 7833 [09/25/17 20:26:30.281][DEBUG] [Camera Thread] Old auto focus method calculated focus at: 7832 [09/25/17 20:26:30.281][DEBUG] [Camera Thread] Using new auto focus method for focuser position [09/25/17 20:26:30.281][DEBUG] [Camera Thread] New focus position is at 7833 (@100.00C). Moving focuser... [09/25/17 20:26:30.282][DEBUG] [Focuser Move Thread] Focuser moving to 7833 [09/25/17 20:26:30.337][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:26:31.392][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7833 matches requested position 7833 [09/25/17 20:26:31.392][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:26:31.448][DEBUG] [Camera Thread] Focuser successfully set to focus position (7833) [09/25/17 20:26:31.559][DEBUG] [Camera Thread] Taking validation frame at focus position... [09/25/17 20:26:31.562][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:26:31.566][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:26:31.566][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:26:31.566][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:26:31.566][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:26:31.593][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:26:31.593][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:26:48.335][DEBUG] [Camera Thread] QSI expose and download: 16.6769539s [09/25/17 20:26:48.562][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:26:48.562][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:26:49.258][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:26:49.373][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:26:54.899][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:26:54.899][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:26:55.110][DEBUG] [Main Thread] Find stars took: 5851 ms... [09/25/17 20:26:55.110][DEBUG] [Main Thread] Star list contains 32 stars... [09/25/17 20:26:55.110][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:26:55.392][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.80 [09/25/17 20:26:56.404][DEBUG] [Camera Thread] Auto focus is complete (best fit method: 7833; HFR 1.80)... [09/25/17 20:26:56.412][DEBUG] [Camera Thread] Entering chart disposal loop... [09/25/17 20:27:18.647][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:27:18.647][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:27:18.647][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:27:18.647][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:27:18.647][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:28:18.748][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:28:18.748][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:28:18.748][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:28:18.748][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:28:18.748][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:29:18.885][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [09/25/17 20:29:18.885][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [09/25/17 20:29:18.885][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [09/25/17 20:29:18.885][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:29:18.885][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [09/25/17 20:30:02.368][DEBUG] [Camera Thread] Chart disposal loop is complete... [09/25/17 20:30:02.368][DEBUG] [Camera Thread] Auto focus is done... [09/25/17 20:30:02.377][DEBUG] [AfChartThread] AF chart dialog is closed... [09/25/17 20:30:02.392][DEBUG] [Camera Thread] Auto focus complete... [09/25/17 20:30:02.406][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [09/25/17 20:32:13.586][DEBUG] [Main Thread] Filter wheel is required... [09/25/17 20:32:13.586][DEBUG] [Main Thread] Filter wheel is still connected. Ignoring connect step... [09/25/17 20:32:13.588][DEBUG] [Main Thread] Focuser is required... [09/25/17 20:32:13.588][DEBUG] [Main Thread] Focuser is still connected. Ignoring connect step... [09/25/17 20:32:13.588][DEBUG] [Main Thread] Telescope is required... [09/25/17 20:32:13.588][DEBUG] [Main Thread] Telescope is still connected. Ignoring connect step... [09/25/17 20:32:13.595][DEBUG] [Main Thread] Safety device might be required... [09/25/17 20:32:13.595][DEBUG] [Main Thread] Safety device is still connected. Ignoring connect step... [09/25/17 20:32:13.595][DEBUG] [Main Thread] Environment device required... [09/25/17 20:32:13.595][DEBUG] [Main Thread] Environment device is still connected. Ignoring connect step... [09/25/17 20:32:13.712][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [09/25/17 20:32:13.719][DEBUG] [Main Thread] GNS Startup... [09/25/17 20:32:13.733][DEBUG] [Sequence Thread] Dispatch loop: Received SGM_RUN_SEQUENCE... [09/25/17 20:32:13.755][DEBUG] [Sequence Thread] GuiderCheck: Checking auto guider status... [09/25/17 20:32:13.755][DEBUG] [Sequence Thread] GuiderCheck: Auto guider reports connected... [09/25/17 20:32:13.755][DEBUG] [Sequence Thread] Checking auto guider version... [09/25/17 20:32:13.756][DEBUG] [Sequence Thread] PHD2: Performing version check... [09/25/17 20:32:13.756][DEBUG] [Sequence Thread] PHD2: Min version is 2.6.0 [09/25/17 20:32:13.756][DEBUG] [Sequence Thread] PHD2: User version is 2.6.3 [09/25/17 20:32:13.757][DEBUG] [Sequence Thread] Finding first active group... [09/25/17 20:32:13.758][DEBUG] [Sequence Thread] Looking at target Ngc6823... [09/25/17 20:32:13.758][DEBUG] [Sequence Thread] Target is active: True [09/25/17 20:32:13.758][DEBUG] [Sequence Thread] Target is complete: False [09/25/17 20:32:13.758][DEBUG] [Sequence Thread] Target marked as past end time: False [09/25/17 20:32:13.758][DEBUG] [Sequence Thread] Target has end time: False [09/25/17 20:32:13.758][DEBUG] [Sequence Thread] Target end time: 9/25/2017 8:30:00 PM [09/25/17 20:32:13.758][DEBUG] [Sequence Thread] Active group found... [09/25/17 20:32:13.758][DEBUG] [Sequence Thread] Sequence should find starting target; Found target: 0 [09/25/17 20:32:13.762][DEBUG] [Sequence Thread] ************** SEQUENCE DUMP ************** [09/25/17 20:32:13.762][DEBUG] [Sequence Thread] sDirectory: C:\Users\Public\Documents\SGP Images [09/25/17 20:32:13.762][DEBUG] [Sequence Thread] sBaseName: [09/25/17 20:32:13.762][DEBUG] [Sequence Thread] nDelayFirst: 0 [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] nDelayBetween: 0 [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] bFinishFullEventFirst: False [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] arEventGroups: System.Collections.Generic.List`1[SequenceGenerator.EventGroup] [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] nCurrentEventIndex: 0 [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] dtElapsedTime: 1/1/0001 12:00:00 AM +00:00 [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] bStarted: False [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] bIsSequenceRunning: False [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] sFileNamePattern: %ft\%tn_%el_%bi_%su_%fn [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] sVersion: 2.6.0.23 [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] tsElapsedTime: 00:00:00 [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] bCaptureUntil: False [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] dtCaptureUntil: 9/25/2017 8:10:00 PM [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] userProfile: [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] nAfNebulosityRejection: 0.85 [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] sequenceFiles: System.Collections.Generic.Dictionary`2[System.String,System.String] [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] sequenceFileList: System.Collections.Generic.List`1[SequenceGenerator.SequenceFile] [09/25/17 20:32:13.765][DEBUG] [Sequence Thread] imageHistory: SequenceGenerator.ImageHistoryManager [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nAfSampleSize: 100 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bCaptureCalFramesIfSequenceFails: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] notificationsList: System.Collections.Generic.List`1[SequenceGenerator.NotoficationInfo] [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bRunEndOfSequenceScript: True [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] sEndOfSequenceScript: C:\Users\Public\Documents\MyObservatoryScripts\ShutDownfor_SGP_Boot.vbs [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bDisconnectAllGearOnSequenceEnd: True [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] ************** PROFILE DUMP ************** [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] sForImagingInstance: Sequence Generator Pro [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] sProfileName: Takahashi [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bDefault: True [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] sCameraName: QSI CCD Camera [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nGain1x1: 0 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nOffset1x1: 100 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nGain2x2: 0 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nOffset2x2: 100 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nGain3x3: 0 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nOffset3x3: 100 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nGain4x4: 0 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nOffset4x4: 100 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nCooldownTemp: -10 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nCooldownTime: 6 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nWarmupTemp: 20 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nWarmupTime: 3 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoCoolDown: True [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoWarmUp: True [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] sFilterWheelName: QSI Internal Filter Wheel [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nFilterDelay: 0 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] sFocuserName: RoboFocus [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bReverseFocuser: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nFineFocusStepSize: 10 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nCoarseFocusStepSize: 30 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoAdjustFocusPerFilter: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoFocusForFilterChangeOnly: True [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bUseAutoFocus: True [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoFocusPerFrame: True [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoFocusOverTime: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nAutoFocusFramerInterval: 3 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nAutoFocusTimerInterval: 10 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoFocusForceForFilter: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoFocusBeforeFirstFrame: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoFocusManualStar: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoManualFocusForFilterChangeOnly: True [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bUseAutoManualFocus: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoManualFocusPerFrame: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoManualFocusOverTime: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nAutoManualFocusFramerInterval: 1 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nAutoManualFocusTimerInterval: 10 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoManualFocusForceForFilter: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoManualFocusBeforeFirstFrame: True [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bOverrideMaxSteps: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nOverrideMaxSteps: 1 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bTempComp: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nStepsPerDegree: 0 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bPhdDither: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nPhdDitherIndex: 0 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nPhdSettleValue: 0.6 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bRecalGuiderOnSlew: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] nDecRecalValue: 0 [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] sTelescopeName: POTH Hub [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] bAutoSlew: False [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] tpFocusFrame: [09/25/17 20:32:13.766][DEBUG] [Sequence Thread] tpTargetFrame: [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] bPausePhdDuringDownload: True [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] bShutdownPhdWhenDone: True [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] bParkTelescopeWhenDone: True [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] sReferenceImagePath: [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] bAutoCenterFrame: False [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] siReference: nEstRa: 0 nEstDec: 0 nRightAscention: 0 nDeclination: 0 nArcsecPerPixel: 0 nAngle: -500 bFlipped: False sSearchType: sBinning: nExposureLength: 0 sImagePath: bFailed: True sInfo: bDoneSolving: True nSides: 0 nMaxSolveTime: 60 [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] siScope: nEstRa: 0 nEstDec: 0 nRightAscention: 0 nDeclination: 0 nArcsecPerPixel: 0 nAngle: 0 bFlipped: False sSearchType: Not Available sBinning: 2x2 nExposureLength: 0 sImagePath: bFailed: True sInfo: bDoneSolving: True nSides: 0 nMaxSolveTime: 60 [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] nSolverExposure1x1: 1 [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] nSolverExposure2x2: 1 [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] nSolverExposure3x3: 1 [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] nSolverExposure4x4: 1 [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] nArcsec1x1: 0 [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] nArcsec2x2: 0 [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] nArcsec3x3: 0 [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] nArcsec4x4: 0 [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] sDithertext: Small Dither [09/25/17 20:32:13.767][DEBUG] [Sequence Thread] sAutoGuider: PHD2 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nFFBinning: 3 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nFFExposure: 1 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nAFExposure: 1 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nAFBinning: 0 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nAFStepSize: 10 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nAFDataPoints: 7 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sPlateSolver: No Plate Solver [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sAutoFocuser: Half Flux Radius [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nAutoFocusDialogCloseDelay: 30 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bAutoFocusDegree: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bAutoManualFocusDegree: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nAutoFocusDegreeInterval: 1 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nAutoManualFocusDegreeInterval: 1 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bAutoFocusAutoContinue: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nNudgeSpeed: 0 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bReverseNs: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bReverseEw: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nHiSpeedRate: 1 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nLoSpeedRate: 0.5 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sCameraGain1x1: High [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sCameraGain2x2: High [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sCameraGain3x3: High [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sCameraGain4x4: High [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sCameraOffset1x1: [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sCameraOffset2x2: [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sCameraOffset3x3: [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sCameraOffset4x4: [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bPauseAutoGuiderDuringAutoFocus: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bUseSameStarsForAf: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bSaveAfData: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sSaveAfDataPath: C:\Users\Public\Documents\SGP Images [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bAllowExternalScopeControl: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sFFBinning: 1x1 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sAFBinning: 1x1 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nMountSettling: 0 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] ffExposure: 1 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] noFilter: SequenceGenerator.Filter [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bAutoFocusOnResume: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sFlatBoxName: No Flat Box [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] flatBoxBrightness: 0 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bFocuserBacklash: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nFocuserBacklashStepSize: 0 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bFocuserBacklashMovesIn: True [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nGuiderSettlingTime: 0 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nAutoCenterAttempts: 1 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nAutoCenterError: 50 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bFrameRestart: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nFrameRestartError: 0 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bDoAutoMeridianFlip: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] autoMeridianFlipVals: SequenceGenerator.AutoMeridianFlipValues [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bUseAfDarks: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sAfDarksPath: [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bUseAutoCenterFilter: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sAutoCenterFilter: Lum [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bUseAutoFocusFilter: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sAutoFocusFilter: Lum [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bSettleAgBeforeAf: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bUseHighSpeedDl: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bBlindSolveFailover: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nReadoutNoise: 0 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] ccdArraySize: {Width=0, Height=0} [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nCameraGain1x1: 0 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nCameraGain2x2: 0 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nCameraGain3x3: 0 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nCameraGain4x4: 0 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sRotatorName: No Rotator [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] nRotationError: 3 [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bUseTemperDevice: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bAutoFocusAfterFlip: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] bReverseManualRotatorCorrections: False [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sObservatoryName: No Observatory [09/25/17 20:32:13.768][DEBUG] [Sequence Thread] sObsType: Roll Off Roof [09/25/17 20:32:13.769][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 [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] bSlaveObsToScope: False [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] bPromptToPlaceLightBox: False [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] nDownloadTime1x1: 0 [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] nDownloadTime2x2: 0 [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] nDownloadTime3x3: 0 [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] nDownloadTime4x4: 0 [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] bAfCropFrames: False [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] nAfCropFramesPercent: 0 [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] sFilePattern: [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] sWeatherStationName: ASCOM Boltwood OK to Image [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] nScopeFocalLength: 0 [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] bCameraCooldownOnSequenceStart: False [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] sRtfNotes: [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] bStopTracking: False [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] bHasCentralObstruction: False [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] sCustomVariables: [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] sPhd2Profile: Tak [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] bAutoConnectPhd2Gear: True [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] bAutoDisconnectPhd2Gear: True [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] bPauseGuiderDuringBacklashComp: False [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] bSetAbsPositiononFirstFilterChange: False [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] sEnvironmentDeviceName: ASCOM Boltwood Observing Conditions [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] bSettleGuiderTime: False [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] equipmentData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.EquipmentData] [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] nMinStarSize: 6 [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] telescopeSyncOption: Sync [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] nAutoguiderDitherEveryXFrameCount: 1 [09/25/17 20:32:13.769][DEBUG] [Sequence Thread] ************** FILTER DUMP ************** [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] >> FILTER 1: [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] bActive: True [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] sName: None [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nAfExposureTime: 1 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFocusPosition: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFocusTemp: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat1: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat2: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat3: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat4: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nNumFlats: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] sFocusWith: Default [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] >> FILTER 2: [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] bActive: True [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] sName: Lum [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nAfExposureTime: 1 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFocusPosition: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFocusTemp: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat1: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat2: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat3: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat4: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nNumFlats: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] sFocusWith: Default [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] >> FILTER 3: [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] bActive: True [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] sName: Red [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nAfExposureTime: 1 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFocusPosition: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFocusTemp: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat1: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat2: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat3: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat4: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nNumFlats: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] sFocusWith: Default [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] >> FILTER 4: [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] bActive: True [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] sName: Green [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nAfExposureTime: 1 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFocusPosition: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFocusTemp: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat1: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat2: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat3: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat4: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nNumFlats: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] sFocusWith: Default [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] >> FILTER 5: [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] bActive: True [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] sName: Blue [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nAfExposureTime: 2 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFocusPosition: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFocusTemp: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat1: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat2: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat3: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nFlat4: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] nNumFlats: 0 [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] sFocusWith: Default [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [09/25/17 20:32:13.770][DEBUG] [Sequence Thread] >> FILTER 6: [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] bActive: True [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] sName: Ha [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nAfExposureTime: 1 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFocusPosition: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFocusTemp: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat1: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat2: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat3: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat4: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nNumFlats: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] sFocusWith: Default [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] >> FILTER 7: [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] bActive: True [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] sName: O3 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nAfExposureTime: 1 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFocusPosition: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFocusTemp: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat1: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat2: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat3: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat4: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nNumFlats: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] sFocusWith: Default [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] >> FILTER 8: [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] bActive: True [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] sName: S2 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nAfExposureTime: 1 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFocusPosition: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFocusTemp: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat1: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat2: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat3: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat4: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nNumFlats: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] sFocusWith: Default [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] >> FILTER 9: [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] bActive: False [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] sName: [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nAfExposureTime: 1 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFocusPosition: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFocusTemp: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat1: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat2: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat3: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat4: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nNumFlats: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] sFocusWith: Default [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] >> FILTER 10: [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] bActive: False [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] sName: [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nAfExposureTime: 1 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFocusPosition: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFocusTemp: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat1: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat2: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat3: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat4: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nNumFlats: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] sFocusWith: Default [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] >> FILTER 11: [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] bActive: False [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] sName: [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nAfExposureTime: 1 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFocusPosition: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFocusTemp: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat1: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat2: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat3: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nFlat4: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] nNumFlats: 0 [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.771][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] sFocusWith: Default [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] >> FILTER 12: [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] bActive: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] sName: [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nAfExposureTime: 1 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nFocusPosition: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nFocusTemp: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nFlat1: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nFlat2: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nFlat3: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nFlat4: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nNumFlats: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] sFocusWith: Default [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] >> FILTER 13: [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] bActive: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] sName: [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nAfExposureTime: 1 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nFocusPosition: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nFocusTemp: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nFlat1: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nFlat2: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nFlat3: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nFlat4: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] nNumFlats: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] sFocusWith: Default [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] ************** EVENT DUMP ************** [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] * Target Ngc6823 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Active: True [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Start Time: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Start: 9/25/2017 8:30:00 PM [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -End Time: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -End: 9/25/2017 8:30:00 PM [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Auto Rotate: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Auto Center: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Location set: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -RA: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -DEC: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Finish Full Event: True [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Completed: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -After End Time: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Rotate Camera: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Rotation: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] ** Event 1 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Active: True [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Frame Type: Light [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Filter: 6 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Suffix: O3 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Exposure Time: 300 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Binning: 1x1 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Repeat: 12 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Gain: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Offset: 100 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Num Complete: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] ** Event 2 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Active: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Frame Type: Light [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Filter: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Suffix: [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Exposure Time: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Binning: 1x1 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Repeat: 1 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Gain: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Offset: 100 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Num Complete: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] ** Event 3 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Active: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Frame Type: Light [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Filter: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Suffix: [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Exposure Time: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Binning: 1x1 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Repeat: 1 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Gain: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Offset: 100 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Num Complete: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] ** Event 4 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Active: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Frame Type: Light [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Filter: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Suffix: [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Exposure Time: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Binning: 1x1 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Repeat: 1 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Gain: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Offset: 100 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Num Complete: 0 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] ** Event 5 [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Active: False [09/25/17 20:32:13.772][DEBUG] [Sequence Thread] -Frame Type: Light [09/25/17 20:32:13.773][DEBUG] [Sequence Thread] -Filter: 0 [09/25/17 20:32:13.773][DEBUG] [Sequence Thread] -Suffix: [09/25/17 20:32:13.773][DEBUG] [Sequence Thread] -Exposure Time: 0 [09/25/17 20:32:13.773][DEBUG] [Sequence Thread] -Binning: 1x1 [09/25/17 20:32:13.773][DEBUG] [Sequence Thread] -Repeat: 1 [09/25/17 20:32:13.773][DEBUG] [Sequence Thread] -Gain: 0 [09/25/17 20:32:13.773][DEBUG] [Sequence Thread] -Offset: 100 [09/25/17 20:32:13.773][DEBUG] [Sequence Thread] -Num Complete: 0 [09/25/17 20:32:13.773][DEBUG] [Sequence Thread] ************** END SEQUENCE DUMP ************** [09/25/17 20:32:13.773][DEBUG] [Sequence Thread] ********** Run sequence started ********** [09/25/17 20:32:13.859][DEBUG] [Sequence Thread] Checking if observatory requires auto slaving... [09/25/17 20:32:13.859][DEBUG] [Sequence Thread] Observatory does not require auto slave... [09/25/17 20:32:13.865][DEBUG] [Sequence Thread] DoEventGroupChange: Changing to event group: Ngc6823 [09/25/17 20:32:13.868][DEBUG] [Sequence Thread] Checking for start delay... [09/25/17 20:32:13.936][DEBUG] [Sequence Thread] DoEventGroupChange: Complete [09/25/17 20:32:13.938][DEBUG] [Sequence Thread] Attempting to find next event... [09/25/17 20:32:13.938][DEBUG] [Sequence Thread] Current event[0] frame count: 0/12... [09/25/17 20:32:13.940][DEBUG] [Sequence Thread] Looking at event[0]... [09/25/17 20:32:13.940][DEBUG] [Sequence Thread] Found event event[0] with remaining frames. [09/25/17 20:32:13.940][DEBUG] [Sequence Thread] Event[0] frame count: 0/12... [09/25/17 20:32:13.940][DEBUG] [Sequence Thread] Getting first event (0)... [09/25/17 20:32:13.991][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [09/25/17 20:32:14.010][DEBUG] [Sequence Thread] Running pre event... [09/25/17 20:32:14.056][DEBUG] [Sequence Thread] Running capture event... [09/25/17 20:32:14.060][DEBUG] [Sequence Thread] SetStartTemp: Using focuser for temperature... [09/25/17 20:32:14.060][DEBUG] [Sequence Thread] Set start frame temp to 100... [09/25/17 20:32:14.093][DEBUG] [Sequence Thread] ------------- Starting capture frame for event[0] ------------- [09/25/17 20:32:14.097][DEBUG] [Sequence Thread] Sending commands... [09/25/17 20:32:14.099][DEBUG] [Sequence Thread] SetFlatBox: Frame Type is Light [09/25/17 20:32:14.100][DEBUG] [Sequence Thread] EventMarker 2 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:32:14.103][DEBUG] [Sequence Thread] EventMarker 3 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:32:14.104][DEBUG] [Sequence Thread] Waiting for AF to complete... [09/25/17 20:32:14.110][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [09/25/17 20:32:14.110][DEBUG] [Camera Thread] Checking for auto focus... [09/25/17 20:32:14.110][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [09/25/17 20:32:14.304][DEBUG] [Sequence Thread] AF is complete, continuing sequence... [09/25/17 20:32:14.308][DEBUG] [Sequence Thread] EventMarker 4 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:32:14.309][DEBUG] [Sequence Thread] Setting filter position 6... [09/25/17 20:32:14.309][DEBUG] [Sequence Thread] Filter position 6 is already set. Skipping... [09/25/17 20:32:14.309][DEBUG] [Sequence Thread] EventMarker 5 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:32:14.312][DEBUG] [Sequence Thread] Checking for auto manual focus (pre)... [09/25/17 20:32:14.312][DEBUG] [Sequence Thread] EventMarker 6 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:32:14.386][DEBUG] [Sequence Thread] Created base name for frame capture: Ngc6823_300sec_1x1_O3_frame1 [09/25/17 20:32:14.386][DEBUG] [Sequence Thread] Created directory for frame capture: C:\Users\Public\Documents\SGP Images\Light\ [09/25/17 20:32:14.386][DEBUG] [Sequence Thread] EventMarker 1 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:32:14.387][DEBUG] [Sequence Thread] EventMarker 7 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:32:14.387][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [09/25/17 20:32:14.389][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:32:14.389][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Looping [09/25/17 20:32:14.389][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:32:14.489][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:32:14.489][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [09/25/17 20:32:14.490][DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 20:32:14.490][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 20:32:14.490][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:32:14.491][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:32:14.491][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:32:14.591][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:32:14.591][DEBUG] [Sequence Thread] User has elected to skip guider settling over time... [09/25/17 20:32:14.591][DEBUG] [Sequence Thread] Waiting for Auto Guider distance to fall below 0.6 [09/25/17 20:32:14.592][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 20:32:14.592][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [09/25/17 20:32:14.599][DEBUG] [Sequence Thread] Distance is below 0.6, starting timer... [09/25/17 20:32:15.100][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 20:32:15.100][DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [09/25/17 20:32:15.109][DEBUG] [Sequence Thread] Distance stayed below 0.6 for 0 seconds, done settling... [09/25/17 20:32:15.110][DEBUG] [Sequence Thread] Auto guider has settled... [09/25/17 20:32:15.110][DEBUG] [Sequence Thread] EventMarker 8 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:32:15.110][DEBUG] [Sequence Thread] EventMarker 9 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:32:15.110][DEBUG] [Sequence Thread] EventMarker 10 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:32:15.111][DEBUG] [Sequence Thread] Finished sending frame capture. Entering wait mode... [09/25/17 20:32:15.111][DEBUG] [Sequence Thread] EventMarker 11 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:32:15.111][DEBUG] [Sequence Thread] EventMarker 12 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:32:15.112][DEBUG] [Sequence Thread] EventMarker 13 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:32:15.115][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE message received... [09/25/17 20:32:15.139][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:32:15.139][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:32:15.252][DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: GOOD [09/25/17 20:37:15.365][DEBUG] [Sequence Thread] EventMarker 15 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:37:15.365][DEBUG] [Sequence Thread] Waking from exposure time sleep period... [09/25/17 20:37:15.366][DEBUG] [Sequence Thread] Checking to see if the CCD has a temp... [09/25/17 20:37:15.366][DEBUG] [Sequence Thread] Saving the CCD temp... [09/25/17 20:37:15.384][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:37:15.384][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:37:15.384][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:37:15.484][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:37:30.880][DEBUG] [Camera Thread] QSI expose and download: 315.6770557s [09/25/17 20:37:30.880][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE complete... [09/25/17 20:37:31.127][DEBUG] [Sequence Thread] Image ready state detected when waiting for download state, continuing sequence... [09/25/17 20:37:31.127][DEBUG] [Sequence Thread] Entering super dangerous loop to await image completion... [09/25/17 20:37:31.138][DEBUG] [Sequence Thread] EventMarker 16 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:37:31.146][DEBUG] [Sequence Thread] EventMarker 17 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:37:31.146][DEBUG] [Sequence Thread] Image reported as complete. Continuing... [09/25/17 20:37:31.160][DEBUG] [Sequence Thread] Collecting FITs headers... [09/25/17 20:37:31.161][DEBUG] [Sequence Thread] QSI Camera - Camera reports last image start time as: 2017-09-26T03:32:17.859 UTC [09/25/17 20:37:31.161][DEBUG] [Sequence Thread] DATE-LOC time provided by camera... [09/25/17 20:37:31.171][DEBUG] [Sequence Thread] GatherFitsHeaders: Writing header info from UI... [09/25/17 20:37:31.180][DEBUG] [Sequence Thread] Clearing timed monitoring events... [09/25/17 20:37:31.186][DEBUG] [Sequence Thread] Created full file name: C:\Users\Public\Documents\SGP Images\Light\Ngc6823_300sec_1x1_O3_frame1-1.fit [09/25/17 20:37:31.333][DEBUG] [Sequence Thread] SaveFileBmp16: Locking bitmap for disk write... [09/25/17 20:37:31.333][DEBUG] [Sequence Thread] SaveFileBmp16: Opening file stream... [09/25/17 20:37:31.334][DEBUG] [Sequence Thread] SaveFileBmp16: Writing FITS headers... [09/25/17 20:37:31.340][DEBUG] [Sequence Thread] SaveFileBmp16: Traversing and persisting bitmap data... [09/25/17 20:37:31.539][DEBUG] [Sequence Thread] SaveFileBmp16: FITS block fill... [09/25/17 20:37:31.539][DEBUG] [Sequence Thread] SaveFileBmp16: Unlocking bitmap... [09/25/17 20:37:31.539][DEBUG] [Sequence Thread] SaveFileBmp16: Closing file stream [09/25/17 20:37:31.542][DEBUG] [Sequence Thread] Internal Interface: Set Preview... [09/25/17 20:37:31.542][DEBUG] [Sequence Thread] Display image preview using asynch task... [09/25/17 20:37:32.439][DEBUG] [Sequence Thread] =========== Save file took 1256 ms [09/25/17 20:37:32.454][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [09/25/17 20:37:32.454][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:37:32.454][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:37:32.454][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:37:32.554][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:37:32.554][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [09/25/17 20:37:32.561][DEBUG] [Sequence Thread] EventMarker 18 - t:Ngc6823 (0); e:0; f:0; o: [09/25/17 20:37:32.576][DEBUG] [Sequence Thread] EventMarker 19 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:32.576][DEBUG] [Sequence Thread] EventMarker 20 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:32.578][DEBUG] [Sequence Thread] Running post event... [09/25/17 20:37:32.578][DEBUG] [Sequence Thread] EventMarker 21 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:32.719][DEBUG] [Sequence Thread] Incremented numComplete (1) for event[0]... [09/25/17 20:37:32.726][DEBUG] [Sequence Thread] Attempting to find next event... [09/25/17 20:37:32.726][DEBUG] [Sequence Thread] Current event[0] frame count: 1/12... [09/25/17 20:37:32.727][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [09/25/17 20:37:32.728][DEBUG] [Sequence Thread] Checking for auto manual focus (post)... [09/25/17 20:37:32.728][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [09/25/17 20:37:32.734][DEBUG] [Sequence Thread] Attempting to move to next event... [09/25/17 20:37:32.734][DEBUG] [Sequence Thread] Attempting to find next event... [09/25/17 20:37:32.735][DEBUG] [Sequence Thread] Current event[0] frame count: 1/12... [09/25/17 20:37:32.735][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [09/25/17 20:37:32.735][DEBUG] [Sequence Thread] Running pre event... [09/25/17 20:37:32.756][DEBUG] [Sequence Thread] Running capture event... [09/25/17 20:37:32.758][DEBUG] [Sequence Thread] SetStartTemp: Using focuser for temperature... [09/25/17 20:37:32.758][DEBUG] [Sequence Thread] Set start frame temp to 100... [09/25/17 20:37:32.800][DEBUG] [Sequence Thread] ------------- Starting capture frame for event[0] ------------- [09/25/17 20:37:32.803][DEBUG] [Sequence Thread] Sending commands... [09/25/17 20:37:32.803][DEBUG] [Sequence Thread] SetFlatBox: Frame Type is Light [09/25/17 20:37:32.803][DEBUG] [Sequence Thread] EventMarker 2 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:32.803][DEBUG] [Sequence Thread] EventMarker 3 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:32.803][DEBUG] [Sequence Thread] Waiting for AF to complete... [09/25/17 20:37:32.809][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [09/25/17 20:37:32.809][DEBUG] [Camera Thread] Checking for auto focus... [09/25/17 20:37:32.809][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [09/25/17 20:37:33.003][DEBUG] [Sequence Thread] AF is complete, continuing sequence... [09/25/17 20:37:33.003][DEBUG] [Sequence Thread] EventMarker 4 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:33.003][DEBUG] [Sequence Thread] Setting filter position 6... [09/25/17 20:37:33.003][DEBUG] [Sequence Thread] Filter position 6 is already set. Skipping... [09/25/17 20:37:33.003][DEBUG] [Sequence Thread] EventMarker 5 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:33.003][DEBUG] [Sequence Thread] Checking for auto manual focus (pre)... [09/25/17 20:37:33.003][DEBUG] [Sequence Thread] EventMarker 6 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:33.062][DEBUG] [Sequence Thread] Created base name for frame capture: Ngc6823_300sec_1x1_O3_frame2 [09/25/17 20:37:33.062][DEBUG] [Sequence Thread] Created directory for frame capture: C:\Users\Public\Documents\SGP Images\Light\ [09/25/17 20:37:33.062][DEBUG] [Sequence Thread] EventMarker 1 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:33.062][DEBUG] [Sequence Thread] EventMarker 7 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:33.062][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [09/25/17 20:37:33.062][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:37:33.062][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:37:33.062][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:37:33.162][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:37:33.162][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [09/25/17 20:37:33.162][DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 20:37:33.162][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 20:37:33.162][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:37:33.162][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:37:33.162][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:37:33.262][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:37:33.262][DEBUG] [Sequence Thread] User has elected to skip guider settling over time... [09/25/17 20:37:33.262][DEBUG] [Sequence Thread] Waiting for Auto Guider distance to fall below 0.6 [09/25/17 20:37:33.262][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 20:37:33.262][DEBUG] [Sequence Thread] PHD2 distance request returned 0.2... [09/25/17 20:37:33.279][DEBUG] [Sequence Thread] Distance is below 0.6, starting timer... [09/25/17 20:37:33.766][DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: GOOD [09/25/17 20:37:33.779][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 20:37:33.779][DEBUG] [Sequence Thread] PHD2 distance request returned 0.2... [09/25/17 20:37:33.797][DEBUG] [Sequence Thread] Distance stayed below 0.6 for 0 seconds, done settling... [09/25/17 20:37:33.798][DEBUG] [Sequence Thread] Auto guider has settled... [09/25/17 20:37:33.798][DEBUG] [Sequence Thread] EventMarker 8 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:33.798][DEBUG] [Sequence Thread] EventMarker 9 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:33.798][DEBUG] [Sequence Thread] EventMarker 10 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:33.798][DEBUG] [Sequence Thread] Finished sending frame capture. Entering wait mode... [09/25/17 20:37:33.798][DEBUG] [Sequence Thread] EventMarker 11 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:33.799][DEBUG] [Sequence Thread] EventMarker 12 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:33.800][DEBUG] [Sequence Thread] EventMarker 13 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:37:33.806][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE message received... [09/25/17 20:37:33.830][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:37:33.830][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:42:33.921][DEBUG] [Sequence Thread] EventMarker 15 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:42:33.922][DEBUG] [Sequence Thread] Waking from exposure time sleep period... [09/25/17 20:42:33.922][DEBUG] [Sequence Thread] Checking to see if the CCD has a temp... [09/25/17 20:42:33.922][DEBUG] [Sequence Thread] Saving the CCD temp... [09/25/17 20:42:33.944][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:42:33.944][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:42:33.944][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:42:34.044][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:42:49.616][DEBUG] [Camera Thread] QSI expose and download: 315.7220583s [09/25/17 20:42:49.616][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE complete... [09/25/17 20:42:49.833][DEBUG] [Sequence Thread] Image ready state detected when waiting for download state, continuing sequence... [09/25/17 20:42:49.833][DEBUG] [Sequence Thread] Entering super dangerous loop to await image completion... [09/25/17 20:42:49.845][DEBUG] [Sequence Thread] EventMarker 16 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:42:49.856][DEBUG] [Sequence Thread] EventMarker 17 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:42:49.856][DEBUG] [Sequence Thread] Image reported as complete. Continuing... [09/25/17 20:42:49.858][DEBUG] [Sequence Thread] Collecting FITs headers... [09/25/17 20:42:49.860][DEBUG] [Sequence Thread] QSI Camera - Camera reports last image start time as: 2017-09-26T03:37:36.551 UTC [09/25/17 20:42:49.860][DEBUG] [Sequence Thread] DATE-LOC time provided by camera... [09/25/17 20:42:49.875][DEBUG] [Sequence Thread] GatherFitsHeaders: Writing header info from UI... [09/25/17 20:42:49.880][DEBUG] [Sequence Thread] Clearing timed monitoring events... [09/25/17 20:42:49.885][DEBUG] [Sequence Thread] Created full file name: C:\Users\Public\Documents\SGP Images\Light\Ngc6823_300sec_1x1_O3_frame2-1.fit [09/25/17 20:42:50.035][DEBUG] [Sequence Thread] SaveFileBmp16: Locking bitmap for disk write... [09/25/17 20:42:50.035][DEBUG] [Sequence Thread] SaveFileBmp16: Opening file stream... [09/25/17 20:42:50.036][DEBUG] [Sequence Thread] SaveFileBmp16: Writing FITS headers... [09/25/17 20:42:50.036][DEBUG] [Sequence Thread] SaveFileBmp16: Traversing and persisting bitmap data... [09/25/17 20:42:50.221][DEBUG] [Sequence Thread] SaveFileBmp16: FITS block fill... [09/25/17 20:42:50.221][DEBUG] [Sequence Thread] SaveFileBmp16: Unlocking bitmap... [09/25/17 20:42:50.221][DEBUG] [Sequence Thread] SaveFileBmp16: Closing file stream [09/25/17 20:42:50.221][DEBUG] [Sequence Thread] Internal Interface: Set Preview... [09/25/17 20:42:50.221][DEBUG] [Sequence Thread] Display image preview using asynch task... [09/25/17 20:42:51.297][DEBUG] [Sequence Thread] =========== Save file took 1416 ms [09/25/17 20:42:51.305][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [09/25/17 20:42:51.305][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:42:51.305][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:42:51.305][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:42:51.405][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:42:51.405][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [09/25/17 20:42:51.410][DEBUG] [Sequence Thread] EventMarker 18 - t:Ngc6823 (0); e:0; f:1; o: [09/25/17 20:42:51.423][DEBUG] [Sequence Thread] EventMarker 19 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:42:51.423][DEBUG] [Sequence Thread] EventMarker 20 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:42:51.423][DEBUG] [Sequence Thread] Running post event... [09/25/17 20:42:51.423][DEBUG] [Sequence Thread] EventMarker 21 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:42:51.424][DEBUG] [Sequence Thread] Incremented numComplete (2) for event[0]... [09/25/17 20:42:51.431][DEBUG] [Sequence Thread] Attempting to find next event... [09/25/17 20:42:51.431][DEBUG] [Sequence Thread] Current event[0] frame count: 2/12... [09/25/17 20:42:51.431][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [09/25/17 20:42:51.431][DEBUG] [Sequence Thread] Checking for auto manual focus (post)... [09/25/17 20:42:51.431][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [09/25/17 20:42:51.437][DEBUG] [Sequence Thread] Attempting to move to next event... [09/25/17 20:42:51.437][DEBUG] [Sequence Thread] Attempting to find next event... [09/25/17 20:42:51.437][DEBUG] [Sequence Thread] Current event[0] frame count: 2/12... [09/25/17 20:42:51.437][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [09/25/17 20:42:51.437][DEBUG] [Sequence Thread] Running pre event... [09/25/17 20:42:51.452][DEBUG] [Sequence Thread] Running capture event... [09/25/17 20:42:51.454][DEBUG] [Sequence Thread] SetStartTemp: Using focuser for temperature... [09/25/17 20:42:51.454][DEBUG] [Sequence Thread] Set start frame temp to 100... [09/25/17 20:42:51.454][DEBUG] [Sequence Thread] ------------- Starting capture frame for event[0] ------------- [09/25/17 20:42:51.458][DEBUG] [Sequence Thread] Sending commands... [09/25/17 20:42:51.458][DEBUG] [Sequence Thread] SetFlatBox: Frame Type is Light [09/25/17 20:42:51.458][DEBUG] [Sequence Thread] EventMarker 2 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:42:51.458][DEBUG] [Sequence Thread] EventMarker 3 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:42:51.458][DEBUG] [Sequence Thread] Waiting for AF to complete... [09/25/17 20:42:51.463][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [09/25/17 20:42:51.463][DEBUG] [Camera Thread] Checking for auto focus... [09/25/17 20:42:51.463][DEBUG] [Camera Thread] Auto focus required (frame count trigger)... [09/25/17 20:42:51.476][DEBUG] [Camera Thread] Auto focus: setting filter O3 [09/25/17 20:42:51.476][DEBUG] [Camera Thread] Setting filter position 6... [09/25/17 20:42:51.476][DEBUG] [Camera Thread] Filter position 6 is already set. Skipping... [09/25/17 20:42:51.478][DEBUG] [Camera Thread] Auto focus running... [09/25/17 20:42:51.485][DEBUG] [Camera Thread] Turning temp comp off.. [09/25/17 20:42:51.489][DEBUG] [Camera Thread] Performing Sequence Generator auto focus using Half Flux Radius. AFID: 1 [09/25/17 20:42:51.551][DEBUG] [AfChartThread] Showing AF chart dialog... [09/25/17 20:42:51.680][DEBUG] [Camera Thread] Auto focus data [09/25/17 20:42:51.680][DEBUG] [Camera Thread] - Data Points: 7 [09/25/17 20:42:51.680][DEBUG] [Camera Thread] - Step Size: 10 [09/25/17 20:42:51.680][DEBUG] [Camera Thread] - Current Position: 7833 [09/25/17 20:42:51.680][DEBUG] [Camera Thread] - Initial Move Position: 7863 [09/25/17 20:42:51.684][DEBUG] [Camera Thread] AF Darks exception: The path is not of a legal form. [09/25/17 20:42:51.685][DEBUG] [Camera Thread] Moving focuser to next position (7863)... [09/25/17 20:42:51.686][DEBUG] [Focuser Move Thread] Focuser moving to 7863 [09/25/17 20:42:51.744][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:42:52.798][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7863 matches requested position 7863 [09/25/17 20:42:52.798][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:42:52.856][DEBUG] [Camera Thread] Focuser position matches requested position (7863), continuing... [09/25/17 20:42:52.913][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:42:52.913][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:42:52.918][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:42:52.918][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:42:52.918][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:42:52.919][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:42:52.953][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:42:52.953][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:43:09.648][DEBUG] [Camera Thread] QSI expose and download: 16.6309512s [09/25/17 20:43:09.829][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:43:09.829][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:43:10.081][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:43:10.172][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:43:15.046][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:43:15.046][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:43:15.218][DEBUG] [Main Thread] Find stars took: 5135 ms... [09/25/17 20:43:15.218][DEBUG] [Main Thread] Star list contains 7 stars... [09/25/17 20:43:15.218][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:43:15.674][DEBUG] [Camera Thread] Auto focus HFR calculated at: 3.35 [09/25/17 20:43:16.683][DEBUG] [Camera Thread] Moving focuser to next position (7853)... [09/25/17 20:43:16.687][DEBUG] [Focuser Move Thread] Focuser moving to 7853 [09/25/17 20:43:16.743][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:43:17.799][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7853 matches requested position 7853 [09/25/17 20:43:17.799][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:43:17.857][DEBUG] [Camera Thread] Focuser position matches requested position (7853), continuing... [09/25/17 20:43:17.913][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:43:17.913][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:43:17.917][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:43:17.917][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:43:17.917][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:43:17.917][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:43:17.950][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:43:17.950][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:43:34.661][DEBUG] [Camera Thread] QSI expose and download: 16.6479522s [09/25/17 20:43:34.834][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:43:34.834][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:43:35.376][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:43:35.479][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:43:40.438][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:43:40.438][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:43:40.518][DEBUG] [Main Thread] Find stars took: 5142 ms... [09/25/17 20:43:40.518][DEBUG] [Main Thread] Star list contains 10 stars... [09/25/17 20:43:40.518][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:43:41.340][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.90 [09/25/17 20:43:42.348][DEBUG] [Camera Thread] Moving focuser to next position (7843)... [09/25/17 20:43:42.348][DEBUG] [Focuser Move Thread] Focuser moving to 7843 [09/25/17 20:43:42.406][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:43:43.460][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7843 matches requested position 7843 [09/25/17 20:43:43.460][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:43:43.522][DEBUG] [Camera Thread] Focuser position matches requested position (7843), continuing... [09/25/17 20:43:43.582][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:43:43.582][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:43:43.584][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:43:43.584][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:43:43.584][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:43:43.584][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:43:43.613][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:43:43.614][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:44:00.317][DEBUG] [Camera Thread] QSI expose and download: 16.6399517s [09/25/17 20:44:00.507][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:44:00.507][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:44:01.177][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:44:01.291][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:44:06.999][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:44:06.999][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:44:07.091][DEBUG] [Main Thread] Find stars took: 5913 ms... [09/25/17 20:44:07.091][DEBUG] [Main Thread] Star list contains 20 stars... [09/25/17 20:44:07.091][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:44:08.087][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.43 [09/25/17 20:44:09.103][DEBUG] [Camera Thread] Moving focuser to next position (7833)... [09/25/17 20:44:09.105][DEBUG] [Focuser Move Thread] Focuser moving to 7833 [09/25/17 20:44:09.162][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:44:10.218][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7833 matches requested position 7833 [09/25/17 20:44:10.218][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:44:10.331][DEBUG] [Camera Thread] Focuser position matches requested position (7833), continuing... [09/25/17 20:44:10.401][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:44:10.403][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:44:10.425][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:44:10.425][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:44:10.425][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:44:10.425][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:44:10.449][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:44:10.449][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:44:27.154][DEBUG] [Camera Thread] QSI expose and download: 16.6409518s [09/25/17 20:44:27.336][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:44:27.336][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:44:28.008][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:44:28.136][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:44:33.979][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:44:33.979][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:44:34.097][DEBUG] [Main Thread] Find stars took: 6089 ms... [09/25/17 20:44:34.098][DEBUG] [Main Thread] Star list contains 31 stars... [09/25/17 20:44:34.098][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:44:34.927][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.95 [09/25/17 20:44:35.946][DEBUG] [Camera Thread] Moving focuser to next position (7823)... [09/25/17 20:44:35.954][DEBUG] [Focuser Move Thread] Focuser moving to 7823 [09/25/17 20:44:36.012][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:44:37.101][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7823 matches requested position 7823 [09/25/17 20:44:37.101][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:44:37.157][DEBUG] [Camera Thread] Focuser position matches requested position (7823), continuing... [09/25/17 20:44:37.224][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:44:37.224][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:44:37.227][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:44:37.227][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:44:37.227][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:44:37.228][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:44:37.267][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:44:37.267][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:44:53.968][DEBUG] [Camera Thread] QSI expose and download: 16.6369516s [09/25/17 20:44:54.133][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:44:54.133][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:44:54.780][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:44:54.895][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:45:00.518][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:45:00.519][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:45:00.619][DEBUG] [Main Thread] Find stars took: 5837 ms... [09/25/17 20:45:00.619][DEBUG] [Main Thread] Star list contains 33 stars... [09/25/17 20:45:00.619][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:45:01.444][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.68 [09/25/17 20:45:02.499][DEBUG] [Camera Thread] Moving focuser to next position (7813)... [09/25/17 20:45:02.513][DEBUG] [Focuser Move Thread] Focuser moving to 7813 [09/25/17 20:45:02.575][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:45:03.659][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7813 matches requested position 7813 [09/25/17 20:45:03.659][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:45:03.716][DEBUG] [Camera Thread] Focuser position matches requested position (7813), continuing... [09/25/17 20:45:03.781][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:45:03.781][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:45:03.787][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:45:03.787][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:45:03.787][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:45:03.787][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:45:03.814][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:45:03.814][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:45:20.526][DEBUG] [Camera Thread] QSI expose and download: 16.6479522s [09/25/17 20:45:20.725][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:45:20.725][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:45:21.352][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:45:21.463][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:45:27.000][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:45:27.000][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:45:27.188][DEBUG] [Main Thread] Find stars took: 5836 ms... [09/25/17 20:45:27.188][DEBUG] [Main Thread] Star list contains 29 stars... [09/25/17 20:45:27.188][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:45:28.062][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.78 [09/25/17 20:45:29.074][DEBUG] [Camera Thread] Moving focuser to next position (7803)... [09/25/17 20:45:29.084][DEBUG] [Focuser Move Thread] Focuser moving to 7803 [09/25/17 20:45:29.201][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:45:30.255][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7803 matches requested position 7803 [09/25/17 20:45:30.255][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:45:30.314][DEBUG] [Camera Thread] Focuser position matches requested position (7803), continuing... [09/25/17 20:45:30.369][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:45:30.369][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:45:30.370][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:45:30.370][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:45:30.370][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:45:30.370][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:45:30.392][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:45:30.392][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:45:47.124][DEBUG] [Camera Thread] QSI expose and download: 16.6679534s [09/25/17 20:45:47.334][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:45:47.334][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:45:48.174][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:45:48.307][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:45:53.972][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:45:53.972][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:45:54.227][DEBUG] [Main Thread] Find stars took: 6051 ms... [09/25/17 20:45:54.227][DEBUG] [Main Thread] Star list contains 24 stars... [09/25/17 20:45:54.227][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:45:55.066][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.14 [09/25/17 20:45:56.087][DEBUG] [Camera Thread] Moving focuser to next position (7793)... [09/25/17 20:45:56.088][DEBUG] [Focuser Move Thread] Focuser moving to 7793 [09/25/17 20:45:56.173][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:45:57.229][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7793 matches requested position 7793 [09/25/17 20:45:57.229][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:45:57.284][DEBUG] [Camera Thread] Focuser position matches requested position (7793), continuing... [09/25/17 20:45:57.353][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 20:45:57.353][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:45:57.356][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:45:57.356][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:45:57.356][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:45:57.356][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:45:57.386][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:45:57.386][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:46:14.090][DEBUG] [Camera Thread] QSI expose and download: 16.6399518s [09/25/17 20:46:14.263][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:46:14.263][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:46:14.934][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:46:15.074][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:46:20.432][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:46:20.432][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:46:20.523][DEBUG] [Main Thread] Find stars took: 5588 ms... [09/25/17 20:46:20.523][DEBUG] [Main Thread] Star list contains 18 stars... [09/25/17 20:46:20.523][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:46:21.423][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.58 [09/25/17 20:46:22.429][DEBUG] [Camera Thread] New auto focus method calculated focus at: 7822 [09/25/17 20:46:22.429][DEBUG] [Camera Thread] Old auto focus method calculated focus at: 7820 [09/25/17 20:46:22.429][DEBUG] [Camera Thread] Using new auto focus method for focuser position [09/25/17 20:46:22.429][DEBUG] [Camera Thread] New focus position is at 7822 (@100.00C). Moving focuser... [09/25/17 20:46:22.429][DEBUG] [Focuser Move Thread] Focuser moving to 7822 [09/25/17 20:46:22.485][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 20:46:23.540][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7822 matches requested position 7822 [09/25/17 20:46:23.541][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 20:46:23.597][DEBUG] [Camera Thread] Focuser successfully set to focus position (7822) [09/25/17 20:46:23.718][DEBUG] [Camera Thread] Taking validation frame at focus position... [09/25/17 20:46:23.719][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 20:46:23.721][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 20:46:23.721][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 20:46:23.721][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 20:46:23.721][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 20:46:23.741][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:46:23.741][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:46:40.505][DEBUG] [Camera Thread] QSI expose and download: 16.6999552s [09/25/17 20:46:40.676][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 20:46:40.676][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 20:46:41.324][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 20:46:41.454][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 20:46:46.997][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 20:46:46.997][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 20:46:47.102][DEBUG] [Main Thread] Find stars took: 5777 ms... [09/25/17 20:46:47.102][DEBUG] [Main Thread] Star list contains 37 stars... [09/25/17 20:46:47.102][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 20:46:47.936][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.60 [09/25/17 20:46:48.938][DEBUG] [Camera Thread] Auto focus is complete (best fit method: 7822; HFR 1.60)... [09/25/17 20:46:48.941][DEBUG] [Camera Thread] Entering chart disposal loop... [09/25/17 20:47:18.957][DEBUG] [Camera Thread] Auto closing chart dialog... [09/25/17 20:47:18.992][DEBUG] [Camera Thread] Auto focus (finally): closing dialog... [09/25/17 20:47:19.065][DEBUG] [AfChartThread] AF chart dialog is closed... [09/25/17 20:47:19.147][DEBUG] [Camera Thread] Auto focus complete... [09/25/17 20:47:19.157][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [09/25/17 20:47:19.328][DEBUG] [Sequence Thread] AF is complete, continuing sequence... [09/25/17 20:47:19.328][DEBUG] [Sequence Thread] EventMarker 4 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:47:19.328][DEBUG] [Sequence Thread] Setting filter position 6... [09/25/17 20:47:19.328][DEBUG] [Sequence Thread] Filter position 6 is already set. Skipping... [09/25/17 20:47:19.328][DEBUG] [Sequence Thread] EventMarker 5 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:47:19.328][DEBUG] [Sequence Thread] Checking for auto manual focus (pre)... [09/25/17 20:47:19.328][DEBUG] [Sequence Thread] EventMarker 6 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:47:19.390][DEBUG] [Sequence Thread] Created base name for frame capture: Ngc6823_300sec_1x1_O3_frame3 [09/25/17 20:47:19.391][DEBUG] [Sequence Thread] Created directory for frame capture: C:\Users\Public\Documents\SGP Images\Light\ [09/25/17 20:47:19.391][DEBUG] [Sequence Thread] EventMarker 1 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:47:19.391][DEBUG] [Sequence Thread] EventMarker 7 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:47:19.391][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [09/25/17 20:47:19.392][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:47:19.392][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:47:19.392][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:47:19.492][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:47:19.492][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [09/25/17 20:47:19.492][DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 20:47:19.492][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 20:47:19.492][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:47:19.492][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:47:19.492][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:47:19.592][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:47:19.592][DEBUG] [Sequence Thread] User has elected to skip guider settling over time... [09/25/17 20:47:19.592][DEBUG] [Sequence Thread] Waiting for Auto Guider distance to fall below 0.6 [09/25/17 20:47:19.592][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 20:47:19.592][DEBUG] [Sequence Thread] PHD2 distance request returned 0.2... [09/25/17 20:47:19.610][DEBUG] [Sequence Thread] Distance is below 0.6, starting timer... [09/25/17 20:47:19.830][DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: GOOD [09/25/17 20:47:20.110][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 20:47:20.110][DEBUG] [Sequence Thread] PHD2 distance request returned 0.2... [09/25/17 20:47:20.128][DEBUG] [Sequence Thread] Distance stayed below 0.6 for 0 seconds, done settling... [09/25/17 20:47:20.128][DEBUG] [Sequence Thread] Auto guider has settled... [09/25/17 20:47:20.129][DEBUG] [Sequence Thread] EventMarker 8 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:47:20.129][DEBUG] [Sequence Thread] EventMarker 9 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:47:20.129][DEBUG] [Sequence Thread] EventMarker 10 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:47:20.129][DEBUG] [Sequence Thread] Finished sending frame capture. Entering wait mode... [09/25/17 20:47:20.129][DEBUG] [Sequence Thread] EventMarker 11 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:47:20.129][DEBUG] [Sequence Thread] EventMarker 12 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:47:20.131][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE message received... [09/25/17 20:47:20.136][DEBUG] [Sequence Thread] EventMarker 13 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:47:20.157][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:47:20.157][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:52:20.134][DEBUG] [Sequence Thread] EventMarker 15 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:52:20.139][DEBUG] [Sequence Thread] Waking from exposure time sleep period... [09/25/17 20:52:20.140][DEBUG] [Sequence Thread] Checking to see if the CCD has a temp... [09/25/17 20:52:20.140][DEBUG] [Sequence Thread] Saving the CCD temp... [09/25/17 20:52:20.161][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:52:20.161][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:52:20.161][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:52:20.261][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:52:35.905][DEBUG] [Camera Thread] QSI expose and download: 315.6840561s [09/25/17 20:52:35.905][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE complete... [09/25/17 20:52:35.921][DEBUG] [Sequence Thread] Image ready state detected when waiting for download state, continuing sequence... [09/25/17 20:52:35.921][DEBUG] [Sequence Thread] Entering super dangerous loop to await image completion... [09/25/17 20:52:35.927][DEBUG] [Sequence Thread] EventMarker 16 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:52:35.938][DEBUG] [Sequence Thread] EventMarker 17 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:52:35.939][DEBUG] [Sequence Thread] Image reported as complete. Continuing... [09/25/17 20:52:35.939][DEBUG] [Sequence Thread] Collecting FITs headers... [09/25/17 20:52:35.940][DEBUG] [Sequence Thread] QSI Camera - Camera reports last image start time as: 2017-09-26T03:47:22.877 UTC [09/25/17 20:52:35.940][DEBUG] [Sequence Thread] DATE-LOC time provided by camera... [09/25/17 20:52:36.012][DEBUG] [Sequence Thread] GatherFitsHeaders: Writing header info from UI... [09/25/17 20:52:36.033][DEBUG] [Sequence Thread] Clearing timed monitoring events... [09/25/17 20:52:36.055][DEBUG] [Sequence Thread] Created full file name: C:\Users\Public\Documents\SGP Images\Light\Ngc6823_300sec_1x1_O3_frame3-1.fit [09/25/17 20:52:36.205][DEBUG] [Sequence Thread] SaveFileBmp16: Locking bitmap for disk write... [09/25/17 20:52:36.205][DEBUG] [Sequence Thread] SaveFileBmp16: Opening file stream... [09/25/17 20:52:36.206][DEBUG] [Sequence Thread] SaveFileBmp16: Writing FITS headers... [09/25/17 20:52:36.206][DEBUG] [Sequence Thread] SaveFileBmp16: Traversing and persisting bitmap data... [09/25/17 20:52:36.391][DEBUG] [Sequence Thread] SaveFileBmp16: FITS block fill... [09/25/17 20:52:36.391][DEBUG] [Sequence Thread] SaveFileBmp16: Unlocking bitmap... [09/25/17 20:52:36.391][DEBUG] [Sequence Thread] SaveFileBmp16: Closing file stream [09/25/17 20:52:36.392][DEBUG] [Sequence Thread] Internal Interface: Set Preview... [09/25/17 20:52:36.392][DEBUG] [Sequence Thread] Display image preview using asynch task... [09/25/17 20:52:37.230][DEBUG] [Sequence Thread] =========== Save file took 1180 ms [09/25/17 20:52:37.251][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [09/25/17 20:52:37.251][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:52:37.251][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:52:37.251][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:52:37.351][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:52:37.351][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [09/25/17 20:52:37.351][DEBUG] [Sequence Thread] EventMarker 18 - t:Ngc6823 (0); e:0; f:2; o: [09/25/17 20:52:37.358][DEBUG] [Sequence Thread] EventMarker 19 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:37.358][DEBUG] [Sequence Thread] EventMarker 20 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:37.358][DEBUG] [Sequence Thread] Running post event... [09/25/17 20:52:37.358][DEBUG] [Sequence Thread] EventMarker 21 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:37.360][DEBUG] [Sequence Thread] Incremented numComplete (3) for event[0]... [09/25/17 20:52:37.367][DEBUG] [Sequence Thread] Attempting to find next event... [09/25/17 20:52:37.367][DEBUG] [Sequence Thread] Current event[0] frame count: 3/12... [09/25/17 20:52:37.367][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [09/25/17 20:52:37.367][DEBUG] [Sequence Thread] Checking for auto manual focus (post)... [09/25/17 20:52:37.367][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [09/25/17 20:52:37.373][DEBUG] [Sequence Thread] Attempting to move to next event... [09/25/17 20:52:37.373][DEBUG] [Sequence Thread] Attempting to find next event... [09/25/17 20:52:37.373][DEBUG] [Sequence Thread] Current event[0] frame count: 3/12... [09/25/17 20:52:37.374][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [09/25/17 20:52:37.374][DEBUG] [Sequence Thread] Running pre event... [09/25/17 20:52:37.536][DEBUG] [Sequence Thread] Running capture event... [09/25/17 20:52:37.539][DEBUG] [Sequence Thread] SetStartTemp: Using focuser for temperature... [09/25/17 20:52:37.539][DEBUG] [Sequence Thread] Set start frame temp to 100... [09/25/17 20:52:37.541][DEBUG] [Sequence Thread] ------------- Starting capture frame for event[0] ------------- [09/25/17 20:52:37.546][DEBUG] [Sequence Thread] Sending commands... [09/25/17 20:52:37.546][DEBUG] [Sequence Thread] SetFlatBox: Frame Type is Light [09/25/17 20:52:37.546][DEBUG] [Sequence Thread] EventMarker 2 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:37.546][DEBUG] [Sequence Thread] EventMarker 3 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:37.546][DEBUG] [Sequence Thread] Waiting for AF to complete... [09/25/17 20:52:37.548][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [09/25/17 20:52:37.548][DEBUG] [Camera Thread] Checking for auto focus... [09/25/17 20:52:37.548][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [09/25/17 20:52:37.746][DEBUG] [Sequence Thread] AF is complete, continuing sequence... [09/25/17 20:52:37.746][DEBUG] [Sequence Thread] EventMarker 4 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:37.746][DEBUG] [Sequence Thread] Setting filter position 6... [09/25/17 20:52:37.746][DEBUG] [Sequence Thread] Filter position 6 is already set. Skipping... [09/25/17 20:52:37.746][DEBUG] [Sequence Thread] EventMarker 5 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:37.746][DEBUG] [Sequence Thread] Checking for auto manual focus (pre)... [09/25/17 20:52:37.746][DEBUG] [Sequence Thread] EventMarker 6 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:37.803][DEBUG] [Sequence Thread] Created base name for frame capture: Ngc6823_300sec_1x1_O3_frame4 [09/25/17 20:52:37.803][DEBUG] [Sequence Thread] Created directory for frame capture: C:\Users\Public\Documents\SGP Images\Light\ [09/25/17 20:52:37.803][DEBUG] [Sequence Thread] EventMarker 1 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:37.803][DEBUG] [Sequence Thread] EventMarker 7 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:37.803][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [09/25/17 20:52:37.803][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:52:37.803][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:52:37.803][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:52:37.903][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:52:37.903][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [09/25/17 20:52:37.918][DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 20:52:37.918][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 20:52:37.918][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:52:37.918][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:52:37.918][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:52:38.019][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:52:38.019][DEBUG] [Sequence Thread] User has elected to skip guider settling over time... [09/25/17 20:52:38.019][DEBUG] [Sequence Thread] Waiting for Auto Guider distance to fall below 0.6 [09/25/17 20:52:38.019][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 20:52:38.019][DEBUG] [Sequence Thread] PHD2 distance request returned 0.2... [09/25/17 20:52:38.037][DEBUG] [Sequence Thread] Distance is below 0.6, starting timer... [09/25/17 20:52:38.162][DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: GOOD [09/25/17 20:52:38.537][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 20:52:38.537][DEBUG] [Sequence Thread] PHD2 distance request returned 0.2... [09/25/17 20:52:38.551][DEBUG] [Sequence Thread] Distance stayed below 0.6 for 0 seconds, done settling... [09/25/17 20:52:38.551][DEBUG] [Sequence Thread] Auto guider has settled... [09/25/17 20:52:38.552][DEBUG] [Sequence Thread] EventMarker 8 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:38.552][DEBUG] [Sequence Thread] EventMarker 9 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:38.552][DEBUG] [Sequence Thread] EventMarker 10 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:38.552][DEBUG] [Sequence Thread] Finished sending frame capture. Entering wait mode... [09/25/17 20:52:38.552][DEBUG] [Sequence Thread] EventMarker 11 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:38.552][DEBUG] [Sequence Thread] EventMarker 12 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:38.553][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE message received... [09/25/17 20:52:38.555][DEBUG] [Sequence Thread] EventMarker 13 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:52:38.577][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:52:38.577][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:57:38.600][DEBUG] [Sequence Thread] EventMarker 15 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:57:38.603][DEBUG] [Sequence Thread] Waking from exposure time sleep period... [09/25/17 20:57:38.604][DEBUG] [Sequence Thread] Checking to see if the CCD has a temp... [09/25/17 20:57:38.604][DEBUG] [Sequence Thread] Saving the CCD temp... [09/25/17 20:57:38.628][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:57:38.628][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:57:38.628][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:57:38.728][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:57:54.357][DEBUG] [Camera Thread] QSI expose and download: 315.7160579s [09/25/17 20:57:54.357][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE complete... [09/25/17 20:57:54.581][DEBUG] [Sequence Thread] Image ready state detected when waiting for download state, continuing sequence... [09/25/17 20:57:54.581][DEBUG] [Sequence Thread] Entering super dangerous loop to await image completion... [09/25/17 20:57:54.592][DEBUG] [Sequence Thread] EventMarker 16 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:57:54.600][DEBUG] [Sequence Thread] EventMarker 17 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:57:54.600][DEBUG] [Sequence Thread] Image reported as complete. Continuing... [09/25/17 20:57:54.602][DEBUG] [Sequence Thread] Collecting FITs headers... [09/25/17 20:57:54.604][DEBUG] [Sequence Thread] QSI Camera - Camera reports last image start time as: 2017-09-26T03:52:41.297 UTC [09/25/17 20:57:54.604][DEBUG] [Sequence Thread] DATE-LOC time provided by camera... [09/25/17 20:57:54.623][DEBUG] [Sequence Thread] GatherFitsHeaders: Writing header info from UI... [09/25/17 20:57:54.630][DEBUG] [Sequence Thread] Clearing timed monitoring events... [09/25/17 20:57:54.635][DEBUG] [Sequence Thread] Created full file name: C:\Users\Public\Documents\SGP Images\Light\Ngc6823_300sec_1x1_O3_frame4-1.fit [09/25/17 20:57:54.773][DEBUG] [Sequence Thread] SaveFileBmp16: Locking bitmap for disk write... [09/25/17 20:57:54.774][DEBUG] [Sequence Thread] SaveFileBmp16: Opening file stream... [09/25/17 20:57:54.774][DEBUG] [Sequence Thread] SaveFileBmp16: Writing FITS headers... [09/25/17 20:57:54.774][DEBUG] [Sequence Thread] SaveFileBmp16: Traversing and persisting bitmap data... [09/25/17 20:57:54.961][DEBUG] [Sequence Thread] SaveFileBmp16: FITS block fill... [09/25/17 20:57:54.962][DEBUG] [Sequence Thread] SaveFileBmp16: Unlocking bitmap... [09/25/17 20:57:54.962][DEBUG] [Sequence Thread] SaveFileBmp16: Closing file stream [09/25/17 20:57:54.962][DEBUG] [Sequence Thread] Internal Interface: Set Preview... [09/25/17 20:57:54.962][DEBUG] [Sequence Thread] Display image preview using asynch task... [09/25/17 20:57:56.122][DEBUG] [Sequence Thread] =========== Save file took 1490 ms [09/25/17 20:57:56.129][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [09/25/17 20:57:56.129][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:57:56.129][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:57:56.129][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:57:56.229][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:57:56.229][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [09/25/17 20:57:56.238][DEBUG] [Sequence Thread] EventMarker 18 - t:Ngc6823 (0); e:0; f:3; o: [09/25/17 20:57:56.248][DEBUG] [Sequence Thread] EventMarker 19 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:56.248][DEBUG] [Sequence Thread] EventMarker 20 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:56.248][DEBUG] [Sequence Thread] Running post event... [09/25/17 20:57:56.248][DEBUG] [Sequence Thread] EventMarker 21 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:56.250][DEBUG] [Sequence Thread] Incremented numComplete (4) for event[0]... [09/25/17 20:57:56.255][DEBUG] [Sequence Thread] Attempting to find next event... [09/25/17 20:57:56.255][DEBUG] [Sequence Thread] Current event[0] frame count: 4/12... [09/25/17 20:57:56.255][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [09/25/17 20:57:56.255][DEBUG] [Sequence Thread] Checking for auto manual focus (post)... [09/25/17 20:57:56.255][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [09/25/17 20:57:56.260][DEBUG] [Sequence Thread] Attempting to move to next event... [09/25/17 20:57:56.260][DEBUG] [Sequence Thread] Attempting to find next event... [09/25/17 20:57:56.261][DEBUG] [Sequence Thread] Current event[0] frame count: 4/12... [09/25/17 20:57:56.261][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [09/25/17 20:57:56.261][DEBUG] [Sequence Thread] Running pre event... [09/25/17 20:57:56.279][DEBUG] [Sequence Thread] Running capture event... [09/25/17 20:57:56.580][DEBUG] [Sequence Thread] SetStartTemp: Using focuser for temperature... [09/25/17 20:57:56.580][DEBUG] [Sequence Thread] Set start frame temp to 100... [09/25/17 20:57:56.581][DEBUG] [Sequence Thread] ------------- Starting capture frame for event[0] ------------- [09/25/17 20:57:56.584][DEBUG] [Sequence Thread] Sending commands... [09/25/17 20:57:56.584][DEBUG] [Sequence Thread] SetFlatBox: Frame Type is Light [09/25/17 20:57:56.584][DEBUG] [Sequence Thread] EventMarker 2 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:56.584][DEBUG] [Sequence Thread] EventMarker 3 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:56.584][DEBUG] [Sequence Thread] Waiting for AF to complete... [09/25/17 20:57:56.585][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [09/25/17 20:57:56.585][DEBUG] [Camera Thread] Checking for auto focus... [09/25/17 20:57:56.585][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [09/25/17 20:57:56.784][DEBUG] [Sequence Thread] AF is complete, continuing sequence... [09/25/17 20:57:56.784][DEBUG] [Sequence Thread] EventMarker 4 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:56.784][DEBUG] [Sequence Thread] Setting filter position 6... [09/25/17 20:57:56.784][DEBUG] [Sequence Thread] Filter position 6 is already set. Skipping... [09/25/17 20:57:56.784][DEBUG] [Sequence Thread] EventMarker 5 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:56.784][DEBUG] [Sequence Thread] Checking for auto manual focus (pre)... [09/25/17 20:57:56.784][DEBUG] [Sequence Thread] EventMarker 6 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:56.841][DEBUG] [Sequence Thread] Created base name for frame capture: Ngc6823_300sec_1x1_O3_frame5 [09/25/17 20:57:56.841][DEBUG] [Sequence Thread] Created directory for frame capture: C:\Users\Public\Documents\SGP Images\Light\ [09/25/17 20:57:56.841][DEBUG] [Sequence Thread] EventMarker 1 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:56.842][DEBUG] [Sequence Thread] EventMarker 7 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:56.842][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [09/25/17 20:57:56.842][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:57:56.842][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:57:56.842][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:57:56.942][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:57:56.942][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [09/25/17 20:57:56.942][DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 20:57:56.942][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 20:57:56.942][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 20:57:56.942][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 20:57:56.942][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 20:57:57.042][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 20:57:57.043][DEBUG] [Sequence Thread] User has elected to skip guider settling over time... [09/25/17 20:57:57.043][DEBUG] [Sequence Thread] Waiting for Auto Guider distance to fall below 0.6 [09/25/17 20:57:57.043][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 20:57:57.043][DEBUG] [Sequence Thread] PHD2 distance request returned 0.2... [09/25/17 20:57:57.058][DEBUG] [Sequence Thread] Distance is below 0.6, starting timer... [09/25/17 20:57:57.558][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 20:57:57.558][DEBUG] [Sequence Thread] PHD2 distance request returned 0.2... [09/25/17 20:57:57.565][DEBUG] [Sequence Thread] Distance stayed below 0.6 for 0 seconds, done settling... [09/25/17 20:57:57.566][DEBUG] [Sequence Thread] Auto guider has settled... [09/25/17 20:57:57.566][DEBUG] [Sequence Thread] EventMarker 8 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:57.566][DEBUG] [Sequence Thread] EventMarker 9 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:57.566][DEBUG] [Sequence Thread] EventMarker 10 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:57.566][DEBUG] [Sequence Thread] Finished sending frame capture. Entering wait mode... [09/25/17 20:57:57.566][DEBUG] [Sequence Thread] EventMarker 11 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:57.566][DEBUG] [Sequence Thread] EventMarker 12 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:57.567][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE message received... [09/25/17 20:57:57.567][DEBUG] [Sequence Thread] EventMarker 13 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 20:57:57.588][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 20:57:57.588][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 20:57:57.760][DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: GOOD [09/25/17 21:02:57.628][DEBUG] [Sequence Thread] EventMarker 15 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 21:02:57.630][DEBUG] [Sequence Thread] Waking from exposure time sleep period... [09/25/17 21:02:57.631][DEBUG] [Sequence Thread] Checking to see if the CCD has a temp... [09/25/17 21:02:57.631][DEBUG] [Sequence Thread] Saving the CCD temp... [09/25/17 21:02:57.654][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 21:02:57.654][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 21:02:57.654][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 21:02:57.754][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 21:03:13.376][DEBUG] [Camera Thread] QSI expose and download: 315.6920565s [09/25/17 21:03:13.376][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE complete... [09/25/17 21:03:13.592][DEBUG] [Sequence Thread] Image ready state detected when waiting for download state, continuing sequence... [09/25/17 21:03:13.592][DEBUG] [Sequence Thread] Entering super dangerous loop to await image completion... [09/25/17 21:03:13.603][DEBUG] [Sequence Thread] EventMarker 16 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 21:03:13.612][DEBUG] [Sequence Thread] EventMarker 17 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 21:03:13.612][DEBUG] [Sequence Thread] Image reported as complete. Continuing... [09/25/17 21:03:13.638][DEBUG] [Sequence Thread] Collecting FITs headers... [09/25/17 21:03:13.640][DEBUG] [Sequence Thread] QSI Camera - Camera reports last image start time as: 2017-09-26T03:58:00.356 UTC [09/25/17 21:03:13.640][DEBUG] [Sequence Thread] DATE-LOC time provided by camera... [09/25/17 21:03:13.955][DEBUG] [Sequence Thread] GatherFitsHeaders: Writing header info from UI... [09/25/17 21:03:13.960][DEBUG] [Sequence Thread] Clearing timed monitoring events... [09/25/17 21:03:13.965][DEBUG] [Sequence Thread] Created full file name: C:\Users\Public\Documents\SGP Images\Light\Ngc6823_300sec_1x1_O3_frame5-1.fit [09/25/17 21:03:14.114][DEBUG] [Sequence Thread] SaveFileBmp16: Locking bitmap for disk write... [09/25/17 21:03:14.114][DEBUG] [Sequence Thread] SaveFileBmp16: Opening file stream... [09/25/17 21:03:14.114][DEBUG] [Sequence Thread] SaveFileBmp16: Writing FITS headers... [09/25/17 21:03:14.115][DEBUG] [Sequence Thread] SaveFileBmp16: Traversing and persisting bitmap data... [09/25/17 21:03:14.297][DEBUG] [Sequence Thread] SaveFileBmp16: FITS block fill... [09/25/17 21:03:14.297][DEBUG] [Sequence Thread] SaveFileBmp16: Unlocking bitmap... [09/25/17 21:03:14.297][DEBUG] [Sequence Thread] SaveFileBmp16: Closing file stream [09/25/17 21:03:14.298][DEBUG] [Sequence Thread] Internal Interface: Set Preview... [09/25/17 21:03:14.298][DEBUG] [Sequence Thread] Display image preview using asynch task... [09/25/17 21:03:15.568][DEBUG] [Sequence Thread] =========== Save file took 1607 ms [09/25/17 21:03:15.579][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [09/25/17 21:03:15.579][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 21:03:15.579][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 21:03:15.579][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 21:03:15.680][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 21:03:15.680][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [09/25/17 21:03:15.692][DEBUG] [Sequence Thread] EventMarker 18 - t:Ngc6823 (0); e:0; f:4; o: [09/25/17 21:03:15.701][DEBUG] [Sequence Thread] EventMarker 19 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:03:15.701][DEBUG] [Sequence Thread] EventMarker 20 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:03:15.701][DEBUG] [Sequence Thread] Running post event... [09/25/17 21:03:15.701][DEBUG] [Sequence Thread] EventMarker 21 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:03:15.703][DEBUG] [Sequence Thread] Incremented numComplete (5) for event[0]... [09/25/17 21:03:15.710][DEBUG] [Sequence Thread] Attempting to find next event... [09/25/17 21:03:15.710][DEBUG] [Sequence Thread] Current event[0] frame count: 5/12... [09/25/17 21:03:15.710][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [09/25/17 21:03:15.710][DEBUG] [Sequence Thread] Checking for auto manual focus (post)... [09/25/17 21:03:15.710][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [09/25/17 21:03:15.717][DEBUG] [Sequence Thread] Attempting to move to next event... [09/25/17 21:03:15.717][DEBUG] [Sequence Thread] Attempting to find next event... [09/25/17 21:03:15.717][DEBUG] [Sequence Thread] Current event[0] frame count: 5/12... [09/25/17 21:03:15.717][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [09/25/17 21:03:15.717][DEBUG] [Sequence Thread] Running pre event... [09/25/17 21:03:15.739][DEBUG] [Sequence Thread] Running capture event... [09/25/17 21:03:15.741][DEBUG] [Sequence Thread] SetStartTemp: Using focuser for temperature... [09/25/17 21:03:15.741][DEBUG] [Sequence Thread] Set start frame temp to 100... [09/25/17 21:03:15.741][DEBUG] [Sequence Thread] ------------- Starting capture frame for event[0] ------------- [09/25/17 21:03:15.745][DEBUG] [Sequence Thread] Sending commands... [09/25/17 21:03:15.745][DEBUG] [Sequence Thread] SetFlatBox: Frame Type is Light [09/25/17 21:03:15.745][DEBUG] [Sequence Thread] EventMarker 2 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:03:15.745][DEBUG] [Sequence Thread] EventMarker 3 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:03:15.745][DEBUG] [Sequence Thread] Waiting for AF to complete... [09/25/17 21:03:15.755][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [09/25/17 21:03:15.755][DEBUG] [Camera Thread] Checking for auto focus... [09/25/17 21:03:15.755][DEBUG] [Camera Thread] Auto focus required (frame count trigger)... [09/25/17 21:03:15.762][DEBUG] [Camera Thread] Auto focus: setting filter O3 [09/25/17 21:03:15.762][DEBUG] [Camera Thread] Setting filter position 6... [09/25/17 21:03:15.762][DEBUG] [Camera Thread] Filter position 6 is already set. Skipping... [09/25/17 21:03:15.764][DEBUG] [Camera Thread] Auto focus running... [09/25/17 21:03:15.772][DEBUG] [Camera Thread] Turning temp comp off.. [09/25/17 21:03:15.775][DEBUG] [Camera Thread] Performing Sequence Generator auto focus using Half Flux Radius. AFID: 2 [09/25/17 21:03:15.845][DEBUG] [AfChartThread] Showing AF chart dialog... [09/25/17 21:03:15.985][DEBUG] [Camera Thread] Auto focus data [09/25/17 21:03:15.985][DEBUG] [Camera Thread] - Data Points: 7 [09/25/17 21:03:15.985][DEBUG] [Camera Thread] - Step Size: 10 [09/25/17 21:03:15.985][DEBUG] [Camera Thread] - Current Position: 7822 [09/25/17 21:03:15.985][DEBUG] [Camera Thread] - Initial Move Position: 7852 [09/25/17 21:03:15.991][DEBUG] [Camera Thread] AF Darks exception: The path is not of a legal form. [09/25/17 21:03:15.993][DEBUG] [Camera Thread] Moving focuser to next position (7852)... [09/25/17 21:03:15.994][DEBUG] [Focuser Move Thread] Focuser moving to 7852 [09/25/17 21:03:16.050][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 21:03:17.104][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7852 matches requested position 7852 [09/25/17 21:03:17.104][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 21:03:17.161][DEBUG] [Camera Thread] Focuser position matches requested position (7852), continuing... [09/25/17 21:03:17.215][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 21:03:17.215][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 21:03:17.219][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 21:03:17.219][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 21:03:17.219][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 21:03:17.219][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 21:03:17.240][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 21:03:17.240][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 21:03:33.938][DEBUG] [Camera Thread] QSI expose and download: 16.6339514s [09/25/17 21:03:34.140][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 21:03:34.140][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 21:03:34.426][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 21:03:34.551][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 21:03:39.985][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 21:03:39.985][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 21:03:40.182][DEBUG] [Main Thread] Find stars took: 5755 ms... [09/25/17 21:03:40.182][DEBUG] [Main Thread] Star list contains 9 stars... [09/25/17 21:03:40.182][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 21:03:40.654][DEBUG] [Camera Thread] Auto focus HFR calculated at: 3.32 [09/25/17 21:03:41.661][DEBUG] [Camera Thread] Moving focuser to next position (7842)... [09/25/17 21:03:41.662][DEBUG] [Focuser Move Thread] Focuser moving to 7842 [09/25/17 21:03:41.719][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 21:03:42.774][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7842 matches requested position 7842 [09/25/17 21:03:42.774][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 21:03:42.829][DEBUG] [Camera Thread] Focuser position matches requested position (7842), continuing... [09/25/17 21:03:42.907][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 21:03:42.907][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 21:03:42.916][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 21:03:42.916][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 21:03:42.916][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 21:03:42.916][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 21:03:42.939][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 21:03:42.939][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 21:03:59.646][DEBUG] [Camera Thread] QSI expose and download: 16.6429519s [09/25/17 21:03:59.907][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 21:03:59.907][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 21:04:00.573][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 21:04:00.685][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 21:04:06.350][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 21:04:06.350][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 21:04:06.444][DEBUG] [Main Thread] Find stars took: 5871 ms... [09/25/17 21:04:06.444][DEBUG] [Main Thread] Star list contains 15 stars... [09/25/17 21:04:06.444][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 21:04:07.316][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.76 [09/25/17 21:04:08.331][DEBUG] [Camera Thread] Moving focuser to next position (7832)... [09/25/17 21:04:08.332][DEBUG] [Focuser Move Thread] Focuser moving to 7832 [09/25/17 21:04:08.447][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 21:04:09.603][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7832 matches requested position 7832 [09/25/17 21:04:09.604][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 21:04:09.661][DEBUG] [Camera Thread] Focuser position matches requested position (7832), continuing... [09/25/17 21:04:09.719][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 21:04:09.719][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 21:04:09.722][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 21:04:09.722][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 21:04:09.722][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 21:04:09.722][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 21:04:09.755][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 21:04:09.755][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 21:04:26.493][DEBUG] [Camera Thread] QSI expose and download: 16.6419519s [09/25/17 21:04:26.699][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 21:04:26.699][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 21:04:27.338][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 21:04:27.473][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 21:04:33.099][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 21:04:33.099][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 21:04:33.327][DEBUG] [Main Thread] Find stars took: 5987 ms... [09/25/17 21:04:33.327][DEBUG] [Main Thread] Star list contains 24 stars... [09/25/17 21:04:33.327][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 21:04:34.136][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.16 [09/25/17 21:04:35.146][DEBUG] [Camera Thread] Moving focuser to next position (7822)... [09/25/17 21:04:35.148][DEBUG] [Focuser Move Thread] Focuser moving to 7822 [09/25/17 21:04:35.205][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 21:04:36.259][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7822 matches requested position 7822 [09/25/17 21:04:36.259][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 21:04:36.318][DEBUG] [Camera Thread] Focuser position matches requested position (7822), continuing... [09/25/17 21:04:36.374][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 21:04:36.374][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 21:04:36.375][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 21:04:36.376][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 21:04:36.376][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 21:04:36.376][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 21:04:36.398][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 21:04:36.398][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 21:04:53.154][DEBUG] [Camera Thread] QSI expose and download: 16.6919547s [09/25/17 21:04:53.355][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 21:04:53.355][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 21:04:53.915][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 21:04:54.012][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 21:04:58.976][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 21:04:58.976][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 21:04:59.067][DEBUG] [Main Thread] Find stars took: 5152 ms... [09/25/17 21:04:59.067][DEBUG] [Main Thread] Star list contains 35 stars... [09/25/17 21:04:59.067][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 21:04:59.869][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.81 [09/25/17 21:05:00.887][DEBUG] [Camera Thread] Moving focuser to next position (7812)... [09/25/17 21:05:00.903][DEBUG] [Focuser Move Thread] Focuser moving to 7812 [09/25/17 21:05:00.966][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 21:05:02.020][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7812 matches requested position 7812 [09/25/17 21:05:02.021][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 21:05:02.075][DEBUG] [Camera Thread] Focuser position matches requested position (7812), continuing... [09/25/17 21:05:02.133][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 21:05:02.133][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 21:05:02.139][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 21:05:02.139][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 21:05:02.139][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 21:05:02.139][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 21:05:02.176][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 21:05:02.176][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 21:05:18.885][DEBUG] [Camera Thread] QSI expose and download: 16.6449521s [09/25/17 21:05:19.070][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 21:05:19.070][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 21:05:19.702][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 21:05:19.808][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 21:05:25.545][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 21:05:25.545][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 21:05:25.654][DEBUG] [Main Thread] Find stars took: 5951 ms... [09/25/17 21:05:25.655][DEBUG] [Main Thread] Star list contains 42 stars... [09/25/17 21:05:25.655][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 21:05:26.518][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.70 [09/25/17 21:05:27.526][DEBUG] [Camera Thread] Moving focuser to next position (7802)... [09/25/17 21:05:27.527][DEBUG] [Focuser Move Thread] Focuser moving to 7802 [09/25/17 21:05:27.584][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 21:05:28.639][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7802 matches requested position 7802 [09/25/17 21:05:28.639][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 21:05:28.697][DEBUG] [Camera Thread] Focuser position matches requested position (7802), continuing... [09/25/17 21:05:28.754][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 21:05:28.754][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 21:05:28.759][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 21:05:28.759][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 21:05:28.759][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 21:05:28.760][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 21:05:28.788][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 21:05:28.788][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 21:05:45.518][DEBUG] [Camera Thread] QSI expose and download: 16.6339514s [09/25/17 21:05:45.702][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 21:05:45.702][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 21:05:46.368][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 21:05:46.501][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 21:05:52.278][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 21:05:52.278][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 21:05:52.372][DEBUG] [Main Thread] Find stars took: 6004 ms... [09/25/17 21:05:52.372][DEBUG] [Main Thread] Star list contains 34 stars... [09/25/17 21:05:52.372][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 21:05:53.213][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.06 [09/25/17 21:05:54.233][DEBUG] [Camera Thread] Moving focuser to next position (7792)... [09/25/17 21:05:54.239][DEBUG] [Focuser Move Thread] Focuser moving to 7792 [09/25/17 21:05:54.299][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 21:05:55.353][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7792 matches requested position 7792 [09/25/17 21:05:55.353][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 21:05:55.412][DEBUG] [Camera Thread] Focuser position matches requested position (7792), continuing... [09/25/17 21:05:55.471][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 21:05:55.471][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 21:05:55.478][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 21:05:55.479][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 21:05:55.479][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 21:05:55.479][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 21:05:55.510][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 21:05:55.510][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 21:06:12.257][DEBUG] [Camera Thread] QSI expose and download: 16.6509524s [09/25/17 21:06:12.430][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 21:06:12.430][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 21:06:13.018][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 21:06:13.115][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 21:06:18.010][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 21:06:18.010][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 21:06:18.246][DEBUG] [Main Thread] Find stars took: 5227 ms... [09/25/17 21:06:18.246][DEBUG] [Main Thread] Star list contains 24 stars... [09/25/17 21:06:18.246][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 21:06:19.017][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.30 [09/25/17 21:06:20.030][DEBUG] [Camera Thread] Moving focuser to next position (7782)... [09/25/17 21:06:20.032][DEBUG] [Focuser Move Thread] Focuser moving to 7782 [09/25/17 21:06:20.088][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 21:06:21.142][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7782 matches requested position 7782 [09/25/17 21:06:21.142][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 21:06:21.197][DEBUG] [Camera Thread] Focuser position matches requested position (7782), continuing... [09/25/17 21:06:21.254][DEBUG] [Camera Thread] Calculating step metric... [09/25/17 21:06:21.254][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 21:06:21.258][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 21:06:21.258][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 21:06:21.258][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 21:06:21.258][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 21:06:21.289][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 21:06:21.290][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 21:06:37.966][DEBUG] [Camera Thread] QSI expose and download: 16.6129502s [09/25/17 21:06:38.160][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 21:06:38.161][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 21:06:38.858][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 21:06:38.963][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 21:06:44.393][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 21:06:44.393][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 21:06:44.483][DEBUG] [Main Thread] Find stars took: 5625 ms... [09/25/17 21:06:44.483][DEBUG] [Main Thread] Star list contains 12 stars... [09/25/17 21:06:44.483][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 21:06:45.365][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.97 [09/25/17 21:06:46.376][DEBUG] [Camera Thread] New auto focus method calculated focus at: 7815 [09/25/17 21:06:46.376][DEBUG] [Camera Thread] Old auto focus method calculated focus at: 7815 [09/25/17 21:06:46.376][DEBUG] [Camera Thread] Using new auto focus method for focuser position [09/25/17 21:06:46.376][DEBUG] [Camera Thread] New focus position is at 7815 (@100.00C). Moving focuser... [09/25/17 21:06:46.378][DEBUG] [Focuser Move Thread] Focuser moving to 7815 [09/25/17 21:06:46.434][DEBUG] [Focuser Move Thread] Focuser move call complete [09/25/17 21:06:47.489][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 7815 matches requested position 7815 [09/25/17 21:06:47.489][DEBUG] [Camera Thread] Focuser move complete... [09/25/17 21:06:47.548][DEBUG] [Camera Thread] Focuser successfully set to focus position (7815) [09/25/17 21:06:47.608][DEBUG] [Camera Thread] Taking validation frame at focus position... [09/25/17 21:06:47.665][DEBUG] [Camera Thread] Taking auto focus frame(s)... [09/25/17 21:06:47.668][DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [09/25/17 21:06:47.668][DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 1x1... [09/25/17 21:06:47.668][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 1 seconds... [09/25/17 21:06:47.668][DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [09/25/17 21:06:47.692][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 21:06:47.692][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 21:07:04.429][DEBUG] [Camera Thread] QSI expose and download: 16.6739537s [09/25/17 21:07:04.600][DEBUG] [Camera Thread] Internal Interface: Set Preview... [09/25/17 21:07:04.600][DEBUG] [Camera Thread] Display image preview using asynch task... [09/25/17 21:07:05.261][DEBUG] [Main Thread] --> Find stars (normal) [09/25/17 21:07:05.401][DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [09/25/17 21:07:11.143][DEBUG] [Main Thread] Star detection using min star size of 4px... [09/25/17 21:07:11.143][DEBUG] [Main Thread] Star detection using max star size of 80px... [09/25/17 21:07:11.235][DEBUG] [Main Thread] Find stars took: 5973 ms... [09/25/17 21:07:11.235][DEBUG] [Main Thread] Star list contains 27 stars... [09/25/17 21:07:11.235][DEBUG] [Main Thread] Calculating HFR with sample size: 6 [09/25/17 21:07:12.122][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.60 [09/25/17 21:07:13.124][DEBUG] [Camera Thread] Auto focus is complete (best fit method: 7815; HFR 1.60)... [09/25/17 21:07:13.127][DEBUG] [Camera Thread] Entering chart disposal loop... [09/25/17 21:07:43.147][DEBUG] [Camera Thread] Auto closing chart dialog... [09/25/17 21:07:43.147][DEBUG] [Camera Thread] Auto focus (finally): closing dialog... [09/25/17 21:07:43.202][DEBUG] [AfChartThread] AF chart dialog is closed... [09/25/17 21:07:43.275][DEBUG] [Camera Thread] Auto focus complete... [09/25/17 21:07:43.295][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [09/25/17 21:07:43.395][DEBUG] [Sequence Thread] AF is complete, continuing sequence... [09/25/17 21:07:43.395][DEBUG] [Sequence Thread] EventMarker 4 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:07:43.395][DEBUG] [Sequence Thread] Setting filter position 6... [09/25/17 21:07:43.395][DEBUG] [Sequence Thread] Filter position 6 is already set. Skipping... [09/25/17 21:07:43.395][DEBUG] [Sequence Thread] EventMarker 5 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:07:43.395][DEBUG] [Sequence Thread] Checking for auto manual focus (pre)... [09/25/17 21:07:43.395][DEBUG] [Sequence Thread] EventMarker 6 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:07:43.513][DEBUG] [Sequence Thread] Created base name for frame capture: Ngc6823_300sec_1x1_O3_frame6 [09/25/17 21:07:43.513][DEBUG] [Sequence Thread] Created directory for frame capture: C:\Users\Public\Documents\SGP Images\Light\ [09/25/17 21:07:43.513][DEBUG] [Sequence Thread] EventMarker 1 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:07:43.514][DEBUG] [Sequence Thread] EventMarker 7 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:07:43.514][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [09/25/17 21:07:43.514][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 21:07:43.514][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 21:07:43.514][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 21:07:43.614][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 21:07:43.614][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [09/25/17 21:07:43.614][DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 21:07:43.614][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 21:07:43.614][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 21:07:43.614][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 21:07:43.614][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 21:07:43.715][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 21:07:43.717][DEBUG] [Sequence Thread] User has elected to skip guider settling over time... [09/25/17 21:07:43.718][DEBUG] [Sequence Thread] Waiting for Auto Guider distance to fall below 0.6 [09/25/17 21:07:43.718][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 21:07:43.718][DEBUG] [Sequence Thread] PHD2 distance request returned 0.2... [09/25/17 21:07:43.744][DEBUG] [Sequence Thread] Distance is below 0.6, starting timer... [09/25/17 21:07:44.245][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 21:07:44.245][DEBUG] [Sequence Thread] PHD2 distance request returned 0.2... [09/25/17 21:07:44.265][DEBUG] [Sequence Thread] Distance stayed below 0.6 for 0 seconds, done settling... [09/25/17 21:07:44.265][DEBUG] [Sequence Thread] Auto guider has settled... [09/25/17 21:07:44.265][DEBUG] [Sequence Thread] EventMarker 8 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:07:44.265][DEBUG] [Sequence Thread] EventMarker 9 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:07:44.265][DEBUG] [Sequence Thread] EventMarker 10 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:07:44.265][DEBUG] [Sequence Thread] Finished sending frame capture. Entering wait mode... [09/25/17 21:07:44.265][DEBUG] [Sequence Thread] EventMarker 11 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:07:44.266][DEBUG] [Sequence Thread] EventMarker 12 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:07:44.274][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE message received... [09/25/17 21:07:44.277][DEBUG] [Sequence Thread] EventMarker 13 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:07:44.304][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 21:07:44.304][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 21:07:44.588][DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: GOOD [09/25/17 21:12:44.392][DEBUG] [Sequence Thread] EventMarker 15 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:12:44.393][DEBUG] [Sequence Thread] Waking from exposure time sleep period... [09/25/17 21:12:44.394][DEBUG] [Sequence Thread] Checking to see if the CCD has a temp... [09/25/17 21:12:44.394][DEBUG] [Sequence Thread] Saving the CCD temp... [09/25/17 21:12:44.417][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 21:12:44.417][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 21:12:44.417][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 21:12:44.517][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 21:13:00.087][DEBUG] [Camera Thread] QSI expose and download: 315.7190581s [09/25/17 21:13:00.087][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE complete... [09/25/17 21:13:00.099][DEBUG] [Sequence Thread] Image ready state detected when waiting for download state, continuing sequence... [09/25/17 21:13:00.099][DEBUG] [Sequence Thread] Entering super dangerous loop to await image completion... [09/25/17 21:13:00.104][DEBUG] [Sequence Thread] EventMarker 16 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:13:00.117][DEBUG] [Sequence Thread] EventMarker 17 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:13:00.117][DEBUG] [Sequence Thread] Image reported as complete. Continuing... [09/25/17 21:13:00.118][DEBUG] [Sequence Thread] Collecting FITs headers... [09/25/17 21:13:00.120][DEBUG] [Sequence Thread] QSI Camera - Camera reports last image start time as: 2017-09-26T04:07:47.023 UTC [09/25/17 21:13:00.120][DEBUG] [Sequence Thread] DATE-LOC time provided by camera... [09/25/17 21:13:00.129][DEBUG] [Sequence Thread] GatherFitsHeaders: Writing header info from UI... [09/25/17 21:13:00.133][DEBUG] [Sequence Thread] Clearing timed monitoring events... [09/25/17 21:13:00.139][DEBUG] [Sequence Thread] Created full file name: C:\Users\Public\Documents\SGP Images\Light\Ngc6823_300sec_1x1_O3_frame6-1.fit [09/25/17 21:13:00.286][DEBUG] [Sequence Thread] SaveFileBmp16: Locking bitmap for disk write... [09/25/17 21:13:00.286][DEBUG] [Sequence Thread] SaveFileBmp16: Opening file stream... [09/25/17 21:13:00.286][DEBUG] [Sequence Thread] SaveFileBmp16: Writing FITS headers... [09/25/17 21:13:00.287][DEBUG] [Sequence Thread] SaveFileBmp16: Traversing and persisting bitmap data... [09/25/17 21:13:00.473][DEBUG] [Sequence Thread] SaveFileBmp16: FITS block fill... [09/25/17 21:13:00.473][DEBUG] [Sequence Thread] SaveFileBmp16: Unlocking bitmap... [09/25/17 21:13:00.473][DEBUG] [Sequence Thread] SaveFileBmp16: Closing file stream [09/25/17 21:13:00.473][DEBUG] [Sequence Thread] Internal Interface: Set Preview... [09/25/17 21:13:00.473][DEBUG] [Sequence Thread] Display image preview using asynch task... [09/25/17 21:13:01.294][DEBUG] [Sequence Thread] =========== Save file took 1159 ms [09/25/17 21:13:01.309][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [09/25/17 21:13:01.309][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 21:13:01.309][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 21:13:01.309][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 21:13:01.413][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 21:13:01.413][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [09/25/17 21:13:01.414][DEBUG] [Sequence Thread] EventMarker 18 - t:Ngc6823 (0); e:0; f:5; o: [09/25/17 21:13:01.421][DEBUG] [Sequence Thread] EventMarker 19 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:01.421][DEBUG] [Sequence Thread] EventMarker 20 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:01.421][DEBUG] [Sequence Thread] Running post event... [09/25/17 21:13:01.421][DEBUG] [Sequence Thread] EventMarker 21 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:01.424][DEBUG] [Sequence Thread] Incremented numComplete (6) for event[0]... [09/25/17 21:13:01.433][DEBUG] [Sequence Thread] Attempting to find next event... [09/25/17 21:13:01.433][DEBUG] [Sequence Thread] Current event[0] frame count: 6/12... [09/25/17 21:13:01.433][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [09/25/17 21:13:01.433][DEBUG] [Sequence Thread] Checking for auto manual focus (post)... [09/25/17 21:13:01.433][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [09/25/17 21:13:01.439][DEBUG] [Sequence Thread] Attempting to move to next event... [09/25/17 21:13:01.439][DEBUG] [Sequence Thread] Attempting to find next event... [09/25/17 21:13:01.439][DEBUG] [Sequence Thread] Current event[0] frame count: 6/12... [09/25/17 21:13:01.439][DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [09/25/17 21:13:01.439][DEBUG] [Sequence Thread] Running pre event... [09/25/17 21:13:01.599][DEBUG] [Sequence Thread] Running capture event... [09/25/17 21:13:01.601][DEBUG] [Sequence Thread] SetStartTemp: Using focuser for temperature... [09/25/17 21:13:01.601][DEBUG] [Sequence Thread] Set start frame temp to 100... [09/25/17 21:13:01.602][DEBUG] [Sequence Thread] ------------- Starting capture frame for event[0] ------------- [09/25/17 21:13:01.606][DEBUG] [Sequence Thread] Sending commands... [09/25/17 21:13:01.606][DEBUG] [Sequence Thread] SetFlatBox: Frame Type is Light [09/25/17 21:13:01.606][DEBUG] [Sequence Thread] EventMarker 2 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:01.606][DEBUG] [Sequence Thread] EventMarker 3 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:01.606][DEBUG] [Sequence Thread] Waiting for AF to complete... [09/25/17 21:13:01.613][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [09/25/17 21:13:01.613][DEBUG] [Camera Thread] Checking for auto focus... [09/25/17 21:13:01.613][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [09/25/17 21:13:01.806][DEBUG] [Sequence Thread] AF is complete, continuing sequence... [09/25/17 21:13:01.806][DEBUG] [Sequence Thread] EventMarker 4 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:01.806][DEBUG] [Sequence Thread] Setting filter position 6... [09/25/17 21:13:01.806][DEBUG] [Sequence Thread] Filter position 6 is already set. Skipping... [09/25/17 21:13:01.806][DEBUG] [Sequence Thread] EventMarker 5 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:01.806][DEBUG] [Sequence Thread] Checking for auto manual focus (pre)... [09/25/17 21:13:01.806][DEBUG] [Sequence Thread] EventMarker 6 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:01.865][DEBUG] [Sequence Thread] Created base name for frame capture: Ngc6823_300sec_1x1_O3_frame7 [09/25/17 21:13:01.865][DEBUG] [Sequence Thread] Created directory for frame capture: C:\Users\Public\Documents\SGP Images\Light\ [09/25/17 21:13:01.865][DEBUG] [Sequence Thread] EventMarker 1 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:01.868][DEBUG] [Sequence Thread] EventMarker 7 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:01.868][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [09/25/17 21:13:01.868][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 21:13:01.868][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 21:13:01.868][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 21:13:01.968][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 21:13:01.968][DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [09/25/17 21:13:01.968][DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 21:13:01.968][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 0.6, "time": 0, "timeout": 600}, false ], "id": 1003} [09/25/17 21:13:01.968][DEBUG] [Sequence Thread] Checking PHD2 state... [09/25/17 21:13:01.968][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [09/25/17 21:13:01.968][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [09/25/17 21:13:02.068][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [09/25/17 21:13:02.068][DEBUG] [Sequence Thread] User has elected to skip guider settling over time... [09/25/17 21:13:02.068][DEBUG] [Sequence Thread] Waiting for Auto Guider distance to fall below 0.6 [09/25/17 21:13:02.068][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 21:13:02.068][DEBUG] [Sequence Thread] PHD2 distance request returned 0.2... [09/25/17 21:13:02.088][DEBUG] [Sequence Thread] Distance is below 0.6, starting timer... [09/25/17 21:13:02.541][DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: GOOD [09/25/17 21:13:02.588][DEBUG] [Sequence Thread] PHD2 distance request... [09/25/17 21:13:02.588][DEBUG] [Sequence Thread] PHD2 distance request returned 0.2... [09/25/17 21:13:02.611][DEBUG] [Sequence Thread] Distance stayed below 0.6 for 0 seconds, done settling... [09/25/17 21:13:02.612][DEBUG] [Sequence Thread] Auto guider has settled... [09/25/17 21:13:02.612][DEBUG] [Sequence Thread] EventMarker 8 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:02.612][DEBUG] [Sequence Thread] EventMarker 9 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:02.612][DEBUG] [Sequence Thread] EventMarker 10 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:02.612][DEBUG] [Sequence Thread] Finished sending frame capture. Entering wait mode... [09/25/17 21:13:02.612][DEBUG] [Sequence Thread] EventMarker 11 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:02.612][DEBUG] [Sequence Thread] EventMarker 12 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:02.614][DEBUG] [Sequence Thread] EventMarker 13 - t:Ngc6823 (0); e:0; f:6; o: [09/25/17 21:13:02.620][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE message received... [09/25/17 21:13:02.642][DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to HIGH... [09/25/17 21:13:02.642][DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [09/25/17 21:18:18.365][DEBUG] [Camera Thread] QSI expose and download: 315.6590546s [09/25/17 21:18:18.365][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE complete... [09/25/17 21:21:02.629][DEBUG] [Monitoring System Timed Message Thread] Adding sequence level notification: Failure while integrating Ngc6823; Event 1; Frame 7 for 300s. Image has not downloaded in alloted time period. [09/25/17 21:26:59.398][DEBUG] [Safety Thread] Adding sequence level notification: Shutting down due to Unsafe Conditions.