[06/28/19 21:27:38.780][DEBUG] [Main Thread] Licensing: Machine ID found... [06/28/19 21:27:38.780][DEBUG] [Main Thread] Checking for valid internet connection... [06/28/19 21:27:39.092][DEBUG] [Main Thread] Valid internet connection detected... [06/28/19 21:27:41.217][DEBUG] [Main Thread] Licensing: Request for licenses successful, writing cookie... [06/28/19 21:27:41.217][DEBUG] [Main Thread] Licensing: Applying licenses.. [06/28/19 21:27:41.217][DEBUG] [Main Thread] Licensing: Licenses applied.. [06/28/19 21:27:41.233][DEBUG] [Main Thread] SGPro retail license... [06/28/19 21:27:42.420][DEBUG] [Main Thread] API successfully started on port 59590... [06/28/19 21:27:43.615][DEBUG] [Main Thread] Error loading notification settings! Could not find file 'C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Sequence Generator Pro\notifications.sgd'. [06/28/19 21:27:43.795][DEBUG] [Main Thread] Error loading GNS endpoint settings! Could not find file 'C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Sequence Generator Pro\gnsSettings.sgd'. [06/28/19 21:27:43.796][DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Sequence Generator Pro\1-emailEndpointAddresses.sgd'. [06/28/19 21:27:43.797][DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Sequence Generator Pro\2-emailEndpointAddresses.sgd'. [06/28/19 21:27:43.797][DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Sequence Generator Pro\3-emailEndpointAddresses.sgd'. [06/28/19 21:27:43.797][DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Sequence Generator Pro\1-textFileEndpointSettings.sgd'. [06/28/19 21:27:43.797][DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Sequence Generator Pro\2-textFileEndpointSettings.sgd'. [06/28/19 21:27:43.797][DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Sequence Generator Pro\3-textFileEndpointSettings.sgd'. [06/28/19 21:27:43.800][DEBUG] [Main Thread] ===== S E Q U E N C E G E N E R A T O R (v3.0.3.169) ===== [06/28/19 21:27:43.831][DEBUG] [Main Thread] OS: Microsoft Windows 10 Home [06/28/19 21:27:44.189][DEBUG] [Focuser Thread] Entering Fouser message dispatch loop... [06/28/19 21:27:44.189][DEBUG] [Camera Thread] Entering camera message dispatch loop... [06/28/19 21:27:44.190][DEBUG] [TEC Thread] Entering TEC message dispatch loop... [06/28/19 21:27:44.190][DEBUG] [Filter Wheel Thread] Entering Filter Wheel message dispatch loop... [06/28/19 21:27:44.190][DEBUG] [Rotator Thread] Entering Rotator message dispatch loop... [06/28/19 21:27:44.191][DEBUG] [Auto Guider Thread] Entering Auto Guider message dispatch loop... [06/28/19 21:27:44.191][DEBUG] [Auto Guider Error Thread] Entering Auto Guider message dispatch loop... [06/28/19 21:27:44.192][DEBUG] [Dome Thread] Entering Dome message dispatch loop... [06/28/19 21:27:44.192][DEBUG] [Safety Thread] Starting safety monitor... [06/28/19 21:27:44.193][DEBUG] [Environment Device Thread] Starting environment device monitor... [06/28/19 21:27:44.203][DEBUG] [Telescope Thread] Entering Telescope message dispatch loop... [06/28/19 21:27:44.229][DEBUG] [Main Thread] Settings changed (or loaded)... [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingMdiAutoStretch = False [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingIgLastFileFolder = [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingFormScaleWarning = False [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingRecoveryDuration = 90 [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingSBIGLpt2Address = 278 [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingFliFlushLow = 0 [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingSBIGLpt1Address = 378 [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingShowBetas = False [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingMdiMouseAction = Stretch [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingLastAscomCamera = [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingTemperhumInterval = 300 [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingASCOMWarningShown = False [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingPlateCamScale = 0 [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingCanonMirrorSettle = 0 [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingInterface = [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingLastAscomFilterWheel = [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingAstroArtDisplayInstructions = True [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingMdiPhdZoom = 40 [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingCheckForUpdatesOnStart = True [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingMdiLastImageDir = [06/28/19 21:27:44.230][DEBUG] [Main Thread] * SETTING: settingTemperHumUserTempComp = 0 [06/28/19 21:27:44.231][DEBUG] [Main Thread] * SETTING: settingCaptureCalFramesAlways = False [06/28/19 21:27:44.231][DEBUG] [Main Thread] * SETTING: settingDelayFirst = 0 [06/28/19 21:27:44.231][DEBUG] [Main Thread] * SETTING: settingFliNormalSpeedMode = 0 [06/28/19 21:27:44.231][DEBUG] [Main Thread] * SETTING: settingFliHighSpeedMode = 0 [06/28/19 21:27:44.231][DEBUG] [Main Thread] * SETTING: settingMfPosition = {X=0,Y=0} [06/28/19 21:27:44.231][DEBUG] [Main Thread] * SETTING: settingSoundAttention = [06/28/19 21:27:44.231][DEBUG] [Main Thread] * SETTING: settingPinpointCatalog = [06/28/19 21:27:44.231][DEBUG] [Main Thread] * SETTING: settingCameraOverhead = [06/28/19 21:27:44.231][DEBUG] [Main Thread] * SETTING: settingPlateSolveOn = False [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingAstrometryNetEndpointList = System.Collections.Specialized.StringCollection [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingSBIGGuider = None [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingFocusLockDirectory = [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingQSIFanSpeed = 2 [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingNaggerText = [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingMdiPhdDisplay = RA/Dec [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingMdiShowToolStrip = True [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingMdiShowCrosshairs = True [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: WindowGeometry = [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingIgRenameStringLocation = 2 [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingIgSubFolders = False [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: WindowGeometrySearch = [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingOffset = -1 [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingAutoStretchLevel = Low [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingTemperHumUnits = C [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingProfileDirectory = [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingBasename = [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingHfrColor = Color [RoyalBlue] [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingNikonAfBinning = 1 [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingSBIGFanOffWithTec = False [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingLastAscomSafetyMonitor = [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingMdiSize = {Width=800, Height=600} [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingIgCopyAndRenameFiles = False [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingSimDownloadTimesAf = False [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingNagger = False [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingImportFromCfw = True [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingMdiShowStatusTrip = True [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingShowTooltipHelp = True [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingLastUpdateCheck = 1/1/2012 12:00:00 AM [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingEventSuffixes = null [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingCpPosition = {X=0,Y=0} [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingSBIGCfwPort = [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingMdiLocation = {X=0,Y=0} [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingIgLastCsvFolder = [06/28/19 21:27:44.238][DEBUG] [Main Thread] * SETTING: settingLoadLastSequence = True [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingPlateSolve3Catalogs = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingSBIGFilterWheel = Auto Detect [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingSBIGConnection = USB [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingDSLRSoftwareBinForAf = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingAutoSave = True [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingFirstTime = True [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingAutoRecoveryActive = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingMdiState = maximized [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingUseSequenceOptions = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingSoundCompleted = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingTrialExpiredShown = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingTemperHumColor = Grey [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingDataDirectory = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingCanonFileFormat = Single Image (CFA FITS) [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingAlnitakComPort = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingIgRenameFiles = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingPhd2InstallPath = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingSubFolder = True [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingLastSGSaveFolder = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingFindStars = Normal (recommended) [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingNikonDataFormat = FITS [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingPlaySounds = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingLastNikonType = Auto Connect [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingLastSequenceStart = 1/1/0001 12:00:00 AM [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingLastAscomTelescope = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingMdiPhdScale = 100 [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingIgRenameType = 0 [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingHelpLanguage = English [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingTemperHumUserHumidityComp = 0 [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingMdiPhdRaColor = Color [Blue] [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingLastImageSaveFolder = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingLastSequence = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingIgOverwriteExisting = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingFinishFullEvent = True [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingMosaicOverlap = 20 [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingQSIFanOffWithTec = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingRecentSequences = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingDefaultDirectory = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingMdiPhdDecColor = Color [Red] [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingAstrometryNetEndpoint = Astrometry.NET (Remote) [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingFliFlushHigh = 0 [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingStarsColor = Color [OrangeRed] [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingDefaultMfwFov = 4.0 [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingSBIGLpt3Address = 3BC [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingLastAscomFocuser = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingIgLastFolder = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: WindowGeometryOpen = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingNumEvents = 5 [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingDelayBetween = 0 [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingCanonAfBinning = 1 [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingPlateCamBlank = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingLogApiCalls = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingNikonUseBulbModeAlways = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingTempFiles = C:\Temp [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingFliHighSpeedDesc = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingSBIGCfwUseRS232 = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingRecoveryInterval = 10 [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingEnableImageHistory = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingSBIGEthernetIP = 0.0.0.0 [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingFliNormalSpeedDesc = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingIgCopyLocation = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingSBIGAutoDetectIp = True [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingAstroArtStartApp = True [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingSimDownloadTimesPlate = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingMicroTouchLocation = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingEventAlwaysVisible = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingMdiNewWindow = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingTrialQuestionsAsked = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingFliRbiMitigation = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingGain = -1 [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingLastAscomDome = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingLookForTemperDevices = False [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingLastAscomRotator = [06/28/19 21:27:44.239][DEBUG] [Main Thread] * SETTING: settingAfTestPackPath = [06/28/19 21:27:44.362][DEBUG] [Main Thread] ASCOM Observing Conditions Hub (OCH) [06/28/19 21:27:44.362][DEBUG] [Main Thread] ASCOM Observing Conditions Simulator [06/28/19 21:27:44.362][DEBUG] [Main Thread] OpenWeatherMap ObservingConditions [06/28/19 21:27:44.362][DEBUG] [Main Thread] TEMPerHUM [06/28/19 21:27:44.364][DEBUG] [Main Thread] Performing initialization... [06/28/19 21:27:44.364][DEBUG] [Main Thread] Creating new sequence with no profile [06/28/19 21:27:44.375][DEBUG] [Main Thread] Performing full form reset (with default data)... [06/28/19 21:27:44.378][DEBUG] [Main Thread] Retreiving new equipment objects... [06/28/19 21:27:44.378][DEBUG] [Main Thread] New camera object (No Camera) dispatched... [06/28/19 21:27:44.379][DEBUG] [Main Thread] New filter wheel object (No Filter Wheel) dispatched... [06/28/19 21:27:44.379][DEBUG] [Main Thread] New environment device object (No Environment Device) dispatched... [06/28/19 21:27:44.380][DEBUG] [Main Thread] New focuser object (No Focuser) dispatched... [06/28/19 21:27:44.380][DEBUG] [Main Thread] New telescope object (No Telescope) dispatched... [06/28/19 21:27:44.380][DEBUG] [Main Thread] New rotator object (No Rotator) dispatched... [06/28/19 21:27:44.381][DEBUG] [Main Thread] New dome object (No Observatory) dispatched... [06/28/19 21:27:44.381][DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched... [06/28/19 21:27:44.382][DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched... [06/28/19 21:27:44.382][DEBUG] [Main Thread] New auto guider object (No Auto Guider) dispatched... [06/28/19 21:27:44.382][DEBUG] [Main Thread] New plate solver object (No Plate Solver) dispatched... [06/28/19 21:27:44.392][DEBUG] [Main Thread] Populating the form controls... [06/28/19 21:27:44.437][DEBUG] [Main Thread] Added row 0... [06/28/19 21:27:44.478][DEBUG] [Main Thread] Added row 1... [06/28/19 21:27:44.530][DEBUG] [Main Thread] Added row 2... [06/28/19 21:27:44.594][DEBUG] [Main Thread] Added row 3... [06/28/19 21:27:44.681][DEBUG] [Main Thread] Added row 4... [06/28/19 21:27:44.694][DEBUG] [Main Thread] Loading custom filter names... [06/28/19 21:27:44.699][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [06/28/19 21:27:44.746][DEBUG] [Main Thread] Retreiving new equipment objects... [06/28/19 21:27:44.746][DEBUG] [Main Thread] New camera object (No Camera) dispatched... [06/28/19 21:27:44.747][DEBUG] [Main Thread] New filter wheel object (No Filter Wheel) dispatched... [06/28/19 21:27:44.748][DEBUG] [Sequence Thread] Entering sequence message dispatch loop... [06/28/19 21:27:44.748][DEBUG] [Main Thread] New environment device object (No Environment Device) dispatched... [06/28/19 21:27:44.748][DEBUG] [Main Thread] New focuser object (No Focuser) dispatched... [06/28/19 21:27:44.749][DEBUG] [Main Thread] New telescope object (No Telescope) dispatched... [06/28/19 21:27:44.750][DEBUG] [Main Thread] New rotator object (No Rotator) dispatched... [06/28/19 21:27:44.751][DEBUG] [Main Thread] New dome object (No Observatory) dispatched... [06/28/19 21:27:44.752][DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched... [06/28/19 21:27:44.752][DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched... [06/28/19 21:27:44.752][DEBUG] [Main Thread] New auto guider object (No Auto Guider) dispatched... [06/28/19 21:27:44.752][DEBUG] [Main Thread] New plate solver object (No Plate Solver) dispatched... [06/28/19 21:27:44.754][DEBUG] [Main Thread] Checking if version check is required... [06/28/19 21:27:45.803][DEBUG] [Cleaner Thread] Running cleanup... [06/28/19 21:27:45.803][DEBUG] [Cleaner Thread] Cleaning 4 files in directory C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Temp\... [06/28/19 21:27:45.804][DEBUG] [Main Thread] UI layout found, loading layout at C:\Users\Lighthouse\AppData\Local\SequenceGenerator\sg_ui_config.xml [06/28/19 21:27:45.864][DEBUG] [Cleaner Thread] Cleaning multi camera registration file... [06/28/19 21:27:45.864][DEBUG] [Cleaner Thread] Cleaning finished... [06/28/19 21:28:24.702][DEBUG] [DSS Fetch Thread] Object name ngc4559 resolved by Local DSO DB... [06/28/19 21:28:24.708][DEBUG] [DSS Fetch Thread] Fetching canvas at: https://skyview.gsfc.nasa.gov/cgi-bin/images?Survey=dss2r&Return=JPG&Size=1.000&Pixels=1500&position=189.000,27.967 [06/28/19 21:28:24.708][DEBUG] [DSS Fetch Thread] URI: https://skyview.gsfc.nasa.gov/cgi-bin/images?Survey=dss2r&Return=JPG&Size=1.000&Pixels=1500&position=189.000,27.967 [06/28/19 21:28:24.916][DEBUG] [DSS Fetch Thread] MFW: Requested canvas image, awaiting response... [06/28/19 21:28:38.928][DEBUG] [DSS Fetch Thread] MFW: Canvas image download complete... [06/28/19 21:28:38.928][DEBUG] [DSS Fetch Thread] MFW image fetched from dss2r [06/28/19 21:28:38.928][DEBUG] [DSS Fetch Thread] -- FOV took 14.22s... [06/28/19 21:28:38.981][DEBUG] [DSS Fetch Thread] Internal Interface: Set Preview... [06/28/19 21:28:38.982][DEBUG] [DSS Fetch Thread] Display image preview using asynch task... [06/28/19 21:29:07.169][DEBUG] [Main Thread] Performing full form reset (with profile 12CEM120_716fr_AtkFWoag_LdStr_SGPro3)... [06/28/19 21:29:07.172][DEBUG] [Main Thread] Retreiving new equipment objects... [06/28/19 21:29:07.173][DEBUG] [Main Thread] New camera object (Atik Camera) dispatched... [06/28/19 21:29:07.176][DEBUG] [Main Thread] New filter wheel object (Atik EFW Driver) dispatched... [06/28/19 21:29:07.178][DEBUG] [Main Thread] New environment device object (OpenWeatherMap ObservingConditions) dispatched... [06/28/19 21:29:07.180][DEBUG] [Main Thread] New focuser object (MicroTouch Focuser1) dispatched... [06/28/19 21:29:07.182][DEBUG] [Main Thread] New telescope object (iOptron ASCOM Driver for CEM120 Mount) dispatched... [06/28/19 21:29:07.183][DEBUG] [Main Thread] New rotator object (No Rotator) dispatched... [06/28/19 21:29:07.184][DEBUG] [Main Thread] New dome object (LesveDomeNet Dome) dispatched... [06/28/19 21:29:07.185][DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched... [06/28/19 21:29:07.186][DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched... [06/28/19 21:29:07.186][DEBUG] [Main Thread] New auto guider object (PHD2) dispatched... [06/28/19 21:29:07.186][DEBUG] [Main Thread] New plate solver object (PlateSolve2) dispatched... [06/28/19 21:29:07.210][DEBUG] [Main Thread] Loading custom filter names... [06/28/19 21:29:07.250][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [06/28/19 21:29:07.266][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [06/28/19 21:29:27.671][DEBUG] [DSS Fetch Thread] Object name ngc4559 resolved by Local DSO DB... [06/28/19 21:29:27.760][DEBUG] [DSS Fetch Thread] Internal Interface: Set Preview... [06/28/19 21:29:27.760][DEBUG] [DSS Fetch Thread] Display image preview using asynch task... [06/28/19 21:29:50.674][DEBUG] [Main Thread] Display image preview using asynch task... [06/28/19 21:29:50.865][DEBUG] [Main Thread] Tile 1 at pos 768,767 => 188.99,27.96 [06/28/19 21:29:50.874][DEBUG] [Main Thread] Populating the form controls... [06/28/19 21:29:50.906][DEBUG] [Main Thread] Added row 0... [06/28/19 21:29:50.941][DEBUG] [Main Thread] Added row 1... [06/28/19 21:29:50.990][DEBUG] [Main Thread] Added row 2... [06/28/19 21:29:51.056][DEBUG] [Main Thread] Added row 3... [06/28/19 21:29:51.139][DEBUG] [Main Thread] Added row 4... [06/28/19 21:29:51.164][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [06/28/19 21:30:29.214][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [06/28/19 21:30:42.566][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [06/28/19 21:31:42.091][DEBUG] [Main Thread] Start time has altitude lock, calculating start time for 66 [06/28/19 21:31:42.383][DEBUG] [Main Thread] Start time set to 6/28/2019 9:30:00 PM [06/28/19 21:31:42.383][DEBUG] [Main Thread] End time has altitude lock, calculating start time for 37 [06/28/19 21:31:42.666][DEBUG] [Main Thread] Start time set to 6/28/2019 11:45:00 PM [06/28/19 21:32:30.591][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [06/28/19 21:32:30.595][DEBUG] [Main Thread] Performing serialize... [06/28/19 21:32:35.598][DEBUG] [Main Thread] Connecting camera in main thread... [06/28/19 21:32:35.603][DEBUG] [Main Thread] Connecting ASCOM camera: ASCOM.Atik.Camera... [06/28/19 21:32:45.765][DEBUG] [Main Thread] Camera does not implement ASCOM gain. [06/28/19 21:32:45.782][DEBUG] [Main Thread] Camera cooler detected... [06/28/19 21:32:45.783][DEBUG] [Main Thread] Camera cooler is OFF... [06/28/19 21:32:45.783][DEBUG] [Main Thread] Camera cooldown on connect is selected... [06/28/19 21:32:45.784][DEBUG] [Main Thread] Camera cooldown is starting... [06/28/19 21:32:45.795][DEBUG] [TEC Thread] SGM_CHANGE_COOLER_TEMP message received... [06/28/19 21:32:45.796][DEBUG] [TEC Thread] TEC Change: Starting... [06/28/19 21:32:45.796][DEBUG] [TEC Thread] TEC Change: After camera connect change, waiting ~5 seconds... [06/28/19 21:32:45.837][DEBUG] [Main Thread] Disconnecting ASCOM camera: Atik Camera... [06/28/19 21:32:46.298][DEBUG] [TEC Thread] SGM_CHANGE_COOLER_TEMP complete... [06/28/19 21:32:53.915][DEBUG] [Main Thread] Connecting ASCOM focuser... [06/28/19 21:32:59.508][DEBUG] [Main Thread] Focuser supports temperature [06/28/19 21:32:59.508][DEBUG] [Main Thread] Current temperature reports: 30.3125 [06/28/19 21:32:59.509][DEBUG] [Main Thread] Focuser reports Max Increment as: 60000 [06/28/19 21:32:59.509][DEBUG] [Main Thread] Focuser reports max steps as: 60000 [06/28/19 21:32:59.531][DEBUG] [Main Thread] Disconnecting ASCOM Focuser: ASCOM.MicroTouchServer.Focuser1 [06/28/19 21:32:59.549][DEBUG] [Main Thread] Connecting camera in main thread... [06/28/19 21:32:59.553][DEBUG] [Main Thread] Connecting ASCOM camera: ASCOM.Atik.Camera... [06/28/19 21:32:59.809][DEBUG] [Main Thread] Camera does not implement ASCOM gain. [06/28/19 21:32:59.825][DEBUG] [Main Thread] Camera cooler detected... [06/28/19 21:32:59.826][DEBUG] [Main Thread] Camera cooler is OFF... [06/28/19 21:32:59.826][DEBUG] [Main Thread] Camera cooldown on connect is selected... [06/28/19 21:32:59.826][DEBUG] [Main Thread] Camera cooldown is starting... [06/28/19 21:32:59.833][DEBUG] [TEC Thread] SGM_CHANGE_COOLER_TEMP message received... [06/28/19 21:32:59.833][DEBUG] [TEC Thread] TEC Change: Starting... [06/28/19 21:32:59.833][DEBUG] [TEC Thread] TEC Change: After camera connect change, waiting ~5 seconds... [06/28/19 21:32:59.840][DEBUG] [Main Thread] Disconnecting ASCOM camera: Atik Camera... [06/28/19 21:32:59.871][DEBUG] [Main Thread] Connecting camera in main thread... [06/28/19 21:32:59.874][DEBUG] [Main Thread] Connecting ASCOM camera: ASCOM.Atik.Camera... [06/28/19 21:32:59.920][DEBUG] [Main Thread] Camera does not implement ASCOM gain. [06/28/19 21:32:59.933][DEBUG] [Main Thread] Camera cooler detected... [06/28/19 21:32:59.934][DEBUG] [Main Thread] Camera cooler is OFF... [06/28/19 21:32:59.934][DEBUG] [Main Thread] Camera cooldown on connect is selected... [06/28/19 21:32:59.934][DEBUG] [Main Thread] Camera cooldown is starting... [06/28/19 21:33:00.338][DEBUG] [TEC Thread] ASCOM Camera: Failed to set CCD Temperature! : SetCCDTemperature set - '30.34' is an invalid value. The valid range is: -40 to 20. (System.Reflection.TargetInvocationException: Exception has been thrown by the target of an invocation. ---> System.Runtime.InteropServices.COMException: SetCCDTemperature set - '30.34' is an invalid value. The valid range is: -40 to 20. --- End of inner exception stack trace --- at System.RuntimeType.InvokeDispMethod(String name, BindingFlags invokeAttr, Object target, Object[] args, Boolean[] byrefModifiers, Int32 culture, String[] namedParameters) at System.RuntimeType.InvokeMember(String name, BindingFlags bindingFlags, Binder binder, Object target, Object[] providedArgs, ParameterModifier[] modifiers, CultureInfo culture, String[] namedParams) at System.Type.InvokeMember(String name, BindingFlags invokeAttr, Binder binder, Object target, Object[] args, CultureInfo culture) at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 331) at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 369 at ASCOM.DriverAccess.Camera.set_SetCCDTemperature(Double value) in C:\ASCOM Build\Export\ASCOM.DriverAccess\Camera.cs:line 572 at q9.if(Double A_0, Boolean A_1) [06/28/19 21:33:00.339][DEBUG] [TEC Thread] SGM_CHANGE_COOLER_TEMP complete... [06/28/19 21:33:01.775][DEBUG] [Main Thread] Connecting ASCOM focuser... [06/28/19 21:33:02.055][DEBUG] [Main Thread] Focuser supports temperature [06/28/19 21:33:02.055][DEBUG] [Main Thread] Current temperature reports: 30.3125 [06/28/19 21:33:02.056][DEBUG] [Main Thread] Focuser reports Max Increment as: 60000 [06/28/19 21:33:02.056][DEBUG] [Main Thread] Focuser reports max steps as: 60000 [06/28/19 21:33:24.767][DEBUG] [Main Thread] Start time has altitude lock, calculating start time for 66 [06/28/19 21:33:25.047][DEBUG] [Main Thread] Start time set to 6/28/2019 9:30:00 PM [06/28/19 21:33:25.047][DEBUG] [Main Thread] End time has altitude lock, calculating start time for 37 [06/28/19 21:33:25.329][DEBUG] [Main Thread] Start time set to 6/28/2019 11:45:00 PM [06/28/19 21:33:25.348][DEBUG] [Main Thread] Filter wheel is required... [06/28/19 21:33:25.348][DEBUG] [Main Thread] Filter wheel is still connected. Ignoring connect step... [06/28/19 21:33:25.348][DEBUG] [Main Thread] Focuser is required... [06/28/19 21:33:25.348][DEBUG] [Main Thread] Focuser is still connected. Ignoring connect step... [06/28/19 21:33:25.348][DEBUG] [Main Thread] Telescope is required... [06/28/19 21:33:25.348][DEBUG] [Main Thread] Telescope is not connected. Sending connect command... [06/28/19 21:33:25.354][DEBUG] [Telescope Thread] Telescope Dispatch loop: Received SGM_TELESCOPE_CONNECT... [06/28/19 21:33:25.407][DEBUG] [Telescope Thread] Telescope can slewing supported... [06/28/19 21:33:25.411][DEBUG] [Telescope Thread] Telescope: Implements MoveAxis... [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] RA Move Rate Range: Min->0.00416666666666667 Max->0.00416666666666667 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] RA Move Rate Range: Min->0.00833333333333333 Max->0.00833333333333333 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] RA Move Rate Range: Min->0.0333333333333333 Max->0.0333333333333333 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] RA Move Rate Range: Min->0.0666666666666667 Max->0.0666666666666667 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] RA Move Rate Range: Min->0.266666666666667 Max->0.266666666666667 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] RA Move Rate Range: Min->0.533333333333333 Max->0.533333333333333 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] RA Move Rate Range: Min->1.06666666666667 Max->1.06666666666667 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] RA Move Rate Range: Min->2.13333333333333 Max->2.13333333333333 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] RA Move Rate Range: Min->4 Max->4 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] DEC Move Rate Range: Min->0.00416666666666667 Max->0.00416666666666667 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] DEC Move Rate Range: Min->0.00833333333333333 Max->0.00833333333333333 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] DEC Move Rate Range: Min->0.0333333333333333 Max->0.0333333333333333 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] DEC Move Rate Range: Min->0.0666666666666667 Max->0.0666666666666667 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] DEC Move Rate Range: Min->0.266666666666667 Max->0.266666666666667 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] DEC Move Rate Range: Min->0.533333333333333 Max->0.533333333333333 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] DEC Move Rate Range: Min->1.06666666666667 Max->1.06666666666667 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] DEC Move Rate Range: Min->2.13333333333333 Max->2.13333333333333 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] DEC Move Rate Range: Min->4 Max->4 [06/28/19 21:33:25.412][DEBUG] [Telescope Thread] Telescope: CanSetSideOfPier returned True [06/28/19 21:33:25.413][DEBUG] [Telescope Thread] Telescope: CanPark returned True [06/28/19 21:33:25.413][DEBUG] [Telescope Thread] Telescope equatorial system is JNOW... [06/28/19 21:33:25.416][DEBUG] [Telescope Thread] SGM_TELESCOPE_CONNECT complete... [06/28/19 21:33:25.458][DEBUG] [Main Thread] Telescope: Setting sync behavior to: Sync [06/28/19 21:33:27.664][DEBUG] [Main Thread] Observatory connection might be required... [06/28/19 21:33:27.664][DEBUG] [Main Thread] Observatory is not connected. Sending connect command... [06/28/19 21:33:27.669][DEBUG] [Main Thread] Connecting ASCOM dome... [06/28/19 21:33:27.695][DEBUG] [Main Thread] Dome: CanSetAzimuth is true [06/28/19 21:33:27.703][DEBUG] [Main Thread] Environment device required... [06/28/19 21:33:27.703][DEBUG] [Main Thread] Environment device is not connected. Sending connect command... [06/28/19 21:33:27.728][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Connected to OpenWeatherMap ObservingConditions [06/28/19 21:33:27.728][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Device Name - Short driver name - please customise [06/28/19 21:33:27.730][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Description - OpenWeatherMap ObservingConditions [06/28/19 21:33:27.730][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Driver Info Information about the driver itself. Version: 6.4 [06/28/19 21:33:27.731][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Driver Version 6.4 [06/28/19 21:33:29.744][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get Seeing! : Property read StarFWHM is not implemented in this driver. (ASCOM.PropertyNotImplementedException: Property read StarFWHM is not implemented in this driver. at ASCOM.OpenWeatherMap.ObservingConditions.get_StarFWHM() in C:\ASCOM Build\Export\Drivers and Simulators\OpenWeatherMap\OpenWeatherMap\Driver.cs:line 415) at ASCOM.DriverAccess.MemberFactory.GetTargetInvocationExceptionHandler(String memberName, Exception e) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 661 at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 231 at ASCOM.DriverAccess.ObservingConditions.get_StarFWHM() in C:\ASCOM Build\Export\ASCOM.DriverAccess\ObservingConditions.cs:line 232 at js.br() [06/28/19 21:33:29.747][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get SkyBrightness! : Property read SkyBrightness is not implemented in this driver. (ASCOM.PropertyNotImplementedException: Property read SkyBrightness is not implemented in this driver. at ASCOM.OpenWeatherMap.ObservingConditions.get_SkyBrightness() in C:\ASCOM Build\Export\Drivers and Simulators\OpenWeatherMap\OpenWeatherMap\Driver.cs:line 391) at ASCOM.DriverAccess.MemberFactory.GetTargetInvocationExceptionHandler(String memberName, Exception e) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 661 at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 231 at ASCOM.DriverAccess.ObservingConditions.get_SkyBrightness() in C:\ASCOM Build\Export\ASCOM.DriverAccess\ObservingConditions.cs:line 204 at js.br() [06/28/19 21:33:29.750][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get SkyQuality! : Property read SkyQuality is not implemented in this driver. (ASCOM.PropertyNotImplementedException: Property read SkyQuality is not implemented in this driver. at ASCOM.OpenWeatherMap.ObservingConditions.get_SkyQuality() in C:\ASCOM Build\Export\Drivers and Simulators\OpenWeatherMap\OpenWeatherMap\Driver.cs:line 403) at ASCOM.DriverAccess.MemberFactory.GetTargetInvocationExceptionHandler(String memberName, Exception e) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 661 at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 231 at ASCOM.DriverAccess.ObservingConditions.get_SkyQuality() in C:\ASCOM Build\Export\ASCOM.DriverAccess\ObservingConditions.cs:line 218 at js.br() [06/28/19 21:33:29.753][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get SkyTemperature! : Property read SkyTemperature is not implemented in this driver. (ASCOM.PropertyNotImplementedException: Property read SkyTemperature is not implemented in this driver. at ASCOM.OpenWeatherMap.ObservingConditions.get_SkyTemperature() in C:\ASCOM Build\Export\Drivers and Simulators\OpenWeatherMap\OpenWeatherMap\Driver.cs:line 427) at ASCOM.DriverAccess.MemberFactory.GetTargetInvocationExceptionHandler(String memberName, Exception e) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 661 at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 231 at ASCOM.DriverAccess.ObservingConditions.get_SkyTemperature() in C:\ASCOM Build\Export\ASCOM.DriverAccess\ObservingConditions.cs:line 249 at js.br() [06/28/19 21:33:29.757][DEBUG] [Main Thread] ASCOM EnvironmentDevice: Failed to get WindGust! : Property read WindGust is not implemented in this driver. (ASCOM.PropertyNotImplementedException: Property read WindGust is not implemented in this driver. at ASCOM.OpenWeatherMap.ObservingConditions.get_WindGust() in C:\ASCOM Build\Export\Drivers and Simulators\OpenWeatherMap\OpenWeatherMap\Driver.cs:line 491) at ASCOM.DriverAccess.MemberFactory.GetTargetInvocationExceptionHandler(String memberName, Exception e) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 661 at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 231 at ASCOM.DriverAccess.ObservingConditions.get_WindGust() in C:\ASCOM Build\Export\ASCOM.DriverAccess\ObservingConditions.cs:line 298 at js.br() [06/28/19 21:33:31.760][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [06/28/19 21:33:31.763][DEBUG] [Main Thread] GNS Startup... [06/28/19 21:33:31.774][DEBUG] [Sequence Thread] Dispatch loop: Received SGM_RUN_SEQUENCE... [06/28/19 21:33:31.781][DEBUG] [Sequence Thread] GuiderCheck: Checking auto guider status... [06/28/19 21:33:31.781][DEBUG] [Sequence Thread] GuiderCheck: Auto guider is not connected, attempting to connect... [06/28/19 21:33:31.782][DEBUG] [Sequence Thread] GuiderCheck: Starting guider and connecting guider equipment for guider profile... [06/28/19 21:33:37.271][DEBUG] [Auto Guider Equipment Connection Thread] Connecting to PHD2... [06/28/19 21:33:37.273][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:37.275][DEBUG] [PHD2 Listener Thread] Attempting to connect to PHD2... [06/28/19 21:33:38.274][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:38.277][DEBUG] [PHD2 Listener Thread] Failed to establish client connection to PHD2 using port 4400: No connection could be made because the target machine actively refused it 127.0.0.1:4400 [06/28/19 21:33:39.275][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:40.276][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:41.276][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:42.277][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:42.280][DEBUG] [PHD2 Listener Thread] Failed to establish client connection to PHD2 using port 4400: No connection could be made because the target machine actively refused it 127.0.0.1:4400 [06/28/19 21:33:43.277][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:44.278][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:45.279][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:45.281][DEBUG] [PHD2 Listener Thread] Could not etablish a connection to PHD2! Aborting... [06/28/19 21:33:45.281][DEBUG] [PHD2 Listener Thread] PHD2 connection terminated... [06/28/19 21:33:45.281][DEBUG] [PHD2 Listener Thread] Exiting PHD2 listener... [06/28/19 21:33:46.279][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:47.280][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:47.280][DEBUG] [Auto Guider Equipment Connection Thread] Failed to connect to PHD2. Could not establish socket connection... [06/28/19 21:33:52.285][DEBUG] [Auto Guider Equipment Connection Thread] Connecting to PHD2... [06/28/19 21:33:52.285][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:52.285][DEBUG] [PHD2 Listener Thread] Attempting to connect to PHD2... [06/28/19 21:33:53.286][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:53.286][DEBUG] [PHD2 Listener Thread] Failed to establish client connection to PHD2 using port 4400: No connection could be made because the target machine actively refused it 127.0.0.1:4400 [06/28/19 21:33:54.287][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:55.287][DEBUG] [Auto Guider Equipment Connection Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:56.288][DEBUG] [Auto Guider Equipment Connection Thread] Successfully connected to PHD2... [06/28/19 21:33:56.288][DEBUG] [Auto Guider Equipment Connection Thread] PHD2 GetPhdStatus - Pre-Wait : BadConnection [06/28/19 21:33:56.288][DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:33:56.389][DEBUG] [Auto Guider Equipment Connection Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [06/28/19 21:33:56.391][DEBUG] [Auto Guider Equipment Connection Thread] PHD2: PHD2 is already open... [06/28/19 21:33:56.391][DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method": "get_profiles", "id": 1009} [06/28/19 21:33:56.893][DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method":"set_connected","params":[false],"id":1007} [06/28/19 21:33:56.893][DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method":"set_profile","params":[3],"id":1008} [06/28/19 21:33:56.893][DEBUG] [Auto Guider Equipment Connection Thread] Sending to PHD2: {"method":"set_connected","params":[true],"id":1007} [06/28/19 21:33:57.309][DEBUG] [Sequence Thread] Connecting to PHD2... [06/28/19 21:33:57.309][DEBUG] [PHD2 Listener Thread] Abort thread message received: Thread was being aborted. [06/28/19 21:33:57.329][DEBUG] [Sequence Thread] Waiting for socket connection to PHD2... [06/28/19 21:33:57.329][DEBUG] [PHD2 Listener Thread] Attempting to connect to PHD2... [06/28/19 21:33:58.330][DEBUG] [Sequence Thread] Successfully connected to PHD2... [06/28/19 21:33:58.330][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [06/28/19 21:33:58.330][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:33:58.431][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [06/28/19 21:33:58.431][DEBUG] [Sequence Thread] GuiderCheck: Auto guider reports connected... [06/28/19 21:33:58.431][DEBUG] [Sequence Thread] Checking auto guider version... [06/28/19 21:33:58.431][DEBUG] [Sequence Thread] PHD2: Performing version check... [06/28/19 21:33:58.431][DEBUG] [Sequence Thread] PHD2: Min version is 2.6.0 [06/28/19 21:33:58.431][DEBUG] [Sequence Thread] PHD2: User version is 2.6.5dev7 [06/28/19 21:33:58.432][DEBUG] [Sequence Thread] Finding first active group... [06/28/19 21:33:58.432][DEBUG] [Sequence Thread] Looking at target ngc4559... [06/28/19 21:33:58.432][DEBUG] [Sequence Thread] Target is active: True [06/28/19 21:33:58.432][DEBUG] [Sequence Thread] Target is complete: False [06/28/19 21:33:58.432][DEBUG] [Sequence Thread] Target marked as past end time: False [06/28/19 21:33:58.432][DEBUG] [Sequence Thread] Target has end time: True [06/28/19 21:33:58.432][DEBUG] [Sequence Thread] Target end time: 06/28/2019 23:45:00 [06/28/19 21:33:58.432][DEBUG] [Sequence Thread] Active group found... [06/28/19 21:33:58.432][DEBUG] [Sequence Thread] Sequence should find starting target; Found target: 0 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] ************** SEQUENCE DUMP ************** [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sDirectory: C:\01 MARKs STUFF\02 SGP Images [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sBaseName: [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nDelayFirst: 0 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nDelayBetween: 0 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bFinishFullEventFirst: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] arEventGroups: System.Collections.Generic.List`1[SequenceGenerator.EventGroup] [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nCurrentEventIndex: 0 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] dtElapsedTime: 01/01/0001 00:00:00 +00:00 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bStarted: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bIsSequenceRunning: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sFileNamePattern: %ft\%bn_%fz_%el_%ct_%fp_%am_%bi_%fe_%ps_%yy_%tm [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sVersion: 3.0.3.169 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] tsElapsedTime: 00:00:26 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bCaptureUntil: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] dtCaptureUntil: 06/28/2019 21:29:00 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] userProfile: SequenceGenerator.UserProfile [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nAfNebulosityRejection: 0.85 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sequenceFiles: System.Collections.Generic.Dictionary`2[System.String,System.String] [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sequenceFileList: System.Collections.Generic.List`1[SequenceGenerator.SequenceFile] [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] imageHistory: SequenceGenerator.ImageHistoryManager [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nAfSampleSize: 100 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bCaptureCalFramesIfSequenceFails: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] notificationsList: System.Collections.Generic.List`1[SequenceGenerator.NotoficationInfo] [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bRunEndOfSequenceScript: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sEndOfSequenceScript: [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bDisconnectAllGearOnSequenceEnd: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] ************** PROFILE DUMP ************** [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sForImagingInstance: Sequence Generator Pro [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sProfileName: 12CEM120_716fr_AtkFWoag_LdStr_SGPro3 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bDefault: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sCameraName: Atik Camera [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nGain1x1: 0 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nOffset1x1: 100 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nGain2x2: 0 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nOffset2x2: 100 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nGain3x3: 0 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nOffset3x3: 100 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nGain4x4: 0 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nOffset4x4: 100 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nCooldownTemp: -10 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nCooldownTime: 10 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nWarmupTemp: 0 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nWarmupTime: 7 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoCoolDown: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoWarmUp: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sFilterWheelName: Atik EFW Driver [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nFilterDelay: 0 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sFocuserName: MicroTouch Focuser1 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bReverseFocuser: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nFineFocusStepSize: 50 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nCoarseFocusStepSize: 250 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoAdjustFocusPerFilter: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoFocusForFilterChangeOnly: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bUseAutoFocus: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoFocusPerFrame: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoFocusOverTime: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nAutoFocusFramerInterval: 5 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nAutoFocusTimerInterval: 50 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoFocusForceForFilter: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoFocusBeforeFirstFrame: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoFocusManualStar: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoManualFocusForFilterChangeOnly: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bUseAutoManualFocus: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoManualFocusPerFrame: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoManualFocusOverTime: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nAutoManualFocusFramerInterval: 1 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nAutoManualFocusTimerInterval: 10 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoManualFocusForceForFilter: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoManualFocusBeforeFirstFrame: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bOverrideMaxSteps: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nOverrideMaxSteps: 1 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bTempComp: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nStepsPerDegree: 113 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bPhdDither: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nPhdDitherIndex: 0 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nPhdSettleValue: 1 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bRecalGuiderOnSlew: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] nDecRecalValue: 0 [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sTelescopeName: iOptron ASCOM Driver for CEM120 Mount [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoSlew: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] tpFocusFrame: [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] tpTargetFrame: [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bPausePhdDuringDownload: False [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bShutdownPhdWhenDone: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bParkTelescopeWhenDone: True [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] sReferenceImagePath: [06/28/19 21:33:58.434][DEBUG] [Sequence Thread] bAutoCenterFrame: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] siReference: nEstRa: 0 nEstDec: 0 nRightAscention: 0 nDeclination: 0 nArcsecPerPixel: 0 nAngle: -500 bFlipped: False sSearchType: sBinning: nExposureLength: 0 sImagePath: bFailed: True sInfo: bDoneSolving: True nSides: 0 nMaxSolveTime: 60 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] siScope: nEstRa: 0 nEstDec: 0 nRightAscention: 0 nDeclination: 0 nArcsecPerPixel: 0 nAngle: 0 bFlipped: False sSearchType: 400 Regions sBinning: 2x2 nExposureLength: 0 sImagePath: bFailed: True sInfo: bDoneSolving: True nSides: 0 nMaxSolveTime: 60 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nSolverExposure1x1: 8 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nSolverExposure2x2: 1 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nSolverExposure3x3: 1 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nSolverExposure4x4: 1 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nArcsec1x1: 0.511 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nArcsec2x2: 0 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nArcsec3x3: 0 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nArcsec4x4: 0 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sDithertext: Small Dither [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sAutoGuider: PHD2 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nFFBinning: 3 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nFFExposure: 1 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nAFExposure: 2 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nAFBinning: 0 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nAFStepSize: 75 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nAFDataPoints: 9 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sPlateSolver: PlateSolve2 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sAutoFocuser: Half Flux Radius [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nAutoFocusDialogCloseDelay: 5 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bAutoFocusDegree: True [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bAutoManualFocusDegree: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nAutoFocusDegreeInterval: 1 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nAutoManualFocusDegreeInterval: 1 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bAutoFocusAutoContinue: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nNudgeSpeed: 0 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bReverseNs: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bReverseEw: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nHiSpeedRate: 1 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nLoSpeedRate: 0.5 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sCameraGain1x1: NA [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sCameraGain2x2: NA [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sCameraGain3x3: NA [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sCameraGain4x4: NA [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sCameraOffset1x1: [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sCameraOffset2x2: [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sCameraOffset3x3: [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sCameraOffset4x4: [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bPauseAutoGuiderDuringAutoFocus: True [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bUseSameStarsForAf: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bSaveAfData: True [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sSaveAfDataPath: C:\01 MARKs STUFF\02 SGP Images [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bAllowExternalScopeControl: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sFFBinning: 4x4 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sAFBinning: 2x2 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nMountSettling: 15 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] ffExposure: 1 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] noFilter: SequenceGenerator.Filter [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bAutoFocusOnResume: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sFlatBoxName: No Flat Box [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] flatBoxBrightness: 0 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bFocuserBacklash: True [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nFocuserBacklashStepSize: 100 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bFocuserBacklashMovesIn: True [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nGuiderSettlingTime: 6 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nAutoCenterAttempts: 6 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nAutoCenterError: 40 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bFrameRestart: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nFrameRestartError: 0 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bDoAutoMeridianFlip: True [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] autoMeridianFlipVals: SequenceGenerator.AutoMeridianFlipValues [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bUseAfDarks: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sAfDarksPath: [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bUseAutoCenterFilter: True [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sAutoCenterFilter: Lum [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bUseAutoFocusFilter: True [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sAutoFocusFilter: Lum [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bSettleAgBeforeAf: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bUseHighSpeedDl: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bBlindSolveFailover: True [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nReadoutNoise: 12.12 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] ccdArraySize: {Width=3362, Height=2504} [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nCameraGain1x1: 0.479 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nCameraGain2x2: 0 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nCameraGain3x3: 0 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nCameraGain4x4: 0 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sRotatorName: No Rotator [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] nRotationError: 3 [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bUseTemperDevice: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bAutoFocusAfterFlip: True [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] bReverseManualRotatorCorrections: False [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sObservatoryName: LesveDomeNet Dome [06/28/19 21:33:58.435][DEBUG] [Sequence Thread] sObsType: Dome [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] SlavingVals: Radius: 48 NorthOffset: -5.5 VerticalOffset: -6 GemOffset: 16.5 SlavingFrequency: 60 SlavingAngleAllowance: 2 SlaveOnSeqStart: True UnparkWithMount: True ParkMountFirst: False OpenShutterFirst: False UnparkOpensShutter: False ParkClosesShutter: False [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bSlaveObsToScope: False [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bPromptToPlaceLightBox: False [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nDownloadTime1x1: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nDownloadTime2x2: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nDownloadTime3x3: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nDownloadTime4x4: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bAfCropFrames: False [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nAfCropFramesPercent: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sFilePattern: %ft\%bn_%fz_%el_%ct_%fp_%am_%bi_%fe_%ps_%yy_%tm [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sWeatherStationName: No Safety Monitor [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nScopeFocalLength: 2182 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bCameraCooldownOnSequenceStart: False [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sRtfNotes: [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bStopTracking: False [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bHasCentralObstruction: True [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sCustomVariables: [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sPhd2Profile: 12in_AtkEfw2_StrznaOag_5Red_LdStr_CEM120Ascom [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bAutoConnectPhd2Gear: True [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bAutoDisconnectPhd2Gear: True [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bPauseGuiderDuringBacklashComp: False [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bSetAbsPositiononFirstFilterChange: False [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sEnvironmentDeviceName: OpenWeatherMap ObservingConditions [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bSettleGuiderTime: True [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] equipmentData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.EquipmentData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nMinStarSize: 6 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] telescopeSyncOption: Sync [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nAutoguiderDitherEveryXFrameCount: 1 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bFocusLockRestartWhenOutOfFocus: False [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bFocusLockPreventFocuserMovement: False [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] ************** FILTER DUMP ************** [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] >> FILTER 1: [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bActive: True [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sName: None [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nAfExposureTime: 1 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFocusPosition: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFocusTemp: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat1: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat2: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat3: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat4: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nNumFlats: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sFocusWith: Default [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] arFocPositions: System.Collections.Generic.List`1[SequenceGenerator.FocusPosData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] >> FILTER 2: [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bActive: True [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sName: Lum [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nAfExposureTime: 5 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFocusPosition: 29700 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFocusTemp: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat1: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat2: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat3: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat4: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nNumFlats: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sFocusWith: Default [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] arFocPositions: [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] >> FILTER 3: [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bActive: True [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sName: Red [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nAfExposureTime: 5 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFocusPosition: 29750 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFocusTemp: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat1: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat2: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat3: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat4: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nNumFlats: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sFocusWith: Default [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] arFocPositions: [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] >> FILTER 4: [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bActive: True [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sName: Green [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nAfExposureTime: 5 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFocusPosition: 29650 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFocusTemp: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat1: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat2: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat3: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat4: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nNumFlats: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sFocusWith: Default [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] arFocPositions: [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] >> FILTER 5: [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bActive: True [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sName: Blue [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nAfExposureTime: 5 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFocusPosition: 29600 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFocusTemp: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat1: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat2: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat3: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat4: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nNumFlats: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sFocusWith: Default [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] arFocPositions: [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] >> FILTER 6: [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] bActive: True [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] sName: NONE [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nAfExposureTime: 1 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFocusPosition: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFocusTemp: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat1: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat2: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat3: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nFlat4: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] nNumFlats: 0 [06/28/19 21:33:58.436][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sFocusWith: Default [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] arFocPositions: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] >> FILTER 7: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] bActive: True [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sName: Ha [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nAfExposureTime: 35 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusPosition: 29750 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusTemp: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat1: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat2: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat3: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat4: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nNumFlats: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sFocusWith: Default [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] arFocPositions: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] >> FILTER 8: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] bActive: True [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sName: OIII [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nAfExposureTime: 35 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusPosition: 29600 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusTemp: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat1: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat2: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat3: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat4: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nNumFlats: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sFocusWith: Default [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] arFocPositions: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] >> FILTER 9: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] bActive: True [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sName: SII [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nAfExposureTime: 35 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusPosition: 29700 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusTemp: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat1: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat2: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat3: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat4: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nNumFlats: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sFocusWith: Default [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] arFocPositions: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] >> FILTER 10: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] bActive: True [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sName: Unnamed 1 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nAfExposureTime: 1 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusPosition: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusTemp: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat1: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat2: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat3: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat4: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nNumFlats: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sFocusWith: Default [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] arFocPositions: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] >> FILTER 11: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] bActive: False [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sName: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nAfExposureTime: 1 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusPosition: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusTemp: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat1: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat2: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat3: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat4: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nNumFlats: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sFocusWith: Default [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] arFocPositions: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] >> FILTER 12: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] bActive: False [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sName: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nAfExposureTime: 1 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusPosition: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusTemp: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat1: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat2: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat3: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat4: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nNumFlats: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sFocusWith: Default [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] arFocPositions: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] >> FILTER 13: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] bActive: False [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sName: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nAfExposureTime: 1 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusPosition: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFocusTemp: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat1: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat2: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat3: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nFlat4: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] nNumFlats: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsData: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataBin: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] flatsDataIso: System.Collections.Generic.Dictionary`2[System.String,SequenceGenerator.FlatData] [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] sFocusWith: Default [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] arFocPositions: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] ************** EVENT DUMP ************** [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] * Target ngc4559 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Active: True [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Start Time: True [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Start: 06/28/2019 21:30:00 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -End Time: True [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -End: 06/28/2019 23:45:00 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Auto Rotate: False [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Auto Center: True [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Location set: False [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -RA: 12.5990944444444 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -DEC: 27.9553333333333 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Finish Full Event: True [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Completed: False [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -After End Time: False [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Rotate Camera: False [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Rotation: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] ** Event 1 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Active: True [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Frame Type: Light [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Filter: 1 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Suffix: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Exposure Time: 600 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Binning: 1x1 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Repeat: 40 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Gain: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Offset: 100 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Num Complete: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] ** Event 2 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Active: True [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Frame Type: Light [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Filter: 2 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Suffix: [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Exposure Time: 300 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Binning: 1x1 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Repeat: 20 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Gain: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Offset: 100 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] -Num Complete: 0 [06/28/19 21:33:58.437][DEBUG] [Sequence Thread] ** Event 3 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Active: True [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Frame Type: Light [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Filter: 4 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Suffix: [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Exposure Time: 300 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Binning: 1x1 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Repeat: 20 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Gain: 0 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Offset: 100 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Num Complete: 0 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] ** Event 4 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Active: True [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Frame Type: Light [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Filter: 3 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Suffix: [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Exposure Time: 300 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Binning: 1x1 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Repeat: 20 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Gain: 0 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Offset: 100 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Num Complete: 0 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] ** Event 5 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Active: False [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Frame Type: Light [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Filter: 0 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Suffix: [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Exposure Time: 300 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Binning: 1x1 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Repeat: 20 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Gain: 0 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Offset: 100 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] -Num Complete: 0 [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] ************** END SEQUENCE DUMP ************** [06/28/19 21:33:58.438][DEBUG] [Sequence Thread] ********** Run sequence started ********** [06/28/19 21:33:58.481][DEBUG] [Sequence Thread] Checking if observatory requires auto slaving... [06/28/19 21:33:58.481][DEBUG] [Sequence Thread] Attempting to auto slave the observatory... [06/28/19 21:33:58.482][DEBUG] [Sequence Thread] Auto slaved the observatory... [06/28/19 21:33:58.485][DEBUG] [Sequence Thread] DoEventGroupChange: Changing to event group: ngc4559 [06/28/19 21:33:58.486][DEBUG] [Sequence Thread] DoEventGroupChange: Waiting for start time 06/28/2019 21:30:00... [06/28/19 21:33:58.491][DEBUG] [Sequence Thread] Start time is good... [06/28/19 21:33:58.491][DEBUG] [Sequence Thread] Checking for start delay... [06/28/19 21:33:58.492][DEBUG] [Sequence Thread] Sending unpark command in DoEventGroupChange... [06/28/19 21:33:58.492][DEBUG] [Sequence Thread] ASCOM Telescope: OpenShutter command sent. [06/28/19 21:33:58.492][DEBUG] [Sequence Thread] ASCOM Telescope: Unpark message received. [06/28/19 21:33:58.529][DEBUG] [Sequence Thread] ASCOM Telescope: Start tracking [06/28/19 21:33:59.149][DEBUG] [Sequence Thread] ASCOM Telescope: Blocking for observatory slaving to complete [06/28/19 21:33:59.152][DEBUG] [Sequence Thread] Observatory: Calculating new position using: [06/28/19 21:33:59.153][DEBUG] [Sequence Thread] Azimuth: 0 [06/28/19 21:33:59.153][DEBUG] [Sequence Thread] Altitude: 32.5016666666667 [06/28/19 21:33:59.153][DEBUG] [Sequence Thread] Hour Angle: -89.999979332381 [06/28/19 21:33:59.153][DEBUG] [Sequence Thread] Pier Side: East [06/28/19 21:33:59.154][DEBUG] [Sequence Thread] Observatory: No adjustment needed. [06/28/19 21:34:00.156][DEBUG] [Sequence Thread] ASCOM Telescope: Observatory slaving complete [06/28/19 21:34:00.158][DEBUG] [Sequence Thread] Unpark complete. [06/28/19 21:34:00.158][DEBUG] [Sequence Thread] DoEventGroupChange: Stopping Autoguider [06/28/19 21:34:00.159][DEBUG] [Sequence Thread] Attempting to stop PHD2 guiding... [06/28/19 21:34:00.159][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:34:00.159][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [06/28/19 21:34:00.159][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:34:00.260][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [06/28/19 21:34:00.260][DEBUG] [Sequence Thread] PHD2 Guider is already stopped. [06/28/19 21:34:00.260][DEBUG] [Sequence Thread] DoEventGroupChange: Slewing to target [06/28/19 21:34:00.268][DEBUG] [Sequence Thread] Telescope: Slewing to J2000 RA: 12.5990944444444 (12h35m56.74s) Dec: 27.9553333333333 (27°57'19.20") [06/28/19 21:34:00.268][DEBUG] [Sequence Thread] Telescope: Slew received J2000 coordinates, mount requires JNOW, converting... [06/28/19 21:34:00.269][DEBUG] [Sequence Thread] Telescope: Slewing to JNOW RA: 12.614855185293 Dec: 27.8529959505728 [06/28/19 21:34:00.269][DEBUG] [Sequence Thread] Telescope: Calling Observatory Slave Slew [06/28/19 21:34:00.271][DEBUG] [Sequence Thread] Observatory: Calculating new position using: [06/28/19 21:34:00.271][DEBUG] [Sequence Thread] Azimuth: 266.665125416535 [06/28/19 21:34:00.271][DEBUG] [Sequence Thread] Altitude: 64.8691891464511 [06/28/19 21:34:00.271][DEBUG] [Sequence Thread] Hour Angle: 28.8107573256962 [06/28/19 21:34:00.271][DEBUG] [Sequence Thread] Pier Side: East [06/28/19 21:34:00.271][DEBUG] [Sequence Thread] Observatory: Adjustment needed, slewing to Azimuth: 230.031021045834 [06/28/19 21:34:18.901][DEBUG] [Sequence Thread] Scope reports it is done with synchronous slew, verifying... [06/28/19 21:34:18.901][DEBUG] [Sequence Thread] Telescope: Observatory is reporting slewing [06/28/19 21:34:19.903][DEBUG] [Sequence Thread] Telescope: Observatory is reporting slewing [06/28/19 21:34:20.904][DEBUG] [Sequence Thread] Telescope: Observatory is reporting slewing [06/28/19 21:34:21.904][DEBUG] [Sequence Thread] Telescope: Observatory is reporting slewing [06/28/19 21:34:22.904][DEBUG] [Sequence Thread] Telescope: Observatory is reporting slewing [06/28/19 21:34:23.906][DEBUG] [Sequence Thread] Telescope: Observatory is reporting slewing [06/28/19 21:34:24.908][DEBUG] [Sequence Thread] Telescope: Observatory is reporting slewing [06/28/19 21:34:25.910][DEBUG] [Sequence Thread] Telescope: Slewing has completed [06/28/19 21:34:25.910][DEBUG] [Sequence Thread] Telescope: Settling for 15 seconds [06/28/19 21:34:40.910][DEBUG] [Sequence Thread] Telescope: Settling has completed [06/28/19 21:34:40.910][DEBUG] [Sequence Thread] DoEventGroupChange: Slew complete [06/28/19 21:34:40.910][DEBUG] [Sequence Thread] DoEventGroupChange: Centering on target [06/28/19 21:34:40.990][DEBUG] [Telescope Thread] Center telescope message received... [06/28/19 21:34:40.990][DEBUG] [Telescope Thread] Solving with Plate Solver PlateSolve2... [06/28/19 21:34:40.990][DEBUG] [Telescope Thread] Setting filter for auto center... [06/28/19 21:34:40.992][DEBUG] [Telescope Thread] Setting filter position 1... [06/28/19 21:34:40.992][DEBUG] [Telescope Thread] Filter position 1 is already set. Skipping... [06/28/19 21:34:40.993][DEBUG] [Telescope Thread] Performing auto center step 1... [06/28/19 21:34:40.993][DEBUG] [Telescope Thread] Skipping step 1... [06/28/19 21:34:40.993][DEBUG] [Telescope Thread] Auto center reference frame solved successfully... [06/28/19 21:34:40.993][DEBUG] [Telescope Thread] Performing auto center step 3 (scope)... [06/28/19 21:34:40.993][DEBUG] [Telescope Thread] Auto center slewing scope to match reference... [06/28/19 21:34:40.997][DEBUG] [Telescope Thread] Telescope: Slewing to J2000 RA: 12.5990944444444 (12h35m56.74s) Dec: 27.9553333333333 (27°57'19.20") [06/28/19 21:34:40.997][DEBUG] [Telescope Thread] Telescope: Slew received J2000 coordinates, mount requires JNOW, converting... [06/28/19 21:34:40.997][DEBUG] [Telescope Thread] Telescope: Slewing to JNOW RA: 12.6148551833499 Dec: 27.8529959587619 [06/28/19 21:34:40.997][DEBUG] [Telescope Thread] Telescope: Calling Observatory Slave Slew [06/28/19 21:34:41.000][DEBUG] [Telescope Thread] Observatory: Calculating new position using: [06/28/19 21:34:41.000][DEBUG] [Telescope Thread] Azimuth: 266.774012034972 [06/28/19 21:34:41.000][DEBUG] [Telescope Thread] Altitude: 64.7259080618441 [06/28/19 21:34:41.000][DEBUG] [Telescope Thread] Hour Angle: 28.982058497621 [06/28/19 21:34:41.000][DEBUG] [Telescope Thread] Pier Side: East [06/28/19 21:34:41.000][DEBUG] [Telescope Thread] Observatory: Adjustment needed, slewing to Azimuth: 230.476393987797 [06/28/19 21:34:43.090][DEBUG] [Telescope Thread] Scope reports it is done with synchronous slew, verifying... [06/28/19 21:34:43.090][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [06/28/19 21:34:44.091][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [06/28/19 21:34:45.092][DEBUG] [Telescope Thread] Telescope: Slewing has completed [06/28/19 21:34:45.092][DEBUG] [Telescope Thread] Telescope: Settling for 15 seconds [06/28/19 21:35:00.093][DEBUG] [Telescope Thread] Telescope: Settling has completed [06/28/19 21:35:00.093][DEBUG] [Telescope Thread] Auto center slew complete... [06/28/19 21:35:00.093][DEBUG] [Telescope Thread] Performing auto center step 4... [06/28/19 21:35:00.093][DEBUG] [Telescope Thread] Created full file name (file does not exist): C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [06/28/19 21:35:00.098][DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE message received... [06/28/19 21:35:00.098][DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [06/28/19 21:35:00.100][DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [06/28/19 21:35:00.112][DEBUG] [Camera Thread] SetAscomNormalSpeed... [06/28/19 21:35:00.113][DEBUG] [Camera Thread] Readout speed set to NORMAL... [06/28/19 21:35:00.307][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [06/28/19 21:35:00.307][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [06/28/19 21:35:00.307][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [06/28/19 21:35:00.307][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:35:00.307][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [06/28/19 21:35:12.547][DEBUG] [Camera Thread] Created full file name (file does not exist): C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [06/28/19 21:35:12.548][DEBUG] [Camera Thread] SaveFileAscom: Start... [06/28/19 21:35:12.548][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [06/28/19 21:35:12.548][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [06/28/19 21:35:12.549][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [06/28/19 21:35:12.549][DEBUG] [Camera Thread] SaveFileAscom: Validating file name... [06/28/19 21:35:12.549][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [06/28/19 21:35:12.846][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [06/28/19 21:35:12.846][DEBUG] [Camera Thread] SaveFileAscom: Saving preview bitmap to disk... [06/28/19 21:35:12.847][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [06/28/19 21:35:12.847][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [06/28/19 21:35:12.847][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [06/28/19 21:35:12.848][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [06/28/19 21:35:12.886][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [06/28/19 21:35:12.886][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [06/28/19 21:35:12.886][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [06/28/19 21:35:12.887][DEBUG] [Camera Thread] Internal Interface: Set Preview... [06/28/19 21:35:12.887][DEBUG] [Camera Thread] Display image preview using asynch task... [06/28/19 21:35:13.055][DEBUG] [Camera Thread] SaveFileAscom: Done [06/28/19 21:35:13.055][DEBUG] [Camera Thread] =========== Save file took 512 ms [06/28/19 21:35:13.055][DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE complete... [06/28/19 21:35:13.283][DEBUG] [Telescope Thread] Auto center verification frame complete. Plate solving image C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [06/28/19 21:35:13.286][DEBUG] [Telescope Thread] ************* SOLVE HINTS **************** [06/28/19 21:35:13.286][DEBUG] [Telescope Thread] SOLVER: PlateSolve2 [06/28/19 21:35:13.286][DEBUG] [Telescope Thread] BLIND: False [06/28/19 21:35:13.286][DEBUG] [Telescope Thread] METHOD: 400 Regions [06/28/19 21:35:13.286][DEBUG] [Telescope Thread] RA: 12.5991031611373 [06/28/19 21:35:13.286][DEBUG] [Telescope Thread] DEC: 27.9553262172778 [06/28/19 21:35:13.286][DEBUG] [Telescope Thread] SCALE: 1.022 [06/28/19 21:35:13.286][DEBUG] [Telescope Thread] ****************************************** [06/28/19 21:35:13.296][DEBUG] [Telescope Thread] FitsFileHeaderData: Angle - 0 [06/28/19 21:35:13.296][DEBUG] [Telescope Thread] FitsFileHeaderData: Scale - 0 [06/28/19 21:35:13.296][DEBUG] [Telescope Thread] FitsFileHeaderData: RA - 12.5991226218643 [06/28/19 21:35:13.296][DEBUG] [Telescope Thread] FitsFileHeaderData: DEC - 27.9553316850299 [06/28/19 21:35:13.300][DEBUG] [Telescope Thread] PlateSove2 Param: RA (RAD) - 3.29843749440407 [06/28/19 21:35:13.300][DEBUG] [Telescope Thread] PlateSove2 Param: DEC (RAD) - 0.487912485960589 [06/28/19 21:35:13.300][DEBUG] [Telescope Thread] PlateSove2 Param: Width - 1677 [06/28/19 21:35:13.300][DEBUG] [Telescope Thread] PlateSove2 Param: Height - 1264 [06/28/19 21:35:13.300][DEBUG] [Telescope Thread] PlateSolve2 Command Line: [06/28/19 21:35:13.300][DEBUG] [Telescope Thread] C:\Users\Lighthouse\AppData\Local\SequenceGenerator\\PlateSolve2.exe 3.29843749440407,0.48791248596059,0.00830919259172,0.00626286191767,400,C:\Users\Lighthouse\AppData\Local\SequenceGenerator\\Temp\psXSolve_0.fit [06/28/19 21:35:16.126][DEBUG] [Telescope Thread] *********** SUCCESSFUL SOLVE ************* [06/28/19 21:35:16.126][DEBUG] [Telescope Thread] SOLVER: False [06/28/19 21:35:16.126][DEBUG] [Telescope Thread] SUCCESS: True [06/28/19 21:35:16.126][DEBUG] [Telescope Thread] CONF: 100 [06/28/19 21:35:16.126][DEBUG] [Telescope Thread] BLIND: False [06/28/19 21:35:16.126][DEBUG] [Telescope Thread] RA: 12.5320499699452 [06/28/19 21:35:16.126][DEBUG] [Telescope Thread] DEC: 27.9589269155036 [06/28/19 21:35:16.126][DEBUG] [Telescope Thread] SCALE: 1.02494 [06/28/19 21:35:16.126][DEBUG] [Telescope Thread] FLIPPED: False [06/28/19 21:35:16.126][DEBUG] [Telescope Thread] ANGLE (EON): 1.19 [06/28/19 21:35:16.126][DEBUG] [Telescope Thread] MSG: Valid solve. [06/28/19 21:35:16.126][DEBUG] [Telescope Thread] ****************************************** [06/28/19 21:35:16.127][DEBUG] [Telescope Thread] Checking to see if solve might be bad... [06/28/19 21:35:16.128][DEBUG] [Telescope Thread] Solve appears to be good... [06/28/19 21:35:16.128][DEBUG] [Telescope Thread] Auto center validation frame solved successfully... [06/28/19 21:35:16.129][DEBUG] [Telescope Thread] Telescope: Syncing to J2000 RA: 12.5320499699452 Dec: 27.9589269155036 [06/28/19 21:35:16.129][DEBUG] [Telescope Thread] Telescope: Sync behavior set to "Sync"... [06/28/19 21:35:16.129][DEBUG] [Telescope Thread] Telescope: Sync Passed in J2000 but mount requires JNOW, converting... [06/28/19 21:35:16.129][DEBUG] [Telescope Thread] Telescope: Syncing to JNOW RA: 12.5478684787159 Dec: 27.8562956181813 [06/28/19 21:35:16.541][DEBUG] [Telescope Thread] Attempting to write fits header info for C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [06/28/19 21:35:16.542][DEBUG] [Telescope Thread] Opening fits file... [06/28/19 21:35:16.542][DEBUG] [Telescope Thread] Successfully opened fits file... [06/28/19 21:35:16.542][DEBUG] [Telescope Thread] Writing fits headers... [06/28/19 21:35:16.543][DEBUG] [Telescope Thread] Closing fits file [06/28/19 21:35:16.543][DEBUG] [Telescope Thread] Could not sync the rotator to 1.19 degrees (not connected)! [06/28/19 21:35:16.544][DEBUG] [Telescope Thread] Auto center complete... [06/28/19 21:35:16.656][DEBUG] [Center Scope Thread] Retrying auto center. Total Error > Allowable error: 7064.7 > 40.0 [06/28/19 21:35:16.656][DEBUG] [Center Scope Thread] RA Error: 7064.6 [06/28/19 21:35:16.656][DEBUG] [Center Scope Thread] DEC Error: -25.2 [06/28/19 21:35:16.663][DEBUG] [Telescope Thread] Center telescope message received... [06/28/19 21:35:16.663][DEBUG] [Telescope Thread] Solving with Plate Solver PlateSolve2... [06/28/19 21:35:16.912][DEBUG] [Center Scope Thread] Error in auto center update thread, Thread was being aborted. [06/28/19 21:35:16.917][DEBUG] [Telescope Thread] Setting filter for auto center... [06/28/19 21:35:16.917][DEBUG] [Telescope Thread] Setting filter position 1... [06/28/19 21:35:16.917][DEBUG] [Telescope Thread] Filter position 1 is already set. Skipping... [06/28/19 21:35:16.917][DEBUG] [Telescope Thread] Performing auto center step 1... [06/28/19 21:35:16.917][DEBUG] [Telescope Thread] Skipping step 1... [06/28/19 21:35:16.917][DEBUG] [Telescope Thread] Auto center reference frame solved successfully... [06/28/19 21:35:16.917][DEBUG] [Telescope Thread] Performing auto center step 3 (scope)... [06/28/19 21:35:16.917][DEBUG] [Telescope Thread] Auto center slewing scope to match reference... [06/28/19 21:35:16.920][DEBUG] [Telescope Thread] Telescope: Slewing to J2000 RA: 12.5990944444444 (12h35m56.74s) Dec: 27.9553333333333 (27°57'19.20") [06/28/19 21:35:16.920][DEBUG] [Telescope Thread] Telescope: Slew received J2000 coordinates, mount requires JNOW, converting... [06/28/19 21:35:16.920][DEBUG] [Telescope Thread] Telescope: Slewing to JNOW RA: 12.6148551816363 Dec: 27.8529959659836 [06/28/19 21:35:16.920][DEBUG] [Telescope Thread] Telescope: Calling Observatory Slave Slew [06/28/19 21:35:16.922][DEBUG] [Telescope Thread] Observatory: Calculating new position using: [06/28/19 21:35:16.922][DEBUG] [Telescope Thread] Azimuth: 266.8694778604 [06/28/19 21:35:16.922][DEBUG] [Telescope Thread] Altitude: 64.5995246487751 [06/28/19 21:35:16.922][DEBUG] [Telescope Thread] Hour Angle: 29.1324692383504 [06/28/19 21:35:16.922][DEBUG] [Telescope Thread] Pier Side: East [06/28/19 21:35:16.922][DEBUG] [Telescope Thread] Observatory: Adjustment needed, slewing to Azimuth: 230.86416780952 [06/28/19 21:35:19.094][DEBUG] [Telescope Thread] Scope reports it is done with synchronous slew, verifying... [06/28/19 21:35:19.095][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [06/28/19 21:35:20.096][DEBUG] [Telescope Thread] Telescope: Observatory is reporting slewing [06/28/19 21:35:21.097][DEBUG] [Telescope Thread] Telescope: Slewing has completed [06/28/19 21:35:21.097][DEBUG] [Telescope Thread] Telescope: Settling for 15 seconds [06/28/19 21:35:36.097][DEBUG] [Telescope Thread] Telescope: Settling has completed [06/28/19 21:35:36.097][DEBUG] [Telescope Thread] Auto center slew complete... [06/28/19 21:35:36.097][DEBUG] [Telescope Thread] Performing auto center step 4... [06/28/19 21:35:36.097][DEBUG] [Telescope Thread] Created full file name (file does not exist): C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [06/28/19 21:35:36.107][DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE message received... [06/28/19 21:35:36.107][DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [06/28/19 21:35:36.107][DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [06/28/19 21:35:36.110][DEBUG] [Camera Thread] SetAscomNormalSpeed... [06/28/19 21:35:36.110][DEBUG] [Camera Thread] Readout speed set to NORMAL... [06/28/19 21:35:44.535][DEBUG] [Dome Thread] Observatory: Calculating new position using: [06/28/19 21:35:44.535][DEBUG] [Dome Thread] Azimuth: 267.286389359544 [06/28/19 21:35:44.535][DEBUG] [Dome Thread] Altitude: 64.3745681232502 [06/28/19 21:35:44.535][DEBUG] [Dome Thread] Hour Angle: 29.249032924224 [06/28/19 21:35:44.535][DEBUG] [Dome Thread] Pier Side: East [06/28/19 21:35:44.535][DEBUG] [Dome Thread] Observatory: Adjustment needed, slewing to Azimuth: 231.865296281339 [06/28/19 21:35:48.518][DEBUG] [Camera Thread] Created full file name (file does not exist): C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [06/28/19 21:35:48.518][DEBUG] [Camera Thread] SaveFileAscom: Start... [06/28/19 21:35:48.518][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [06/28/19 21:35:48.518][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [06/28/19 21:35:48.519][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [06/28/19 21:35:48.519][DEBUG] [Camera Thread] SaveFileAscom: Validating file name... [06/28/19 21:35:48.519][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [06/28/19 21:35:48.820][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [06/28/19 21:35:48.820][DEBUG] [Camera Thread] SaveFileAscom: Saving preview bitmap to disk... [06/28/19 21:35:48.820][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [06/28/19 21:35:48.820][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [06/28/19 21:35:48.820][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [06/28/19 21:35:48.820][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [06/28/19 21:35:48.842][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [06/28/19 21:35:48.842][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [06/28/19 21:35:48.842][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [06/28/19 21:35:48.842][DEBUG] [Camera Thread] Internal Interface: Set Preview... [06/28/19 21:35:48.842][DEBUG] [Camera Thread] Display image preview using asynch task... [06/28/19 21:35:49.051][DEBUG] [Camera Thread] SaveFileAscom: Done [06/28/19 21:35:49.051][DEBUG] [Camera Thread] =========== Save file took 533 ms [06/28/19 21:35:49.051][DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE complete... [06/28/19 21:35:49.225][DEBUG] [Telescope Thread] Auto center verification frame complete. Plate solving image C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [06/28/19 21:35:49.227][DEBUG] [Telescope Thread] ************* SOLVE HINTS **************** [06/28/19 21:35:49.227][DEBUG] [Telescope Thread] SOLVER: PlateSolve2 [06/28/19 21:35:49.227][DEBUG] [Telescope Thread] BLIND: False [06/28/19 21:35:49.227][DEBUG] [Telescope Thread] METHOD: 400 Regions [06/28/19 21:35:49.227][DEBUG] [Telescope Thread] RA: 12.5991281847018 [06/28/19 21:35:49.227][DEBUG] [Telescope Thread] DEC: 27.9553372045218 [06/28/19 21:35:49.227][DEBUG] [Telescope Thread] SCALE: 1.02494 [06/28/19 21:35:49.227][DEBUG] [Telescope Thread] ****************************************** [06/28/19 21:35:49.230][DEBUG] [Telescope Thread] PlateSove2 Param: RA (RAD) - 3.29844404555793 [06/28/19 21:35:49.230][DEBUG] [Telescope Thread] PlateSove2 Param: DEC (RAD) - 0.487912677724173 [06/28/19 21:35:49.230][DEBUG] [Telescope Thread] PlateSove2 Param: Width - 1677 [06/28/19 21:35:49.230][DEBUG] [Telescope Thread] PlateSove2 Param: Height - 1264 [06/28/19 21:35:49.230][DEBUG] [Telescope Thread] PlateSolve2 Command Line: [06/28/19 21:35:49.230][DEBUG] [Telescope Thread] C:\Users\Lighthouse\AppData\Local\SequenceGenerator\\PlateSolve2.exe 3.29844404555793,0.48791267772417,0.00833309574849,0.00628087836976,400,C:\Users\Lighthouse\AppData\Local\SequenceGenerator\\Temp\psXSolve_1.fit [06/28/19 21:35:50.769][DEBUG] [Telescope Thread] *********** SUCCESSFUL SOLVE ************* [06/28/19 21:35:50.769][DEBUG] [Telescope Thread] SOLVER: False [06/28/19 21:35:50.769][DEBUG] [Telescope Thread] SUCCESS: True [06/28/19 21:35:50.769][DEBUG] [Telescope Thread] CONF: 100 [06/28/19 21:35:50.769][DEBUG] [Telescope Thread] BLIND: False [06/28/19 21:35:50.769][DEBUG] [Telescope Thread] RA: 12.599151731136 [06/28/19 21:35:50.769][DEBUG] [Telescope Thread] DEC: 27.9554370295734 [06/28/19 21:35:50.769][DEBUG] [Telescope Thread] SCALE: 1.02455 [06/28/19 21:35:50.769][DEBUG] [Telescope Thread] FLIPPED: False [06/28/19 21:35:50.769][DEBUG] [Telescope Thread] ANGLE (EON): 1.08999999999997 [06/28/19 21:35:50.769][DEBUG] [Telescope Thread] MSG: Valid solve. [06/28/19 21:35:50.769][DEBUG] [Telescope Thread] ****************************************** [06/28/19 21:35:50.769][DEBUG] [Telescope Thread] Checking to see if solve might be bad... [06/28/19 21:35:50.770][DEBUG] [Telescope Thread] Solve appears to be good... [06/28/19 21:35:50.770][DEBUG] [Telescope Thread] Auto center validation frame solved successfully... [06/28/19 21:35:50.770][DEBUG] [Telescope Thread] Telescope: Syncing to J2000 RA: 12.599151731136 Dec: 27.9554370295734 [06/28/19 21:35:50.770][DEBUG] [Telescope Thread] Telescope: Sync behavior set to "Sync"... [06/28/19 21:35:50.770][DEBUG] [Telescope Thread] Telescope: Sync Passed in J2000 but mount requires JNOW, converting... [06/28/19 21:35:50.770][DEBUG] [Telescope Thread] Telescope: Syncing to JNOW RA: 12.6149124146252 Dec: 27.8530999426518 [06/28/19 21:35:51.213][DEBUG] [Telescope Thread] Attempting to write fits header info for C:\Users\Lighthouse\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [06/28/19 21:35:51.213][DEBUG] [Telescope Thread] Opening fits file... [06/28/19 21:35:51.214][DEBUG] [Telescope Thread] Successfully opened fits file... [06/28/19 21:35:51.214][DEBUG] [Telescope Thread] Writing fits headers... [06/28/19 21:35:51.214][DEBUG] [Telescope Thread] Closing fits file [06/28/19 21:35:51.214][DEBUG] [Telescope Thread] Could not sync the rotator to 1.09 degrees (not connected)! [06/28/19 21:35:51.214][DEBUG] [Telescope Thread] Auto center complete... [06/28/19 21:35:51.381][DEBUG] [Center Scope Thread] Automatic Auto Center Success - Total Error <= Allowable error: 6.1 <= 40.0 [06/28/19 21:35:51.381][DEBUG] [Center Scope Thread] RA Error: -6.0 [06/28/19 21:35:51.381][DEBUG] [Center Scope Thread] DEC Error: -0.7 [06/28/19 21:35:51.544][DEBUG] [Sequence Thread] DoEventGroupChange: Slewed or Centered, attempting to start guiding. [06/28/19 21:35:51.547][DEBUG] [Sequence Thread] DoEventGroupChange: Pier flipped, flipping Cal data [06/28/19 21:35:51.548][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "flip_calibration", "id": 1005} [06/28/19 21:35:52.549][DEBUG] [Sequence Thread] PHD2: Auto Resume [06/28/19 21:35:52.549][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:35:52.549][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [06/28/19 21:35:52.549][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:35:52.650][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [06/28/19 21:35:53.651][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:35:53.651][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [06/28/19 21:35:53.651][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:35:53.752][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [06/28/19 21:35:54.753][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:35:54.753][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [06/28/19 21:35:54.753][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:35:54.854][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [06/28/19 21:35:55.855][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:35:55.855][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [06/28/19 21:35:55.855][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:35:55.956][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [06/28/19 21:35:56.956][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:35:56.956][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [06/28/19 21:35:56.956][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:35:57.057][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Stopped [06/28/19 21:35:57.057][DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 1, "time": 6, "timeout": 600}, false ], "id": 1003} [06/28/19 21:35:57.057][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 1, "time": 6, "timeout": 600}, false ], "id": 1003} [06/28/19 21:35:57.057][DEBUG] [Sequence Thread] PHD2: Attempting to start guiding, waiting for PHD2 settle done message... [06/28/19 21:36:06.895][DEBUG] [PHD2 Listener Thread] Unknown object from PHD2: {"Event":"SettleBegin","Timestamp":1561775766.888,"Host":"LIGHTHOUSEOBS","Inst":1} [06/28/19 21:36:16.396][DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: GOOD [06/28/19 21:36:17.072][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:36:17.072][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [06/28/19 21:36:17.072][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:36:17.173][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [06/28/19 21:36:17.173][DEBUG] [Sequence Thread] PHD2 settle successful... [06/28/19 21:36:17.207][DEBUG] [Sequence Thread] DoEventGroupChange: Complete [06/28/19 21:36:17.208][DEBUG] [Sequence Thread] Attempting to find next event... [06/28/19 21:36:17.208][DEBUG] [Sequence Thread] Current event[0] frame count: 0/40... [06/28/19 21:36:17.209][DEBUG] [Sequence Thread] Looking at event[0]... [06/28/19 21:36:17.209][DEBUG] [Sequence Thread] Found event event[0] with remaining frames. [06/28/19 21:36:17.209][DEBUG] [Sequence Thread] Event[0] frame count: 0/40... [06/28/19 21:36:17.209][DEBUG] [Sequence Thread] Getting first event (0)... [06/28/19 21:36:17.209][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [06/28/19 21:36:17.211][DEBUG] [Sequence Thread] DoEventGroupChange: Waiting for start time 06/28/2019 21:30:00... [06/28/19 21:36:17.216][DEBUG] [Sequence Thread] Start time is good... [06/28/19 21:36:17.220][DEBUG] [Sequence Thread] SetStartTemp: Using focuser for temperature... [06/28/19 21:36:17.273][DEBUG] [Sequence Thread] Set start frame temp to 30.3125... [06/28/19 21:36:17.273][DEBUG] [Sequence Thread] Running pre event... [06/28/19 21:36:17.280][DEBUG] [Sequence Thread] Current target has end time at 06/28/2019 23:45:00 [06/28/19 21:36:17.280][DEBUG] [Sequence Thread] End time of next frame is at 06/28/2019 21:46:17 [06/28/19 21:36:17.280][DEBUG] [Sequence Thread] Target is still before end time, continuing... [06/28/19 21:36:17.282][DEBUG] [Sequence Thread] Running capture event... [06/28/19 21:36:17.287][DEBUG] [Sequence Thread] ------------- Starting capture frame for event[0] ------------- [06/28/19 21:36:17.289][DEBUG] [Sequence Thread] Sending commands... [06/28/19 21:36:17.291][DEBUG] [Sequence Thread] SetFlatBox: Frame Type is Light [06/28/19 21:36:17.291][DEBUG] [Sequence Thread] EventMarker 2 - t:ngc4559 (0); e:0; f:0; o: [06/28/19 21:36:17.292][DEBUG] [Sequence Thread] Checking if Meridian Flip is needed [06/28/19 21:36:17.292][DEBUG] [Sequence Thread] Meridian flip not needed, telescope on East side [06/28/19 21:36:17.293][DEBUG] [Sequence Thread] EventMarker 3 - t:ngc4559 (0); e:0; f:0; o: [06/28/19 21:36:17.293][DEBUG] [Sequence Thread] Waiting for AF to complete... [06/28/19 21:36:17.298][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received... [06/28/19 21:36:17.300][DEBUG] [Camera Thread] Checking for auto focus... [06/28/19 21:36:17.300][DEBUG] [Camera Thread] Auto focus required (focus before first frame)... [06/28/19 21:36:17.300][DEBUG] [Camera Thread] Auto focus required (post centering trigger)... [06/28/19 21:36:17.301][DEBUG] [Camera Thread] Pause guiding while AF is active, pause command sent, waiting for guider to pause... [06/28/19 21:36:17.301][DEBUG] [Camera Thread] Checking PHD2 state... [06/28/19 21:36:17.301][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [06/28/19 21:36:17.301][DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:36:17.311][DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE message received... [06/28/19 21:36:17.311][DEBUG] [Auto Guider Thread] Pausing auto guider... [06/28/19 21:36:17.312][DEBUG] [Auto Guider Thread] Checking PHD2 state... [06/28/19 21:36:17.312][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [06/28/19 21:36:17.312][DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:36:17.402][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [06/28/19 21:36:17.413][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [06/28/19 21:36:17.413][DEBUG] [Auto Guider Thread] Sending to PHD2: {"method":"set_paused","params":[true,"full"],"id":42} [06/28/19 21:36:17.413][DEBUG] [Auto Guider Thread] Checking PHD2 state... [06/28/19 21:36:17.413][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [06/28/19 21:36:17.413][DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:36:17.513][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [06/28/19 21:36:18.403][DEBUG] [Camera Thread] Checking PHD2 state... [06/28/19 21:36:18.403][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [06/28/19 21:36:18.403][DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:36:18.504][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [06/28/19 21:36:18.514][DEBUG] [Auto Guider Thread] Checking PHD2 state... [06/28/19 21:36:18.514][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [06/28/19 21:36:18.514][DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:36:18.614][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Paused [06/28/19 21:36:18.614][DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE complete... [06/28/19 21:36:19.505][DEBUG] [Camera Thread] Checking PHD2 state... [06/28/19 21:36:19.505][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [06/28/19 21:36:19.505][DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:36:19.605][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [06/28/19 21:36:20.605][DEBUG] [Camera Thread] Checking PHD2 state... [06/28/19 21:36:20.605][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [06/28/19 21:36:20.605][DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:36:20.706][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [06/28/19 21:36:21.707][DEBUG] [Camera Thread] Checking PHD2 state... [06/28/19 21:36:21.707][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [06/28/19 21:36:21.707][DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:36:21.908][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [06/28/19 21:36:22.909][DEBUG] [Camera Thread] Checking PHD2 state... [06/28/19 21:36:22.909][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [06/28/19 21:36:22.909][DEBUG] [Camera Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:36:23.010][DEBUG] [Camera Thread] PHD2 GetPhdStatus - Post-Wait: Paused [06/28/19 21:36:23.015][DEBUG] [Camera Thread] Auto focus: setting filter Lum [06/28/19 21:36:23.015][DEBUG] [Camera Thread] Setting filter position 1... [06/28/19 21:36:23.015][DEBUG] [Camera Thread] Filter position 1 is already set. Skipping... [06/28/19 21:36:23.016][DEBUG] [Camera Thread] Auto focus running... [06/28/19 21:36:23.021][DEBUG] [Camera Thread] Turning temp comp off.. [06/28/19 21:36:23.048][DEBUG] [Camera Thread] ASCOM Focuser: Temp comp is avaialble, setting to False [06/28/19 21:36:23.056][DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE message received... [06/28/19 21:36:23.056][DEBUG] [Auto Guider Thread] Pausing auto guider... [06/28/19 21:36:23.056][DEBUG] [Auto Guider Thread] Checking PHD2 state... [06/28/19 21:36:23.056][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [06/28/19 21:36:23.056][DEBUG] [Auto Guider Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:36:23.056][DEBUG] [Camera Thread] Performing Sequence Generator auto focus using Half Flux Radius. AFID: 0 [06/28/19 21:36:23.114][DEBUG] [AfChartThread] Showing AF chart dialog... [06/28/19 21:36:23.141][DEBUG] [Camera Thread] Auto focus data [06/28/19 21:36:23.141][DEBUG] [Camera Thread] - Data Points: 9 [06/28/19 21:36:23.141][DEBUG] [Camera Thread] - Step Size: 75 [06/28/19 21:36:23.141][DEBUG] [Camera Thread] - Current Position: 28303 [06/28/19 21:36:23.141][DEBUG] [Camera Thread] - Initial Move Position: 28603 [06/28/19 21:36:23.146][DEBUG] [Camera Thread] AF Darks exception: The path is not of a legal form. [06/28/19 21:36:23.146][DEBUG] [Camera Thread] Moving focuser to next position (28603)... [06/28/19 21:36:23.151][DEBUG] [Focuser Move Thread] Focuser moving to 28603 [06/28/19 21:36:23.157][DEBUG] [Auto Guider Thread] PHD2 GetPhdStatus - Post-Wait: Paused [06/28/19 21:36:23.157][DEBUG] [Auto Guider Thread] PHD2: Requested pause, but PHD2 reports it is not guiding [06/28/19 21:36:23.157][DEBUG] [Auto Guider Thread] SGM_GUIDE_PAUSE complete... [06/28/19 21:36:23.178][DEBUG] [Focuser Move Thread] Focuser backlash active, modified move to 28703 [06/28/19 21:36:23.179][DEBUG] [Focuser Move Thread] Focuser move call complete [06/28/19 21:36:23.180][DEBUG] [Focuser Backlash Thread] Focuser backlash thread has started... [06/28/19 21:36:24.180][DEBUG] [Focuser Backlash Thread] Backlash thread has detected that movement to modified position (28703) is complete... [06/28/19 21:36:24.180][DEBUG] [Focuser Backlash Thread] Moving focuser to original requested position (28603)... [06/28/19 21:36:24.180][DEBUG] [Focuser Backlash Thread] Focuser backlash compensation needed. Steps: 100 Direction:IN [06/28/19 21:36:24.180][DEBUG] [Focuser Backlash Thread] Focuser moving to 28603 [06/28/19 21:36:24.235][DEBUG] [Focuser Backlash Thread] Focuser move call complete [06/28/19 21:36:25.236][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 28603 matches requested position 28603 [06/28/19 21:36:25.236][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Waiting for focuser to report done... [06/28/19 21:36:25.262][DEBUG] [Focuser Backlash Thread] Focuser backlash completed. Focuser is at original request position (28603)... [06/28/19 21:36:25.262][DEBUG] [Focuser Backlash Thread] Focuser backlash thread has ended... [06/28/19 21:36:26.263][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser reports it is done moving, continuing... [06/28/19 21:36:26.263][DEBUG] [Camera Thread] Focuser move complete... [06/28/19 21:36:26.289][DEBUG] [Camera Thread] Focuser position matches requested position (28603), continuing... [06/28/19 21:36:26.315][DEBUG] [Camera Thread] Calculating step metric... [06/28/19 21:36:26.316][DEBUG] [Camera Thread] Taking auto focus frame(s)... [06/28/19 21:36:26.317][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [06/28/19 21:36:26.318][DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [06/28/19 21:36:26.318][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds... [06/28/19 21:36:26.318][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [06/28/19 21:36:26.320][DEBUG] [Camera Thread] SetAscomNormalSpeed... [06/28/19 21:36:26.320][DEBUG] [Camera Thread] Readout speed set to NORMAL... [06/28/19 21:36:35.725][DEBUG] [Camera Thread] SaveFileAscom: Start... [06/28/19 21:36:35.725][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [06/28/19 21:36:35.725][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [06/28/19 21:36:35.725][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [06/28/19 21:36:35.726][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [06/28/19 21:36:36.027][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [06/28/19 21:36:36.027][DEBUG] [Camera Thread] SaveFileAscom: Done [06/28/19 21:36:36.028][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [06/28/19 21:36:36.028][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [06/28/19 21:36:36.029][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [06/28/19 21:36:36.029][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [06/28/19 21:36:36.051][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [06/28/19 21:36:36.051][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [06/28/19 21:36:36.051][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [06/28/19 21:36:36.051][DEBUG] [Camera Thread] Internal Interface: Set Preview... [06/28/19 21:36:36.051][DEBUG] [Camera Thread] Display image preview using asynch task... [06/28/19 21:36:36.143][DEBUG] [Main Thread] --> Find stars (normal) [06/28/19 21:36:36.899][DEBUG] [Main Thread] Star detection using min star size of 3px... [06/28/19 21:36:36.899][DEBUG] [Main Thread] Star detection using max star size of 60px... [06/28/19 21:36:36.941][DEBUG] [Main Thread] Find stars took: 798 ms... [06/28/19 21:36:36.942][DEBUG] [Main Thread] Star list contains 2 stars... [06/28/19 21:36:36.942][DEBUG] [Main Thread] Calculating HFR with sample size: 3 [06/28/19 21:36:37.140][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.57 [06/28/19 21:36:38.152][DEBUG] [Camera Thread] Moving focuser to next position (28528)... [06/28/19 21:36:38.152][DEBUG] [Focuser Move Thread] Focuser moving to 28528 [06/28/19 21:36:38.205][DEBUG] [Focuser Move Thread] Focuser move call complete [06/28/19 21:36:39.232][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 28528 matches requested position 28528 [06/28/19 21:36:39.232][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Waiting for focuser to report done... [06/28/19 21:36:40.232][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser reports it is done moving, continuing... [06/28/19 21:36:40.232][DEBUG] [Camera Thread] Focuser move complete... [06/28/19 21:36:40.258][DEBUG] [Camera Thread] Focuser position matches requested position (28528), continuing... [06/28/19 21:36:40.284][DEBUG] [Camera Thread] Calculating step metric... [06/28/19 21:36:40.284][DEBUG] [Camera Thread] Taking auto focus frame(s)... [06/28/19 21:36:40.285][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [06/28/19 21:36:40.285][DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [06/28/19 21:36:40.285][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds... [06/28/19 21:36:40.285][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [06/28/19 21:36:40.287][DEBUG] [Camera Thread] SetAscomNormalSpeed... [06/28/19 21:36:40.288][DEBUG] [Camera Thread] Readout speed set to NORMAL... [06/28/19 21:36:44.626][DEBUG] [Dome Thread] Observatory: Calculating new position using: [06/28/19 21:36:44.626][DEBUG] [Dome Thread] Azimuth: 267.441326910255 [06/28/19 21:36:44.626][DEBUG] [Dome Thread] Altitude: 64.1635338516296 [06/28/19 21:36:44.626][DEBUG] [Dome Thread] Hour Angle: 29.499550725632 [06/28/19 21:36:44.626][DEBUG] [Dome Thread] Pier Side: East [06/28/19 21:36:44.626][DEBUG] [Dome Thread] Observatory: Adjustment needed, slewing to Azimuth: 232.488443074954 [06/28/19 21:36:49.702][DEBUG] [Camera Thread] SaveFileAscom: Start... [06/28/19 21:36:49.702][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [06/28/19 21:36:49.702][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [06/28/19 21:36:49.703][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [06/28/19 21:36:49.703][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [06/28/19 21:36:50.011][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [06/28/19 21:36:50.011][DEBUG] [Camera Thread] SaveFileAscom: Done [06/28/19 21:36:50.011][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [06/28/19 21:36:50.011][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [06/28/19 21:36:50.011][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [06/28/19 21:36:50.011][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [06/28/19 21:36:50.060][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [06/28/19 21:36:50.060][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [06/28/19 21:36:50.060][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [06/28/19 21:36:50.060][DEBUG] [Camera Thread] Internal Interface: Set Preview... [06/28/19 21:36:50.060][DEBUG] [Camera Thread] Display image preview using asynch task... [06/28/19 21:36:50.199][DEBUG] [Main Thread] --> Find stars (normal) [06/28/19 21:36:50.986][DEBUG] [Main Thread] Star detection using min star size of 3px... [06/28/19 21:36:50.987][DEBUG] [Main Thread] Star detection using max star size of 60px... [06/28/19 21:36:51.010][DEBUG] [Main Thread] Find stars took: 810 ms... [06/28/19 21:36:51.010][DEBUG] [Main Thread] Star list contains 2 stars... [06/28/19 21:36:51.010][DEBUG] [Main Thread] Calculating HFR with sample size: 3 [06/28/19 21:36:51.205][DEBUG] [Camera Thread] Auto focus HFR calculated at: 4.75 [06/28/19 21:36:52.211][DEBUG] [Camera Thread] Moving focuser to next position (28453)... [06/28/19 21:36:52.211][DEBUG] [Focuser Move Thread] Focuser moving to 28453 [06/28/19 21:36:52.263][DEBUG] [Focuser Move Thread] Focuser move call complete [06/28/19 21:36:53.290][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 28453 matches requested position 28453 [06/28/19 21:36:53.290][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Waiting for focuser to report done... [06/28/19 21:36:54.290][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser reports it is done moving, continuing... [06/28/19 21:36:54.290][DEBUG] [Camera Thread] Focuser move complete... [06/28/19 21:36:54.316][DEBUG] [Camera Thread] Focuser position matches requested position (28453), continuing... [06/28/19 21:36:54.342][DEBUG] [Camera Thread] Calculating step metric... [06/28/19 21:36:54.342][DEBUG] [Camera Thread] Taking auto focus frame(s)... [06/28/19 21:36:54.343][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [06/28/19 21:36:54.343][DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [06/28/19 21:36:54.343][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds... [06/28/19 21:36:54.343][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [06/28/19 21:36:54.345][DEBUG] [Camera Thread] SetAscomNormalSpeed... [06/28/19 21:36:54.345][DEBUG] [Camera Thread] Readout speed set to NORMAL... [06/28/19 21:37:03.751][DEBUG] [Camera Thread] SaveFileAscom: Start... [06/28/19 21:37:03.751][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [06/28/19 21:37:03.751][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [06/28/19 21:37:03.752][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [06/28/19 21:37:03.752][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [06/28/19 21:37:04.055][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [06/28/19 21:37:04.056][DEBUG] [Camera Thread] SaveFileAscom: Done [06/28/19 21:37:04.056][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [06/28/19 21:37:04.056][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [06/28/19 21:37:04.056][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [06/28/19 21:37:04.056][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [06/28/19 21:37:04.077][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [06/28/19 21:37:04.077][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [06/28/19 21:37:04.077][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [06/28/19 21:37:04.077][DEBUG] [Camera Thread] Internal Interface: Set Preview... [06/28/19 21:37:04.077][DEBUG] [Camera Thread] Display image preview using asynch task... [06/28/19 21:37:04.166][DEBUG] [Main Thread] --> Find stars (normal) [06/28/19 21:37:04.907][DEBUG] [Main Thread] Star detection using min star size of 3px... [06/28/19 21:37:04.907][DEBUG] [Main Thread] Star detection using max star size of 60px... [06/28/19 21:37:04.925][DEBUG] [Main Thread] Find stars took: 758 ms... [06/28/19 21:37:04.925][DEBUG] [Main Thread] Star list contains 3 stars... [06/28/19 21:37:04.925][DEBUG] [Main Thread] Calculating HFR with sample size: 3 [06/28/19 21:37:05.063][DEBUG] [Camera Thread] Auto focus HFR calculated at: 3.79 [06/28/19 21:37:06.068][DEBUG] [Camera Thread] Moving focuser to next position (28378)... [06/28/19 21:37:06.068][DEBUG] [Focuser Move Thread] Focuser moving to 28378 [06/28/19 21:37:06.120][DEBUG] [Focuser Move Thread] Focuser move call complete [06/28/19 21:37:07.147][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 28378 matches requested position 28378 [06/28/19 21:37:07.147][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Waiting for focuser to report done... [06/28/19 21:37:08.147][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser reports it is done moving, continuing... [06/28/19 21:37:08.147][DEBUG] [Camera Thread] Focuser move complete... [06/28/19 21:37:08.173][DEBUG] [Camera Thread] Focuser position matches requested position (28378), continuing... [06/28/19 21:37:08.199][DEBUG] [Camera Thread] Calculating step metric... [06/28/19 21:37:08.199][DEBUG] [Camera Thread] Taking auto focus frame(s)... [06/28/19 21:37:08.200][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [06/28/19 21:37:08.200][DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [06/28/19 21:37:08.200][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds... [06/28/19 21:37:08.200][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [06/28/19 21:37:08.202][DEBUG] [Camera Thread] SetAscomNormalSpeed... [06/28/19 21:37:08.202][DEBUG] [Camera Thread] Readout speed set to NORMAL... [06/28/19 21:37:17.603][DEBUG] [Camera Thread] SaveFileAscom: Start... [06/28/19 21:37:17.603][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [06/28/19 21:37:17.603][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [06/28/19 21:37:17.604][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [06/28/19 21:37:17.604][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [06/28/19 21:37:17.903][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [06/28/19 21:37:17.903][DEBUG] [Camera Thread] SaveFileAscom: Done [06/28/19 21:37:17.903][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [06/28/19 21:37:17.903][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [06/28/19 21:37:17.904][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [06/28/19 21:37:17.904][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [06/28/19 21:37:17.951][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [06/28/19 21:37:17.951][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [06/28/19 21:37:17.951][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [06/28/19 21:37:17.951][DEBUG] [Camera Thread] Internal Interface: Set Preview... [06/28/19 21:37:17.951][DEBUG] [Camera Thread] Display image preview using asynch task... [06/28/19 21:37:18.057][DEBUG] [Main Thread] --> Find stars (normal) [06/28/19 21:37:18.798][DEBUG] [Main Thread] Star detection using min star size of 3px... [06/28/19 21:37:18.798][DEBUG] [Main Thread] Star detection using max star size of 60px... [06/28/19 21:37:18.824][DEBUG] [Main Thread] Find stars took: 767 ms... [06/28/19 21:37:18.824][DEBUG] [Main Thread] Star list contains 5 stars... [06/28/19 21:37:18.824][DEBUG] [Main Thread] Calculating HFR with sample size: 3 [06/28/19 21:37:18.970][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.99 [06/28/19 21:37:19.979][DEBUG] [Camera Thread] Moving focuser to next position (28303)... [06/28/19 21:37:19.979][DEBUG] [Focuser Move Thread] Focuser moving to 28303 [06/28/19 21:37:20.031][DEBUG] [Focuser Move Thread] Focuser move call complete [06/28/19 21:37:21.058][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 28303 matches requested position 28303 [06/28/19 21:37:21.058][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Waiting for focuser to report done... [06/28/19 21:37:22.059][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser reports it is done moving, continuing... [06/28/19 21:37:22.059][DEBUG] [Camera Thread] Focuser move complete... [06/28/19 21:37:22.085][DEBUG] [Camera Thread] Focuser position matches requested position (28303), continuing... [06/28/19 21:37:22.111][DEBUG] [Camera Thread] Calculating step metric... [06/28/19 21:37:22.111][DEBUG] [Camera Thread] Taking auto focus frame(s)... [06/28/19 21:37:22.112][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [06/28/19 21:37:22.112][DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [06/28/19 21:37:22.112][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds... [06/28/19 21:37:22.112][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [06/28/19 21:37:22.114][DEBUG] [Camera Thread] SetAscomNormalSpeed... [06/28/19 21:37:22.114][DEBUG] [Camera Thread] Readout speed set to NORMAL... [06/28/19 21:37:23.164][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [06/28/19 21:37:23.164][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [06/28/19 21:37:23.164][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [06/28/19 21:37:23.164][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:37:23.164][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Paused [06/28/19 21:37:31.521][DEBUG] [Camera Thread] SaveFileAscom: Start... [06/28/19 21:37:31.521][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [06/28/19 21:37:31.521][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [06/28/19 21:37:31.522][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [06/28/19 21:37:31.522][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [06/28/19 21:37:31.825][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [06/28/19 21:37:31.825][DEBUG] [Camera Thread] SaveFileAscom: Done [06/28/19 21:37:31.825][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [06/28/19 21:37:31.825][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [06/28/19 21:37:31.825][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [06/28/19 21:37:31.825][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [06/28/19 21:37:31.861][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [06/28/19 21:37:31.861][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [06/28/19 21:37:31.861][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [06/28/19 21:37:31.861][DEBUG] [Camera Thread] Internal Interface: Set Preview... [06/28/19 21:37:31.861][DEBUG] [Camera Thread] Display image preview using asynch task... [06/28/19 21:37:31.955][DEBUG] [Main Thread] --> Find stars (normal) [06/28/19 21:37:32.675][DEBUG] [Main Thread] Star detection using min star size of 3px... [06/28/19 21:37:32.675][DEBUG] [Main Thread] Star detection using max star size of 60px... [06/28/19 21:37:32.697][DEBUG] [Main Thread] Find stars took: 742 ms... [06/28/19 21:37:32.697][DEBUG] [Main Thread] Star list contains 9 stars... [06/28/19 21:37:32.697][DEBUG] [Main Thread] Calculating HFR with sample size: 3 [06/28/19 21:37:32.847][DEBUG] [Camera Thread] Auto focus HFR calculated at: 2.27 [06/28/19 21:37:33.852][DEBUG] [Camera Thread] Moving focuser to next position (28228)... [06/28/19 21:37:33.853][DEBUG] [Focuser Move Thread] Focuser moving to 28228 [06/28/19 21:37:33.879][DEBUG] [Focuser Move Thread] Focuser move call complete [06/28/19 21:37:34.906][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 28228 matches requested position 28228 [06/28/19 21:37:34.906][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Waiting for focuser to report done... [06/28/19 21:37:35.907][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser reports it is done moving, continuing... [06/28/19 21:37:35.907][DEBUG] [Camera Thread] Focuser move complete... [06/28/19 21:37:35.933][DEBUG] [Camera Thread] Focuser position matches requested position (28228), continuing... [06/28/19 21:37:35.959][DEBUG] [Camera Thread] Calculating step metric... [06/28/19 21:37:35.959][DEBUG] [Camera Thread] Taking auto focus frame(s)... [06/28/19 21:37:35.960][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [06/28/19 21:37:35.960][DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [06/28/19 21:37:35.960][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds... [06/28/19 21:37:35.960][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [06/28/19 21:37:35.962][DEBUG] [Camera Thread] SetAscomNormalSpeed... [06/28/19 21:37:35.963][DEBUG] [Camera Thread] Readout speed set to NORMAL... [06/28/19 21:37:44.681][DEBUG] [Dome Thread] Observatory: Calculating new position using: [06/28/19 21:37:44.681][DEBUG] [Dome Thread] Azimuth: 267.594854202421 [06/28/19 21:37:44.681][DEBUG] [Dome Thread] Altitude: 63.9522347549233 [06/28/19 21:37:44.681][DEBUG] [Dome Thread] Hour Angle: 29.750318695611 [06/28/19 21:37:44.681][DEBUG] [Dome Thread] Pier Side: East [06/28/19 21:37:44.681][DEBUG] [Dome Thread] Observatory: Adjustment needed, slewing to Azimuth: 233.099624758734 [06/28/19 21:37:45.366][DEBUG] [Camera Thread] SaveFileAscom: Start... [06/28/19 21:37:45.366][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [06/28/19 21:37:45.366][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [06/28/19 21:37:45.367][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [06/28/19 21:37:45.367][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [06/28/19 21:37:45.672][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [06/28/19 21:37:45.673][DEBUG] [Camera Thread] SaveFileAscom: Done [06/28/19 21:37:45.673][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [06/28/19 21:37:45.673][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [06/28/19 21:37:45.673][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [06/28/19 21:37:45.673][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [06/28/19 21:37:45.739][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [06/28/19 21:37:45.739][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [06/28/19 21:37:45.739][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [06/28/19 21:37:45.739][DEBUG] [Camera Thread] Internal Interface: Set Preview... [06/28/19 21:37:45.739][DEBUG] [Camera Thread] Display image preview using asynch task... [06/28/19 21:37:45.848][DEBUG] [Main Thread] --> Find stars (normal) [06/28/19 21:37:46.599][DEBUG] [Main Thread] Star detection using min star size of 3px... [06/28/19 21:37:46.599][DEBUG] [Main Thread] Star detection using max star size of 60px... [06/28/19 21:37:46.617][DEBUG] [Main Thread] Find stars took: 768 ms... [06/28/19 21:37:46.617][DEBUG] [Main Thread] Star list contains 13 stars... [06/28/19 21:37:46.617][DEBUG] [Main Thread] Calculating HFR with sample size: 3 [06/28/19 21:37:46.771][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.69 [06/28/19 21:37:47.776][DEBUG] [Camera Thread] Moving focuser to next position (28153)... [06/28/19 21:37:47.776][DEBUG] [Focuser Move Thread] Focuser moving to 28153 [06/28/19 21:37:47.803][DEBUG] [Focuser Move Thread] Focuser move call complete [06/28/19 21:37:48.829][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 28153 matches requested position 28153 [06/28/19 21:37:48.829][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Waiting for focuser to report done... [06/28/19 21:37:48.856][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser reports it is done moving, continuing... [06/28/19 21:37:48.856][DEBUG] [Camera Thread] Focuser move complete... [06/28/19 21:37:48.908][DEBUG] [Camera Thread] Focuser position matches requested position (28153), continuing... [06/28/19 21:37:48.934][DEBUG] [Camera Thread] Calculating step metric... [06/28/19 21:37:48.934][DEBUG] [Camera Thread] Taking auto focus frame(s)... [06/28/19 21:37:48.935][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [06/28/19 21:37:48.935][DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [06/28/19 21:37:48.935][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds... [06/28/19 21:37:48.935][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [06/28/19 21:37:48.937][DEBUG] [Camera Thread] SetAscomNormalSpeed... [06/28/19 21:37:48.938][DEBUG] [Camera Thread] Readout speed set to NORMAL... [06/28/19 21:37:58.339][DEBUG] [Camera Thread] SaveFileAscom: Start... [06/28/19 21:37:58.339][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [06/28/19 21:37:58.339][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [06/28/19 21:37:58.340][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [06/28/19 21:37:58.340][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [06/28/19 21:37:58.643][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [06/28/19 21:37:58.643][DEBUG] [Camera Thread] SaveFileAscom: Done [06/28/19 21:37:58.643][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [06/28/19 21:37:58.643][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [06/28/19 21:37:58.643][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [06/28/19 21:37:58.644][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [06/28/19 21:37:58.677][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [06/28/19 21:37:58.678][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [06/28/19 21:37:58.678][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [06/28/19 21:37:58.678][DEBUG] [Camera Thread] Internal Interface: Set Preview... [06/28/19 21:37:58.678][DEBUG] [Camera Thread] Display image preview using asynch task... [06/28/19 21:37:58.794][DEBUG] [Main Thread] --> Find stars (normal) [06/28/19 21:37:59.500][DEBUG] [Main Thread] Star detection using min star size of 3px... [06/28/19 21:37:59.500][DEBUG] [Main Thread] Star detection using max star size of 60px... [06/28/19 21:37:59.519][DEBUG] [Main Thread] Find stars took: 725 ms... [06/28/19 21:37:59.519][DEBUG] [Main Thread] Star list contains 14 stars... [06/28/19 21:37:59.519][DEBUG] [Main Thread] Calculating HFR with sample size: 3 [06/28/19 21:37:59.671][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.54 [06/28/19 21:38:00.677][DEBUG] [Camera Thread] Moving focuser to next position (28078)... [06/28/19 21:38:00.678][DEBUG] [Focuser Move Thread] Focuser moving to 28078 [06/28/19 21:38:00.704][DEBUG] [Focuser Move Thread] Focuser move call complete [06/28/19 21:38:01.730][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 28078 matches requested position 28078 [06/28/19 21:38:01.730][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Waiting for focuser to report done... [06/28/19 21:38:01.756][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser reports it is done moving, continuing... [06/28/19 21:38:01.756][DEBUG] [Camera Thread] Focuser move complete... [06/28/19 21:38:01.782][DEBUG] [Camera Thread] Focuser position matches requested position (28078), continuing... [06/28/19 21:38:01.808][DEBUG] [Camera Thread] Calculating step metric... [06/28/19 21:38:01.808][DEBUG] [Camera Thread] Taking auto focus frame(s)... [06/28/19 21:38:01.809][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [06/28/19 21:38:01.809][DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [06/28/19 21:38:01.809][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds... [06/28/19 21:38:01.809][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [06/28/19 21:38:01.811][DEBUG] [Camera Thread] SetAscomNormalSpeed... [06/28/19 21:38:01.811][DEBUG] [Camera Thread] Readout speed set to NORMAL... [06/28/19 21:38:11.213][DEBUG] [Camera Thread] SaveFileAscom: Start... [06/28/19 21:38:11.213][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [06/28/19 21:38:11.213][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [06/28/19 21:38:11.214][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [06/28/19 21:38:11.214][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [06/28/19 21:38:11.512][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [06/28/19 21:38:11.512][DEBUG] [Camera Thread] SaveFileAscom: Done [06/28/19 21:38:11.512][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [06/28/19 21:38:11.512][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [06/28/19 21:38:11.512][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [06/28/19 21:38:11.512][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [06/28/19 21:38:11.555][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [06/28/19 21:38:11.555][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [06/28/19 21:38:11.555][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [06/28/19 21:38:11.555][DEBUG] [Camera Thread] Internal Interface: Set Preview... [06/28/19 21:38:11.555][DEBUG] [Camera Thread] Display image preview using asynch task... [06/28/19 21:38:11.667][DEBUG] [Main Thread] --> Find stars (normal) [06/28/19 21:38:12.431][DEBUG] [Main Thread] Star detection using min star size of 3px... [06/28/19 21:38:12.431][DEBUG] [Main Thread] Star detection using max star size of 60px... [06/28/19 21:38:12.460][DEBUG] [Main Thread] Find stars took: 793 ms... [06/28/19 21:38:12.460][DEBUG] [Main Thread] Star list contains 14 stars... [06/28/19 21:38:12.460][DEBUG] [Main Thread] Calculating HFR with sample size: 3 [06/28/19 21:38:12.640][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.66 [06/28/19 21:38:13.645][DEBUG] [Camera Thread] Moving focuser to next position (28003)... [06/28/19 21:38:13.645][DEBUG] [Focuser Move Thread] Focuser moving to 28003 [06/28/19 21:38:13.698][DEBUG] [Focuser Move Thread] Focuser move call complete [06/28/19 21:38:14.725][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 28003 matches requested position 28003 [06/28/19 21:38:14.725][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Waiting for focuser to report done... [06/28/19 21:38:15.726][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser reports it is done moving, continuing... [06/28/19 21:38:15.726][DEBUG] [Camera Thread] Focuser move complete... [06/28/19 21:38:15.752][DEBUG] [Camera Thread] Focuser position matches requested position (28003), continuing... [06/28/19 21:38:15.778][DEBUG] [Camera Thread] Calculating step metric... [06/28/19 21:38:15.778][DEBUG] [Camera Thread] Taking auto focus frame(s)... [06/28/19 21:38:15.779][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame... [06/28/19 21:38:15.779][DEBUG] [Camera Thread] ASCOM: AF Binning: 2x2... [06/28/19 21:38:15.779][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds... [06/28/19 21:38:15.779][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b [06/28/19 21:38:15.781][DEBUG] [Camera Thread] SetAscomNormalSpeed... [06/28/19 21:38:15.781][DEBUG] [Camera Thread] Readout speed set to NORMAL... [06/28/19 21:38:23.306][DEBUG] [PHD2 Listener Thread] PHD2 - No messages received from PHD2 for 1 minute, checking socket with status... [06/28/19 21:38:23.306][DEBUG] [PHD2 Listener Thread] Checking PHD2 state... [06/28/19 21:38:23.306][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [06/28/19 21:38:23.306][DEBUG] [PHD2 Listener Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:38:23.306][DEBUG] [PHD2 Listener Thread] PHD2 GetPhdStatus - Post-Wait: Paused [06/28/19 21:38:25.394][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:26.779][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:28.163][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:29.550][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:30.934][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:32.319][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:33.702][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:34.984][DEBUG] [MF Update Thread] ASCOM Focuser: Error in GetTemperature. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Temperature() at rh.get_Temperature() at rb.lh() [06/28/19 21:38:36.267][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:37.653][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:39.037][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:40.424][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:41.811][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:43.198][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:44.583][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:44.690][DEBUG] [Dome Thread] Observatory: Calculating new position using: [06/28/19 21:38:44.690][DEBUG] [Dome Thread] Azimuth: 267.744406573267 [06/28/19 21:38:44.690][DEBUG] [Dome Thread] Altitude: 63.7446086327794 [06/28/19 21:38:44.690][DEBUG] [Dome Thread] Hour Angle: 30.000878164153 [06/28/19 21:38:44.690][DEBUG] [Dome Thread] Pier Side: East [06/28/19 21:38:44.690][DEBUG] [Dome Thread] Observatory: Adjustment needed, slewing to Azimuth: 233.688443301786 [06/28/19 21:38:45.968][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:47.353][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:48.739][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:50.122][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:51.508][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:52.776][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Communication Failure at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:52.884][DEBUG] [CP Update Thread] ASCOM Focuser: Error in GetCurrentPosition. : Device is not connected at System.RuntimeType.ForwardCallToInvokeMember(String memberName, BindingFlags flags, Object target, Int32[] aWrapperTypes, MessageData& msgData) at ASCOM.DeviceInterface.IFocuserV2.get_Position() at rh.get_Position() at rb.ij(Boolean A_0) [06/28/19 21:38:52.884][DEBUG] [CP Update Thread] Disconnecting ASCOM Focuser: ASCOM.MicroTouchServer.Focuser1 [06/28/19 21:39:13.887][DEBUG] [Camera Thread] ASCOM Camera: abort message received in download... [06/28/19 21:39:13.887][DEBUG] [Camera Thread] ASCOM Camera: Attempting to abort exposure... [06/28/19 21:39:13.888][DEBUG] [Camera Thread] ASCOM Camera: Asking camera to abort... [06/28/19 21:39:13.890][DEBUG] [Camera Thread] ASCOM Camera: Camera has acknowledged abort request... [06/28/19 21:39:13.890][DEBUG] [Camera Thread] ASCOM Camera: Blocking until image is aborted... [06/28/19 21:39:13.890][DEBUG] [Camera Thread] ASCOM Camera: Image is aborted... [06/28/19 21:39:13.891][DEBUG] [Camera Thread] HFR value from auto focuser is 0!, trying again... [06/28/19 21:39:13.891][DEBUG] [Camera Thread] AF abort requested [06/28/19 21:39:13.892][DEBUG] [Camera Thread] MoveFocuserAbs: Error! The focuser is no longer connected! [06/28/19 21:39:13.892][DEBUG] [Camera Thread] Auto focus (finally): closing dialog... [06/28/19 21:39:13.906][DEBUG] [AfChartThread] AF chart dialog is closed... [06/28/19 21:39:13.942][DEBUG] [Camera Thread] Auto focus complete... [06/28/19 21:39:13.946][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete... [06/28/19 21:39:14.067][DEBUG] [Sequence Thread] AF is complete, continuing sequence... [06/28/19 21:39:14.067][DEBUG] [Sequence Thread] EventMarker 4 - t:ngc4559 (0); e:0; f:0; o: [06/28/19 21:39:14.067][DEBUG] [Sequence Thread] Setting filter position 1... [06/28/19 21:39:14.067][DEBUG] [Sequence Thread] Filter position 1 is already set. Skipping... [06/28/19 21:39:14.067][DEBUG] [Sequence Thread] EventMarker 5 - t:ngc4559 (0); e:0; f:0; o: [06/28/19 21:39:14.068][DEBUG] [Sequence Thread] Checking for auto manual focus (pre)... [06/28/19 21:39:14.068][DEBUG] [Sequence Thread] EventMarker 6 - t:ngc4559 (0); e:0; f:0; o: [06/28/19 21:39:14.069][DEBUG] [Sequence Thread] EventMarker 1 - t:ngc4559 (0); e:0; f:0; o: [06/28/19 21:39:14.074][DEBUG] [Sequence Thread] Created base name for frame capture: ngc4559_0001_600sec_31C_fpos_NA_amb_NA_1x1_Lum_sop-east_2019_213914 [06/28/19 21:39:14.074][DEBUG] [Sequence Thread] Created directory for frame capture: C:\01 MARKs STUFF\02 SGP Images\Light\ [06/28/19 21:39:14.074][DEBUG] [Sequence Thread] EventMarker 7 - t:ngc4559 (0); e:0; f:0; o: [06/28/19 21:39:14.076][DEBUG] [Sequence Thread] Resuming auto guiding (settling)... [06/28/19 21:39:14.076][DEBUG] [Sequence Thread] EventMarker 170 - t:ngc4559 (0); e:0; f:0; o: [06/28/19 21:39:14.076][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:39:14.076][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [06/28/19 21:39:14.076][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:39:14.177][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Paused [06/28/19 21:39:14.177][DEBUG] [Sequence Thread] Sending to PHD2: {"method":"set_paused","params":[false],"id":42} [06/28/19 21:39:14.177][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:39:14.177][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Paused [06/28/19 21:39:14.177][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:39:14.278][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Paused [06/28/19 21:39:15.279][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:39:15.279][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [06/28/19 21:39:15.279][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:39:15.379][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [06/28/19 21:39:16.380][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:39:16.380][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [06/28/19 21:39:16.380][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:39:16.480][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [06/28/19 21:39:17.481][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:39:17.481][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [06/28/19 21:39:17.481][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:39:17.581][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [06/28/19 21:39:18.582][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:39:18.582][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [06/28/19 21:39:18.582][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:39:18.683][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [06/28/19 21:39:19.684][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:39:19.684][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [06/28/19 21:39:19.684][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:39:19.785][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [06/28/19 21:39:19.785][DEBUG] [Sequence Thread] EventMarker 171 - t:ngc4559 (0); e:0; f:0; o: [06/28/19 21:39:19.785][DEBUG] [Sequence Thread] {"method": "guide", "params": [{"pixels": 1, "time": 6, "timeout": 600}, false ], "id": 1003} [06/28/19 21:39:19.785][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "guide", "params": [{"pixels": 1, "time": 6, "timeout": 600}, false ], "id": 1003} [06/28/19 21:39:19.785][DEBUG] [Sequence Thread] EventMarker 172 - t:ngc4559 (0); e:0; f:0; o: [06/28/19 21:39:19.785][DEBUG] [Sequence Thread] Checking PHD2 state... [06/28/19 21:39:19.785][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Guiding [06/28/19 21:39:19.785][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001} [06/28/19 21:39:19.851][DEBUG] [PHD2 Listener Thread] Unknown object from PHD2: {"Event":"SettleBegin","Timestamp":1561775959.800,"Host":"LIGHTHOUSEOBS","Inst":1} [06/28/19 21:39:19.886][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Post-Wait: Guiding [06/28/19 21:39:19.886][DEBUG] [Sequence Thread] EventMarker 173 - t:ngc4559 (0); e:0; f:0; o: [06/28/19 21:39:19.886][DEBUG] [Sequence Thread] Waiting for Auto Guider distance to fall below 1 [06/28/19 21:39:19.886][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:19.886][DEBUG] [Sequence Thread] PHD2 distance request returned 5.5... [06/28/19 21:39:20.044][DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_REL message received... [06/28/19 21:39:20.044][DEBUG] [Focuser Thread] ASCOM Focuser: Focuser is null, GetMaxSteps returning 0 [06/28/19 21:39:20.044][DEBUG] [Focuser Thread] ASCOM Focuser: Focuser is null, GetMaxSteps returning 0 [06/28/19 21:39:20.044][DEBUG] [Focuser Thread] Focuser moving to 0 [06/28/19 21:39:20.044][DEBUG] [Focuser Thread] ASCOM Focuser: Focuser is null, GetMaxSteps returning 0 [06/28/19 21:39:20.044][DEBUG] [Focuser Thread] ASCOM Focuser: MaxStep is 0. Ignoring this, hopefully bad things don't follow. [06/28/19 21:39:20.044][DEBUG] [Focuser Thread] ASCOM Focuser: Error in Move(abs) : Object reference not set to an instance of an object. at rb.ip(Int32 A_0) [06/28/19 21:39:20.393][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:20.393][DEBUG] [Sequence Thread] PHD2 distance request returned 5.5... [06/28/19 21:39:20.899][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:20.899][DEBUG] [Sequence Thread] PHD2 distance request returned 5.5... [06/28/19 21:39:21.404][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:21.404][DEBUG] [Sequence Thread] PHD2 distance request returned 5.5... [06/28/19 21:39:21.909][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:21.909][DEBUG] [Sequence Thread] PHD2 distance request returned 4.3... [06/28/19 21:39:22.416][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:22.416][DEBUG] [Sequence Thread] PHD2 distance request returned 4.3... [06/28/19 21:39:22.922][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:22.922][DEBUG] [Sequence Thread] PHD2 distance request returned 4.3... [06/28/19 21:39:23.426][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:23.426][DEBUG] [Sequence Thread] PHD2 distance request returned 4.3... [06/28/19 21:39:23.931][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:23.931][DEBUG] [Sequence Thread] PHD2 distance request returned 4.3... [06/28/19 21:39:24.436][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:24.436][DEBUG] [Sequence Thread] PHD2 distance request returned 4.3... [06/28/19 21:39:24.944][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:24.944][DEBUG] [Sequence Thread] PHD2 distance request returned 3.2... [06/28/19 21:39:25.452][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:25.452][DEBUG] [Sequence Thread] PHD2 distance request returned 3.2... [06/28/19 21:39:25.957][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:25.957][DEBUG] [Sequence Thread] PHD2 distance request returned 3.2... [06/28/19 21:39:26.463][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:26.463][DEBUG] [Sequence Thread] PHD2 distance request returned 3.2... [06/28/19 21:39:26.968][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:26.968][DEBUG] [Sequence Thread] PHD2 distance request returned 3.2... [06/28/19 21:39:27.474][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:27.474][DEBUG] [Sequence Thread] PHD2 distance request returned 3.2... [06/28/19 21:39:27.978][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:27.978][DEBUG] [Sequence Thread] PHD2 distance request returned 2.3... [06/28/19 21:39:28.486][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:28.486][DEBUG] [Sequence Thread] PHD2 distance request returned 2.3... [06/28/19 21:39:28.991][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:28.991][DEBUG] [Sequence Thread] PHD2 distance request returned 2.3... [06/28/19 21:39:29.497][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:29.497][DEBUG] [Sequence Thread] PHD2 distance request returned 2.3... [06/28/19 21:39:30.002][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:30.002][DEBUG] [Sequence Thread] PHD2 distance request returned 2.3... [06/28/19 21:39:30.507][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:30.507][DEBUG] [Sequence Thread] PHD2 distance request returned 2.3... [06/28/19 21:39:31.012][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:31.012][DEBUG] [Sequence Thread] PHD2 distance request returned 2.3... [06/28/19 21:39:31.517][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:31.517][DEBUG] [Sequence Thread] PHD2 distance request returned 1.8... [06/28/19 21:39:32.025][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:32.025][DEBUG] [Sequence Thread] PHD2 distance request returned 1.8... [06/28/19 21:39:32.530][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:32.530][DEBUG] [Sequence Thread] PHD2 distance request returned 1.8... [06/28/19 21:39:33.035][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:33.035][DEBUG] [Sequence Thread] PHD2 distance request returned 1.8... [06/28/19 21:39:33.540][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:33.540][DEBUG] [Sequence Thread] PHD2 distance request returned 1.8... [06/28/19 21:39:34.045][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:34.045][DEBUG] [Sequence Thread] PHD2 distance request returned 1.8... [06/28/19 21:39:34.550][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:34.550][DEBUG] [Sequence Thread] PHD2 distance request returned 1.3... [06/28/19 21:39:34.736][DEBUG] [Main Thread] User requested sequence abort... [06/28/19 21:39:34.737][DEBUG] [Main Thread] User elected NOT to run end of sequence options! [06/28/19 21:39:35.058][DEBUG] [Sequence Thread] PHD2 distance request... [06/28/19 21:39:35.058][DEBUG] [Sequence Thread] PHD2 distance request returned 1.3... [06/28/19 21:39:35.060][DEBUG] [Sequence Thread] Auto guider has settled... [06/28/19 21:39:35.061][DEBUG] [Sequence Thread] EventMarker 8 [06/28/19 21:39:35.061][DEBUG] [Sequence Thread] EventMarker 9 [06/28/19 21:39:35.061][DEBUG] [Sequence Thread] EventMarker 10 [06/28/19 21:39:35.063][DEBUG] [Sequence Thread] ASCOM Camera: Attempting to abort exposure... [06/28/19 21:39:35.064][DEBUG] [Sequence Thread] ASCOM Camera: Asking camera to abort... [06/28/19 21:39:35.068][DEBUG] [Sequence Thread] ASCOM Camera: Camera has acknowledged abort request... [06/28/19 21:39:35.068][DEBUG] [Sequence Thread] ASCOM Camera: Blocking until image is aborted... [06/28/19 21:39:35.068][DEBUG] [Sequence Thread] ASCOM Camera: Image is aborted... [06/28/19 21:39:35.068][DEBUG] [Sequence Thread] Run event requested sequence abort... [06/28/19 21:39:35.068][DEBUG] [Sequence Thread] ********* Run post sequence ********* [06/28/19 21:39:35.068][DEBUG] [Sequence Thread] SGPro capture cal frame mode is OFF... [06/28/19 21:39:35.070][DEBUG] [Sequence Thread] Clearing timed monitoring events... [06/28/19 21:39:35.070][DEBUG] [Sequence Thread] Checking RunEndOfSequenceEquipmentOptions, force = False [06/28/19 21:39:35.070][DEBUG] [Sequence Thread] Sequence was aborted, skipping end of sequence options... [06/28/19 21:39:35.071][DEBUG] [Camera Thread] SGM_CAMERA_CAPTURE message received... [06/28/19 21:39:35.071][DEBUG] [Camera Thread] ASCOM Camera: Attempting to abort exposure... [06/28/19 21:39:35.071][DEBUG] [Camera Thread] ASCOM Camera: Asking camera to abort... [06/28/19 21:39:35.073][DEBUG] [Camera Thread] ASCOM Camera: Camera has acknowledged abort request... [06/28/19 21:39:35.073][DEBUG] [Camera Thread] ASCOM Camera: Blocking until image is aborted... [06/28/19 21:39:35.073][DEBUG] [Camera Thread] ASCOM Camera: Image is aborted... [06/28/19 21:39:35.073][DEBUG] [Main Thread] Aborting sequence timer thread... [06/28/19 21:39:35.073][DEBUG] [Main Thread] Sending sequence end notification... [06/28/19 21:39:35.073][DEBUG] [Main Thread] Resetting UI elements... [06/28/19 21:39:35.073][DEBUG] [Main Thread] Checking if sequence has work left... [06/28/19 21:39:35.073][DEBUG] [Main Thread] Work left... [06/28/19 21:39:35.073][DEBUG] [Main Thread] Updating big status... [06/28/19 21:39:35.073][DEBUG] [Main Thread] Enabling menu items... [06/28/19 21:39:35.075][DEBUG] [Camera Thread] SetAscomNormalSpeed... [06/28/19 21:39:35.075][DEBUG] [Camera Thread] Readout speed set to NORMAL... [06/28/19 21:39:35.086][DEBUG] [Camera Thread] ASCOM Camera Error : CheckDotNetExceptions ASCOM.Atik.Camera StartExposure System.ApplicationException: StartExposure - Camera not idle (See Inner Exception for details) (System.ApplicationException: StartExposure - Camera not idle) at ASCOM.DriverAccess.MemberFactory.CheckDotNetExceptions(String memberName, Exception e) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 630 at ASCOM.DriverAccess.MemberFactory.MethodTargetInvocationExceptionHandler(String memberName, Exception e) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 678 at ASCOM.DriverAccess.MemberFactory.CallMember(Int32 memberCode, String memberName, Type[] parameterTypes, Object[] parms) in C:\ASCOM Build\Export\ASCOM.DriverAccess\MemberFactory.cs:line 487 at ASCOM.DriverAccess.Camera.StartExposure(Double Duration, Boolean Light) in C:\ASCOM Build\Export\ASCOM.DriverAccess\Camera.cs:line 593 at q9.ie(pk A_0, rj& A_1) [06/28/19 21:39:35.086][DEBUG] [Camera Thread] ASCOM Camera: Attempting to abort exposure... [06/28/19 21:39:35.086][DEBUG] [Camera Thread] ASCOM Camera: Asking camera to abort... [06/28/19 21:39:35.089][DEBUG] [Camera Thread] ASCOM Camera: Camera has acknowledged abort request... [06/28/19 21:39:35.089][DEBUG] [Camera Thread] ASCOM Camera: Blocking until image is aborted... [06/28/19 21:39:35.109][DEBUG] [Main Thread] Set target icons... [06/28/19 21:39:35.109][DEBUG] [Main Thread] Removing camera protection... [06/28/19 21:39:35.138][DEBUG] [Main Thread] Monitoring system shutdown... [06/28/19 21:39:35.138][DEBUG] [Main Thread] SequenceEnds complete... [06/28/19 21:39:35.138][DEBUG] [Sequence Thread] Restoring system standby state... [06/28/19 21:39:44.771][DEBUG] [Dome Thread] Observatory: Calculating new position using: [06/28/19 21:39:44.771][DEBUG] [Dome Thread] Azimuth: 267.89072594662 [06/28/19 21:39:44.771][DEBUG] [Dome Thread] Altitude: 63.5315296815398 [06/28/19 21:39:44.771][DEBUG] [Dome Thread] Hour Angle: 30.248634579926 [06/28/19 21:39:44.771][DEBUG] [Dome Thread] Pier Side: East [06/28/19 21:39:44.771][DEBUG] [Dome Thread] Observatory: No adjustment needed. [06/28/19 21:39:46.977][DEBUG] [PHD2 Listener Thread] PHD2: Settle done received: GOOD [06/28/19 21:39:49.739][DEBUG] [Main Thread] Disconnecting ASCOM camera: Atik Camera... [06/28/19 21:39:50.467][DEBUG] [Main Thread] Disconnecting ASCOM Filter Wheel: ASCOM.AtikEFW.FilterWheel [06/28/19 21:39:51.339][DEBUG] [Main Thread] Disconnecting ASCOM Telescope: ASCOM.iOptron2017.Telescope [06/28/19 21:39:52.524][DEBUG] [Main Thread] Disconnecting ASCOM Observatory: ASCOM.LesveDomeNet.Dome [06/28/19 21:39:52.524][DEBUG] [Main Thread] Dome: Disconnecting [06/28/19 21:39:53.347][DEBUG] [Main Thread] Disconnecting ASCOM Env Device: ASCOM.OpenWeatherMap.ObservingConditions [06/28/19 21:39:57.034][DEBUG] [Main Thread] PopulateDataModel: Transferring view to the data model... [06/28/19 21:39:57.036][DEBUG] [Main Thread] Performing serialize... [06/28/19 21:39:57.123][DEBUG] [Sequence Thread] Dispatch loop: Received SGM_TERMINATE... [06/28/19 21:39:57.127][DEBUG] [Telescope Thread] Telescope Dispatch loop: Received SGM_TERMINATE... [06/28/19 21:39:57.127][DEBUG] [Filter Wheel Thread] Filter Wheel Dispatch loop: Received SGM_TERMINATE... [06/28/19 21:39:57.131][DEBUG] [Auto Guider Thread] Auto Guider Dispatch loop: Received SGM_TERMINATE... [06/28/19 21:39:57.131][DEBUG] [TEC Thread] TEC Dispatch loop: Received SGM_TERMINATE... [06/28/19 21:39:57.154][DEBUG] [Main Thread] Performing clean up...