[03/07/17 18:37:19.124][DEBUG] [Main Thread] Licensing: Machine ID found...
[03/07/17 18:37:19.130][DEBUG] [Main Thread] Checking for valid internet connection...
[03/07/17 18:37:19.361][DEBUG] [Main Thread] Valid internet connection detected...
[03/07/17 18:37:20.033][DEBUG] [Main Thread] Licensing: Request for licenses successful, writing cookie...
[03/07/17 18:37:20.045][DEBUG] [Main Thread] Licensing: Applying licenses..
[03/07/17 18:37:20.045][DEBUG] [Main Thread] Licensing: Licenses applied..
[03/07/17 18:37:20.048][DEBUG] [Main Thread] SGPro retail license...
[03/07/17 18:37:21.125][DEBUG] [Main Thread] API successfully started on port 59590...
[03/07/17 18:37:21.957][DEBUG] [Main Thread] Error loading notification settings! Could not find file 'C:\Users\Mark\AppData\Local\SequenceGenerator\Sequence Generator Pro\notifications.sgd'.
[03/07/17 18:37:21.962][DEBUG] [Main Thread] Error loading GNS endpoint settings! Could not find file 'C:\Users\Mark\AppData\Local\SequenceGenerator\Sequence Generator Pro\gnsSettings.sgd'.
[03/07/17 18:37:21.963][DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\Mark\AppData\Local\SequenceGenerator\Sequence Generator Pro\1-emailEndpointAddresses.sgd'.
[03/07/17 18:37:21.963][DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\Mark\AppData\Local\SequenceGenerator\Sequence Generator Pro\2-emailEndpointAddresses.sgd'.
[03/07/17 18:37:21.964][DEBUG] [Main Thread] Error loading email endpoint addresses! Could not find file 'C:\Users\Mark\AppData\Local\SequenceGenerator\Sequence Generator Pro\3-emailEndpointAddresses.sgd'.
[03/07/17 18:37:21.965][DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Mark\AppData\Local\SequenceGenerator\Sequence Generator Pro\1-textFileEndpointSettings.sgd'.
[03/07/17 18:37:21.965][DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Mark\AppData\Local\SequenceGenerator\Sequence Generator Pro\2-textFileEndpointSettings.sgd'.
[03/07/17 18:37:21.965][DEBUG] [Main Thread] Error loading text file endpoint data! Could not find file 'C:\Users\Mark\AppData\Local\SequenceGenerator\Sequence Generator Pro\3-textFileEndpointSettings.sgd'.
[03/07/17 18:37:22.140][DEBUG] [Main Thread] ===== S E Q U E N C E   G E N E R A T O R (v2.6.0.17) =====
[03/07/17 18:37:22.244][DEBUG] [Main Thread] OS: Microsoft Windows 10 Home
[03/07/17 18:37:22.763][DEBUG] [Focuser Thread] Entering Fouser message dispatch loop...
[03/07/17 18:37:22.765][DEBUG] [Camera Thread] Entering camera message dispatch loop...
[03/07/17 18:37:22.768][DEBUG] [TEC Thread] Entering TEC message dispatch loop...
[03/07/17 18:37:22.770][DEBUG] [Filter Wheel Thread] Entering Filter Wheel message dispatch loop...
[03/07/17 18:37:22.773][DEBUG] [Rotator Thread] Entering Rotator message dispatch loop...
[03/07/17 18:37:22.774][DEBUG] [Auto Guider Thread] Entering Auto Guider message dispatch loop...
[03/07/17 18:37:22.775][DEBUG] [Auto Guider Error Thread] Entering Auto Guider message dispatch loop...
[03/07/17 18:37:22.775][DEBUG] [Dome Thread] Entering Dome message dispatch loop...
[03/07/17 18:37:22.775][DEBUG] [Safety Thread] Starting safety monitor...
[03/07/17 18:37:22.777][DEBUG] [Environment Device Thread] Starting environment device monitor...
[03/07/17 18:37:22.797][DEBUG] [Telescope Thread] Entering Telescope message dispatch loop...
[03/07/17 18:37:22.832][DEBUG] [Main Thread] Settings changed (or loaded)...
[03/07/17 18:37:22.832][DEBUG] [Main Thread] * SETTING: settingMdiAutoStretch = False
[03/07/17 18:37:22.832][DEBUG] [Main Thread] * SETTING: settingIgLastFileFolder = 
[03/07/17 18:37:22.832][DEBUG] [Main Thread] * SETTING: settingFormScaleWarning = False
[03/07/17 18:37:22.832][DEBUG] [Main Thread] * SETTING: settingRecoveryDuration = 90
[03/07/17 18:37:22.832][DEBUG] [Main Thread] * SETTING: settingSBIGLpt2Address = 278
[03/07/17 18:37:22.832][DEBUG] [Main Thread] * SETTING: settingFliFlushLow = 0
[03/07/17 18:37:22.832][DEBUG] [Main Thread] * SETTING: settingSBIGLpt1Address = 378
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingMdiMouseAction = Stretch
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingLastAscomCamera = 
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingTemperhumInterval = 300
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingASCOMWarningShown = False
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingPlateCamScale = 0
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingCanonMirrorSettle = 0
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingInterface = 
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingLastAscomFilterWheel = 
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingAstroArtDisplayInstructions = True
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingMdiPhdZoom = 40
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingCheckForUpdatesOnStart = True
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingMdiLastImageDir = 
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingTemperHumUserTempComp = 0
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingCaptureCalFramesAlways = False
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingDelayFirst = 0
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingFliNormalSpeedMode = 0
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingFliHighSpeedMode = 0
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingMfPosition = {X=0,Y=0}
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingSoundAttention = 
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingPinpointCatalog = 
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingCameraOverhead = 
[03/07/17 18:37:22.833][DEBUG] [Main Thread] * SETTING: settingPlateSolveOn = False
[03/07/17 18:37:22.862][DEBUG] [Main Thread] * SETTING: settingAstrometryNetEndpointList = System.Collections.Specialized.StringCollection
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingSBIGGuider = None
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingQSIFanSpeed = 2
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingNaggerText = 
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingMdiPhdDisplay = RA/Dec
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingMdiShowToolStrip = True
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingMdiShowCrosshairs = True
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: WindowGeometry = 
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingIgRenameStringLocation = 2
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingIgSubFolders = False
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: WindowGeometrySearch = 
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingOffset = -1
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingAutoStretchLevel = Low
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingTemperHumUnits = C
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingProfileDirectory = 
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingBasename = 
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingHfrColor = Color [RoyalBlue]
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingNikonAfBinning = 1
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingSBIGFanOffWithTec = False
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingLastAscomSafetyMonitor = 
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingMdiSize = {Width=800, Height=600}
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingIgCopyAndRenameFiles = False
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingSimDownloadTimesAf = False
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingNagger = False
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingImportFromCfw = True
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingMdiShowStatusTrip = True
[03/07/17 18:37:22.863][DEBUG] [Main Thread] * SETTING: settingShowTooltipHelp = True
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingLastUpdateCheck = 1/1/2012 12:00:00 AM
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingEventSuffixes = null
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingCpPosition = {X=0,Y=0}
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingSBIGCfwPort = 
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingMdiLocation = {X=0,Y=0}
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingIgLastCsvFolder = 
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingPlateSolve3Catalogs = 
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingSBIGFilterWheel = Auto Detect
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingSBIGConnection = USB
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingDSLRSoftwareBinForAf = False
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingAutoSave = True
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingFirstTime = True
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingAutoRecoveryActive = False
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingMdiState = maximized
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingUseSequenceOptions = False
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingSoundCompleted = 
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingTrialExpiredShown = False
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingTemperHumColor = Grey
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingDataDirectory = 
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingCanonFileFormat = Single Image (CFA FITS)
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingAlnitakComPort = 
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingIgRenameFiles = False
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingPhd2InstallPath = 
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingSubFolder = True
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingLastSGSaveFolder = 
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingFindStars = Normal (recommended)
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingNikonDataFormat = FITS
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingPlaySounds = False
[03/07/17 18:37:22.864][DEBUG] [Main Thread] * SETTING: settingLastNikonType = Auto Connect
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingLastSequenceStart = 1/1/0001 12:00:00 AM
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingLastAscomTelescope = 
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingMdiPhdScale = 100
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingIgRenameType = 0
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingHelpLanguage = English
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingTemperHumUserHumidityComp = 0
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingMdiPhdRaColor = Color [Blue]
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingLastImageSaveFolder = 
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingIgOverwriteExisting = False
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingFinishFullEvent = True
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingMosaicOverlap = 20
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingQSIFanOffWithTec = False
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingRecentSequences = 
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingDefaultDirectory = 
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingMdiPhdDecColor = Color [Red]
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingAstrometryNetEndpoint = Astrometry.NET (Remote)
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingFliFlushHigh = 0
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingStarsColor = Color [OrangeRed]
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingDefaultMfwFov = 4.0
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingSBIGLpt3Address = 3BC
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingLastAscomFocuser = 
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingIgLastFolder = 
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: WindowGeometryOpen = 
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingNumEvents = 5
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingDelayBetween = 0
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingCanonAfBinning = 1
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingPlateCamBlank = 
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingLogApiCalls = False
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingNikonUseBulbModeAlways = False
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingTempFiles = C:\Temp
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingFliHighSpeedDesc = 
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingSBIGCfwUseRS232 = False
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingRecoveryInterval = 10
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingEnableImageHistory = False
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingSBIGEthernetIP = 0.0.0.0
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingFliNormalSpeedDesc = 
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingIgCopyLocation = 
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingSBIGAutoDetectIp = True
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingAstroArtStartApp = True
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingSimDownloadTimesPlate = False
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingMicroTouchLocation = 
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingEventAlwaysVisible = False
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingMdiNewWindow = False
[03/07/17 18:37:22.865][DEBUG] [Main Thread] * SETTING: settingTrialQuestionsAsked = False
[03/07/17 18:37:22.866][DEBUG] [Main Thread] * SETTING: settingFliRbiMitigation = False
[03/07/17 18:37:22.866][DEBUG] [Main Thread] * SETTING: settingGain = -1
[03/07/17 18:37:22.866][DEBUG] [Main Thread] * SETTING: settingLastAscomDome = 
[03/07/17 18:37:22.866][DEBUG] [Main Thread] * SETTING: settingLookForTemperDevices = False
[03/07/17 18:37:22.866][DEBUG] [Main Thread] * SETTING: settingLastAscomRotator = 
[03/07/17 18:37:22.866][DEBUG] [Main Thread] * SETTING: settingAfTestPackPath = 
[03/07/17 18:37:22.996][DEBUG] [Main Thread] ASCOM Observing Conditions Hub (OCH)
[03/07/17 18:37:22.997][DEBUG] [Main Thread] ASCOM Observing Conditions Simulator
[03/07/17 18:37:22.997][DEBUG] [Main Thread] OpenWeatherMap ObservingConditions
[03/07/17 18:37:22.997][DEBUG] [Main Thread] TEMPerHUM
[03/07/17 18:37:23.000][DEBUG] [Main Thread] Performing initialization...
[03/07/17 18:37:23.000][DEBUG] [Main Thread] Creating new sequence with no profile
[03/07/17 18:37:23.020][DEBUG] [Main Thread] Performing full form reset (with default data)...
[03/07/17 18:37:23.026][DEBUG] [Main Thread] Retreiving new equipment objects...
[03/07/17 18:37:23.026][DEBUG] [Main Thread] New camera object (No Camera) dispatched...
[03/07/17 18:37:23.026][DEBUG] [Main Thread] New filter wheel object (No Filter Wheel) dispatched...
[03/07/17 18:37:23.027][DEBUG] [Main Thread] New environment device object (No Environment Device) dispatched...
[03/07/17 18:37:23.028][DEBUG] [Main Thread] New focuser object (No Focuser) dispatched...
[03/07/17 18:37:23.030][DEBUG] [Main Thread] New telescope object (No Telescope) dispatched...
[03/07/17 18:37:23.031][DEBUG] [Main Thread] New rotator object (No Rotator) dispatched...
[03/07/17 18:37:23.032][DEBUG] [Main Thread] New dome object (No Observatory) dispatched...
[03/07/17 18:37:23.032][DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched...
[03/07/17 18:37:23.033][DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched...
[03/07/17 18:37:23.034][DEBUG] [Main Thread] New auto guider object (No Auto Guider) dispatched...
[03/07/17 18:37:23.034][DEBUG] [Main Thread] New plate solver object (No Plate Solver) dispatched...
[03/07/17 18:37:23.052][DEBUG] [Main Thread] Populating the form controls...
[03/07/17 18:37:23.124][DEBUG] [Main Thread] Added row 0...
[03/07/17 18:37:23.187][DEBUG] [Main Thread] Added row 1...
[03/07/17 18:37:23.267][DEBUG] [Main Thread] Added row 2...
[03/07/17 18:37:23.372][DEBUG] [Main Thread] Added row 3...
[03/07/17 18:37:23.499][DEBUG] [Main Thread] Added row 4...
[03/07/17 18:37:23.519][DEBUG] [Main Thread] Loading custom filter names...
[03/07/17 18:37:23.529][DEBUG] [Main Thread] PopulateDataModel:  Transferring view to the data model...
[03/07/17 18:37:23.597][DEBUG] [Main Thread] Retreiving new equipment objects...
[03/07/17 18:37:23.597][DEBUG] [Main Thread] New camera object (No Camera) dispatched...
[03/07/17 18:37:23.598][DEBUG] [Main Thread] New filter wheel object (No Filter Wheel) dispatched...
[03/07/17 18:37:23.599][DEBUG] [Main Thread] New environment device object (No Environment Device) dispatched...
[03/07/17 18:37:23.599][DEBUG] [Sequence Thread] Entering sequence message dispatch loop...
[03/07/17 18:37:23.600][DEBUG] [Main Thread] New focuser object (No Focuser) dispatched...
[03/07/17 18:37:23.601][DEBUG] [Main Thread] New telescope object (No Telescope) dispatched...
[03/07/17 18:37:23.601][DEBUG] [Main Thread] New rotator object (No Rotator) dispatched...
[03/07/17 18:37:23.602][DEBUG] [Main Thread] New dome object (No Observatory) dispatched...
[03/07/17 18:37:23.603][DEBUG] [Main Thread] New flat box object (No Flat Box) dispatched...
[03/07/17 18:37:23.604][DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched...
[03/07/17 18:37:23.612][DEBUG] [Main Thread] New auto guider object (No Auto Guider) dispatched...
[03/07/17 18:37:23.612][DEBUG] [Main Thread] New plate solver object (No Plate Solver) dispatched...
[03/07/17 18:37:23.616][DEBUG] [Main Thread] Checking if version check is required...
[03/07/17 18:37:23.727][DEBUG] [Cleaner Thread] Running cleanup...
[03/07/17 18:37:23.728][DEBUG] [Cleaner Thread] Cleaning 0 files in directory C:\Users\Mark\AppData\Local\SequenceGenerator\Temp\...
[03/07/17 18:37:23.728][DEBUG] [Cleaner Thread] Cleaning multi camera registration file...
[03/07/17 18:37:23.728][DEBUG] [Cleaner Thread] Cleaning finished...
[03/07/17 18:37:23.728][DEBUG] [Main Thread] UI layout found, loading layout at C:\Users\Mark\AppData\Local\SequenceGenerator\sg_ui_config.xml
[03/07/17 18:37:39.350][DEBUG] [Main Thread] Performing full form reset (with profile SCT8-F6.2 (383))...
[03/07/17 18:37:39.364][DEBUG] [Main Thread] Retreiving new equipment objects...
[03/07/17 18:37:39.364][DEBUG] [Main Thread] New camera object (Atik Camera) dispatched...
[03/07/17 18:37:39.370][DEBUG] [Main Thread] New filter wheel object (Manual Filter Wheel) dispatched...
[03/07/17 18:37:39.373][DEBUG] [Main Thread] New environment device object (No Environment Device) dispatched...
[03/07/17 18:37:39.374][DEBUG] [Main Thread] New focuser object (GCUSB_nSTEP) dispatched...
[03/07/17 18:37:39.377][DEBUG] [Main Thread] New telescope object (Celestron Telescope Driver) dispatched...
[03/07/17 18:37:39.381][DEBUG] [Main Thread] New rotator object (Manual Rotator) dispatched...
[03/07/17 18:37:39.383][DEBUG] [Main Thread] New dome object (No Observatory) dispatched...
[03/07/17 18:37:39.384][DEBUG] [Main Thread] New flat box object (Alnitak Flat Box) dispatched...
[03/07/17 18:37:39.387][DEBUG] [Main Thread] New safety monitor object (No Safety Monitor) dispatched...
[03/07/17 18:37:39.389][DEBUG] [Main Thread] New auto guider object (PHD2) dispatched...
[03/07/17 18:37:39.389][DEBUG] [Main Thread] No change in plate solver object...
[03/07/17 18:37:39.439][DEBUG] [Main Thread] Loading custom filter names...
[03/07/17 18:37:39.449][DEBUG] [Main Thread] PopulateDataModel:  Transferring view to the data model...
[03/07/17 18:37:39.478][DEBUG] [Main Thread] PopulateDataModel:  Transferring view to the data model...
[03/07/17 18:37:42.066][DEBUG] [Main Thread] Connecting camera in main thread...
[03/07/17 18:37:42.072][DEBUG] [Main Thread] Connecting ASCOM camera: ASCOM.Atik.Camera...
[03/07/17 18:37:42.411][DEBUG] [Main Thread] Camera does not implement ASCOM gain.
[03/07/17 18:37:42.447][DEBUG] [Main Thread] Camera cooler detected...
[03/07/17 18:37:42.450][DEBUG] [Main Thread] Camera cooler is OFF...
[03/07/17 18:37:44.041][DEBUG] [Main Thread] Connecting ASCOM focuser...
[03/07/17 18:37:48.641][DEBUG] [Main Thread] Focuser supports temperature
[03/07/17 18:37:48.641][DEBUG] [Main Thread] Current temperature reports: 66.2
[03/07/17 18:37:48.643][DEBUG] [Main Thread] Focuser reports Max Increment as: 999
[03/07/17 18:37:48.643][DEBUG] [Main Thread] Focuser reports max steps as: 30000
[03/07/17 18:38:24.141][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS message received...
[03/07/17 18:38:24.146][DEBUG] [Camera Thread] Checking for auto focus...
[03/07/17 18:38:24.146][DEBUG] [Camera Thread] Auto focus required (temperature change trigger). Last temp: -500; Current temp: 66.2
[03/07/17 18:38:24.146][DEBUG] [Camera Thread] Auto focus required (time trigger)...
[03/07/17 18:38:24.147][DEBUG] [Camera Thread] Pause guiding while AF is active, pause command sent, waiting for guider to pause...
[03/07/17 18:38:24.148][DEBUG] [Camera Thread] Tried to pause guider for AF, but failed on timeout, continuing AF anyhow...
[03/07/17 18:38:24.160][DEBUG] [Camera Thread] Auto focus: setting filter None
[03/07/17 18:38:24.168][DEBUG] [Camera Thread] Auto focus running...
[03/07/17 18:38:24.176][DEBUG] [Camera Thread] Turning temp comp off..
[03/07/17 18:38:24.181][DEBUG] [Camera Thread] ASCOM Focuser: Temp comp is avaialble, setting to False
[03/07/17 18:38:24.197][DEBUG] [Camera Thread] Performing Sequence Generator auto focus using Half Flux Radius.  AFID: 0
[03/07/17 18:38:24.216][DEBUG] [AfChartThread] Showing AF chart dialog...
[03/07/17 18:38:24.228][DEBUG] [Camera Thread] Auto focus data
[03/07/17 18:38:24.228][DEBUG] [Camera Thread]  - Data Points: 9
[03/07/17 18:38:24.228][DEBUG] [Camera Thread]  - Step Size: 250
[03/07/17 18:38:24.228][DEBUG] [Camera Thread]  - Current Position: 15000
[03/07/17 18:38:24.228][DEBUG] [Camera Thread]  - Initial Move Position: 16000
[03/07/17 18:38:24.249][DEBUG] [Camera Thread] AF Darks exception: The path is not of a legal form.
[03/07/17 18:38:24.252][DEBUG] [Camera Thread] Moving focuser to next position (16000)...
[03/07/17 18:38:24.257][DEBUG] [Focuser Move Thread] Focuser moving to 16000
[03/07/17 18:38:24.260][DEBUG] [Focuser Move Thread] Focuser backlash active, modified move to 17500
[03/07/17 18:38:24.267][DEBUG] [Focuser Move Thread] Focuser move call complete
[03/07/17 18:38:24.272][DEBUG] [Focuser Backlash Thread] Focuser backlash thread has started...
[03/07/17 18:39:07.072][DEBUG] [Focuser Backlash Thread] Backlash thread has detected that movement to modified position (17500) is complete...
[03/07/17 18:39:07.072][DEBUG] [Focuser Backlash Thread] Moving focuser to original requested position (16000)...
[03/07/17 18:39:07.072][DEBUG] [Focuser Backlash Thread] Focuser backlash compensation needed. Steps: 1500 Direction:IN
[03/07/17 18:39:07.072][DEBUG] [Focuser Backlash Thread] Focuser moving to 16000
[03/07/17 18:39:07.089][DEBUG] [Focuser Backlash Thread] Focuser move call complete
[03/07/17 18:39:27.832][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 16000 matches requested position 16000
[03/07/17 18:39:27.832][DEBUG] [Camera Thread] Focuser move complete...
[03/07/17 18:39:35.621][DEBUG] [Focuser Backlash Thread] Focuser backlash completed.  Focuser is at original request position (16000)...
[03/07/17 18:39:35.621][DEBUG] [Focuser Backlash Thread] Focuser backlash thread has ended...
[03/07/17 18:39:35.841][DEBUG] [Camera Thread] Focuser position matches requested position (16000), continuing...
[03/07/17 18:39:35.855][DEBUG] [Camera Thread] Auto focus settling before next frame...
[03/07/17 18:39:35.862][DEBUG] [Camera Thread] Calculating step metric...
[03/07/17 18:39:35.865][DEBUG] [Camera Thread] Taking auto focus frame(s)...
[03/07/17 18:39:35.868][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame...
[03/07/17 18:39:35.868][DEBUG] [Camera Thread] ASCOM: AF Binning: 3x3...
[03/07/17 18:39:35.868][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds...
[03/07/17 18:39:35.868][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b
[03/07/17 18:39:35.881][DEBUG] [Camera Thread] SetAscomNormalSpeed... 
[03/07/17 18:39:35.882][DEBUG] [Camera Thread] Readout speed set to NORMAL...
[03/07/17 18:39:43.714][DEBUG] [Camera Thread] SaveFileAscom: Start...
[03/07/17 18:39:43.714][DEBUG] [Camera Thread] SaveFileAscom: Checking image data...
[03/07/17 18:39:43.714][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap...
[03/07/17 18:39:43.715][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits...
[03/07/17 18:39:43.715][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal...
[03/07/17 18:39:43.728][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits...
[03/07/17 18:39:43.728][DEBUG] [Camera Thread] SaveFileAscom: Done
[03/07/17 18:39:43.738][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write...
[03/07/17 18:39:43.738][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream...
[03/07/17 18:39:43.738][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers...
[03/07/17 18:39:43.743][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data...
[03/07/17 18:39:43.765][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill...
[03/07/17 18:39:43.765][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap...
[03/07/17 18:39:43.765][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream
[03/07/17 18:39:43.772][DEBUG] [Camera Thread] Internal Interface: Set Preview...
[03/07/17 18:39:43.773][DEBUG] [Camera Thread] Display image preview using asynch task...
[03/07/17 18:39:43.936][DEBUG] [Main Thread] --> Find stars (normal)
[03/07/17 18:39:44.598][DEBUG] [Main Thread] Star detection using min star size of 2px...
[03/07/17 18:39:44.598][DEBUG] [Main Thread] Star detection using max star size of 40px...
[03/07/17 18:39:44.654][DEBUG] [Main Thread] Find stars took: 718 ms...
[03/07/17 18:39:44.656][DEBUG] [Main Thread] Star list contains 18 stars...
[03/07/17 18:39:44.656][DEBUG] [Main Thread] Calculating HFR with sample size: 2
[03/07/17 18:39:44.888][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.16
[03/07/17 18:39:45.916][DEBUG] [Camera Thread] Moving focuser to next position (15750)...
[03/07/17 18:39:45.916][DEBUG] [Focuser Move Thread] Focuser moving to 15750
[03/07/17 18:39:45.943][DEBUG] [Focuser Move Thread] Focuser move call complete
[03/07/17 18:39:50.015][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 15750 matches requested position 15750
[03/07/17 18:39:50.015][DEBUG] [Camera Thread] Focuser move complete...
[03/07/17 18:39:50.027][DEBUG] [Camera Thread] Focuser position matches requested position (15750), continuing...
[03/07/17 18:39:50.040][DEBUG] [Camera Thread] Auto focus settling before next frame...
[03/07/17 18:39:50.042][DEBUG] [Camera Thread] Calculating step metric...
[03/07/17 18:39:50.042][DEBUG] [Camera Thread] Taking auto focus frame(s)...
[03/07/17 18:39:50.044][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame...
[03/07/17 18:39:50.044][DEBUG] [Camera Thread] ASCOM: AF Binning: 3x3...
[03/07/17 18:39:50.044][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds...
[03/07/17 18:39:50.044][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b
[03/07/17 18:39:50.048][DEBUG] [Camera Thread] SetAscomNormalSpeed... 
[03/07/17 18:39:50.049][DEBUG] [Camera Thread] Readout speed set to NORMAL...
[03/07/17 18:39:57.861][DEBUG] [Camera Thread] SaveFileAscom: Start...
[03/07/17 18:39:57.861][DEBUG] [Camera Thread] SaveFileAscom: Checking image data...
[03/07/17 18:39:57.861][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap...
[03/07/17 18:39:57.862][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits...
[03/07/17 18:39:57.862][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal...
[03/07/17 18:39:57.876][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits...
[03/07/17 18:39:57.876][DEBUG] [Camera Thread] SaveFileAscom: Done
[03/07/17 18:39:57.876][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write...
[03/07/17 18:39:57.876][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream...
[03/07/17 18:39:57.877][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers...
[03/07/17 18:39:57.877][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data...
[03/07/17 18:39:57.901][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill...
[03/07/17 18:39:57.901][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap...
[03/07/17 18:39:57.901][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream
[03/07/17 18:39:57.907][DEBUG] [Camera Thread] Internal Interface: Set Preview...
[03/07/17 18:39:57.907][DEBUG] [Camera Thread] Display image preview using asynch task...
[03/07/17 18:39:58.023][DEBUG] [Main Thread] --> Find stars (normal)
[03/07/17 18:39:58.650][DEBUG] [Main Thread] Star detection using min star size of 2px...
[03/07/17 18:39:58.650][DEBUG] [Main Thread] Star detection using max star size of 40px...
[03/07/17 18:39:58.689][DEBUG] [Main Thread] Find stars took: 666 ms...
[03/07/17 18:39:58.690][DEBUG] [Main Thread] Star list contains 8 stars...
[03/07/17 18:39:58.690][DEBUG] [Main Thread] Calculating HFR with sample size: 2
[03/07/17 18:39:58.863][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.37
[03/07/17 18:39:59.871][DEBUG] [Camera Thread] Moving focuser to next position (15500)...
[03/07/17 18:39:59.872][DEBUG] [Focuser Move Thread] Focuser moving to 15500
[03/07/17 18:39:59.897][DEBUG] [Focuser Move Thread] Focuser move call complete
[03/07/17 18:40:03.971][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 15500 matches requested position 15500
[03/07/17 18:40:03.971][DEBUG] [Camera Thread] Focuser move complete...
[03/07/17 18:40:03.985][DEBUG] [Camera Thread] Focuser position matches requested position (15500), continuing...
[03/07/17 18:40:03.997][DEBUG] [Camera Thread] Auto focus settling before next frame...
[03/07/17 18:40:03.999][DEBUG] [Camera Thread] Calculating step metric...
[03/07/17 18:40:03.999][DEBUG] [Camera Thread] Taking auto focus frame(s)...
[03/07/17 18:40:04.001][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame...
[03/07/17 18:40:04.001][DEBUG] [Camera Thread] ASCOM: AF Binning: 3x3...
[03/07/17 18:40:04.001][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds...
[03/07/17 18:40:04.001][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b
[03/07/17 18:40:04.004][DEBUG] [Camera Thread] SetAscomNormalSpeed... 
[03/07/17 18:40:04.004][DEBUG] [Camera Thread] Readout speed set to NORMAL...
[03/07/17 18:40:11.835][DEBUG] [Camera Thread] SaveFileAscom: Start...
[03/07/17 18:40:11.835][DEBUG] [Camera Thread] SaveFileAscom: Checking image data...
[03/07/17 18:40:11.835][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap...
[03/07/17 18:40:11.835][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits...
[03/07/17 18:40:11.836][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal...
[03/07/17 18:40:11.850][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits...
[03/07/17 18:40:11.850][DEBUG] [Camera Thread] SaveFileAscom: Done
[03/07/17 18:40:11.850][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write...
[03/07/17 18:40:11.850][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream...
[03/07/17 18:40:11.854][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers...
[03/07/17 18:40:11.854][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data...
[03/07/17 18:40:11.874][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill...
[03/07/17 18:40:11.875][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap...
[03/07/17 18:40:11.875][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream
[03/07/17 18:40:11.882][DEBUG] [Camera Thread] Internal Interface: Set Preview...
[03/07/17 18:40:11.882][DEBUG] [Camera Thread] Display image preview using asynch task...
[03/07/17 18:40:12.000][DEBUG] [Main Thread] --> Find stars (normal)
[03/07/17 18:40:12.637][DEBUG] [Main Thread] Star detection using min star size of 2px...
[03/07/17 18:40:12.637][DEBUG] [Main Thread] Star detection using max star size of 40px...
[03/07/17 18:40:12.671][DEBUG] [Main Thread] Find stars took: 670 ms...
[03/07/17 18:40:12.671][DEBUG] [Main Thread] Star list contains 8 stars...
[03/07/17 18:40:12.671][DEBUG] [Main Thread] Calculating HFR with sample size: 2
[03/07/17 18:40:12.836][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.38
[03/07/17 18:40:13.847][DEBUG] [Camera Thread] Moving focuser to next position (15250)...
[03/07/17 18:40:13.847][DEBUG] [Focuser Move Thread] Focuser moving to 15250
[03/07/17 18:40:13.873][DEBUG] [Focuser Move Thread] Focuser move call complete
[03/07/17 18:40:17.960][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 15250 matches requested position 15250
[03/07/17 18:40:17.961][DEBUG] [Camera Thread] Focuser move complete...
[03/07/17 18:40:17.972][DEBUG] [Camera Thread] Focuser position matches requested position (15250), continuing...
[03/07/17 18:40:17.985][DEBUG] [Camera Thread] Auto focus settling before next frame...
[03/07/17 18:40:17.987][DEBUG] [Camera Thread] Calculating step metric...
[03/07/17 18:40:17.987][DEBUG] [Camera Thread] Taking auto focus frame(s)...
[03/07/17 18:40:17.988][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame...
[03/07/17 18:40:17.988][DEBUG] [Camera Thread] ASCOM: AF Binning: 3x3...
[03/07/17 18:40:17.988][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds...
[03/07/17 18:40:17.988][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b
[03/07/17 18:40:17.991][DEBUG] [Camera Thread] SetAscomNormalSpeed... 
[03/07/17 18:40:17.992][DEBUG] [Camera Thread] Readout speed set to NORMAL...
[03/07/17 18:40:25.813][DEBUG] [Camera Thread] SaveFileAscom: Start...
[03/07/17 18:40:25.813][DEBUG] [Camera Thread] SaveFileAscom: Checking image data...
[03/07/17 18:40:25.813][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap...
[03/07/17 18:40:25.814][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits...
[03/07/17 18:40:25.814][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal...
[03/07/17 18:40:25.828][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits...
[03/07/17 18:40:25.828][DEBUG] [Camera Thread] SaveFileAscom: Done
[03/07/17 18:40:25.828][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write...
[03/07/17 18:40:25.828][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream...
[03/07/17 18:40:25.829][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers...
[03/07/17 18:40:25.830][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data...
[03/07/17 18:40:25.852][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill...
[03/07/17 18:40:25.852][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap...
[03/07/17 18:40:25.852][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream
[03/07/17 18:40:25.862][DEBUG] [Camera Thread] Internal Interface: Set Preview...
[03/07/17 18:40:25.862][DEBUG] [Camera Thread] Display image preview using asynch task...
[03/07/17 18:40:25.969][DEBUG] [Main Thread] --> Find stars (normal)
[03/07/17 18:40:26.596][DEBUG] [Main Thread] Star detection using min star size of 2px...
[03/07/17 18:40:26.596][DEBUG] [Main Thread] Star detection using max star size of 40px...
[03/07/17 18:40:26.617][DEBUG] [Main Thread] Find stars took: 648 ms...
[03/07/17 18:40:26.618][DEBUG] [Main Thread] Star list contains 12 stars...
[03/07/17 18:40:26.618][DEBUG] [Main Thread] Calculating HFR with sample size: 2
[03/07/17 18:40:26.810][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.00
[03/07/17 18:40:27.829][DEBUG] [Camera Thread] Moving focuser to next position (15000)...
[03/07/17 18:40:27.829][DEBUG] [Focuser Move Thread] Focuser moving to 15000
[03/07/17 18:40:27.854][DEBUG] [Focuser Move Thread] Focuser move call complete
[03/07/17 18:40:31.930][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 15000 matches requested position 15000
[03/07/17 18:40:31.930][DEBUG] [Camera Thread] Focuser move complete...
[03/07/17 18:40:31.941][DEBUG] [Camera Thread] Focuser position matches requested position (15000), continuing...
[03/07/17 18:40:31.955][DEBUG] [Camera Thread] Auto focus settling before next frame...
[03/07/17 18:40:31.957][DEBUG] [Camera Thread] Calculating step metric...
[03/07/17 18:40:31.957][DEBUG] [Camera Thread] Taking auto focus frame(s)...
[03/07/17 18:40:31.959][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame...
[03/07/17 18:40:31.959][DEBUG] [Camera Thread] ASCOM: AF Binning: 3x3...
[03/07/17 18:40:31.959][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds...
[03/07/17 18:40:31.959][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b
[03/07/17 18:40:31.963][DEBUG] [Camera Thread] SetAscomNormalSpeed... 
[03/07/17 18:40:31.964][DEBUG] [Camera Thread] Readout speed set to NORMAL...
[03/07/17 18:40:39.784][DEBUG] [Camera Thread] SaveFileAscom: Start...
[03/07/17 18:40:39.784][DEBUG] [Camera Thread] SaveFileAscom: Checking image data...
[03/07/17 18:40:39.784][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap...
[03/07/17 18:40:39.785][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits...
[03/07/17 18:40:39.785][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal...
[03/07/17 18:40:39.799][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits...
[03/07/17 18:40:39.800][DEBUG] [Camera Thread] SaveFileAscom: Done
[03/07/17 18:40:39.800][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write...
[03/07/17 18:40:39.800][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream...
[03/07/17 18:40:39.801][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers...
[03/07/17 18:40:39.801][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data...
[03/07/17 18:40:39.824][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill...
[03/07/17 18:40:39.825][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap...
[03/07/17 18:40:39.825][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream
[03/07/17 18:40:39.831][DEBUG] [Camera Thread] Internal Interface: Set Preview...
[03/07/17 18:40:39.831][DEBUG] [Camera Thread] Display image preview using asynch task...
[03/07/17 18:40:39.950][DEBUG] [Main Thread] --> Find stars (normal)
[03/07/17 18:40:40.587][DEBUG] [Main Thread] Star detection using min star size of 2px...
[03/07/17 18:40:40.588][DEBUG] [Main Thread] Star detection using max star size of 40px...
[03/07/17 18:40:40.609][DEBUG] [Main Thread] Find stars took: 658 ms...
[03/07/17 18:40:40.609][DEBUG] [Main Thread] Star list contains 8 stars...
[03/07/17 18:40:40.609][DEBUG] [Main Thread] Calculating HFR with sample size: 2
[03/07/17 18:40:40.781][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.04
[03/07/17 18:40:41.789][DEBUG] [Camera Thread] Moving focuser to next position (14750)...
[03/07/17 18:40:41.790][DEBUG] [Focuser Move Thread] Focuser moving to 14750
[03/07/17 18:40:41.818][DEBUG] [Focuser Move Thread] Focuser move call complete
[03/07/17 18:40:45.908][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 14750 matches requested position 14750
[03/07/17 18:40:45.908][DEBUG] [Camera Thread] Focuser move complete...
[03/07/17 18:40:45.924][DEBUG] [Camera Thread] Focuser position matches requested position (14750), continuing...
[03/07/17 18:40:45.934][DEBUG] [Camera Thread] Auto focus settling before next frame...
[03/07/17 18:40:45.937][DEBUG] [Camera Thread] Calculating step metric...
[03/07/17 18:40:45.937][DEBUG] [Camera Thread] Taking auto focus frame(s)...
[03/07/17 18:40:45.939][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame...
[03/07/17 18:40:45.939][DEBUG] [Camera Thread] ASCOM: AF Binning: 3x3...
[03/07/17 18:40:45.939][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds...
[03/07/17 18:40:45.939][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b
[03/07/17 18:40:45.944][DEBUG] [Camera Thread] SetAscomNormalSpeed... 
[03/07/17 18:40:45.945][DEBUG] [Camera Thread] Readout speed set to NORMAL...
[03/07/17 18:40:53.767][DEBUG] [Camera Thread] SaveFileAscom: Start...
[03/07/17 18:40:53.767][DEBUG] [Camera Thread] SaveFileAscom: Checking image data...
[03/07/17 18:40:53.767][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap...
[03/07/17 18:40:53.768][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits...
[03/07/17 18:40:53.768][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal...
[03/07/17 18:40:53.782][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits...
[03/07/17 18:40:53.782][DEBUG] [Camera Thread] SaveFileAscom: Done
[03/07/17 18:40:53.782][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write...
[03/07/17 18:40:53.782][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream...
[03/07/17 18:40:53.783][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers...
[03/07/17 18:40:53.783][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data...
[03/07/17 18:40:53.803][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill...
[03/07/17 18:40:53.804][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap...
[03/07/17 18:40:53.804][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream
[03/07/17 18:40:53.808][DEBUG] [Camera Thread] Internal Interface: Set Preview...
[03/07/17 18:40:53.808][DEBUG] [Camera Thread] Display image preview using asynch task...
[03/07/17 18:40:53.932][DEBUG] [Main Thread] --> Find stars (normal)
[03/07/17 18:40:54.559][DEBUG] [Main Thread] Star detection using min star size of 2px...
[03/07/17 18:40:54.559][DEBUG] [Main Thread] Star detection using max star size of 40px...
[03/07/17 18:40:54.589][DEBUG] [Main Thread] Find stars took: 656 ms...
[03/07/17 18:40:54.589][DEBUG] [Main Thread] Star list contains 5 stars...
[03/07/17 18:40:54.589][DEBUG] [Main Thread] Calculating HFR with sample size: 2
[03/07/17 18:40:54.752][DEBUG] [Camera Thread] Auto focus HFR calculated at: 0.98
[03/07/17 18:40:55.764][DEBUG] [Camera Thread] Moving focuser to next position (14500)...
[03/07/17 18:40:55.764][DEBUG] [Focuser Move Thread] Focuser moving to 14500
[03/07/17 18:40:55.780][DEBUG] [Focuser Move Thread] Focuser move call complete
[03/07/17 18:40:59.865][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 14500 matches requested position 14500
[03/07/17 18:40:59.865][DEBUG] [Camera Thread] Focuser move complete...
[03/07/17 18:40:59.876][DEBUG] [Camera Thread] Focuser position matches requested position (14500), continuing...
[03/07/17 18:40:59.888][DEBUG] [Camera Thread] Auto focus settling before next frame...
[03/07/17 18:40:59.890][DEBUG] [Camera Thread] Calculating step metric...
[03/07/17 18:40:59.890][DEBUG] [Camera Thread] Taking auto focus frame(s)...
[03/07/17 18:40:59.892][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame...
[03/07/17 18:40:59.892][DEBUG] [Camera Thread] ASCOM: AF Binning: 3x3...
[03/07/17 18:40:59.892][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds...
[03/07/17 18:40:59.892][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b
[03/07/17 18:40:59.895][DEBUG] [Camera Thread] SetAscomNormalSpeed... 
[03/07/17 18:40:59.896][DEBUG] [Camera Thread] Readout speed set to NORMAL...
[03/07/17 18:41:07.724][DEBUG] [Camera Thread] SaveFileAscom: Start...
[03/07/17 18:41:07.724][DEBUG] [Camera Thread] SaveFileAscom: Checking image data...
[03/07/17 18:41:07.724][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap...
[03/07/17 18:41:07.724][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits...
[03/07/17 18:41:07.724][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal...
[03/07/17 18:41:07.738][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits...
[03/07/17 18:41:07.738][DEBUG] [Camera Thread] SaveFileAscom: Done
[03/07/17 18:41:07.738][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write...
[03/07/17 18:41:07.738][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream...
[03/07/17 18:41:07.739][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers...
[03/07/17 18:41:07.739][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data...
[03/07/17 18:41:07.763][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill...
[03/07/17 18:41:07.763][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap...
[03/07/17 18:41:07.763][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream
[03/07/17 18:41:07.769][DEBUG] [Camera Thread] Internal Interface: Set Preview...
[03/07/17 18:41:07.769][DEBUG] [Camera Thread] Display image preview using asynch task...
[03/07/17 18:41:07.876][DEBUG] [Main Thread] --> Find stars (normal)
[03/07/17 18:41:08.519][DEBUG] [Main Thread] Star detection using min star size of 2px...
[03/07/17 18:41:08.519][DEBUG] [Main Thread] Star detection using max star size of 40px...
[03/07/17 18:41:08.539][DEBUG] [Main Thread] Find stars took: 663 ms...
[03/07/17 18:41:08.539][DEBUG] [Main Thread] Star list contains 2 stars...
[03/07/17 18:41:08.539][DEBUG] [Main Thread] Calculating HFR with sample size: 2
[03/07/17 18:41:08.713][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.84
[03/07/17 18:41:09.722][DEBUG] [Camera Thread] Moving focuser to next position (14250)...
[03/07/17 18:41:09.723][DEBUG] [Focuser Move Thread] Focuser moving to 14250
[03/07/17 18:41:09.752][DEBUG] [Focuser Move Thread] Focuser move call complete
[03/07/17 18:41:13.882][DEBUG] [Focuser Move Thread] MoveFocuserAbsBlocking: Focuser position 14250 matches requested position 14250
[03/07/17 18:41:13.882][DEBUG] [Camera Thread] Focuser move complete...
[03/07/17 18:41:13.895][DEBUG] [Camera Thread] Focuser position matches requested position (14250), continuing...
[03/07/17 18:41:13.910][DEBUG] [Camera Thread] Auto focus settling before next frame...
[03/07/17 18:41:13.913][DEBUG] [Camera Thread] Calculating step metric...
[03/07/17 18:41:13.913][DEBUG] [Camera Thread] Taking auto focus frame(s)...
[03/07/17 18:41:13.914][DEBUG] [Camera Thread] ASCOM camera: Capturing auto focus frame...
[03/07/17 18:41:13.914][DEBUG] [Camera Thread] ASCOM: AF Binning: 3x3...
[03/07/17 18:41:13.914][DEBUG] [Camera Thread] ASCOM: AF Exposure length: 5 seconds...
[03/07/17 18:41:13.914][DEBUG] [Camera Thread] ASCOM: AF Exposure DL speed: b
[03/07/17 18:41:13.918][DEBUG] [Camera Thread] SetAscomNormalSpeed... 
[03/07/17 18:41:13.919][DEBUG] [Camera Thread] Readout speed set to NORMAL...
[03/07/17 18:41:21.745][DEBUG] [Camera Thread] SaveFileAscom: Start...
[03/07/17 18:41:21.745][DEBUG] [Camera Thread] SaveFileAscom: Checking image data...
[03/07/17 18:41:21.745][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap...
[03/07/17 18:41:21.746][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits...
[03/07/17 18:41:21.746][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal...
[03/07/17 18:41:21.760][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits...
[03/07/17 18:41:21.760][DEBUG] [Camera Thread] SaveFileAscom: Done
[03/07/17 18:41:21.760][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write...
[03/07/17 18:41:21.760][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream...
[03/07/17 18:41:21.761][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers...
[03/07/17 18:41:21.761][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data...
[03/07/17 18:41:21.783][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill...
[03/07/17 18:41:21.783][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap...
[03/07/17 18:41:21.783][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream
[03/07/17 18:41:21.790][DEBUG] [Camera Thread] Internal Interface: Set Preview...
[03/07/17 18:41:21.790][DEBUG] [Camera Thread] Display image preview using asynch task...
[03/07/17 18:41:21.911][DEBUG] [Main Thread] --> Find stars (normal)
[03/07/17 18:41:22.533][DEBUG] [Main Thread] Star detection using min star size of 2px...
[03/07/17 18:41:22.533][DEBUG] [Main Thread] Star detection using max star size of 40px...
[03/07/17 18:41:22.565][DEBUG] [Main Thread] Find stars took: 654 ms...
[03/07/17 18:41:22.565][DEBUG] [Main Thread] Star list contains 3 stars...
[03/07/17 18:41:22.565][DEBUG] [Main Thread] Calculating HFR with sample size: 2
[03/07/17 18:41:22.731][DEBUG] [Camera Thread] Auto focus HFR calculated at: 1.45
[03/07/17 18:41:23.743][DEBUG] [Camera Thread] Moving focuser to next position (14000)...
[03/07/17 18:41:23.744][DEBUG] [Focuser Move Thread] Focuser moving to 14000
[03/07/17 18:41:23.767][DEBUG] [Focuser Move Thread] Focuser move call complete
[03/07/17 18:41:27.619][DEBUG] [Camera Thread] Attempting to abort focuser move...
[03/07/17 18:41:28.120][DEBUG] [Camera Thread] AF abort requested
[03/07/17 18:41:28.122][DEBUG] [Camera Thread] Auto focus (finally): closing dialog...
[03/07/17 18:41:28.126][DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_ABS message received...
[03/07/17 18:41:28.126][DEBUG] [Focuser Thread] Focuser moving to 15000
[03/07/17 18:41:28.141][DEBUG] [AfChartThread] AF chart dialog is closed...
[03/07/17 18:41:28.156][DEBUG] [Camera Thread] Auto focus complete...
[03/07/17 18:41:28.177][DEBUG] [Camera Thread] SGM_FOCUSER_AUTO_FOCUS complete...
[03/07/17 18:41:34.112][DEBUG] [Focuser Thread] Focuser backlash active, modified move to 16500
[03/07/17 18:41:34.122][DEBUG] [Focuser Thread] Focuser move call complete
[03/07/17 18:41:34.122][DEBUG] [Focuser Backlash Thread] Focuser backlash thread has started...
[03/07/17 18:42:16.705][DEBUG] [Focuser Backlash Thread] Backlash thread has detected that movement to modified position (16500) is complete...
[03/07/17 18:42:16.705][DEBUG] [Focuser Backlash Thread] Moving focuser to original requested position (15000)...
[03/07/17 18:42:16.705][DEBUG] [Focuser Backlash Thread] Focuser backlash compensation needed. Steps: 1500 Direction:IN
[03/07/17 18:42:16.705][DEBUG] [Focuser Backlash Thread] Focuser moving to 15000
[03/07/17 18:42:16.718][DEBUG] [Focuser Backlash Thread] Focuser move call complete
[03/07/17 18:42:44.121][DEBUG] [Focuser Backlash Thread] Focuser backlash completed.  Focuser is at original request position (15000)...
[03/07/17 18:42:44.121][DEBUG] [Focuser Backlash Thread] Focuser backlash thread has ended...
[03/07/17 18:42:44.259][DEBUG] [Focuser Thread] SGM_FOCUSER_MOVE_ABS complete...
[03/07/17 18:42:48.895][DEBUG] [Main Thread] Disconnecting ASCOM Focuser: GCUSB_nSTEP.Focuser
[03/07/17 18:42:49.905][DEBUG] [Main Thread] Disconnecting ASCOM camera: Atik Camera...
[03/07/17 18:42:53.772][DEBUG] [Main Thread] Alnitak Flat Box - Disconnecting
[03/07/17 18:42:53.779][DEBUG] [Main Thread] Error while disconencting all equipment: Value cannot be null.
[03/07/17 18:42:53.780][DEBUG] [TEC Thread] TEC Dispatch loop: Received SGM_TERMINATE...
[03/07/17 18:42:53.780][DEBUG] [Sequence Thread] Dispatch loop: Received SGM_TERMINATE...
[03/07/17 18:42:53.780][DEBUG] [Telescope Thread] Telescope Dispatch loop: Received SGM_TERMINATE...
[03/07/17 18:42:53.780][DEBUG] [Camera Thread] Camera Dispatch loop: Received SGM_TERMINATE...
[03/07/17 18:42:53.790][DEBUG] [Filter Wheel Thread] Filter Wheel Dispatch loop: Received SGM_TERMINATE...
[03/07/17 18:42:53.790][DEBUG] [Auto Guider Thread] Auto Guider Dispatch loop: Received SGM_TERMINATE...
[03/07/17 18:42:53.790][DEBUG] [Focuser Thread] Focuser Dispatch loop: Received SGM_TERMINATE...
[03/07/17 18:42:53.851][DEBUG] [Main Thread] Performing clean up...