[8/9/2016 8:28:46 PM] [DEBUG] [Main Thread] Licensing: Machine ID found... [8/9/2016 8:28:46 PM] [DEBUG] [Main Thread] Checking for valid internet connection... [8/9/2016 8:29:01 PM] [DEBUG] [Main Thread] Error validating internet connection: The operation has timed out [8/9/2016 8:29:01 PM] [DEBUG] [Main Thread] Licensing: Request for licenses failed, looking for cookie.. [8/9/2016 8:29:01 PM] [DEBUG] [Main Thread] Licensing: Cookie found.. [8/9/2016 8:29:01 PM] [DEBUG] [Main Thread] Licensing: Applying licenses.. [8/9/2016 8:29:01 PM] [DEBUG] [Main Thread] Licensing: Licenses applied.. [8/9/2016 8:29:01 PM] [DEBUG] [Main Thread] SGPro retail license... [8/9/2016 8:29:02 PM] [DEBUG] [Main Thread] API successfully started on port 59590... [8/9/2016 8:29:02 PM] [DEBUG] [Main Thread] Error loading notification settings! Could not find file 'C:\Users\admin\AppData\Local\SequenceGenerator\Sequence Generator Pro\notifications.sgd'. [8/9/2016 8:29:02 PM] [DEBUG] [Main Thread] Error loading GNS endpoint settings! Could not find file 'C:\Users\admin\AppData\Local\SequenceGenerator\Sequence Generator Pro\gnsSettings.sgd'. [8/9/2016 8:29:02 PM] [DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\admin\AppData\Local\SequenceGenerator\Sequence Generator Pro\1-emailEndpointAddresses.sgd'. [8/9/2016 8:29:02 PM] [DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\admin\AppData\Local\SequenceGenerator\Sequence Generator Pro\2-emailEndpointAddresses.sgd'. [8/9/2016 8:29:02 PM] [DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\admin\AppData\Local\SequenceGenerator\Sequence Generator Pro\3-emailEndpointAddresses.sgd'. [8/9/2016 8:29:02 PM] [DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\admin\AppData\Local\SequenceGenerator\Sequence Generator Pro\1-textFileEndpointSettings.sgd'. [8/9/2016 8:29:02 PM] [DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\admin\AppData\Local\SequenceGenerator\Sequence Generator Pro\2-textFileEndpointSettings.sgd'. [8/9/2016 8:29:02 PM] [DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\admin\AppData\Local\SequenceGenerator\Sequence Generator Pro\3-textFileEndpointSettings.sgd'. [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] ===== S E Q U E N C E G E N E R A T O R (v2.5.1.17) ===== [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] OS: Microsoft Windows 7 Home Premium [8/9/2016 8:29:03 PM] [DEBUG] [Focuser Thread] Entering Fouser message dispatch loop... [8/9/2016 8:29:03 PM] [DEBUG] [TEC Thread] Entering TEC message dispatch loop... [8/9/2016 8:29:03 PM] [DEBUG] [Camera Thread] Entering camera message dispatch loop... [8/9/2016 8:29:03 PM] [DEBUG] [Filter Wheel Thread] Entering Filter Wheel message dispatch loop... [8/9/2016 8:29:03 PM] [DEBUG] [Rotator Thread] Entering Rotator message dispatch loop... [8/9/2016 8:29:03 PM] [DEBUG] [Auto Guider Thread] Entering Auto Guider message dispatch loop... [8/9/2016 8:29:03 PM] [DEBUG] [Auto Guider Error Thread] Entering Auto Guider message dispatch loop... [8/9/2016 8:29:03 PM] [DEBUG] [Dome Thread] Entering Dome message dispatch loop... [8/9/2016 8:29:03 PM] [DEBUG] [Safety Thread] Starting safety monitor... [8/9/2016 8:29:03 PM] [DEBUG] [Environment Device Thread] Starting environment device monitor... [8/9/2016 8:29:03 PM] [DEBUG] [Telescope Thread] Entering Telescope message dispatch loop... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] Settings changed (or loaded)... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiAutoStretch = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingIgLastFileFolder = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingFormScaleWarning = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingRecoveryDuration = 90 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingDelayBetween = 0 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingFliFlushLow = 0 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGLpt2Address = 278 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiMouseAction = Stretch [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomCamera = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingAutoRecoveryActive = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingTemperhumInterval = 300 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingASCOMWarningShown = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingPlateCamScale = 0 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingCanonMirrorSettle = 0 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingInterface = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomFilterWheel = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingAstroArtDisplayInstructions = True [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGLpt1Address = 378 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingTrialQuestionsAsked = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiLastImageDir = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingTemperHumUserTempComp = 0 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingCaptureCalFramesAlways = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingDelayFirst = 0 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingFliNormalSpeedMode = 0 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingFliHighSpeedMode = 0 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMfPosition = {X=0,Y=0} [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSoundAttention = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingPinpointCatalog = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingCameraOverhead = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingPlateSolveOn = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingAstrometryNetEndpointList = System.Collections.Specialized.StringCollection [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGGuider = None [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingQSIFanSpeed = 2 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingNaggerText = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiPhdDisplay = RA/Dec [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiShowToolStrip = True [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiShowCrosshairs = True [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: WindowGeometry = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingIgRenameStringLocation = 2 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingIgSubFolders = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: WindowGeometrySearch = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingOffset = -1 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingAutoStretchLevel = Low [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingTemperHumUnits = C [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingProfileDirectory = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingBasename = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingHfrColor = Color [RoyalBlue] [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingNikonAfBinning = 1 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGFanOffWithTec = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomSafetyMonitor = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiSize = {Width=800, Height=600} [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingIgCopyAndRenameFiles = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSimDownloadTimesAf = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingNagger = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingImportFromCfw = True [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiShowStatusTrip = True [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingShowTooltipHelp = True [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingLastUpdateCheck = 1/1/2012 12:00:00 AM [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingCpPosition = {X=0,Y=0} [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGCfwPort = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiLocation = {X=0,Y=0} [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingIgLastCsvFolder = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGFilterWheel = Auto Detect [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGConnection = USB [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingDSLRSoftwareBinForAf = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingAutoSave = True [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingFirstTime = True [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingFliFlushHigh = 0 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiState = maximized [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingUseSequenceOptions = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSoundCompleted = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingTrialExpiredShown = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingTemperHumColor = Grey [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingDataDirectory = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingCanonFileFormat = Single Image (CFA FITS) [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingAlnitakComPort = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingIgRenameFiles = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSubFolder = True [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingLastSGSaveFolder = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingNikonDataFormat = FITS [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingPlaySounds = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingPlateSolve3Catalogs = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingLastNikonType = Auto Connect [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingLastSequenceStart = 1/1/0001 12:00:00 AM [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomTelescope = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiPhdScale = 100 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingIgRenameType = 0 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingTemperHumUserHumidityComp = 0 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiPhdRaColor = Color [Blue] [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingLastImageSaveFolder = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingEnableImageHistory = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingFinishFullEvent = True [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMosaicOverlap = 20 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingQSIFanOffWithTec = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingRecentSequences = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingDefaultDirectory = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiPhdDecColor = Color [Red] [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingAstrometryNetEndpoint = Astrometry.NET (Remote) [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGCfwUseRS232 = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingStarsColor = Color [OrangeRed] [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingPhd2InstallPath = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingIgOverwriteExisting = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomFocuser = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingIgLastFolder = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: WindowGeometryOpen = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingNumEvents = 5 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingCanonAfBinning = 1 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingPlateCamBlank = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingNikonUseBulbModeAlways = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingTempFiles = C:\Temp [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingFliHighSpeedDesc = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingRecoveryInterval = 10 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGEthernetIP = 0.0.0.0 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGLpt3Address = 3BC [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingFliNormalSpeedDesc = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingIgCopyLocation = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGAutoDetectIp = True [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingAstroArtStartApp = True [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingSimDownloadTimesPlate = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMicroTouchLocation = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiPhdZoom = 40 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingMdiNewWindow = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingEventAlwaysVisible = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingFliRbiMitigation = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingGain = -1 [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomDome = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingLookForTemperDevices = False [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomRotator = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] * SETTING: settingAfTestPackPath = [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] Error loading profile C:\Users\admin\AppData\Local\SequenceGenerator\Sequence Generator Pro\AT10RC with QSI 683ws-g.sgp. End of Stream encountered before parsing was completed. [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] ASCOM Observing Conditions Hub (OCH) [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] ASCOM Observing Conditions Simulator [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] Blue Astro Stickstation [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] OpenWeatherMap ObservingConditions [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] TEMPerHUM [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] Performing initialization... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] Creating new sequence with no profile [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] Performing full form reset (with default data)... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] Retreiving new equipment objects... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] New camera object (No Camera) dispatched... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] New filter wheel object (No Filter Wheel) dispatched... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] New environment device object (No Environment Device) dispatched... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] New focuser object (No Focuser) dispatched... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] New telescope object (No Telescope) dispatched... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] New rotator object (No Rotator) dispatched... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] New dome object (No Observatory) dispatched... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] New auto guider object (No Auto Guider) dispatched... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] New plate solver object (No Plate Solver) dispatched... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] Added row 2... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] Added row 3... [8/9/2016 8:29:03 PM] [DEBUG] [Main Thread] Added row 4... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] Added row 5... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] Loading custom filter names... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] Retreiving new equipment objects... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] New camera object (No Camera) dispatched... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] New filter wheel object (No Filter Wheel) dispatched... [8/9/2016 8:29:04 PM] [DEBUG] [Sequence Thread] Entering sequence message dispatch loop... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] New environment device object (No Environment Device) dispatched... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] New focuser object (No Focuser) dispatched... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] New telescope object (No Telescope) dispatched... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] New rotator object (No Rotator) dispatched... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] New dome object (No Observatory) dispatched... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] New auto guider object (No Auto Guider) dispatched... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] New plate solver object (No Plate Solver) dispatched... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] Checking if version check is required... [8/9/2016 8:29:04 PM] [DEBUG] [Cleaner Thread] Running cleanup... [8/9/2016 8:29:04 PM] [DEBUG] [Main Thread] UI layout found, loading layout at C:\Users\admin\AppData\Local\SequenceGenerator\sg_ui_config.xml [8/9/2016 8:29:04 PM] [DEBUG] [Cleaner Thread] Cleaning 11 files in directory C:\Users\admin\AppData\Local\SequenceGenerator\Temp\... [8/9/2016 8:29:04 PM] [DEBUG] [Cleaner Thread] Cleaning multi camera registration file... [8/9/2016 8:29:04 PM] [DEBUG] [Cleaner Thread] Cleaning finished... [8/9/2016 8:29:09 PM] [DEBUG] [Main Thread] Performing deserialize... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] Loading custom filter names... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] ReflectDataModel: Transferring data model to the view... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] Retreiving new equipment objects... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] New camera object (QSI CCD Camera) dispatched... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] New filter wheel object (QSI Internal Filter Wheel) dispatched... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] New environment device object (No Environment Device) dispatched... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] New focuser object (FocusLynx Focuser 2) dispatched... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] New telescope object (AstroPhysics GTO V2 Mount) dispatched... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] New rotator object (Manual Rotator) dispatched... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] New dome object (No Observatory) dispatched... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] New flat box object (Manual Flat Box) dispatched... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] New auto guider object (PHD2) dispatched... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] No change in plate solver object... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] Added row 2... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] Added row 3... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] Added row 4... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] Added row 5... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] Added row 6... [8/9/2016 8:29:10 PM] [DEBUG] [Main Thread] Added row 7... [8/9/2016 8:29:11 PM] [DEBUG] [Main Thread] Added row 8... [8/9/2016 8:29:11 PM] [DEBUG] [Main Thread] Added row 9... [8/9/2016 8:29:11 PM] [DEBUG] [Main Thread] Added row 10... [8/9/2016 8:29:11 PM] [DEBUG] [Main Thread] Added row 11... [8/9/2016 8:29:12 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:12 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:12 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:12 PM] [DEBUG] [Main Thread] Added row 2... [8/9/2016 8:29:12 PM] [DEBUG] [Main Thread] Added row 3... [8/9/2016 8:29:12 PM] [DEBUG] [Main Thread] Added row 4... [8/9/2016 8:29:12 PM] [DEBUG] [Main Thread] Added row 5... [8/9/2016 8:29:12 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:12 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:12 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:12 PM] [DEBUG] [Main Thread] Added row 2... [8/9/2016 8:29:13 PM] [DEBUG] [Main Thread] Added row 3... [8/9/2016 8:29:13 PM] [DEBUG] [Main Thread] Added row 4... [8/9/2016 8:29:13 PM] [DEBUG] [Main Thread] Added row 5... [8/9/2016 8:29:13 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:13 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:13 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:13 PM] [DEBUG] [Main Thread] Added row 2... [8/9/2016 8:29:13 PM] [DEBUG] [Main Thread] Added row 3... [8/9/2016 8:29:13 PM] [DEBUG] [Main Thread] Added row 4... [8/9/2016 8:29:13 PM] [DEBUG] [Main Thread] Added row 5... [8/9/2016 8:29:14 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:14 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:14 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:14 PM] [DEBUG] [Main Thread] Added row 2... [8/9/2016 8:29:14 PM] [DEBUG] [Main Thread] Added row 3... [8/9/2016 8:29:14 PM] [DEBUG] [Main Thread] Added row 4... [8/9/2016 8:29:14 PM] [DEBUG] [Main Thread] Added row 5... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 2... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 3... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 4... [8/9/2016 8:29:15 PM] [DEBUG] [Main Thread] Added row 5... [8/9/2016 8:29:16 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:16 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:16 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:16 PM] [DEBUG] [Main Thread] Added row 2... [8/9/2016 8:29:16 PM] [DEBUG] [Main Thread] Added row 3... [8/9/2016 8:29:16 PM] [DEBUG] [Main Thread] Added row 4... [8/9/2016 8:29:16 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:16 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:16 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:16 PM] [DEBUG] [Main Thread] Added row 2... [8/9/2016 8:29:16 PM] [DEBUG] [Main Thread] Added row 3... [8/9/2016 8:29:16 PM] [DEBUG] [Main Thread] Added row 4... [8/9/2016 8:29:16 PM] [DEBUG] [Main Thread] Added row 5... [8/9/2016 8:29:17 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:17 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:17 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:17 PM] [DEBUG] [Main Thread] Added row 2... [8/9/2016 8:29:17 PM] [DEBUG] [Main Thread] Added row 3... [8/9/2016 8:29:17 PM] [DEBUG] [Main Thread] Added row 4... [8/9/2016 8:29:17 PM] [DEBUG] [Main Thread] Added row 5... [8/9/2016 8:29:17 PM] [DEBUG] [Main Thread] Populating the form controls... [8/9/2016 8:29:17 PM] [DEBUG] [Main Thread] Added row 0... [8/9/2016 8:29:17 PM] [DEBUG] [Main Thread] Added row 1... [8/9/2016 8:29:17 PM] [DEBUG] [Main Thread] Added row 2... [8/9/2016 8:29:18 PM] [DEBUG] [Main Thread] Added row 3... [8/9/2016 8:29:18 PM] [DEBUG] [Main Thread] Added row 4... [8/9/2016 8:29:18 PM] [DEBUG] [Main Thread] Added row 5... [8/9/2016 8:29:19 PM] [DEBUG] [Main Thread] Display image preview using asynch task... [8/9/2016 8:29:20 PM] [DEBUG] [Main Thread] Display image preview using asynch task... [8/9/2016 8:29:20 PM] [DEBUG] [Main Thread] Display image preview using asynch task... [8/9/2016 8:29:20 PM] [DEBUG] [Main Thread] Display image preview using asynch task... [8/9/2016 8:29:20 PM] [DEBUG] [Main Thread] Display image preview using asynch task... [8/9/2016 8:29:20 PM] [DEBUG] [Main Thread] Display image preview using asynch task... [8/9/2016 8:29:31 PM] [DEBUG] [Main Thread] Connecting camera in camera thread... [8/9/2016 8:29:31 PM] [DEBUG] [Camera Thread] SGM_CAMERA_CONNECT message received... [8/9/2016 8:29:31 PM] [DEBUG] [Camera Thread] Connecting QSI camera... [8/9/2016 8:29:31 PM] [DEBUG] [Camera Thread] QSI Camera: version check... [8/9/2016 8:29:31 PM] [DEBUG] [Camera Thread] QSI Driver Version: 7.4.1824.0(QSI - Camera not connected) [8/9/2016 8:29:32 PM] [DEBUG] [Camera Thread] Connected to 683ws [8/9/2016 8:29:32 PM] [DEBUG] [Camera Thread] SGM_CAMERA_CONNECT complete... [8/9/2016 8:29:36 PM] [DEBUG] [Main Thread] Connecting ASCOM focuser... [8/9/2016 8:29:38 PM] [DEBUG] [Main Thread] Focuser supports temperature [8/9/2016 8:29:38 PM] [DEBUG] [Main Thread] Current temperature reports: 17.9 [8/9/2016 8:29:38 PM] [DEBUG] [Main Thread] Focuser reports Max Increment as: 65535 [8/9/2016 8:29:38 PM] [DEBUG] [Main Thread] Focuser reports max steps as: 65535 [8/9/2016 8:29:38 PM] [DEBUG] [Telescope Thread] Telescope Dispatch loop: Received SGM_TELESCOPE_CONNECT... [8/9/2016 8:29:38 PM] [DEBUG] [Telescope Thread] Telescope can slewing supported... [8/9/2016 8:29:38 PM] [DEBUG] [Telescope Thread] Telescope: Implements MoveAxis... [8/9/2016 8:29:38 PM] [DEBUG] [Telescope Thread] RA Move Rate Range: Min->0 Max->5 [8/9/2016 8:29:38 PM] [DEBUG] [Telescope Thread] DEC Move Rate Range: Min->0 Max->5 [8/9/2016 8:29:38 PM] [DEBUG] [Telescope Thread] Telescope: CanSetSideOfPier returned False [8/9/2016 8:29:38 PM] [DEBUG] [Telescope Thread] Telescope: CanPark returned True [8/9/2016 8:29:38 PM] [DEBUG] [Telescope Thread] Telescope equatorial system is JNOW... [8/9/2016 8:29:38 PM] [DEBUG] [Telescope Thread] SGM_TELESCOPE_CONNECT complete... [8/9/2016 8:29:40 PM] [DEBUG] [Main Thread] Connecting Manual rotator... [8/9/2016 8:30:40 PM] [DEBUG] [Main Thread] Slewing to target... [8/9/2016 8:30:40 PM] [DEBUG] [Telescope Thread] Slew telescope message received... [8/9/2016 8:30:40 PM] [DEBUG] [Slew Monitor] Waiting for slew to complete... [8/9/2016 8:30:40 PM] [DEBUG] [CP Update Thread] Error in control panel UI updater: Object reference not set to an instance of an object. [8/9/2016 8:30:40 PM] [DEBUG] [Telescope Thread] Telescope: Slewing to J2000 RA: 20.8266666666667 (20h49m36.00s) Dec: 31.6463888888889 (31°38'47.00") [8/9/2016 8:30:40 PM] [DEBUG] [Telescope Thread] Telescope: Slew received J2000 coordinates, mount requires JNOW, converting... [8/9/2016 8:30:40 PM] [DEBUG] [Telescope Thread] Telescope: Slewing to JNOW RA: 20.8384820997157 Dec: 31.7119409895565 [8/9/2016 8:30:41 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [8/9/2016 8:30:41 PM] [DEBUG] [MF Update Thread] Performing serialize... [8/9/2016 8:30:56 PM] [DEBUG] [Telescope Thread] Scope reports it is done with synchronous slew, verifying... [8/9/2016 8:30:56 PM] [DEBUG] [Telescope Thread] Telescope: Slewing has completed [8/9/2016 8:30:56 PM] [DEBUG] [Telescope Thread] Telescope: Settling for 1 seconds [8/9/2016 8:30:57 PM] [DEBUG] [Telescope Thread] Telescope: Settling has completed [8/9/2016 8:30:57 PM] [DEBUG] [Telescope Thread] Slew complete... [8/9/2016 8:31:36 PM] [DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_REL message received... [8/9/2016 8:31:36 PM] [DEBUG] [Focuser Thread] Focuser moving to 10307 [8/9/2016 8:31:36 PM] [DEBUG] [Focuser Thread] Focuser move call complete [8/9/2016 8:31:37 PM] [DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_REL complete... [8/9/2016 8:31:39 PM] [DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_REL message received... [8/9/2016 8:31:39 PM] [DEBUG] [Focuser Thread] Focuser moving to 10407 [8/9/2016 8:31:39 PM] [DEBUG] [Focuser Thread] Focuser move call complete [8/9/2016 8:31:40 PM] [DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_REL complete... [8/9/2016 8:33:05 PM] [DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_ABS message received... [8/9/2016 8:33:05 PM] [DEBUG] [Focuser Thread] Focuser moving to 10407 [8/9/2016 8:33:05 PM] [DEBUG] [Focuser Thread] Focuser move call complete [8/9/2016 8:33:06 PM] [DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_ABS complete... [8/9/2016 8:33:07 PM] [DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_REL message received... [8/9/2016 8:33:07 PM] [DEBUG] [Focuser Thread] Focuser moving to 10507 [8/9/2016 8:33:07 PM] [DEBUG] [Focuser Thread] Focuser backlash active, modified move to 10707 [8/9/2016 8:33:08 PM] [DEBUG] [Focuser Thread] Focuser move call complete [8/9/2016 8:33:08 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash thread has started... [8/9/2016 8:33:09 PM] [DEBUG] [Focuser Backlash Thread] Backlash thread has detected that movement to modified position (10707) is complete... [8/9/2016 8:33:09 PM] [DEBUG] [Focuser Backlash Thread] Moving focuser to original requested position (10507)... [8/9/2016 8:33:09 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash compensation needed. Steps: 200 Direction:IN [8/9/2016 8:33:09 PM] [DEBUG] [Focuser Backlash Thread] Focuser moving to 10507 [8/9/2016 8:33:09 PM] [DEBUG] [Focuser Backlash Thread] Focuser move call complete [8/9/2016 8:33:11 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash completed. Focuser is at original request position (10507)... [8/9/2016 8:33:11 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash thread has ended... [8/9/2016 8:33:11 PM] [DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_REL complete... [8/9/2016 8:33:20 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [8/9/2016 8:33:20 PM] [DEBUG] [MF Update Thread] Performing serialize... [8/9/2016 8:33:23 PM] [DEBUG] [Camera Thread] SGM_FRAME_AND_FOCUS message received... [8/9/2016 8:33:23 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: frame and focus... [8/9/2016 8:33:23 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:33:23 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:33:33 PM] [DEBUG] [Camera Thread] QSI expose and download: 9.9015663s [8/9/2016 8:33:33 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:33:33 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:33:34 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:33:34 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:33:34 PM] [DEBUG] [Main Thread] Find stars took: 335 ms... [8/9/2016 8:33:34 PM] [DEBUG] [Main Thread] Star list contains 108 stars... [8/9/2016 8:33:34 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:33:34 PM] [DEBUG] [Camera Thread] SGM_FRAME_AND_FOCUS complete... [8/9/2016 8:33:39 PM] [DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [8/9/2016 8:33:39 PM] [DEBUG] [Camera Thread] Checking for auto focus... [8/9/2016 8:33:39 PM] [DEBUG] [Camera Thread] Auto focus required (temperature change trigger). Last temp: -500; Current temp: 18.25 [8/9/2016 8:33:39 PM] [DEBUG] [Camera Thread] Auto focus required (focus before first frame)... [8/9/2016 8:33:39 PM] [DEBUG] [Camera Thread] Pause guiding while AF is active, pause command sent, waiting for guider to pause... [8/9/2016 8:33:39 PM] [DEBUG] [Camera Thread] Tried to pause guider for AF, but failed on timeout, continuing AF anyhow... [8/9/2016 8:33:39 PM] [DEBUG] [Camera Thread] Auto focus: setting filter Lum [8/9/2016 8:33:39 PM] [DEBUG] [Camera Thread] Setting filter position 4... [8/9/2016 8:33:39 PM] [DEBUG] [Camera Thread] Setting filter: Lum... [8/9/2016 8:33:39 PM] [DEBUG] [Camera Thread] Moving filter wheel, isMoving, check 1... [8/9/2016 8:33:39 PM] [DEBUG] [Camera Thread] Moving filter wheel, isMoving, check 1 is complete... [8/9/2016 8:33:41 PM] [DEBUG] [Camera Thread] Adjust focuser pos per filter: Moving focsuer to focus position (4500)... [8/9/2016 8:33:41 PM] [DEBUG] [Camera Thread] Focuser moving to 10501 [8/9/2016 8:33:41 PM] [DEBUG] [Camera Thread] Focuser move call complete [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (10501), continuing... [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] focuser move is complete... [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] Moving filter wheel, isMoving, check 2... [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] Moving filter wheel, isMoving, check 2 complete... [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] Auto focus running... [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] Turning temp comp off.. [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] ASCOM Focuser: Temp comp is avaialble, setting to False [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] Performing Sequence Generator auto focus using Half Flux Radius. AFID: 0 [8/9/2016 8:33:42 PM] [DEBUG] [AfChartThread] Showing AF chart dialog... [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] Auto focus data [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] - Data Points: 9 [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] - Step Size: 100 [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] - Current Position: 10501 [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] - Initial Move Position: 10901 [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] AF Darks exception: The path is not of a legal form. [8/9/2016 8:33:42 PM] [DEBUG] [Camera Thread] Moving focuser to next position (10901)... [8/9/2016 8:33:42 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 10901 [8/9/2016 8:33:42 PM] [DEBUG] [Focuser Move Thread] Focuser backlash active, modified move to 11101 [8/9/2016 8:33:42 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [8/9/2016 8:33:42 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash thread has started... [8/9/2016 8:33:44 PM] [DEBUG] [Focuser Backlash Thread] Backlash thread has detected that movement to modified position (11101) is complete... [8/9/2016 8:33:44 PM] [DEBUG] [Focuser Backlash Thread] Moving focuser to original requested position (10901)... [8/9/2016 8:33:44 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash compensation needed. Steps: 200 Direction:IN [8/9/2016 8:33:44 PM] [DEBUG] [Focuser Backlash Thread] Focuser moving to 10901 [8/9/2016 8:33:44 PM] [DEBUG] [Focuser Backlash Thread] Focuser move call complete [8/9/2016 8:33:45 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 10901 matches requested position 10901 [8/9/2016 8:33:45 PM] [DEBUG] [Camera Thread] Focuser move complete... [8/9/2016 8:33:46 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash completed. Focuser is at original request position (10901)... [8/9/2016 8:33:46 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash thread has ended... [8/9/2016 8:33:46 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (10901), continuing... [8/9/2016 8:33:46 PM] [DEBUG] [Camera Thread] Calculating step metric... [8/9/2016 8:33:46 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [8/9/2016 8:33:46 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [8/9/2016 8:33:46 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 4x4... [8/9/2016 8:33:46 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 2 seconds... [8/9/2016 8:33:46 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [8/9/2016 8:33:46 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:33:46 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:33:50 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: abort message received... [8/9/2016 8:33:50 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: Attempting to abort exposure... [8/9/2016 8:33:50 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: Exposure aborted... [8/9/2016 8:33:50 PM] [DEBUG] [Camera Thread] HFR value from auto focuser is 0!, trying again... [8/9/2016 8:33:50 PM] [DEBUG] [Camera Thread] AF abort requested [8/9/2016 8:33:50 PM] [DEBUG] [Camera Thread] Auto focus (finally): closing dialog... [8/9/2016 8:33:50 PM] [DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_ABS message received... [8/9/2016 8:33:50 PM] [DEBUG] [Focuser Thread] Focuser moving to 10501 [8/9/2016 8:33:50 PM] [DEBUG] [AfChartThread] AF chart dialog is closed... [8/9/2016 8:33:50 PM] [DEBUG] [Camera Thread] Auto focus complete... [8/9/2016 8:33:50 PM] [DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [8/9/2016 8:33:50 PM] [DEBUG] [Focuser Thread] Focuser move call complete [8/9/2016 8:33:51 PM] [DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_ABS complete... [8/9/2016 8:33:52 PM] [DEBUG] [Main Thread] Turning camera cooler on... [8/9/2016 8:33:52 PM] [DEBUG] [Main Thread] Turning camera cooler on... [8/9/2016 8:33:54 PM] [DEBUG] [TEC Thread] SGM_CHANGE_COOLER_TEMP message received... [8/9/2016 8:33:54 PM] [DEBUG] [TEC Thread] TEC Change: Starting... [8/9/2016 8:33:54 PM] [DEBUG] [TEC Thread] TEC Change: Time change is 0, setting to -25.00... [8/9/2016 8:33:54 PM] [DEBUG] [TEC Thread] SGM_CHANGE_COOLER_TEMP complete... [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] Checking for auto focus... [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] Auto focus required (focus before first frame)... [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] Pause guiding while AF is active, pause command sent, waiting for guider to pause... [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] Tried to pause guider for AF, but failed on timeout, continuing AF anyhow... [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] Auto focus: setting filter Lum [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] Setting filter position 4... [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] Filter position 4 is already set. Skipping... [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] Auto focus running... [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] Turning temp comp off.. [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] ASCOM Focuser: Temp comp is avaialble, setting to False [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] Performing Sequence Generator auto focus using Half Flux Radius. AFID: 1 [8/9/2016 8:33:58 PM] [DEBUG] [AfChartThread] Showing AF chart dialog... [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] Auto focus data [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] - Data Points: 9 [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] - Step Size: 100 [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] - Current Position: 10501 [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] - Initial Move Position: 10901 [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] AF Darks exception: The path is not of a legal form. [8/9/2016 8:33:58 PM] [DEBUG] [Camera Thread] Moving focuser to next position (10901)... [8/9/2016 8:33:58 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 10901 [8/9/2016 8:33:58 PM] [DEBUG] [Focuser Move Thread] Focuser backlash active, modified move to 11101 [8/9/2016 8:33:58 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [8/9/2016 8:33:58 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash thread has started... [8/9/2016 8:34:00 PM] [DEBUG] [Focuser Backlash Thread] Backlash thread has detected that movement to modified position (11101) is complete... [8/9/2016 8:34:00 PM] [DEBUG] [Focuser Backlash Thread] Moving focuser to original requested position (10901)... [8/9/2016 8:34:00 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash compensation needed. Steps: 200 Direction:IN [8/9/2016 8:34:00 PM] [DEBUG] [Focuser Backlash Thread] Focuser moving to 10901 [8/9/2016 8:34:00 PM] [DEBUG] [Focuser Backlash Thread] Focuser move call complete [8/9/2016 8:34:01 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 10901 matches requested position 10901 [8/9/2016 8:34:01 PM] [DEBUG] [Camera Thread] Focuser move complete... [8/9/2016 8:34:01 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash completed. Focuser is at original request position (10901)... [8/9/2016 8:34:01 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash thread has ended... [8/9/2016 8:34:01 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (10901), continuing... [8/9/2016 8:34:01 PM] [DEBUG] [Camera Thread] Calculating step metric... [8/9/2016 8:34:01 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [8/9/2016 8:34:01 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [8/9/2016 8:34:01 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 4x4... [8/9/2016 8:34:01 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 2 seconds... [8/9/2016 8:34:01 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [8/9/2016 8:34:01 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:34:01 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:34:10 PM] [DEBUG] [Camera Thread] QSI expose and download: 8.3534778s [8/9/2016 8:34:10 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:34:10 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:34:10 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:34:10 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:34:10 PM] [DEBUG] [Main Thread] Find stars took: 195 ms... [8/9/2016 8:34:10 PM] [DEBUG] [Main Thread] Star list contains 11 stars... [8/9/2016 8:34:10 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:34:10 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 3.60 [8/9/2016 8:34:11 PM] [DEBUG] [Camera Thread] Moving focuser to next position (10801)... [8/9/2016 8:34:11 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 10801 [8/9/2016 8:34:12 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [8/9/2016 8:34:12 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 10801 matches requested position 10801 [8/9/2016 8:34:12 PM] [DEBUG] [Camera Thread] Focuser move complete... [8/9/2016 8:34:12 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (10801), continuing... [8/9/2016 8:34:12 PM] [DEBUG] [Camera Thread] Calculating step metric... [8/9/2016 8:34:12 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [8/9/2016 8:34:12 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [8/9/2016 8:34:12 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 4x4... [8/9/2016 8:34:12 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 2 seconds... [8/9/2016 8:34:12 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [8/9/2016 8:34:12 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:34:12 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:34:21 PM] [DEBUG] [Camera Thread] QSI expose and download: 8.3184758s [8/9/2016 8:34:21 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:34:21 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:34:21 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:34:21 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:34:21 PM] [DEBUG] [Main Thread] Find stars took: 199 ms... [8/9/2016 8:34:21 PM] [DEBUG] [Main Thread] Star list contains 25 stars... [8/9/2016 8:34:21 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:34:21 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 3.22 [8/9/2016 8:34:22 PM] [DEBUG] [Camera Thread] Moving focuser to next position (10701)... [8/9/2016 8:34:22 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 10701 [8/9/2016 8:34:22 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [8/9/2016 8:34:23 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 10701 matches requested position 10701 [8/9/2016 8:34:23 PM] [DEBUG] [Camera Thread] Focuser move complete... [8/9/2016 8:34:23 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (10701), continuing... [8/9/2016 8:34:23 PM] [DEBUG] [Camera Thread] Calculating step metric... [8/9/2016 8:34:23 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [8/9/2016 8:34:23 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [8/9/2016 8:34:23 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 4x4... [8/9/2016 8:34:23 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 2 seconds... [8/9/2016 8:34:23 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [8/9/2016 8:34:23 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:34:23 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:34:31 PM] [DEBUG] [Camera Thread] QSI expose and download: 8.3204759s [8/9/2016 8:34:31 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:34:31 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:34:32 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:34:32 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:34:32 PM] [DEBUG] [Main Thread] Find stars took: 204 ms... [8/9/2016 8:34:32 PM] [DEBUG] [Main Thread] Star list contains 33 stars... [8/9/2016 8:34:32 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:34:32 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.49 [8/9/2016 8:34:33 PM] [DEBUG] [Camera Thread] Moving focuser to next position (10601)... [8/9/2016 8:34:33 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 10601 [8/9/2016 8:34:33 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [8/9/2016 8:34:34 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 10601 matches requested position 10601 [8/9/2016 8:34:34 PM] [DEBUG] [Camera Thread] Focuser move complete... [8/9/2016 8:34:34 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (10601), continuing... [8/9/2016 8:34:34 PM] [DEBUG] [Camera Thread] Calculating step metric... [8/9/2016 8:34:34 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [8/9/2016 8:34:34 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [8/9/2016 8:34:34 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 4x4... [8/9/2016 8:34:34 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 2 seconds... [8/9/2016 8:34:34 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [8/9/2016 8:34:34 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:34:34 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:34:40 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [8/9/2016 8:34:40 PM] [DEBUG] [MF Update Thread] Performing serialize... [8/9/2016 8:34:42 PM] [DEBUG] [Camera Thread] QSI expose and download: 8.321476s [8/9/2016 8:34:42 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:34:42 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:34:42 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:34:42 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:34:42 PM] [DEBUG] [Main Thread] Find stars took: 211 ms... [8/9/2016 8:34:42 PM] [DEBUG] [Main Thread] Star list contains 60 stars... [8/9/2016 8:34:42 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:34:43 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.75 [8/9/2016 8:34:44 PM] [DEBUG] [Camera Thread] Moving focuser to next position (10501)... [8/9/2016 8:34:44 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 10501 [8/9/2016 8:34:44 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [8/9/2016 8:34:44 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 10501 matches requested position 10501 [8/9/2016 8:34:44 PM] [DEBUG] [Camera Thread] Focuser move complete... [8/9/2016 8:34:44 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (10501), continuing... [8/9/2016 8:34:44 PM] [DEBUG] [Camera Thread] Calculating step metric... [8/9/2016 8:34:44 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [8/9/2016 8:34:44 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [8/9/2016 8:34:44 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 4x4... [8/9/2016 8:34:44 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 2 seconds... [8/9/2016 8:34:44 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [8/9/2016 8:34:44 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:34:44 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:34:53 PM] [DEBUG] [Camera Thread] QSI expose and download: 8.322476s [8/9/2016 8:34:53 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:34:53 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:34:53 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:34:53 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:34:53 PM] [DEBUG] [Main Thread] Find stars took: 191 ms... [8/9/2016 8:34:53 PM] [DEBUG] [Main Thread] Star list contains 122 stars... [8/9/2016 8:34:53 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:34:53 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.30 [8/9/2016 8:34:54 PM] [DEBUG] [Camera Thread] Moving focuser to next position (10401)... [8/9/2016 8:34:54 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 10401 [8/9/2016 8:34:54 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [8/9/2016 8:34:55 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 10401 matches requested position 10401 [8/9/2016 8:34:55 PM] [DEBUG] [Camera Thread] Focuser move complete... [8/9/2016 8:34:55 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (10401), continuing... [8/9/2016 8:34:55 PM] [DEBUG] [Camera Thread] Calculating step metric... [8/9/2016 8:34:55 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [8/9/2016 8:34:55 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [8/9/2016 8:34:55 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 4x4... [8/9/2016 8:34:55 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 2 seconds... [8/9/2016 8:34:55 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [8/9/2016 8:34:55 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:34:55 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:35:04 PM] [DEBUG] [Camera Thread] QSI expose and download: 8.3194759s [8/9/2016 8:35:04 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:35:04 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:35:04 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:35:04 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:35:04 PM] [DEBUG] [Main Thread] Find stars took: 194 ms... [8/9/2016 8:35:04 PM] [DEBUG] [Main Thread] Star list contains 244 stars... [8/9/2016 8:35:04 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:35:04 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.12 [8/9/2016 8:35:05 PM] [DEBUG] [Camera Thread] Moving focuser to next position (10301)... [8/9/2016 8:35:05 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 10301 [8/9/2016 8:35:05 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [8/9/2016 8:35:06 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 10301 matches requested position 10301 [8/9/2016 8:35:06 PM] [DEBUG] [Camera Thread] Focuser move complete... [8/9/2016 8:35:06 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (10301), continuing... [8/9/2016 8:35:06 PM] [DEBUG] [Camera Thread] Calculating step metric... [8/9/2016 8:35:06 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [8/9/2016 8:35:06 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [8/9/2016 8:35:06 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 4x4... [8/9/2016 8:35:06 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 2 seconds... [8/9/2016 8:35:06 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [8/9/2016 8:35:06 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:35:06 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:35:14 PM] [DEBUG] [Camera Thread] QSI expose and download: 8.322476s [8/9/2016 8:35:14 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:35:14 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:35:15 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:35:15 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:35:15 PM] [DEBUG] [Main Thread] Find stars took: 244 ms... [8/9/2016 8:35:15 PM] [DEBUG] [Main Thread] Star list contains 169 stars... [8/9/2016 8:35:15 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:35:15 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 0.99 [8/9/2016 8:35:16 PM] [DEBUG] [Camera Thread] Moving focuser to next position (10201)... [8/9/2016 8:35:16 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 10201 [8/9/2016 8:35:16 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [8/9/2016 8:35:17 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 10201 matches requested position 10201 [8/9/2016 8:35:17 PM] [DEBUG] [Camera Thread] Focuser move complete... [8/9/2016 8:35:17 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (10201), continuing... [8/9/2016 8:35:17 PM] [DEBUG] [Camera Thread] Calculating step metric... [8/9/2016 8:35:17 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [8/9/2016 8:35:17 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [8/9/2016 8:35:17 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 4x4... [8/9/2016 8:35:17 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 2 seconds... [8/9/2016 8:35:17 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [8/9/2016 8:35:17 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:35:17 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:35:25 PM] [DEBUG] [Camera Thread] QSI expose and download: 8.322476s [8/9/2016 8:35:25 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:35:25 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:35:25 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:35:25 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:35:25 PM] [DEBUG] [Main Thread] Find stars took: 197 ms... [8/9/2016 8:35:25 PM] [DEBUG] [Main Thread] Star list contains 199 stars... [8/9/2016 8:35:25 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:35:26 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.05 [8/9/2016 8:35:27 PM] [DEBUG] [Camera Thread] Moving focuser to next position (10101)... [8/9/2016 8:35:27 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 10101 [8/9/2016 8:35:27 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [8/9/2016 8:35:27 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 10101 matches requested position 10101 [8/9/2016 8:35:27 PM] [DEBUG] [Camera Thread] Focuser move complete... [8/9/2016 8:35:27 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (10101), continuing... [8/9/2016 8:35:27 PM] [DEBUG] [Camera Thread] Calculating step metric... [8/9/2016 8:35:27 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [8/9/2016 8:35:27 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [8/9/2016 8:35:27 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 4x4... [8/9/2016 8:35:27 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 2 seconds... [8/9/2016 8:35:27 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [8/9/2016 8:35:28 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:35:28 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:35:36 PM] [DEBUG] [Camera Thread] QSI expose and download: 8.3174757s [8/9/2016 8:35:36 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:35:36 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:35:36 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:35:36 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:35:36 PM] [DEBUG] [Main Thread] Find stars took: 204 ms... [8/9/2016 8:35:36 PM] [DEBUG] [Main Thread] Star list contains 120 stars... [8/9/2016 8:35:36 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:35:36 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.35 [8/9/2016 8:35:37 PM] [DEBUG] [Camera Thread] Moving focuser to next position (10001)... [8/9/2016 8:35:37 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 10001 [8/9/2016 8:35:38 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [8/9/2016 8:35:38 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 10001 matches requested position 10001 [8/9/2016 8:35:38 PM] [DEBUG] [Camera Thread] Focuser move complete... [8/9/2016 8:35:38 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (10001), continuing... [8/9/2016 8:35:38 PM] [DEBUG] [Camera Thread] Calculating step metric... [8/9/2016 8:35:38 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [8/9/2016 8:35:38 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [8/9/2016 8:35:38 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 4x4... [8/9/2016 8:35:38 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 2 seconds... [8/9/2016 8:35:38 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [8/9/2016 8:35:38 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:35:38 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:35:47 PM] [DEBUG] [Camera Thread] QSI expose and download: 8.3174757s [8/9/2016 8:35:47 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:35:47 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:35:47 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:35:47 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:35:47 PM] [DEBUG] [Main Thread] Find stars took: 204 ms... [8/9/2016 8:35:47 PM] [DEBUG] [Main Thread] Star list contains 62 stars... [8/9/2016 8:35:47 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:35:47 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.80 [8/9/2016 8:35:48 PM] [DEBUG] [Camera Thread] Moving focuser to next position (9901)... [8/9/2016 8:35:48 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 9901 [8/9/2016 8:35:48 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [8/9/2016 8:35:49 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 9901 matches requested position 9901 [8/9/2016 8:35:49 PM] [DEBUG] [Camera Thread] Focuser move complete... [8/9/2016 8:35:49 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (9901), continuing... [8/9/2016 8:35:49 PM] [DEBUG] [Camera Thread] Calculating step metric... [8/9/2016 8:35:49 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [8/9/2016 8:35:49 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [8/9/2016 8:35:49 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 4x4... [8/9/2016 8:35:49 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 2 seconds... [8/9/2016 8:35:49 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [8/9/2016 8:35:49 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:35:49 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:35:57 PM] [DEBUG] [Camera Thread] QSI expose and download: 8.3224761s [8/9/2016 8:35:57 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:35:57 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:35:58 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:35:58 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:35:58 PM] [DEBUG] [Main Thread] Find stars took: 181 ms... [8/9/2016 8:35:58 PM] [DEBUG] [Main Thread] Star list contains 36 stars... [8/9/2016 8:35:58 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:35:58 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.47 [8/9/2016 8:35:59 PM] [DEBUG] [Camera Thread] New auto focus method calculated focus at: 10286 [8/9/2016 8:35:59 PM] [DEBUG] [Camera Thread] Old auto focus method calculated focus at: 10272 [8/9/2016 8:35:59 PM] [DEBUG] [Camera Thread] Using new auto focus method for focuser position [8/9/2016 8:35:59 PM] [DEBUG] [Camera Thread] New focus position is at 10286 (@18.38C). Moving focuser... [8/9/2016 8:35:59 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 10286 [8/9/2016 8:35:59 PM] [DEBUG] [Focuser Move Thread] Focuser backlash active, modified move to 10486 [8/9/2016 8:35:59 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [8/9/2016 8:35:59 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash thread has started... [8/9/2016 8:36:01 PM] [DEBUG] [Focuser Backlash Thread] Backlash thread has detected that movement to modified position (10486) is complete... [8/9/2016 8:36:01 PM] [DEBUG] [Focuser Backlash Thread] Moving focuser to original requested position (10286)... [8/9/2016 8:36:01 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash compensation needed. Steps: 200 Direction:IN [8/9/2016 8:36:01 PM] [DEBUG] [Focuser Backlash Thread] Focuser moving to 10286 [8/9/2016 8:36:01 PM] [DEBUG] [Focuser Backlash Thread] Focuser move call complete [8/9/2016 8:36:02 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 10286 matches requested position 10286 [8/9/2016 8:36:02 PM] [DEBUG] [Camera Thread] Focuser move complete... [8/9/2016 8:36:02 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash completed. Focuser is at original request position (10286)... [8/9/2016 8:36:02 PM] [DEBUG] [Focuser Backlash Thread] Focuser backlash thread has ended... [8/9/2016 8:36:02 PM] [DEBUG] [Camera Thread] Focuser successfully set to focus position (10286) [8/9/2016 8:36:02 PM] [DEBUG] [Camera Thread] Taking validation frame at focus position... [8/9/2016 8:36:02 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [8/9/2016 8:36:02 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: Capturing auto focus frame... [8/9/2016 8:36:02 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Binning: 4x4... [8/9/2016 8:36:02 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure length: 2 seconds... [8/9/2016 8:36:02 PM] [DEBUG] [Camera Thread] ASCOM (QSI): AF Exposure DL speed: b [8/9/2016 8:36:03 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:36:03 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:36:11 PM] [DEBUG] [Camera Thread] QSI expose and download: 8.3194758s [8/9/2016 8:36:11 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:36:11 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:36:11 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:36:11 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:36:11 PM] [DEBUG] [Main Thread] Find stars took: 321 ms... [8/9/2016 8:36:11 PM] [DEBUG] [Main Thread] Star list contains 194 stars... [8/9/2016 8:36:11 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:36:11 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 0.98 [8/9/2016 8:36:12 PM] [DEBUG] [Camera Thread] Auto focus is complete (best fit method: 10286; HFR 0.98)... [8/9/2016 8:36:12 PM] [DEBUG] [Camera Thread] Entering chart disposal loop... [8/9/2016 8:36:18 PM] [DEBUG] [AfChartThread] AF chart dialog is closed... [8/9/2016 8:36:18 PM] [DEBUG] [Camera Thread] Chart disposal loop is complete... [8/9/2016 8:36:18 PM] [DEBUG] [Camera Thread] Auto focus is done... [8/9/2016 8:36:18 PM] [DEBUG] [Camera Thread] Auto focus complete... [8/9/2016 8:36:18 PM] [DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [8/9/2016 8:42:58 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:42:58 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:42:58 PM] [DEBUG] [Main Thread] Find stars took: 189 ms... [8/9/2016 8:42:58 PM] [DEBUG] [Main Thread] Star list contains 194 stars... [8/9/2016 8:42:58 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [8/9/2016 8:42:59 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [8/9/2016 8:42:59 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [8/9/2016 8:42:59 PM] [DEBUG] [Main Thread] Find stars took: 194 ms... [8/9/2016 8:42:59 PM] [DEBUG] [Main Thread] Star list contains 194 stars... [8/9/2016 8:42:59 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 1 [8/9/2016 8:43:07 PM] [DEBUG] [Telescope Thread] Center telescope message received... [8/9/2016 8:43:07 PM] [DEBUG] [Telescope Thread] Solving with Plate Solver PlateSolve2... [8/9/2016 8:43:07 PM] [DEBUG] [Telescope Thread] Setting filter for auto center... [8/9/2016 8:43:07 PM] [DEBUG] [Telescope Thread] Setting filter position 4... [8/9/2016 8:43:07 PM] [DEBUG] [Telescope Thread] Filter position 4 is already set. Skipping... [8/9/2016 8:43:07 PM] [DEBUG] [Telescope Thread] Performing auto center step 1... [8/9/2016 8:43:07 PM] [DEBUG] [Telescope Thread] Skipping step 1... [8/9/2016 8:43:07 PM] [DEBUG] [Telescope Thread] Auto center reference frame solved successfully... [8/9/2016 8:43:07 PM] [DEBUG] [Telescope Thread] Performing auto center step 2... [8/9/2016 8:43:07 PM] [DEBUG] [Telescope Thread] Created full file name (file does not exist): C:\Users\admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [8/9/2016 8:43:07 PM] [DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE message received... [8/9/2016 8:43:07 PM] [DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [8/9/2016 8:43:07 PM] [DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [8/9/2016 8:43:08 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:43:08 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:43:17 PM] [DEBUG] [Camera Thread] QSI expose and download: 9.3125327s [8/9/2016 8:43:17 PM] [DEBUG] [Camera Thread] Created full file name (file does not exist): C:\Users\admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [8/9/2016 8:43:17 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [8/9/2016 8:43:17 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [8/9/2016 8:43:17 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [8/9/2016 8:43:17 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [8/9/2016 8:43:17 PM] [DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [8/9/2016 8:43:17 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [8/9/2016 8:43:17 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [8/9/2016 8:43:17 PM] [DEBUG] [Telescope Thread] Capture complete, attempting to plate solve image C:\Users\admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [8/9/2016 8:43:17 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:43:17 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:43:17 PM] [DEBUG] [Camera Thread] =========== Save file took 261 ms [8/9/2016 8:43:17 PM] [DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE complete... [8/9/2016 8:43:17 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: RA (HRS) - 20.8266844978487 [8/9/2016 8:43:17 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: RA (RAD) - 5.45241325142283 [8/9/2016 8:43:17 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: DEC (DEG) - 31.6458360013097 [8/9/2016 8:43:17 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: DEC (RAD) - 0.552324032769011 [8/9/2016 8:43:17 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: SCALE - 8.38604 [8/9/2016 8:43:17 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: Width - 831 [8/9/2016 8:43:17 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: Height - 626 [8/9/2016 8:43:17 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: Regions - 999 [8/9/2016 8:43:17 PM] [DEBUG] [Telescope Thread] PlateSolve2 Command Line: [8/9/2016 8:43:17 PM] [DEBUG] [Telescope Thread] C:\Users\admin\AppData\Local\SequenceGenerator\\PlateSolve2.exe 5.45241325142283,0.55232403276901,0.03378569212458,0.02545107493380,999,C:\Users\admin\AppData\Local\SequenceGenerator\\Temp\psXSolve_0.fit [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Auto Center scope frame solved successfully... [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Telescope: Syncing to J2000 RA: 20.8327572338873 Dec: 31.6511110650768 [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Telescope Sync: Passed in J2000 but mount requires JNOW, converting... [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Telescope: Syncing to JNOW RA: 20.8445764242337 Dec: 31.716764806077 [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Attempting to write fits header info for C:\Users\admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Opening fits file... [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Successfully opened fits file... [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Writing fits headers... [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Closing fits file [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Syncing the rotator to 300.23 degrees... [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Performing auto center step 3 (scope)... [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Auto center slewing scope to match reference... [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Telescope: Slewing to J2000 RA: 20.8266666666667 (20h49m36.00s) Dec: 31.6463888888889 (31°38'47.00") [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Telescope: Slew received J2000 coordinates, mount requires JNOW, converting... [8/9/2016 8:43:19 PM] [DEBUG] [Telescope Thread] Telescope: Slewing to JNOW RA: 20.8384821019282 Dec: 31.7119416731843 [8/9/2016 8:43:22 PM] [DEBUG] [Telescope Thread] Scope reports it is done with synchronous slew, verifying... [8/9/2016 8:43:22 PM] [DEBUG] [Telescope Thread] Telescope: Slewing has completed [8/9/2016 8:43:22 PM] [DEBUG] [Telescope Thread] Telescope: Settling for 1 seconds [8/9/2016 8:43:23 PM] [DEBUG] [Telescope Thread] Telescope: Settling has completed [8/9/2016 8:43:23 PM] [DEBUG] [Telescope Thread] Auto center slew complete... [8/9/2016 8:43:23 PM] [DEBUG] [Telescope Thread] Performing auto center step 4... [8/9/2016 8:43:23 PM] [DEBUG] [Telescope Thread] Created full file name (file does not exist): C:\Users\admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [8/9/2016 8:43:23 PM] [DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE message received... [8/9/2016 8:43:23 PM] [DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [8/9/2016 8:43:23 PM] [DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [8/9/2016 8:43:23 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:43:23 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:43:33 PM] [DEBUG] [Camera Thread] QSI expose and download: 9.3135327s [8/9/2016 8:43:33 PM] [DEBUG] [Camera Thread] Created full file name (file does not exist): C:\Users\admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [8/9/2016 8:43:33 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [8/9/2016 8:43:33 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [8/9/2016 8:43:33 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [8/9/2016 8:43:33 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [8/9/2016 8:43:33 PM] [DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [8/9/2016 8:43:33 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [8/9/2016 8:43:33 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [8/9/2016 8:43:33 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:43:33 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:43:33 PM] [DEBUG] [Camera Thread] =========== Save file took 224 ms [8/9/2016 8:43:33 PM] [DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE complete... [8/9/2016 8:43:51 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [8/9/2016 8:43:51 PM] [DEBUG] [MF Update Thread] Performing serialize... [8/9/2016 8:47:26 PM] [DEBUG] [Telescope Thread] Aborting solver frame. Time out! [8/9/2016 8:47:26 PM] [DEBUG] [Telescope Thread] Aborting auto center... [8/9/2016 8:47:26 PM] [DEBUG] [Telescope Thread] Auto center aborted, closing centering dialog... [8/9/2016 8:47:38 PM] [DEBUG] [Telescope Thread] SGM_TELESCOPE_SOLVE message received... [8/9/2016 8:47:38 PM] [DEBUG] [Telescope Thread] Telescope solve with plate solver PlateSolve2... [8/9/2016 8:47:38 PM] [DEBUG] [Telescope Thread] Setting filter for scope sync... [8/9/2016 8:47:38 PM] [DEBUG] [Telescope Thread] Setting filter position 4... [8/9/2016 8:47:38 PM] [DEBUG] [Telescope Thread] Filter position 4 is already set. Skipping... [8/9/2016 8:47:38 PM] [DEBUG] [Telescope Thread] Plate solving scope frame... [8/9/2016 8:47:38 PM] [DEBUG] [Telescope Thread] Created full file name: C:\Users\admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image-1.fit [8/9/2016 8:47:38 PM] [DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE message received... [8/9/2016 8:47:38 PM] [DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [8/9/2016 8:47:38 PM] [DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [8/9/2016 8:47:38 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:47:38 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:47:47 PM] [DEBUG] [Camera Thread] QSI expose and download: 9.3105326s [8/9/2016 8:47:47 PM] [DEBUG] [Camera Thread] Created full file name: C:\Users\admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image-1.fit [8/9/2016 8:47:47 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [8/9/2016 8:47:47 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [8/9/2016 8:47:47 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [8/9/2016 8:47:47 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [8/9/2016 8:47:47 PM] [DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [8/9/2016 8:47:47 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [8/9/2016 8:47:47 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [8/9/2016 8:47:47 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:47:47 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:47:47 PM] [DEBUG] [Camera Thread] =========== Save file took 243 ms [8/9/2016 8:47:47 PM] [DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE complete... [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] FitsFileHeaderData: Angle - 0 [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] FitsFileHeaderData: Scale - 0 [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] FitsFileHeaderData: RA - 20.8266567945137 [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] FitsFileHeaderData: DEC - 31.6463915912935 [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: RA (HRS) - 20.8266567945137 [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: RA (RAD) - 5.45240599870669 [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: DEC (DEG) - 31.6463915912935 [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: DEC (RAD) - 0.552333729643519 [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: SCALE - 8.38159 [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: Width - 831 [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: Height - 626 [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: Regions - 999 [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] PlateSolve2 Command Line: [8/9/2016 8:47:47 PM] [DEBUG] [Telescope Thread] C:\Users\admin\AppData\Local\SequenceGenerator\\PlateSolve2.exe 5.45240599870669,0.55233372964352,0.03376776395706,0.02543756947908,999,C:\Users\admin\AppData\Local\SequenceGenerator\\Temp\psXSolve_1.fit [8/9/2016 8:47:49 PM] [DEBUG] [Telescope Thread] Plate solving scope frame successful, scope is synced, writing FITs header info... [8/9/2016 8:47:49 PM] [DEBUG] [Telescope Thread] Telescope: Syncing to J2000 RA: 20.8266463716219 Dec: 31.6480165200253 [8/9/2016 8:47:49 PM] [DEBUG] [Telescope Thread] Telescope Sync: Passed in J2000 but mount requires JNOW, converting... [8/9/2016 8:47:49 PM] [DEBUG] [Telescope Thread] Telescope: Syncing to JNOW RA: 20.8384616277715 Dec: 31.7135691919068 [8/9/2016 8:47:49 PM] [DEBUG] [Telescope Thread] Attempting to write fits header info for C:\Users\admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image-1.fit [8/9/2016 8:47:49 PM] [DEBUG] [Telescope Thread] Opening fits file... [8/9/2016 8:47:49 PM] [DEBUG] [Telescope Thread] Successfully opened fits file... [8/9/2016 8:47:49 PM] [DEBUG] [Telescope Thread] Writing fits headers... [8/9/2016 8:47:49 PM] [DEBUG] [Telescope Thread] Closing fits file [8/9/2016 8:47:49 PM] [DEBUG] [Telescope Thread] Syncing the rotator to 300.27 degrees... [8/9/2016 8:47:55 PM] [DEBUG] [Telescope Thread] Scope solve complete... [8/9/2016 8:47:55 PM] [DEBUG] [Telescope Thread] SGM_TELESCOPE_SOLVE message complete... [8/9/2016 8:48:47 PM] [DEBUG] [Telescope Thread] Center telescope message received... [8/9/2016 8:48:47 PM] [DEBUG] [Telescope Thread] Solving with Plate Solver PlateSolve2... [8/9/2016 8:48:47 PM] [DEBUG] [Telescope Thread] Setting filter for auto center... [8/9/2016 8:48:47 PM] [DEBUG] [Telescope Thread] Setting filter position 4... [8/9/2016 8:48:47 PM] [DEBUG] [Telescope Thread] Filter position 4 is already set. Skipping... [8/9/2016 8:48:47 PM] [DEBUG] [Telescope Thread] Performing auto center step 1... [8/9/2016 8:48:47 PM] [DEBUG] [Telescope Thread] Skipping step 1... [8/9/2016 8:48:47 PM] [DEBUG] [Telescope Thread] Auto center reference frame solved successfully... [8/9/2016 8:48:47 PM] [DEBUG] [Telescope Thread] Performing auto center step 2... [8/9/2016 8:48:47 PM] [DEBUG] [Telescope Thread] Created full file name: C:\Users\admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image-1.fit [8/9/2016 8:48:47 PM] [DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE message received... [8/9/2016 8:48:47 PM] [DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [8/9/2016 8:48:47 PM] [DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [8/9/2016 8:48:47 PM] [DEBUG] [Camera Thread] ASCOM (QSI) Camera: setting gain to LOW... [8/9/2016 8:48:47 PM] [DEBUG] [Camera Thread] ASCOM (QSI) camera: setting normal speed readout... [8/9/2016 8:48:56 PM] [DEBUG] [Camera Thread] QSI expose and download: 9.3125327s [8/9/2016 8:48:56 PM] [DEBUG] [Camera Thread] Created full file name: C:\Users\admin\AppData\Local\SequenceGenerator\Temp\plate_solve_image-1.fit [8/9/2016 8:48:56 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [8/9/2016 8:48:56 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [8/9/2016 8:48:56 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [8/9/2016 8:48:56 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [8/9/2016 8:48:56 PM] [DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [8/9/2016 8:48:56 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [8/9/2016 8:48:56 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [8/9/2016 8:48:56 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [8/9/2016 8:48:56 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [8/9/2016 8:48:56 PM] [DEBUG] [Camera Thread] =========== Save file took 204 ms [8/9/2016 8:48:56 PM] [DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE complete... [8/9/2016 8:49:03 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [8/9/2016 8:49:03 PM] [DEBUG] [MF Update Thread] Performing serialize... [8/9/2016 8:52:50 PM] [DEBUG] [Telescope Thread] Aborting solver frame. Time out! [8/9/2016 8:52:50 PM] [DEBUG] [Telescope Thread] Aborting auto center... [8/9/2016 8:52:50 PM] [DEBUG] [Telescope Thread] Auto center aborted, closing centering dialog... [8/9/2016 8:53:08 PM] [DEBUG] [Sequence Thread] Dispatch loop: Received SGM_TERMINATE... [8/9/2016 8:53:12 PM] [DEBUG] [Main Thread] Disconnecting ASCOM (QSI) camera: QSI CCD Camera... [8/9/2016 8:53:12 PM] [DEBUG] [Main Thread] Error while disconencting all equipment: Value cannot be null. [8/9/2016 8:53:12 PM] [DEBUG] [Auto Guider Thread] Auto Guider Dispatch loop: Received SGM_TERMINATE... [8/9/2016 8:53:12 PM] [DEBUG] [Telescope Thread] Telescope Dispatch loop: Received SGM_TERMINATE... [8/9/2016 8:53:12 PM] [DEBUG] [Camera Thread] Camera Dispatch loop: Received SGM_TERMINATE... [8/9/2016 8:53:12 PM] [DEBUG] [TEC Thread] TEC Dispatch loop: Received SGM_TERMINATE... [8/9/2016 8:53:12 PM] [DEBUG] [Filter Wheel Thread] Filter Wheel Dispatch loop: Received SGM_TERMINATE... [8/9/2016 8:53:12 PM] [DEBUG] [Focuser Thread] Focuser Dispatch loop: Received SGM_TERMINATE... [8/9/2016 8:53:12 PM] [DEBUG] [Main Thread] Performing clean up...