[9/28/2016 10:02:22 PM] [DEBUG] [Main Thread] Licensing: Machine ID found... [9/28/2016 10:02:22 PM] [DEBUG] [Main Thread] Checking for valid internet connection... [9/28/2016 10:02:23 PM] [DEBUG] [Main Thread] Valid internet connection detected... [9/28/2016 10:02:24 PM] [DEBUG] [Main Thread] Licensing: Request for licenses successful, writing cookie... [9/28/2016 10:02:24 PM] [DEBUG] [Main Thread] Licensing: Applying licenses.. [9/28/2016 10:02:24 PM] [DEBUG] [Main Thread] Licensing: Licenses applied.. [9/28/2016 10:02:24 PM] [DEBUG] [Main Thread] SGPro retail license... [9/28/2016 10:02:25 PM] [DEBUG] [Main Thread] API successfully started on port 59590... [9/28/2016 10:02:26 PM] [DEBUG] [Main Thread] Error loading notification settings! Could not find file 'C:\Users\Home\AppData\Local\SequenceGenerator\Sequence Generator Pro\notifications.sgd'. [9/28/2016 10:02:26 PM] [DEBUG] [Main Thread] Error loading GNS endpoint settings! Could not find file 'C:\Users\Home\AppData\Local\SequenceGenerator\Sequence Generator Pro\gnsSettings.sgd'. [9/28/2016 10:02:26 PM] [DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\Home\AppData\Local\SequenceGenerator\Sequence Generator Pro\1-emailEndpointAddresses.sgd'. [9/28/2016 10:02:26 PM] [DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\Home\AppData\Local\SequenceGenerator\Sequence Generator Pro\2-emailEndpointAddresses.sgd'. [9/28/2016 10:02:26 PM] [DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\Home\AppData\Local\SequenceGenerator\Sequence Generator Pro\3-emailEndpointAddresses.sgd'. [9/28/2016 10:02:26 PM] [DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Home\AppData\Local\SequenceGenerator\Sequence Generator Pro\1-textFileEndpointSettings.sgd'. [9/28/2016 10:02:26 PM] [DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Home\AppData\Local\SequenceGenerator\Sequence Generator Pro\2-textFileEndpointSettings.sgd'. [9/28/2016 10:02:26 PM] [DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Home\AppData\Local\SequenceGenerator\Sequence Generator Pro\3-textFileEndpointSettings.sgd'. [9/28/2016 10:02:27 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) ===== [9/28/2016 10:02:27 PM] [DEBUG] [Main Thread] OS: Microsoft Windows 8.1 Pro with Media Center [9/28/2016 10:02:27 PM] [DEBUG] [Focuser Thread] Entering Fouser message dispatch loop... [9/28/2016 10:02:27 PM] [DEBUG] [TEC Thread] Entering TEC message dispatch loop... [9/28/2016 10:02:27 PM] [DEBUG] [Camera Thread] Entering camera message dispatch loop... [9/28/2016 10:02:27 PM] [DEBUG] [Filter Wheel Thread] Entering Filter Wheel message dispatch loop... [9/28/2016 10:02:28 PM] [DEBUG] [Rotator Thread] Entering Rotator message dispatch loop... [9/28/2016 10:02:28 PM] [DEBUG] [Auto Guider Error Thread] Entering Auto Guider message dispatch loop... [9/28/2016 10:02:28 PM] [DEBUG] [Auto Guider Thread] Entering Auto Guider message dispatch loop... [9/28/2016 10:02:28 PM] [DEBUG] [Dome Thread] Entering Dome message dispatch loop... [9/28/2016 10:02:28 PM] [DEBUG] [Safety Thread] Starting safety monitor... [9/28/2016 10:02:28 PM] [DEBUG] [Environment Device Thread] Starting environment device monitor... [9/28/2016 10:02:28 PM] [DEBUG] [Telescope Thread] Entering Telescope message dispatch loop... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] Settings changed (or loaded)... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiAutoStretch = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingIgLastFileFolder = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingFormScaleWarning = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingRecoveryDuration = 90 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGLpt2Address = 278 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingFliFlushLow = 0 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGLpt1Address = 378 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiMouseAction = Stretch [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomCamera = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingTemperhumInterval = 300 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingASCOMWarningShown = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingPlateCamScale = 0 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingCanonMirrorSettle = 0 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingInterface = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomFilterWheel = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingAstroArtDisplayInstructions = True [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiPhdZoom = 40 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiLastImageDir = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingTemperHumUserTempComp = 0 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingCaptureCalFramesAlways = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingDelayFirst = 0 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingFliNormalSpeedMode = 0 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingFliHighSpeedMode = 0 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMfPosition = {X=0,Y=0} [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSoundAttention = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingPinpointCatalog = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingCameraOverhead = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingPlateSolveOn = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingAstrometryNetEndpointList = System.Collections.Specialized.StringCollection [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGGuider = None [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingQSIFanSpeed = 2 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingNaggerText = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiPhdDisplay = RA/Dec [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiShowToolStrip = True [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiShowCrosshairs = True [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: WindowGeometry = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingIgRenameStringLocation = 2 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingIgSubFolders = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: WindowGeometrySearch = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingOffset = -1 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingAutoStretchLevel = Low [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingTemperHumUnits = C [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingProfileDirectory = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingBasename = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingHfrColor = Color [RoyalBlue] [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingNikonAfBinning = 1 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGFanOffWithTec = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomSafetyMonitor = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiSize = {Width=800, Height=600} [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingIgCopyAndRenameFiles = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSimDownloadTimesAf = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingNagger = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingImportFromCfw = True [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiShowStatusTrip = True [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingShowTooltipHelp = True [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingLastUpdateCheck = 1/1/2012 12:00:00 AM [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingCpPosition = {X=0,Y=0} [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGCfwPort = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiLocation = {X=0,Y=0} [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingIgLastCsvFolder = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingPlateSolve3Catalogs = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGFilterWheel = Auto Detect [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGConnection = USB [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingDSLRSoftwareBinForAf = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingAutoSave = True [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingFirstTime = True [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingAutoRecoveryActive = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiState = maximized [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingUseSequenceOptions = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSoundCompleted = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingTrialExpiredShown = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingTemperHumColor = Grey [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingDataDirectory = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingCanonFileFormat = Single Image (CFA FITS) [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingAlnitakComPort = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingIgRenameFiles = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingPhd2InstallPath = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSubFolder = True [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingLastSGSaveFolder = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingNikonDataFormat = FITS [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingPlaySounds = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingLastNikonType = Auto Connect [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingLastSequenceStart = 1/1/0001 12:00:00 AM [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomTelescope = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiPhdScale = 100 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingIgRenameType = 0 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingTemperHumUserHumidityComp = 0 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiPhdRaColor = Color [Blue] [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingLastImageSaveFolder = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingIgOverwriteExisting = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingFinishFullEvent = True [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMosaicOverlap = 20 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingQSIFanOffWithTec = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingRecentSequences = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingDefaultDirectory = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiPhdDecColor = Color [Red] [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingAstrometryNetEndpoint = Astrometry.NET (Remote) [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingFliFlushHigh = 0 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingStarsColor = Color [OrangeRed] [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGLpt3Address = 3BC [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomFocuser = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingIgLastFolder = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: WindowGeometryOpen = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingNumEvents = 5 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingDelayBetween = 0 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingCanonAfBinning = 1 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingPlateCamBlank = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingNikonUseBulbModeAlways = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingTempFiles = C:\Temp [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingFliHighSpeedDesc = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGCfwUseRS232 = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingRecoveryInterval = 10 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingEnableImageHistory = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGEthernetIP = 0.0.0.0 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingFliNormalSpeedDesc = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingIgCopyLocation = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSBIGAutoDetectIp = True [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingAstroArtStartApp = True [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingSimDownloadTimesPlate = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMicroTouchLocation = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingEventAlwaysVisible = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingMdiNewWindow = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingTrialQuestionsAsked = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingFliRbiMitigation = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingGain = -1 [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomDome = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingLookForTemperDevices = False [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingLastAscomRotator = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] * SETTING: settingAfTestPackPath = [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] ASCOM Observing Conditions Hub (OCH) [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] ASCOM Observing Conditions Simulator [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] OpenWeatherMap ObservingConditions [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] TEMPerHUM [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] Performing initialization... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] Creating new sequence with default profile: ZWO 178 Mono [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] Performing full form reset (with profile ZWO 178 Mono)... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] Retreiving new equipment objects... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] New camera object (ASI Camera (1)) dispatched... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] New filter wheel object (Manual Filter Wheel) dispatched... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] New environment device object (No Environment Device) dispatched... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] New focuser object (FocusLynx Focuser 1) dispatched... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] New telescope object (EQMOD ASCOM HEQ5/6) dispatched... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] New rotator object (No Rotator) dispatched... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] New dome object (No Observatory) dispatched... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] New auto guider object (PHD2) dispatched... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] No change in plate solver object... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] Populating the form controls... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] Added row 0... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] Added row 1... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] Added row 2... [9/28/2016 10:02:28 PM] [DEBUG] [Main Thread] Added row 3... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] Added row 4... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] Loading custom filter names... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] Retreiving new equipment objects... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] No change in camera object... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] No change in filter wheel object... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] New environment device object (No Environment Device) dispatched... [9/28/2016 10:02:29 PM] [DEBUG] [Sequence Thread] Entering sequence message dispatch loop... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] No change in focuser object... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] MoveFocuserAbs: Error! The focuser is no longer connected! [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] No change in telescope object... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] New rotator object (No Rotator) dispatched... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] New dome object (No Observatory) dispatched... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] New auto guider object (PHD2) dispatched... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] No change in plate solver object... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] Checking if version check is required... [9/28/2016 10:02:29 PM] [DEBUG] [Cleaner Thread] Running cleanup... [9/28/2016 10:02:29 PM] [DEBUG] [Main Thread] UI layout found, loading layout at C:\Users\Home\AppData\Local\SequenceGenerator\sg_ui_config.xml [9/28/2016 10:02:29 PM] [DEBUG] [Cleaner Thread] Cleaning 8 files in directory C:\Users\Home\AppData\Local\SequenceGenerator\Temp\... [9/28/2016 10:02:29 PM] [DEBUG] [Cleaner Thread] Cleaning multi camera registration file... [9/28/2016 10:02:29 PM] [DEBUG] [Cleaner Thread] Cleaning finished... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] Performing deserialize... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] Loading custom filter names... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] ReflectDataModel: Transferring data model to the view... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] Retreiving new equipment objects... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] New camera object (QHY8L-StarSenseSci) dispatched... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] New filter wheel object (No Filter Wheel) dispatched... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] New environment device object (No Environment Device) dispatched... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] No change in focuser object... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] MoveFocuserAbs: Error! The focuser is no longer connected! [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] No change in telescope object... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] New rotator object (No Rotator) dispatched... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] New dome object (No Observatory) dispatched... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] New auto guider object (PHD2) dispatched... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] No change in plate solver object... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] Populating the form controls... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] Added row 0... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] Added row 1... [9/28/2016 10:02:39 PM] [DEBUG] [Main Thread] Added row 2... [9/28/2016 10:02:40 PM] [DEBUG] [Main Thread] Added row 3... [9/28/2016 10:02:40 PM] [DEBUG] [Main Thread] Added row 4... [9/28/2016 10:02:40 PM] [DEBUG] [Main Thread] Populating the form controls... [9/28/2016 10:02:40 PM] [DEBUG] [Main Thread] Added row 0... [9/28/2016 10:02:40 PM] [DEBUG] [Main Thread] Added row 1... [9/28/2016 10:02:40 PM] [DEBUG] [Main Thread] Added row 2... [9/28/2016 10:02:40 PM] [DEBUG] [Main Thread] Added row 3... [9/28/2016 10:02:40 PM] [DEBUG] [Main Thread] Added row 4... [9/28/2016 10:02:49 PM] [DEBUG] [Telescope Thread] Telescope Dispatch loop: Received SGM_TELESCOPE_CONNECT... [9/28/2016 10:02:49 PM] [DEBUG] [Telescope Thread] Telescope can slewing supported... [9/28/2016 10:02:49 PM] [DEBUG] [Telescope Thread] Telescope: Implements MoveAxis... [9/28/2016 10:02:49 PM] [DEBUG] [Telescope Thread] RA Move Rate Range: Min->0 Max->3.34245933333333 [9/28/2016 10:02:49 PM] [DEBUG] [Telescope Thread] DEC Move Rate Range: Min->0 Max->3.34245933333333 [9/28/2016 10:02:49 PM] [DEBUG] [Telescope Thread] Telescope: CanSetSideOfPier returned False [9/28/2016 10:02:49 PM] [DEBUG] [Telescope Thread] Telescope: CanPark returned True [9/28/2016 10:02:49 PM] [DEBUG] [Telescope Thread] Telescope equatorial system is J2000... [9/28/2016 10:02:49 PM] [DEBUG] [Telescope Thread] SGM_TELESCOPE_CONNECT complete... [9/28/2016 10:02:49 PM] [DEBUG] [Main Thread] Connecting ASCOM focuser... [9/28/2016 10:02:50 PM] [DEBUG] [Main Thread] Focuser supports temperature [9/28/2016 10:02:50 PM] [DEBUG] [Main Thread] Current temperature reports: 20.7 [9/28/2016 10:02:50 PM] [DEBUG] [Main Thread] Focuser reports Max Increment as: 65535 [9/28/2016 10:02:50 PM] [DEBUG] [Main Thread] Focuser reports max steps as: 65535 [9/28/2016 10:02:50 PM] [DEBUG] [Main Thread] Connecting camera in main thread... [9/28/2016 10:02:50 PM] [DEBUG] [Main Thread] Connecting ASCOM camera: ASCOM.QHY8L.Camera... [9/28/2016 10:02:51 PM] [DEBUG] [Main Thread] Failed to get ExposureMin from camera. : Property read ASCOM.QHY8L.Camera ExposureMin is not implemented in this driver. (System.Runtime.InteropServices.COMException (0x80020006): Unknown name. (Exception from HRESULT: 0x80020006 (DISP_E_UNKNOWNNAME)) 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 263 at ASCOM.DriverAccess.Camera.get_ExposureMin() in c:\ASCOM Build\Export\ASCOM.DriverAccess\Camera.cs:line 729 at fa.aw() [9/28/2016 10:02:51 PM] [DEBUG] [TEC Thread] SGM_CHANGE_COOLER_TEMP message received... [9/28/2016 10:02:51 PM] [DEBUG] [TEC Thread] TEC Change: Starting... [9/28/2016 10:02:51 PM] [DEBUG] [TEC Thread] TEC Change: After camera connect change, waiting ~5 seconds... [9/28/2016 10:02:56 PM] [DEBUG] [TEC Thread] TEC Change: Attempting to turn the camera cooler on... [9/28/2016 10:02:56 PM] [DEBUG] [Main Thread] Turning camera cooler on... [9/28/2016 10:02:56 PM] [DEBUG] [Main Thread] Slewing to target... [9/28/2016 10:02:56 PM] [DEBUG] [Telescope Thread] Slew telescope message received... [9/28/2016 10:02:56 PM] [DEBUG] [Slew Monitor] Waiting for slew to complete... [9/28/2016 10:02:56 PM] [DEBUG] [CP Update Thread] Error in control panel UI updater: Object reference not set to an instance of an object. [9/28/2016 10:02:56 PM] [DEBUG] [Telescope Thread] Telescope: Slewing to J2000 RA: 21.2203694444444 (21h13m13.33s) Dec: 60.1685833333333 (60°10'06.90") [9/28/2016 10:02:56 PM] [DEBUG] [Main Thread] Turning camera cooler on... [9/28/2016 10:03:01 PM] [DEBUG] [TEC Thread] TEC Change: Changing temp from -9.93 to -10.00 in 600 seconds... [9/28/2016 10:03:53 PM] [DEBUG] [Telescope Thread] Scope reports it is done with synchronous slew, verifying... [9/28/2016 10:03:53 PM] [DEBUG] [Telescope Thread] Telescope: Slewing has completed [9/28/2016 10:03:53 PM] [DEBUG] [Telescope Thread] Telescope: Settling for 20 seconds [9/28/2016 10:04:00 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [9/28/2016 10:04:00 PM] [DEBUG] [MF Update Thread] Performing serialize... [9/28/2016 10:04:13 PM] [DEBUG] [Telescope Thread] Telescope: Settling has completed [9/28/2016 10:04:13 PM] [DEBUG] [Telescope Thread] Slew complete... [9/28/2016 10:04:16 PM] [DEBUG] [Telescope Thread] Center telescope message received... [9/28/2016 10:04:16 PM] [DEBUG] [Telescope Thread] Solving with Plate Solver PlateSolve2... [9/28/2016 10:04:16 PM] [DEBUG] [Telescope Thread] Performing auto center step 1... [9/28/2016 10:04:16 PM] [DEBUG] [Telescope Thread] Skipping step 1... [9/28/2016 10:04:16 PM] [DEBUG] [Telescope Thread] Auto center reference frame solved successfully... [9/28/2016 10:04:16 PM] [DEBUG] [Telescope Thread] Performing auto center step 2... [9/28/2016 10:04:16 PM] [DEBUG] [Telescope Thread] Created full file name (file does not exist): C:\Users\Home\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [9/28/2016 10:04:16 PM] [DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE message received... [9/28/2016 10:04:16 PM] [DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [9/28/2016 10:04:16 PM] [DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [9/28/2016 10:04:16 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:04:16 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] Created full file name (file does not exist): C:\Users\Home\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileAscom: Validating file name... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:04:29 PM] [DEBUG] [Telescope Thread] Capture complete, attempting to plate solve image C:\Users\Home\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileAscom: Saving preview bitmap to disk... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:04:29 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:04:30 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:04:30 PM] [DEBUG] [Camera Thread] =========== Save file took 651 ms [9/28/2016 10:04:30 PM] [DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE complete... [9/28/2016 10:04:30 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: RA (HRS) - 21.2207019744562 [9/28/2016 10:04:30 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: RA (RAD) - 5.55556678558082 [9/28/2016 10:04:30 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: DEC (DEG) - 60.1685904255319 [9/28/2016 10:04:30 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: DEC (RAD) - 1.05014000920947 [9/28/2016 10:04:30 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: SCALE - 6.63692 [9/28/2016 10:04:30 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: Width - 1664 [9/28/2016 10:04:30 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: Height - 1015 [9/28/2016 10:04:30 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: Regions - 999 [9/28/2016 10:04:30 PM] [DEBUG] [Telescope Thread] PlateSolve2 Command Line: [9/28/2016 10:04:30 PM] [DEBUG] [Telescope Thread] C:\Users\Home\AppData\Local\SequenceGenerator\\PlateSolve2.exe 5.55556678558082,1.05014000920947,0.05354202241739,0.03265934660676,999,C:\Users\Home\AppData\Local\SequenceGenerator\\Temp\psXSolve_0.fit [9/28/2016 10:04:35 PM] [DEBUG] [Telescope Thread] Auto Center scope frame solved successfully... [9/28/2016 10:04:35 PM] [DEBUG] [Telescope Thread] Telescope: Syncing to J2000 RA: 21.2708791522166 Dec: 59.9074890199226 [9/28/2016 10:04:35 PM] [DEBUG] [Telescope Thread] Attempting to write fits header info for C:\Users\Home\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [9/28/2016 10:04:35 PM] [DEBUG] [Telescope Thread] Opening fits file... [9/28/2016 10:04:35 PM] [DEBUG] [Telescope Thread] Successfully opened fits file... [9/28/2016 10:04:35 PM] [DEBUG] [Telescope Thread] Writing fits headers... [9/28/2016 10:04:35 PM] [DEBUG] [Telescope Thread] Closing fits file [9/28/2016 10:04:35 PM] [DEBUG] [Telescope Thread] Failed to sync the rotator to 89.72 degrees, not connected! [9/28/2016 10:04:35 PM] [DEBUG] [Telescope Thread] Performing auto center step 3 (scope)... [9/28/2016 10:04:35 PM] [DEBUG] [Telescope Thread] Auto center slewing scope to match reference... [9/28/2016 10:04:35 PM] [DEBUG] [Telescope Thread] Telescope: Slewing to J2000 RA: 21.2203694444444 (21h13m13.33s) Dec: 60.1685833333333 (60°10'06.90") [9/28/2016 10:04:40 PM] [DEBUG] [Telescope Thread] Scope reports it is done with synchronous slew, verifying... [9/28/2016 10:04:40 PM] [DEBUG] [Telescope Thread] Telescope: Slewing has completed [9/28/2016 10:04:40 PM] [DEBUG] [Telescope Thread] Telescope: Settling for 20 seconds [9/28/2016 10:05:00 PM] [DEBUG] [Telescope Thread] Telescope: Settling has completed [9/28/2016 10:05:00 PM] [DEBUG] [Telescope Thread] Auto center slew complete... [9/28/2016 10:05:00 PM] [DEBUG] [Telescope Thread] Performing auto center step 4... [9/28/2016 10:05:00 PM] [DEBUG] [Telescope Thread] Created full file name (file does not exist): C:\Users\Home\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [9/28/2016 10:05:00 PM] [DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE message received... [9/28/2016 10:05:00 PM] [DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [9/28/2016 10:05:00 PM] [DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [9/28/2016 10:05:00 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:05:00 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] Created full file name (file does not exist): C:\Users\Home\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileAscom: Validating file name... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileAscom: Saving preview bitmap to disk... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [9/28/2016 10:05:13 PM] [DEBUG] [Telescope Thread] Auto center verification frame complete. Plate solving image C:\Users\Home\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] =========== Save file took 447 ms [9/28/2016 10:05:13 PM] [DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE complete... [9/28/2016 10:05:13 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: RA (HRS) - 21.2203982542471 [9/28/2016 10:05:13 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: RA (RAD) - 5.55548727181604 [9/28/2016 10:05:13 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: DEC (DEG) - 60.1685904255319 [9/28/2016 10:05:13 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: DEC (RAD) - 1.05014000920947 [9/28/2016 10:05:13 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: SCALE - 6.63692 [9/28/2016 10:05:13 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: Width - 1664 [9/28/2016 10:05:13 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: Height - 1015 [9/28/2016 10:05:13 PM] [DEBUG] [Telescope Thread] PlateSove2 Param: Regions - 999 [9/28/2016 10:05:13 PM] [DEBUG] [Telescope Thread] PlateSolve2 Command Line: [9/28/2016 10:05:13 PM] [DEBUG] [Telescope Thread] C:\Users\Home\AppData\Local\SequenceGenerator\\PlateSolve2.exe 5.55548727181604,1.05014000920947,0.05354202241739,0.03265934660676,999,C:\Users\Home\AppData\Local\SequenceGenerator\\Temp\psXSolve_1.fit [9/28/2016 10:05:19 PM] [DEBUG] [Telescope Thread] Auto center validation frame solved successfully... [9/28/2016 10:05:19 PM] [DEBUG] [Telescope Thread] Telescope: Syncing to J2000 RA: 21.2212733830467 Dec: 60.1670698408378 [9/28/2016 10:05:19 PM] [DEBUG] [Telescope Thread] Attempting to write fits header info for C:\Users\Home\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [9/28/2016 10:05:19 PM] [DEBUG] [Telescope Thread] Opening fits file... [9/28/2016 10:05:19 PM] [DEBUG] [Telescope Thread] Successfully opened fits file... [9/28/2016 10:05:19 PM] [DEBUG] [Telescope Thread] Writing fits headers... [9/28/2016 10:05:19 PM] [DEBUG] [Telescope Thread] Closing fits file [9/28/2016 10:05:19 PM] [DEBUG] [Telescope Thread] Failed to sync the rotator to 90.36 degrees, not connected! [9/28/2016 10:05:19 PM] [DEBUG] [Telescope Thread] Auto center complete... [9/28/2016 10:05:19 PM] [DEBUG] [Center Scope Thread] Automatic Auto Center Success - Total Error <= Allowable error: 14.8 <= 75.0 [9/28/2016 10:05:19 PM] [DEBUG] [Center Scope Thread] RA Error: -14.7 [9/28/2016 10:05:19 PM] [DEBUG] [Center Scope Thread] DEC Error: 1.6 [9/28/2016 10:05:27 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [9/28/2016 10:05:27 PM] [DEBUG] [MF Update Thread] Performing serialize... [9/28/2016 10:05:29 PM] [DEBUG] [Main Thread] Centering: User abort... [9/28/2016 10:06:40 PM] [DEBUG] [Main Thread] Camera is not connected. Sending connect command... [9/28/2016 10:06:40 PM] [DEBUG] [Main Thread] Connecting camera in main thread... [9/28/2016 10:06:40 PM] [DEBUG] [Main Thread] Focuser is required... [9/28/2016 10:06:40 PM] [DEBUG] [Main Thread] Focuser is still connected. Ignoring connect step... [9/28/2016 10:06:40 PM] [DEBUG] [Main Thread] Telescope is required... [9/28/2016 10:06:40 PM] [DEBUG] [Main Thread] Telescope is still connected. Ignoring connect step... [9/28/2016 10:06:40 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [9/28/2016 10:06:40 PM] [DEBUG] [Main Thread] GNS Startup... [9/28/2016 10:06:40 PM] [DEBUG] [Sequence Thread] Dispatch loop: Received SGM_RUN_SEQUENCE... [9/28/2016 10:06:40 PM] [DEBUG] [Sequence Thread] GuiderCheck: Checking auto guider status... [9/28/2016 10:06:40 PM] [DEBUG] [Sequence Thread] GuiderCheck: Auto guider is not connected, attempting to connect... [9/28/2016 10:06:40 PM] [DEBUG] [Sequence Thread] GuiderCheck: Starting guider and connecting guider equipment for guider profile... [9/28/2016 10:06:40 PM] [DEBUG] [Auto Guider Equipment Connection Thread] PHD2: PHD2 is already open... [9/28/2016 10:06:40 PM] [DEBUG] [Auto Guider Equipment Connection Thread] Connecting to PHD2... [9/28/2016 10:06:40 PM] [DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [9/28/2016 10:06:40 PM] [DEBUG] [PHD2 Listener Thread] Attempting to connect to PHD2... [9/28/2016 10:06:41 PM] [DEBUG] [Auto Guider Equipment Connection Thread] Successfully connected to PHD2... [9/28/2016 10:06:41 PM] [DEBUG] [Auto Guider Equipment Connection Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:41 PM] [DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:41 PM] [DEBUG] [Auto Guider Equipment Connection Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:41 PM] [DEBUG] [Auto Guider Equipment Connection Thread] PHD2: PHD2 is already open... [9/28/2016 10:06:41 PM] [DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method": "get_profiles", "id": 1009} [9/28/2016 10:06:42 PM] [DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method":"set_connected","params":[false],"id":1007} [9/28/2016 10:06:42 PM] [DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method":"set_profile","params":[1],"id":1008} [9/28/2016 10:06:42 PM] [DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method":"set_connected","params":[true],"id":1007} [9/28/2016 10:06:42 PM] [DEBUG] [PHD2 Listener Thread] Error received from RPC: cannot disconnect equipment while capture active [9/28/2016 10:06:42 PM] [DEBUG] [Sequence Thread] Connecting to PHD2... [9/28/2016 10:06:42 PM] [DEBUG] [PHD2 Listener Thread] Abort thread message received: Thread was being aborted. [9/28/2016 10:06:42 PM] [DEBUG] [Sequence Thread] Waiting for socket connection to PHD2... [9/28/2016 10:06:42 PM] [DEBUG] [PHD2 Listener Thread] Attempting to connect to PHD2... [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] Successfully connected to PHD2... [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] GuiderCheck: Auto guider reports connected... [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] Checking auto guider version... [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] PHD2: Performing version check... [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] PHD2: Min version is 2.6.0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] PHD2: User version is 2.6.1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] Finding first active group... [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] Looking at target Sh2-129... [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] Target is active: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] Target is complete: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] Target marked as past end time: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] Target has end time: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] Target end time: 9/29/2016 4:30:00 AM [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] Active group found... [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] ************** SEQUENCE DUMP ************** [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sDirectory: C:\Users\Home\Documents\Astrophotography [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sBaseName: [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nDelayFirst: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nDelayBetween: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bFinishFullEventFirst: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] arEventGroups: System.Collections.Generic.List`1[SequenceGenerator.EventGroup] [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nCurrentEventIndex: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] dtElapsedTime: 1/1/0001 12:00:00 AM +00:00 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bStarted: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bIsSequenceRunning: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sFileNamePattern: %tn\%tn_%su_%el_%fz_%ct [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sVersion: 2.4.3.12 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] tsElapsedTime: 00:00:02 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bCaptureUntil: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] dtCaptureUntil: 9/28/2016 7:40:00 PM [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] userProfile: SequenceGenerator.UserProfile [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nAfNebulosityRejection: 0.85 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sequenceFiles: System.Collections.Generic.Dictionary`2[System.String,System.String] [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sequenceFileList: System.Collections.Generic.List`1[SequenceGenerator.SequenceFile] [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] imageHistory: SequenceGenerator.ImageHistoryManager [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nAfSampleSize: 100 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bCaptureCalFramesIfSequenceFails: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] notificationsList: System.Collections.Generic.List`1[SequenceGenerator.NotoficationInfo] [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bRunEndOfSequenceScript: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sEndOfSequenceScript: [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] ************** PROFILE DUMP ************** [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sForImagingInstance: Sequence Generator Pro [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sProfileName: ZWO 178 Mono [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bDefault: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sCameraName: QHY8L-StarSenseSci [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nGain1x1: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nOffset1x1: 100 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nGain2x2: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nOffset2x2: 100 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nGain3x3: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nOffset3x3: 100 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nGain4x4: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nOffset4x4: 100 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nCooldownTemp: -10 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nCooldownTime: 10 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nWarmupTemp: 10 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nWarmupTime: 10 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoCoolDown: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoWarmUp: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sFilterWheelName: No Filter Wheel [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nFilterDelay: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sFocuserName: FocusLynx Focuser 1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bReverseFocuser: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nFineFocusStepSize: 80 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nCoarseFocusStepSize: 1000 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoAdjustFocusPerFilter: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoFocusForFilterChangeOnly: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bUseAutoFocus: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoFocusPerFrame: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoFocusOverTime: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nAutoFocusFramerInterval: 1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nAutoFocusTimerInterval: 10 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoFocusForceForFilter: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoFocusBeforeFirstFrame: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoFocusManualStar: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoManualFocusForFilterChangeOnly: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bUseAutoManualFocus: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoManualFocusPerFrame: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoManualFocusOverTime: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nAutoManualFocusFramerInterval: 1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nAutoManualFocusTimerInterval: 10 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoManualFocusForceForFilter: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoManualFocusBeforeFirstFrame: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bOverrideMaxSteps: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nOverrideMaxSteps: 1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bTempComp: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nStepsPerDegree: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bPhdDither: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nPhdDitherIndex: 2 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nPhdSettleValue: 0.4 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bRecalGuiderOnSlew: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nDecRecalValue: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sTelescopeName: EQMOD ASCOM HEQ5/6 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoSlew: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] tpFocusFrame: [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] tpTargetFrame: [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bPausePhdDuringDownload: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bShutdownPhdWhenDone: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bParkTelescopeWhenDone: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sReferenceImagePath: [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoCenterFrame: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] siReference: nEstRa: 0 nEstDec: 0 nRightAscention: 0 nDeclination: 0 nArcsecPerPixel: 0 nAngle: -500 bFlipped: False sSearchType: sBinning: nExposureLength: 0 sImagePath: bFailed: False sInfo: bDoneSolving: True nSides: 100 nMaxSolveTime: 60 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] siScope: nEstRa: 0 nEstDec: 0 nRightAscention: 0 nDeclination: 0 nArcsecPerPixel: 0 nAngle: 90.36 bFlipped: False sSearchType: Max Regions sBinning: 2x2 nExposureLength: 0 sImagePath: bFailed: True sInfo: bDoneSolving: True nSides: 0 nMaxSolveTime: 60 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nSolverExposure1x1: 8 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nSolverExposure2x2: 1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nSolverExposure3x3: 1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nSolverExposure4x4: 1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nArcsec1x1: 3.318 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nArcsec2x2: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nArcsec3x3: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nArcsec4x4: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sDithertext: High Dither [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sAutoGuider: PHD2 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nFFBinning: 3 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nFFExposure: 1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nAFExposure: 1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nAFBinning: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nAFStepSize: 150 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nAFDataPoints: 8 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sPlateSolver: PlateSolve2 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sAutoFocuser: Half Flux Radius [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nAutoFocusDialogCloseDelay: 10 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoFocusDegree: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoManualFocusDegree: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nAutoFocusDegreeInterval: 1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nAutoManualFocusDegreeInterval: 1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoFocusAutoContinue: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nNudgeSpeed: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bReverseNs: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bReverseEw: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nHiSpeedRate: 1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nLoSpeedRate: 0.5 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sCameraGain1x1: [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sCameraGain2x2: [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sCameraGain3x3: [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sCameraGain4x4: [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sCameraOffset1x1: [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sCameraOffset2x2: [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sCameraOffset3x3: [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sCameraOffset4x4: [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bPauseAutoGuiderDuringAutoFocus: True [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bUseSameStarsForAf: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bSaveAfData: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sSaveAfDataPath: C:\Users\Don\Documents\Astrophotography [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAllowExternalScopeControl: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sFFBinning: 1x1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sAFBinning: 2x2 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] nMountSettling: 20 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] ffExposure: 1 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] noFilter: SequenceGenerator.Filter [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bAutoFocusOnResume: False [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] sFlatBoxName: No Flat Box [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] flatBoxBrightness: 0 [9/28/2016 10:06:43 PM] [DEBUG] [Sequence Thread] bFocuserBacklash: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocuserBacklashStepSize: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bFocuserBacklashMovesIn: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nGuiderSettlingTime: 10 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAutoCenterAttempts: 5 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAutoCenterError: 75 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bFrameRestart: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFrameRestartError: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bDoAutoMeridianFlip: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] autoMeridianFlipVals: SequenceGenerator.AutoMeridianFlipValues [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bUseAfDarks: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sAfDarksPath: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bUseAutoCenterFilter: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sAutoCenterFilter: None [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bUseAutoFocusFilter: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sAutoFocusFilter: None [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bSettleAgBeforeAf: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bUseHighSpeedDl: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bBlindSolveFailover: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nReadoutNoise: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ccdArraySize: {Width=3328, Height=2030} [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nCameraGain1x1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nCameraGain2x2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nCameraGain3x3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nCameraGain4x4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sRotatorName: No Rotator [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nRotationError: 3 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bUseTemperDevice: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bAutoFocusAfterFlip: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bReverseManualRotatorCorrections: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sObservatoryName: No Observatory [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sObsType: Dome [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] SlavingVals: SequenceGenerator.ObservatorySlavingValues [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bSlaveObsToScope: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bPromptToPlaceLightBox: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nDownloadTime1x1: 4 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nDownloadTime2x2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nDownloadTime3x3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nDownloadTime4x4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bAfCropFrames: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfCropFramesPercent: 10 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFilePattern: %tn\%fe\%tn_%fe_%su_%el_%fz_%ct [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sWeatherStationName: No Safety Monitor [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nScopeFocalLength: 480 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bCameraCooldownOnSequenceStart: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sRtfNotes: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bStopTracking: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bHasCentralObstruction: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sCustomVariables: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sPhd2Profile: QHY_NativeDvr [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bAutoConnectPhd2Gear: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bAutoDisconnectPhd2Gear: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bPauseGuiderDuringBacklashComp: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bSetAbsPositiononFirstFilterChange: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sEnvironmentDeviceName: No Environment Device [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bSettleGuiderTime: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] equipmentData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.EquipmentData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nMinStarSize: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ************** FILTER DUMP ************** [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] >> FILTER 1: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bActive: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sName: None [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfExposureTime: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusPosition: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusTemp: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nNumFlats: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFocusWith: Default [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] >> FILTER 2: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bActive: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sName: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfExposureTime: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusPosition: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusTemp: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nNumFlats: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFocusWith: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] >> FILTER 3: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bActive: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sName: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfExposureTime: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusPosition: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusTemp: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nNumFlats: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFocusWith: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] >> FILTER 4: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bActive: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sName: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfExposureTime: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusPosition: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusTemp: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nNumFlats: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFocusWith: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] >> FILTER 5: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bActive: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sName: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfExposureTime: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusPosition: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusTemp: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nNumFlats: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFocusWith: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] >> FILTER 6: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bActive: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sName: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfExposureTime: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusPosition: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusTemp: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nNumFlats: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFocusWith: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] >> FILTER 7: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bActive: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sName: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfExposureTime: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusPosition: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusTemp: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nNumFlats: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFocusWith: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] >> FILTER 8: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bActive: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sName: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfExposureTime: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusPosition: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusTemp: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nNumFlats: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFocusWith: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] >> FILTER 9: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bActive: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sName: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfExposureTime: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusPosition: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusTemp: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nNumFlats: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFocusWith: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] >> FILTER 10: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bActive: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sName: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfExposureTime: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusPosition: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusTemp: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nNumFlats: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFocusWith: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] >> FILTER 11: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bActive: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sName: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfExposureTime: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusPosition: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusTemp: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nNumFlats: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFocusWith: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] >> FILTER 12: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bActive: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sName: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfExposureTime: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusPosition: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusTemp: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nNumFlats: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFocusWith: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] >> FILTER 13: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] bActive: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sName: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nAfExposureTime: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusPosition: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFocusTemp: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat1: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nFlat4: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] nNumFlats: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] sFocusWith: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ************** EVENT DUMP ************** [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] * Target Sh2-129 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Active: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Start Time: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Start: 9/18/2016 8:40:00 PM [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -End Time: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -End: 9/29/2016 4:30:00 AM [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Auto Rotate: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Auto Center: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Location set: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -RA: 21.2203694444444 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -DEC: 60.1685833333333 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Finish Full Event: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Completed: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -After End Time: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Rotate Camera: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Rotation: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ** Event 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Active: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Frame Type: Light [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Filter: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Suffix: LPS [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Exposure Time: 1200 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Binning: 1x1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Repeat: 90 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Gain: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Offset: 100 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Num Complete: 20 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ** Event 2 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Active: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Frame Type: Light [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Filter: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Suffix: LPS [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Exposure Time: 120 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Binning: 1x1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Repeat: 30 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Gain: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Offset: 100 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Num Complete: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ** Event 3 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Active: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Frame Type: Light [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Filter: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Suffix: LPS [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Exposure Time: 120 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Binning: 1x1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Repeat: 30 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Gain: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Offset: 100 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Num Complete: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ** Event 4 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Active: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Frame Type: Light [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Filter: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Suffix: LPS [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Exposure Time: 120 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Binning: 1x1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Repeat: 30 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Gain: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Offset: 100 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Num Complete: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ** Event 5 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Active: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Frame Type: Light [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Filter: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Suffix: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Exposure Time: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Binning: 1x1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Repeat: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Gain: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Offset: 100 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Num Complete: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] * Target NGC7822 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Active: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Start Time: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Start: 9/28/2016 1:13:00 AM [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -End Time: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -End: 9/29/2016 5:30:00 AM [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Auto Rotate: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Auto Center: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Location set: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -RA: 0.0215416666666667 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -DEC: 67.9444444444444 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Finish Full Event: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Completed: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -After End Time: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Rotate Camera: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Rotation: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ** Event 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Active: True [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Frame Type: Light [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Filter: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Suffix: LPS [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Exposure Time: 1200 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Binning: 1x1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Repeat: 90 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Gain: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Offset: 100 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Num Complete: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ** Event 2 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Active: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Frame Type: Light [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Filter: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Suffix: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Exposure Time: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Binning: 1x1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Repeat: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Gain: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Offset: 100 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Num Complete: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ** Event 3 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Active: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Frame Type: Light [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Filter: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Suffix: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Exposure Time: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Binning: 1x1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Repeat: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Gain: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Offset: 100 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Num Complete: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ** Event 4 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Active: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Frame Type: Light [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Filter: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Suffix: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Exposure Time: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Binning: 1x1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Repeat: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Gain: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Offset: 100 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Num Complete: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ** Event 5 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Active: False [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Frame Type: Light [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Filter: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Suffix: [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Exposure Time: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Binning: 1x1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Repeat: 1 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Gain: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Offset: 100 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] -Num Complete: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ************** END SEQUENCE DUMP ************** [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ********** Run sequence started ********** [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Checking if observatory requires auto slaving... [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Observatory does not require auto slave... [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] DoEventGroupChange: Changing to event group: Sh2-129 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Checking for start delay... [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] DoEventGroupChange: Complete [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Attempting to find next event... [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Current event[0] frame count: 20/90... [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Looking at event[0]... [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Found event event[0] with remaining frames. [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Event[0] frame count: 20/90... [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Getting first event (0)... [9/28/2016 10:06:44 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Current target has end time at 9/29/2016 4:30:00 AM [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] End time of next frame is at 9/28/2016 10:26:44 PM [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Target is still before end time, continuing... [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Running capture event... [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] ------------- Starting capture frame for event[0] ------------- [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Sending commands... [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] SetFlatBox: Frame Type is Light [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] TEMP - Current Event2: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Checking if Meridian Flip is needed [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Meridian flip not needed, telescope on East side [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] TEMP - Current Event3: 0 [9/28/2016 10:06:44 PM] [DEBUG] [Sequence Thread] Waiting for AF to complete... [9/28/2016 10:06:44 PM] [DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [9/28/2016 10:06:44 PM] [DEBUG] [Camera Thread] Checking for auto focus... [9/28/2016 10:06:44 PM] [DEBUG] [Camera Thread] Auto focus required (frame count trigger)... [9/28/2016 10:06:44 PM] [DEBUG] [Camera Thread] Auto focus required (focus before first frame)... [9/28/2016 10:06:44 PM] [DEBUG] [Camera Thread] Pause guiding while AF is active, pause command sent, waiting for guider to pause... [9/28/2016 10:06:44 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:44 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:44 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:44 PM] [DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE message received... [9/28/2016 10:06:44 PM] [DEBUG] [Auto Guider Thread] Pausing auto guider... [9/28/2016 10:06:44 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:44 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:44 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:44 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:44 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:44 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method":"set_paused","params":[true,"full"],"id":42} [9/28/2016 10:06:44 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:44 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:44 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:44 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:45 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:45 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:45 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:45 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:45 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:45 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:45 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:45 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:46 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:46 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:46 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:46 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:46 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:46 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:46 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:46 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:47 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:47 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:47 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:47 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:47 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:47 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:47 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:47 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:48 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:48 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:48 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:48 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:48 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:48 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:48 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:49 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:49 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:49 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:49 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:50 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:50 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:50 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:50 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:50 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:51 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:51 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:51 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:51 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:51 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:51 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:51 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:51 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:52 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:52 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:52 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:52 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:52 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:52 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:52 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:52 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:53 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:53 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:53 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:53 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:53 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:53 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:53 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:53 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:54 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:54 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:54 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:54 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:54 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:54 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:54 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:54 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:54 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [9/28/2016 10:06:54 PM] [DEBUG] [MF Update Thread] Performing serialize... [9/28/2016 10:06:55 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:55 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:55 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:55 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:55 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:55 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:55 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:55 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:56 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:56 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:56 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:56 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:56 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:56 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:56 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:56 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:57 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:57 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:57 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:57 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:57 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:57 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:58 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:58 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:59 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:06:59 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:59 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:59 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:06:59 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:06:59 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:06:59 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:06:59 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:00 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:00 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:00 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:00 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:00 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:00 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:00 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:00 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:01 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:01 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:01 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:01 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:01 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:01 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:01 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:01 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:02 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:02 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:02 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:02 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:02 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:02 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:02 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:02 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:03 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:03 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:03 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:03 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:03 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:03 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:03 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:03 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:04 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:04 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:04 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:04 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:04 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:04 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:04 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:04 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:05 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:05 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:05 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:05 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:05 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:05 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:05 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:05 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:06 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:06 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:06 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:06 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:06 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:06 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:06 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:06 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:07 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:07 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:07 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:07 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:07 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:07 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:08 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:08 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:09 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:09 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:09 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:09 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:09 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:09 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:09 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:09 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:10 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:10 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:10 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:10 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:10 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:10 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:10 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:10 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:11 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:11 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:11 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:11 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:11 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:11 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:11 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:11 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:12 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:12 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:12 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:12 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:12 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:12 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:12 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:12 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:13 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:13 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:13 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:13 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:13 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:13 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:13 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:13 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:14 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:14 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:14 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:14 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:14 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:14 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:14 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:14 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:15 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:15 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:15 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:15 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:15 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:15 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:15 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:15 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:16 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:16 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:16 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:16 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:16 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:16 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:16 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:16 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:16 PM] [DEBUG] [Auto Guider Thread] PHD2: Sent pause to PHD2, but PHD2 never entered a pause state (timeout). [9/28/2016 10:07:16 PM] [DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE complete... [9/28/2016 10:07:17 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:17 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:17 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:18 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] Tried to pause guider for, but failed on timeout... [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] Tried to pause guider for AF, but failed on timeout, continuing AF anyhow... [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] Auto focus: setting filter None [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] Auto focus running... [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] Turning temp comp off.. [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] ASCOM Focuser: Temp comp is avaialble, setting to False [9/28/2016 10:07:19 PM] [DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE message received... [9/28/2016 10:07:19 PM] [DEBUG] [Auto Guider Thread] Pausing auto guider... [9/28/2016 10:07:19 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:19 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:19 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] Performing Sequence Generator auto focus using Half Flux Radius. AFID: 0 [9/28/2016 10:07:19 PM] [DEBUG] [AfChartThread] Showing AF chart dialog... [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] Auto focus data [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] - Data Points: 8 [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] - Step Size: 150 [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] - Current Position: 35219 [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] - Initial Move Position: 35819 [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] AF Darks exception: The path is not of a legal form. [9/28/2016 10:07:19 PM] [DEBUG] [Camera Thread] Moving focuser to next position (35819)... [9/28/2016 10:07:19 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35819 [9/28/2016 10:07:19 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:07:19 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method":"set_paused","params":[true,"full"],"id":42} [9/28/2016 10:07:19 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:07:19 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:07:19 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:07:19 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:07:19 PM] [DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE complete... [9/28/2016 10:07:19 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:07:21 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35819 matches requested position 35819 [9/28/2016 10:07:21 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:07:21 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (35819), continuing... [9/28/2016 10:07:21 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:07:21 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:07:21 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:07:21 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:07:21 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:07:21 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:07:21 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:07:21 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:07:26 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:07:26 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:07:26 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:07:26 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:07:26 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:07:27 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:07:27 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:07:27 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:07:27 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:07:28 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:07:28 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:07:29 PM] [DEBUG] [Main Thread] Find stars took: 1792 ms... [9/28/2016 10:07:29 PM] [DEBUG] [Main Thread] Star list contains 64 stars... [9/28/2016 10:07:29 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:07:29 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.73 [9/28/2016 10:07:30 PM] [DEBUG] [Camera Thread] Moving focuser to next position (35669)... [9/28/2016 10:07:30 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35669 [9/28/2016 10:07:30 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:07:31 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35669 matches requested position 35669 [9/28/2016 10:07:31 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:07:31 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (35669), continuing... [9/28/2016 10:07:31 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:07:31 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:07:31 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:07:31 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:07:31 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:07:31 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:07:31 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:07:31 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:07:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:07:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:07:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:07:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:07:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:07:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:07:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:07:37 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:07:37 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:07:38 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:07:38 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:07:38 PM] [DEBUG] [Main Thread] Find stars took: 1675 ms... [9/28/2016 10:07:38 PM] [DEBUG] [Main Thread] Star list contains 66 stars... [9/28/2016 10:07:38 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:07:39 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.74 [9/28/2016 10:07:40 PM] [DEBUG] [Camera Thread] Moving focuser to next position (35519)... [9/28/2016 10:07:40 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35519 [9/28/2016 10:07:40 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:07:41 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35519 matches requested position 35519 [9/28/2016 10:07:41 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:07:41 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (35519), continuing... [9/28/2016 10:07:41 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:07:41 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:07:41 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:07:41 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:07:41 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:07:41 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:07:41 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:07:41 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:07:46 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:07:46 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:07:46 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:07:46 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:07:46 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:07:47 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:07:47 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:07:47 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:07:47 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:07:48 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:07:48 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:07:48 PM] [DEBUG] [Main Thread] Find stars took: 1684 ms... [9/28/2016 10:07:48 PM] [DEBUG] [Main Thread] Star list contains 75 stars... [9/28/2016 10:07:48 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:07:49 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.43 [9/28/2016 10:07:50 PM] [DEBUG] [Camera Thread] Moving focuser to next position (35369)... [9/28/2016 10:07:50 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35369 [9/28/2016 10:07:50 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:07:51 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35369 matches requested position 35369 [9/28/2016 10:07:51 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:07:51 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (35369), continuing... [9/28/2016 10:07:51 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:07:51 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:07:51 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:07:51 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:07:51 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:07:51 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:07:51 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:07:51 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:07:56 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:07:56 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:07:56 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:07:56 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:07:56 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:07:57 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:07:57 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:07:57 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:07:57 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:07:58 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:07:58 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:07:58 PM] [DEBUG] [Main Thread] Find stars took: 1676 ms... [9/28/2016 10:07:58 PM] [DEBUG] [Main Thread] Star list contains 63 stars... [9/28/2016 10:07:58 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:07:59 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.01 [9/28/2016 10:08:00 PM] [DEBUG] [Camera Thread] Moving focuser to next position (35219)... [9/28/2016 10:08:00 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35219 [9/28/2016 10:08:00 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:08:01 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35219 matches requested position 35219 [9/28/2016 10:08:01 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:08:01 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (35219), continuing... [9/28/2016 10:08:01 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:08:01 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:08:01 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:08:01 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:08:01 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:08:01 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:08:01 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:08:01 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:08:07 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:08:07 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:08:07 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:08:07 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:08:07 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:08:07 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:08:07 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:08:07 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:08:07 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:08:09 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:08:09 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:08:09 PM] [DEBUG] [Main Thread] Find stars took: 1688 ms... [9/28/2016 10:08:09 PM] [DEBUG] [Main Thread] Star list contains 58 stars... [9/28/2016 10:08:09 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:08:09 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 0.78 [9/28/2016 10:08:10 PM] [DEBUG] [Camera Thread] Moving focuser to next position (35069)... [9/28/2016 10:08:10 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35069 [9/28/2016 10:08:10 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:08:11 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35069 matches requested position 35069 [9/28/2016 10:08:11 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:08:11 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (35069), continuing... [9/28/2016 10:08:11 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:08:11 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:08:11 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:08:11 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:08:11 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:08:11 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:08:11 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:08:11 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:08:17 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:08:17 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:08:17 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:08:17 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:08:17 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:08:17 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:08:17 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:08:17 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:08:17 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:08:19 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:08:19 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:08:19 PM] [DEBUG] [Main Thread] Find stars took: 1675 ms... [9/28/2016 10:08:19 PM] [DEBUG] [Main Thread] Star list contains 95 stars... [9/28/2016 10:08:19 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:08:19 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 0.94 [9/28/2016 10:08:19 PM] [DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [9/28/2016 10:08:19 PM] [DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [9/28/2016 10:08:19 PM] [DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:08:19 PM] [DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:08:19 PM] [DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:08:20 PM] [DEBUG] [Camera Thread] Moving focuser to next position (34919)... [9/28/2016 10:08:20 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 34919 [9/28/2016 10:08:21 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:08:21 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 34919 matches requested position 34919 [9/28/2016 10:08:21 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:08:21 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (34919), continuing... [9/28/2016 10:08:21 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:08:21 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:08:21 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:08:21 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:08:21 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:08:21 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:08:21 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:08:21 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:08:27 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:08:27 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:08:27 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:08:27 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:08:27 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:08:27 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:08:27 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:08:27 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:08:27 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:08:29 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:08:29 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:08:29 PM] [DEBUG] [Main Thread] Find stars took: 1692 ms... [9/28/2016 10:08:29 PM] [DEBUG] [Main Thread] Star list contains 67 stars... [9/28/2016 10:08:29 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:08:29 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.43 [9/28/2016 10:08:30 PM] [DEBUG] [Camera Thread] Moving focuser to next position (34769)... [9/28/2016 10:08:30 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 34769 [9/28/2016 10:08:30 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:08:31 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 34769 matches requested position 34769 [9/28/2016 10:08:31 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:08:31 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (34769), continuing... [9/28/2016 10:08:31 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:08:31 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:08:31 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:08:31 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:08:31 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:08:31 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:08:31 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:08:31 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:08:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:08:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:08:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:08:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:08:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:08:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:08:37 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:08:37 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:08:37 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:08:39 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:08:39 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:08:39 PM] [DEBUG] [Main Thread] Find stars took: 1675 ms... [9/28/2016 10:08:39 PM] [DEBUG] [Main Thread] Star list contains 41 stars... [9/28/2016 10:08:39 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:08:39 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.03 [9/28/2016 10:08:40 PM] [DEBUG] [Camera Thread] AF has detected >= 3 left slope and >= 3 right slope but an asymmetrical fit (Ratio: 54.1). Something isn't right here! Defaulting to lowest weighted HFR method [9/28/2016 10:08:40 PM] [DEBUG] [Camera Thread] Adding sequence level notification: Cannot find focus point (asymmetrical slopes), defaulting to lowest weighted HFR method... [9/28/2016 10:08:40 PM] [DEBUG] [Camera Thread] New auto focus method calculated focus at: 35130 [9/28/2016 10:08:40 PM] [DEBUG] [Camera Thread] Old auto focus method calculated focus at: 35214 [9/28/2016 10:08:40 PM] [DEBUG] [Camera Thread] Using old auto focus method for focuser position [9/28/2016 10:08:40 PM] [DEBUG] [Camera Thread] New focus position is at 35214 (@20.79C). Moving focuser... [9/28/2016 10:08:40 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35214 [9/28/2016 10:08:40 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:08:42 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35214 matches requested position 35214 [9/28/2016 10:08:42 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:08:42 PM] [DEBUG] [Camera Thread] Focuser successfully set to focus position (35214) [9/28/2016 10:08:42 PM] [DEBUG] [Camera Thread] Taking validation frame at focus position... [9/28/2016 10:08:42 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:08:42 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:08:42 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:08:42 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:08:42 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:08:42 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:08:42 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:08:47 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:08:47 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:08:47 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:08:47 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:08:47 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:08:47 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:08:47 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:08:47 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:08:47 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:08:49 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:08:49 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:08:49 PM] [DEBUG] [Main Thread] Find stars took: 1696 ms... [9/28/2016 10:08:49 PM] [DEBUG] [Main Thread] Star list contains 82 stars... [9/28/2016 10:08:49 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:08:50 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.15 [9/28/2016 10:08:51 PM] [DEBUG] [Camera Thread] Warning! Auto focus validation frame HFR (1.14) might be out of tolerance with respect to expected HFR (0.85 or lower). [9/28/2016 10:08:51 PM] [DEBUG] [Camera Thread] Adding sequence level notification: Warning! Auto focus validation frame HFR (1.14) might be out of tolerance with respect to expected HFR (0.85 or lower). [9/28/2016 10:08:53 PM] [DEBUG] [Camera Thread] Auto focus is complete (weighted avg method: 35214; HFR 1.14)... [9/28/2016 10:08:53 PM] [DEBUG] [Camera Thread] Entering chart disposal loop... [9/28/2016 10:08:57 PM] [DEBUG] [Camera Thread] Chart disposal loop is complete... [9/28/2016 10:08:57 PM] [DEBUG] [Camera Thread] Auto focus is done... [9/28/2016 10:08:57 PM] [DEBUG] [AfChartThread] AF chart dialog is closed... [9/28/2016 10:08:57 PM] [DEBUG] [Camera Thread] Auto focus complete... [9/28/2016 10:08:57 PM] [DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] AF is complete, continuing sequence... [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] TEMP - Current Event4: 0 [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] TEMP - Current Event5: 0 [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] Checking for auto manual focus (pre)... [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] TEMP - Current Event6: 0 [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] Running dither... [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] PHD2 dither request: 2... [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method":"set_paused","params":[false],"id":42} [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:08:57 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:08:58 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:08:58 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:08:58 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:08:58 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:08:59 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:08:59 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:08:59 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:08:59 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:09:00 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:09:00 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:09:00 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:09:01 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:09:02 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:09:02 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:09:02 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:09:02 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "dither", "params": [2, false, {"pixels": 0.4, "time": 0, "timeout": 300}], "id": 1002} [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Created base name for frame capture: Sh2-129_LPS_1200sec_0021_-13.3C [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Created directory for frame capture: C:\Users\Home\Documents\Astrophotography\Sh2-129\ [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] TEMP - Current Event1: 0 [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] TEMP - Current Event7: 0 [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 0.4, "time": 10, "timeout": 300}, false ], "id": 1003} [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 0.4, "time": 10, "timeout": 300}, false ], "id": 1003} [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:09:03 PM] [DEBUG] [PHD2 Listener Thread] Error received from RPC: Cannot initiate guide while dither is in progress [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] User has elected to skip guider settling over time... [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] Waiting for Auto Guider distance to fall below 0.4 [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:03 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 1.1... [9/28/2016 10:09:04 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:04 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 1.1... [9/28/2016 10:09:04 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:04 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 1.1... [9/28/2016 10:09:05 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:05 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 1.1... [9/28/2016 10:09:05 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:05 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 1.1... [9/28/2016 10:09:06 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:06 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 1.1... [9/28/2016 10:09:06 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:06 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 1.1... [9/28/2016 10:09:07 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:07 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 2.2... [9/28/2016 10:09:07 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:07 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 2.2... [9/28/2016 10:09:08 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:08 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 2.2... [9/28/2016 10:09:09 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:09 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 2.2... [9/28/2016 10:09:09 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:09 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.6... [9/28/2016 10:09:10 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:10 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.6... [9/28/2016 10:09:10 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:10 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.6... [9/28/2016 10:09:11 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:11 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.5... [9/28/2016 10:09:11 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:11 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.5... [9/28/2016 10:09:12 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:12 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.5... [9/28/2016 10:09:12 PM] [DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: 0 [9/28/2016 10:09:12 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:12 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [9/28/2016 10:09:12 PM] [DEBUG] [Sequence Thread] Distance is below 0.4, starting timer... [9/28/2016 10:09:13 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:09:13 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [9/28/2016 10:09:13 PM] [DEBUG] [Sequence Thread] Distance stayed below 0.4 for 0 seconds, done settling... [9/28/2016 10:09:13 PM] [DEBUG] [Sequence Thread] Auto guider has settled... [9/28/2016 10:09:13 PM] [DEBUG] [Sequence Thread] TEMP - Current Event8: 0 [9/28/2016 10:09:13 PM] [DEBUG] [Sequence Thread] TEMP - Current Event9: 0 [9/28/2016 10:09:13 PM] [DEBUG] [Sequence Thread] TEMP - Current Event10: 0 [9/28/2016 10:09:13 PM] [DEBUG] [Sequence Thread] Finished sending frame capture. Entering wait mode... [9/28/2016 10:09:13 PM] [DEBUG] [Sequence Thread] TEMP - Current Event11: 0 [9/28/2016 10:09:13 PM] [DEBUG] [Sequence Thread] TEMP - Current Event12: 0 [9/28/2016 10:09:13 PM] [DEBUG] [Sequence Thread] TEMP - Current Event13: 0 [9/28/2016 10:09:13 PM] [DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE message received... [9/28/2016 10:09:13 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:09:13 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:13:01 PM] [DEBUG] [TEC Thread] TEC Change: Complete... [9/28/2016 10:13:01 PM] [DEBUG] [TEC Thread] SGM_CHANGE_COOLER_TEMP complete... [9/28/2016 10:29:13 PM] [DEBUG] [Sequence Thread] TEMP - Current Event15: 0 [9/28/2016 10:29:13 PM] [DEBUG] [Sequence Thread] Waking from exposure time sleep period... [9/28/2016 10:29:13 PM] [DEBUG] [Sequence Thread] Checking to see if the CCD has a temp... [9/28/2016 10:29:13 PM] [DEBUG] [Sequence Thread] Saving the CCD temp... [9/28/2016 10:29:13 PM] [DEBUG] [Sequence Thread] Entering super dangerous loop to await image completion... [9/28/2016 10:29:13 PM] [DEBUG] [Sequence Thread] TEMP - Current Event16: 0 [9/28/2016 10:29:21 PM] [DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE complete... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] TEMP - Current Event17: 0 [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] Image reported as complete. Continuing... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] Collecting FITs headers... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] DATE-LOC time provided by SGPro (failed to retrieve valid entry camera)... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] GatherFitsHeaders: Writing header info for last solve... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] GatherFitsHeaders: Writing header info from UI... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] Clearing timed monitoring events... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] Created full file name (file does not exist): C:\Users\Home\Documents\Astrophotography\Sh2-129\Sh2-129_LPS_1200sec_0021_-13.3C.fit [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileAscom: Start... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileAscom: Checking image data... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileAscom: Validating file name... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileAscom: Saving preview bitmap to disk... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileBmp16: Locking bitmap for disk write... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileBmp16: Opening file stream... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileBmp16: Writing FITS headers... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileBmp16: Traversing and persisting bitmap data... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileBmp16: FITS block fill... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileBmp16: Unlocking bitmap... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileBmp16: Closing file stream [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] SaveFileAscom: Displaying image preview in UI... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] Internal Interface: Set Preview... [9/28/2016 10:29:22 PM] [DEBUG] [Sequence Thread] Display image preview using asynch task... [9/28/2016 10:29:23 PM] [DEBUG] [Main Thread] AF frame was too large... downsample = 0.75... [9/28/2016 10:29:28 PM] [DEBUG] [Main Thread] Star detection using min star size of 3px... [9/28/2016 10:29:28 PM] [DEBUG] [Main Thread] Star detection using max star size of 60px... [9/28/2016 10:29:28 PM] [DEBUG] [Main Thread] Find stars took: 5936 ms... [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] SaveFileAscom: Done [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] =========== Save file took 7422 ms [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] TEMP - Current Event18: 0 [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] TEMP - Current Event19: 0 [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] TEMP - Current Event20: 0 [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] TEMP - Current Event21: 0 [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Incremented numComplete (21) for event[0]... [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Attempting to find next event... [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Current event[0] frame count: 21/90... [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Checking for auto manual focus (post)... [9/28/2016 10:29:29 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Attempting to move to next event... [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Attempting to find next event... [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Current event[0] frame count: 21/90... [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Current event event[0] has remaining frames. Returning current event. [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Current target has end time at 9/29/2016 4:30:00 AM [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] End time of next frame is at 9/28/2016 10:49:29 PM [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Target is still before end time, continuing... [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Running capture event... [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] ------------- Starting capture frame for event[0] ------------- [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Sending commands... [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] SetFlatBox: Frame Type is Light [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] TEMP - Current Event2: 0 [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Checking if Meridian Flip is needed [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Meridian flip not needed, telescope on East side [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] TEMP - Current Event3: 0 [9/28/2016 10:29:29 PM] [DEBUG] [Sequence Thread] Waiting for AF to complete... [9/28/2016 10:29:29 PM] [DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [9/28/2016 10:29:29 PM] [DEBUG] [Camera Thread] Checking for auto focus... [9/28/2016 10:29:29 PM] [DEBUG] [Camera Thread] Auto focus required (frame count trigger)... [9/28/2016 10:29:29 PM] [DEBUG] [Camera Thread] Pause guiding while AF is active, pause command sent, waiting for guider to pause... [9/28/2016 10:29:29 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:29:29 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:29:29 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:29:29 PM] [DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE message received... [9/28/2016 10:29:29 PM] [DEBUG] [Auto Guider Thread] Pausing auto guider... [9/28/2016 10:29:29 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:29:29 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:29:29 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:29:30 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:29:30 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:29:30 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method":"set_paused","params":[true,"full"],"id":42} [9/28/2016 10:29:30 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:29:30 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:29:30 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:29:30 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:29:31 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:29:31 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:29:31 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:29:31 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:29:31 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:29:31 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:29:31 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:29:31 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:29:31 PM] [DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE complete... [9/28/2016 10:29:32 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:29:32 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:29:32 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:29:32 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:29:33 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:29:33 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:29:33 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:29:33 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:29:34 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:29:34 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:29:34 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:29:34 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:29:35 PM] [DEBUG] [Camera Thread] Checking PHD2 state... [9/28/2016 10:29:35 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:29:35 PM] [DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:29:35 PM] [DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:29:35 PM] [DEBUG] [Camera Thread] Auto focus: setting filter None [9/28/2016 10:29:35 PM] [DEBUG] [Camera Thread] Auto focus running... [9/28/2016 10:29:35 PM] [DEBUG] [Camera Thread] Turning temp comp off.. [9/28/2016 10:29:35 PM] [DEBUG] [Camera Thread] ASCOM Focuser: Temp comp is avaialble, setting to False [9/28/2016 10:29:36 PM] [DEBUG] [Camera Thread] Performing Sequence Generator auto focus using Half Flux Radius. AFID: 1 [9/28/2016 10:29:36 PM] [DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE message received... [9/28/2016 10:29:36 PM] [DEBUG] [Auto Guider Thread] Pausing auto guider... [9/28/2016 10:29:36 PM] [DEBUG] [Auto Guider Thread] Checking PHD2 state... [9/28/2016 10:29:36 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:29:36 PM] [DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:29:36 PM] [DEBUG] [AfChartThread] Showing AF chart dialog... [9/28/2016 10:29:36 PM] [DEBUG] [Camera Thread] Auto focus data [9/28/2016 10:29:36 PM] [DEBUG] [Camera Thread] - Data Points: 8 [9/28/2016 10:29:36 PM] [DEBUG] [Camera Thread] - Step Size: 150 [9/28/2016 10:29:36 PM] [DEBUG] [Camera Thread] - Current Position: 35214 [9/28/2016 10:29:36 PM] [DEBUG] [Camera Thread] - Initial Move Position: 35814 [9/28/2016 10:29:36 PM] [DEBUG] [Camera Thread] AF Darks exception: The path is not of a legal form. [9/28/2016 10:29:36 PM] [DEBUG] [Camera Thread] Moving focuser to next position (35814)... [9/28/2016 10:29:36 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35814 [9/28/2016 10:29:36 PM] [DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:29:36 PM] [DEBUG] [Auto Guider Thread] PHD2: Requested pause, but PHD2 reports it is not guiding [9/28/2016 10:29:36 PM] [DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE complete... [9/28/2016 10:29:36 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:29:37 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35814 matches requested position 35814 [9/28/2016 10:29:37 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:29:37 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (35814), continuing... [9/28/2016 10:29:37 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:29:37 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:29:37 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:29:37 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:29:37 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:29:37 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:29:37 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:29:37 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:29:43 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:29:43 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:29:43 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:29:43 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:29:43 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:29:43 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:29:43 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:29:43 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:29:43 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:29:45 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:29:45 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:29:45 PM] [DEBUG] [Main Thread] Find stars took: 1682 ms... [9/28/2016 10:29:45 PM] [DEBUG] [Main Thread] Star list contains 65 stars... [9/28/2016 10:29:45 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:29:45 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.80 [9/28/2016 10:29:46 PM] [DEBUG] [Camera Thread] Moving focuser to next position (35664)... [9/28/2016 10:29:46 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35664 [9/28/2016 10:29:46 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:29:47 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35664 matches requested position 35664 [9/28/2016 10:29:47 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:29:47 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (35664), continuing... [9/28/2016 10:29:47 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:29:47 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:29:47 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:29:47 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:29:47 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:29:47 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:29:47 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:29:47 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:29:53 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:29:53 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:29:53 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:29:53 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:29:53 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:29:53 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:29:53 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:29:53 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:29:53 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:29:55 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:29:55 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:29:55 PM] [DEBUG] [Main Thread] Find stars took: 1683 ms... [9/28/2016 10:29:55 PM] [DEBUG] [Main Thread] Star list contains 65 stars... [9/28/2016 10:29:55 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:29:55 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.79 [9/28/2016 10:29:56 PM] [DEBUG] [Camera Thread] Moving focuser to next position (35514)... [9/28/2016 10:29:56 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35514 [9/28/2016 10:29:56 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:29:57 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35514 matches requested position 35514 [9/28/2016 10:29:57 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:29:57 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (35514), continuing... [9/28/2016 10:29:57 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:29:57 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:29:57 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:29:57 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:29:57 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:29:57 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:29:57 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:29:57 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:30:03 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:30:03 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:30:03 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:30:03 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:30:03 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:30:03 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:30:03 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:30:03 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:30:03 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:30:04 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:30:04 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:30:04 PM] [DEBUG] [Main Thread] Find stars took: 1694 ms... [9/28/2016 10:30:04 PM] [DEBUG] [Main Thread] Star list contains 74 stars... [9/28/2016 10:30:04 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:30:05 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.48 [9/28/2016 10:30:06 PM] [DEBUG] [Camera Thread] Moving focuser to next position (35364)... [9/28/2016 10:30:06 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35364 [9/28/2016 10:30:06 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:30:07 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35364 matches requested position 35364 [9/28/2016 10:30:07 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:30:07 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (35364), continuing... [9/28/2016 10:30:07 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:30:07 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:30:07 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:30:07 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:30:07 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:30:07 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:30:07 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:30:07 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:30:12 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:30:12 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:30:12 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:30:12 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:30:12 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:30:13 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:30:13 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:30:13 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:30:13 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:30:14 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:30:14 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:30:14 PM] [DEBUG] [Main Thread] Find stars took: 1678 ms... [9/28/2016 10:30:14 PM] [DEBUG] [Main Thread] Star list contains 66 stars... [9/28/2016 10:30:14 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:30:15 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 0.97 [9/28/2016 10:30:16 PM] [DEBUG] [Camera Thread] Moving focuser to next position (35214)... [9/28/2016 10:30:16 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35214 [9/28/2016 10:30:16 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:30:17 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35214 matches requested position 35214 [9/28/2016 10:30:17 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:30:17 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (35214), continuing... [9/28/2016 10:30:17 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:30:17 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:30:17 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:30:17 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:30:17 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:30:17 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:30:17 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:30:17 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:30:22 PM] [DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [9/28/2016 10:30:22 PM] [DEBUG] [MF Update Thread] Performing serialize... [9/28/2016 10:30:22 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:30:22 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:30:22 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:30:22 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:30:22 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:30:22 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:30:22 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:30:22 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:30:22 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:30:24 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:30:24 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:30:24 PM] [DEBUG] [Main Thread] Find stars took: 1679 ms... [9/28/2016 10:30:24 PM] [DEBUG] [Main Thread] Star list contains 48 stars... [9/28/2016 10:30:24 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:30:25 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 0.74 [9/28/2016 10:30:26 PM] [DEBUG] [Camera Thread] Moving focuser to next position (35064)... [9/28/2016 10:30:26 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35064 [9/28/2016 10:30:26 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:30:26 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35064 matches requested position 35064 [9/28/2016 10:30:26 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:30:26 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (35064), continuing... [9/28/2016 10:30:26 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:30:26 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:30:26 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:30:26 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:30:26 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:30:26 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:30:26 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:30:26 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:30:32 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:30:32 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:30:32 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:30:32 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:30:32 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:30:32 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:30:32 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:30:32 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:30:32 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:30:34 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:30:34 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:30:34 PM] [DEBUG] [Main Thread] Find stars took: 1686 ms... [9/28/2016 10:30:34 PM] [DEBUG] [Main Thread] Star list contains 96 stars... [9/28/2016 10:30:34 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:30:34 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 0.89 [9/28/2016 10:30:35 PM] [DEBUG] [Camera Thread] Moving focuser to next position (34914)... [9/28/2016 10:30:35 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 34914 [9/28/2016 10:30:36 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:30:36 PM] [DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [9/28/2016 10:30:36 PM] [DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [9/28/2016 10:30:36 PM] [DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:30:36 PM] [DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:30:36 PM] [DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:30:36 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 34914 matches requested position 34914 [9/28/2016 10:30:36 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:30:36 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (34914), continuing... [9/28/2016 10:30:36 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:30:36 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:30:36 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:30:36 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:30:36 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:30:36 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:30:36 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:30:36 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:30:42 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:30:42 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:30:42 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:30:42 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:30:42 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:30:42 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:30:42 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:30:42 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:30:42 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:30:44 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:30:44 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:30:44 PM] [DEBUG] [Main Thread] Find stars took: 1680 ms... [9/28/2016 10:30:44 PM] [DEBUG] [Main Thread] Star list contains 75 stars... [9/28/2016 10:30:44 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:30:44 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.44 [9/28/2016 10:30:45 PM] [DEBUG] [Camera Thread] Moving focuser to next position (34764)... [9/28/2016 10:30:45 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 34764 [9/28/2016 10:30:46 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:30:46 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 34764 matches requested position 34764 [9/28/2016 10:30:46 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:30:46 PM] [DEBUG] [Camera Thread] Focuser position matches requested position (34764), continuing... [9/28/2016 10:30:46 PM] [DEBUG] [Camera Thread] Calculating step metric... [9/28/2016 10:30:46 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:30:46 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:30:46 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:30:46 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:30:46 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:30:46 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:30:46 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:30:52 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:30:52 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:30:52 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:30:52 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:30:52 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:30:52 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:30:52 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:30:52 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:30:52 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:30:54 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:30:54 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:30:54 PM] [DEBUG] [Main Thread] Find stars took: 1712 ms... [9/28/2016 10:30:54 PM] [DEBUG] [Main Thread] Star list contains 45 stars... [9/28/2016 10:30:54 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:30:54 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.01 [9/28/2016 10:30:55 PM] [DEBUG] [Camera Thread] AF has detected >= 3 left slope and >= 3 right slope but an asymmetrical fit (Ratio: 49.5). Something isn't right here! Defaulting to lowest weighted HFR method [9/28/2016 10:30:55 PM] [DEBUG] [Camera Thread] Adding sequence level notification: Cannot find focus point (asymmetrical slopes), defaulting to lowest weighted HFR method... [9/28/2016 10:30:55 PM] [DEBUG] [Camera Thread] New auto focus method calculated focus at: 35129 [9/28/2016 10:30:55 PM] [DEBUG] [Camera Thread] Old auto focus method calculated focus at: 35205 [9/28/2016 10:30:55 PM] [DEBUG] [Camera Thread] Using old auto focus method for focuser position [9/28/2016 10:30:55 PM] [DEBUG] [Camera Thread] New focus position is at 35205 (@20.53C). Moving focuser... [9/28/2016 10:30:55 PM] [DEBUG] [Focuser Move Thread] Focuser moving to 35205 [9/28/2016 10:30:56 PM] [DEBUG] [Focuser Move Thread] Focuser move call complete [9/28/2016 10:30:57 PM] [DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 35205 matches requested position 35205 [9/28/2016 10:30:57 PM] [DEBUG] [Camera Thread] Focuser move complete... [9/28/2016 10:30:57 PM] [DEBUG] [Camera Thread] Focuser successfully set to focus position (35205) [9/28/2016 10:30:57 PM] [DEBUG] [Camera Thread] Taking validation frame at focus position... [9/28/2016 10:30:57 PM] [DEBUG] [Camera Thread] Taking auto focus frame(s)... [9/28/2016 10:30:57 PM] [DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [9/28/2016 10:30:57 PM] [DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [9/28/2016 10:30:57 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure length: 1 seconds... [9/28/2016 10:30:57 PM] [DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [9/28/2016 10:30:57 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:30:57 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:31:02 PM] [DEBUG] [Camera Thread] SaveFileAscom: Start... [9/28/2016 10:31:02 PM] [DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [9/28/2016 10:31:02 PM] [DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [9/28/2016 10:31:02 PM] [DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [9/28/2016 10:31:02 PM] [DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [9/28/2016 10:31:02 PM] [DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [9/28/2016 10:31:02 PM] [DEBUG] [Camera Thread] SaveFileAscom: Done [9/28/2016 10:31:02 PM] [DEBUG] [Camera Thread] Internal Interface: Set Preview... [9/28/2016 10:31:02 PM] [DEBUG] [Camera Thread] Display image preview using asynch task... [9/28/2016 10:31:04 PM] [DEBUG] [Main Thread] Star detection using min star size of 2px... [9/28/2016 10:31:04 PM] [DEBUG] [Main Thread] Star detection using max star size of 40px... [9/28/2016 10:31:04 PM] [DEBUG] [Main Thread] Find stars took: 1681 ms... [9/28/2016 10:31:04 PM] [DEBUG] [Main Thread] Star list contains 87 stars... [9/28/2016 10:31:04 PM] [DEBUG] [Main Thread] Calculating HFR with sample size: 2 [9/28/2016 10:31:05 PM] [DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.21 [9/28/2016 10:31:06 PM] [DEBUG] [Camera Thread] Warning! Auto focus validation frame HFR (1.21) might be out of tolerance with respect to expected HFR (0.81 or lower). [9/28/2016 10:31:06 PM] [DEBUG] [Camera Thread] Adding sequence level notification: Warning! Auto focus validation frame HFR (1.21) might be out of tolerance with respect to expected HFR (0.81 or lower). [9/28/2016 10:31:12 PM] [DEBUG] [Camera Thread] Auto focus is complete (weighted avg method: 35205; HFR 1.21)... [9/28/2016 10:31:12 PM] [DEBUG] [Camera Thread] Entering chart disposal loop... [9/28/2016 10:31:22 PM] [DEBUG] [Camera Thread] Auto closing chart dialog... [9/28/2016 10:31:22 PM] [DEBUG] [Camera Thread] Auto focus (finally): closing dialog... [9/28/2016 10:31:22 PM] [DEBUG] [AfChartThread] AF chart dialog is closed... [9/28/2016 10:31:22 PM] [DEBUG] [Camera Thread] Auto focus complete... [9/28/2016 10:31:22 PM] [DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] AF is complete, continuing sequence... [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] TEMP - Current Event4: 0 [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] TEMP - Current Event5: 0 [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] Checking for auto manual focus (pre)... [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] TEMP - Current Event6: 0 [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] Running dither... [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] PHD2 dither request: 2... [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method":"set_paused","params":[false],"id":42} [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:31:22 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Paused [9/28/2016 10:31:23 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:31:23 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:31:23 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:31:23 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:31:24 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:31:24 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:31:24 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:31:25 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:31:26 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:31:26 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:31:26 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:31:26 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:31:27 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:31:27 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:31:27 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:31:27 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "dither", "params": [2, false, {"pixels": 0.4, "time": 0, "timeout": 300}], "id": 1002} [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Created base name for frame capture: Sh2-129_LPS_1200sec_0022_-9.4C [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Created directory for frame capture: C:\Users\Home\Documents\Astrophotography\Sh2-129\ [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] TEMP - Current Event1: 0 [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] TEMP - Current Event7: 0 [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] PHD2: Requested unpause, but PHD2 reports it is not in a paused state [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 0.4, "time": 10, "timeout": 300}, false ], "id": 1003} [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 0.4, "time": 10, "timeout": 300}, false ], "id": 1003} [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Checking PHD2 state... [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [9/28/2016 10:31:28 PM] [DEBUG] [PHD2 Listener Thread] Error received from RPC: Cannot initiate guide while dither is in progress [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] User has elected to skip guider settling over time... [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] Waiting for Auto Guider distance to fall below 0.4 [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:28 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.5... [9/28/2016 10:31:29 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:29 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.5... [9/28/2016 10:31:29 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:29 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.5... [9/28/2016 10:31:30 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:30 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.5... [9/28/2016 10:31:30 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:30 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.5... [9/28/2016 10:31:31 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:31 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.6... [9/28/2016 10:31:31 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:31 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.6... [9/28/2016 10:31:32 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:32 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.6... [9/28/2016 10:31:33 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:33 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.6... [9/28/2016 10:31:33 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:33 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.6... [9/28/2016 10:31:34 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:34 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.5... [9/28/2016 10:31:34 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:34 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.5... [9/28/2016 10:31:35 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:35 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.5... [9/28/2016 10:31:35 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:35 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.5... [9/28/2016 10:31:36 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:36 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.5... [9/28/2016 10:31:36 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:36 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [9/28/2016 10:31:37 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:37 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [9/28/2016 10:31:37 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:37 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [9/28/2016 10:31:37 PM] [DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: 0 [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] Distance is below 0.4, starting timer... [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] PHD2 distance request... [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] PHD2 distance request returned 0.4... [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] Distance stayed below 0.4 for 0 seconds, done settling... [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] Auto guider has settled... [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] TEMP - Current Event8: 0 [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] TEMP - Current Event9: 0 [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] TEMP - Current Event10: 0 [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] Finished sending frame capture. Entering wait mode... [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] TEMP - Current Event11: 0 [9/28/2016 10:31:38 PM] [DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE message received... [9/28/2016 10:31:38 PM] [DEBUG] [Camera Thread] SetAscomNormalSpeed... [9/28/2016 10:31:38 PM] [DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] TEMP - Current Event12: 0 [9/28/2016 10:31:38 PM] [DEBUG] [Sequence Thread] TEMP - Current Event13: 0