21:03:35.910 00.016 90092 PHD2 version 2.6.1 begins execution with:
21:03:35.910 00.000 90092    wxWidgets 3.0.2
21:03:35.910 00.000 90092    cfitsio 3.37
21:03:35.910 00.000 90092 CoInitializeEx returns 1
21:03:35.910 00.000 90092 Using Locale Dir C:\Program Files (x86)\PHDGuiding2\locale exists=1
21:03:35.910 00.000 90092 GetInt("/wxLanguage", 0) returns 0
21:03:35.926 00.016 90092 locale.AddCatalog failed
21:03:35.957 00.031 90092 GetString("/frame/LogDir", "") returns ""
21:03:35.957 00.000 90092 GetInt("/currentProfile", 0) returns 3
21:03:35.973 00.016 90092 StartWorkerThread(0x00000000) begins
21:03:35.988 00.015 90092 WorkerThread constructor called
21:03:35.988 00.000 90092 StartWorkerThread(0x01232E18) ends
21:03:35.988 00.000 98436 WorkerThread::Entry() begins
21:03:35.988 00.000 90092 StartWorkerThread(0x00000000) begins
21:03:35.988 00.000 98436 worker thread CoInitializeEx returns 0
21:03:35.988 00.000 90092 WorkerThread constructor called
21:03:35.988 00.000 90092 StartWorkerThread(0x012331A0) ends
21:03:35.988 00.000 99212 WorkerThread::Entry() begins
21:03:35.988 00.000 99212 worker thread CoInitializeEx returns 0
21:03:35.988 00.000 90092 GetBoolean("/ServerMode", 1) returns 1
21:03:35.988 00.000 90092 GetInt("/LoggedImageFormat", 0) returns 0
21:03:36.270 00.282 90092 Status Line 2: 
21:03:36.270 00.000 90092 Status Line 3: 
21:03:36.270 00.000 90092 Status Line 4: 
21:03:36.270 00.000 90092 Status Line 5: No cal
21:03:36.270 00.000 90092 GetInt("/profile/3/NoiseReductionMethod", 0) returns 0
21:03:36.270 00.000 90092 GetDouble("/profile/3/DitherScaleFactor", 1.000000) returns 1.000000
21:03:36.270 00.000 90092 GetBoolean("/profile/3/DitherRaOnly", 0) returns 0
21:03:36.285 00.015 90092 GetInt("/profile/3/frame/timeLapse", 0) returns 0
21:03:36.285 00.000 90092 GetBoolean("/profile/3/AutoLoadCalibration", 0) returns 0
21:03:36.285 00.000 90092 GetInt("/profile/3/frame/focalLength", 0) returns 0
21:03:36.285 00.000 90092 GetInt("/profile/3/auto_exp/exposure_min", 1000) returns 1000
21:03:36.285 00.000 90092 GetInt("/profile/3/auto_exp/exposure_max", 5000) returns 5000
21:03:36.285 00.000 90092 GetDouble("/profile/3/auto_exp/target_snr", 6.000000) returns 6.000000
21:03:36.285 00.000 90092 AutoExp: config min = 1000 max = 5000 snr = 6.00
21:03:36.285 00.000 90092 AutoExp: reset exp to 5000
21:03:36.285 00.000 90092 GetString("/profile/3/ExposureDuration", "1.0 s") returns "1.0 s"
21:03:36.301 00.016 90092 OnExposureDurationSelected: duration = 1000
21:03:36.301 00.000 90092 GetInt("/profile/3/Gamma", 100) returns 300
21:03:36.316 00.015 90092 GetInt("/profile/3/overlay/slit/center.x", 376) returns 376
21:03:36.332 00.016 90092 GetInt("/profile/3/overlay/slit/center.y", 290) returns 290
21:03:36.332 00.000 90092 GetInt("/profile/3/overlay/slit/width", 8) returns 8
21:03:36.332 00.000 90092 GetInt("/profile/3/overlay/slit/height", 100) returns 100
21:03:36.332 00.000 90092 GetInt("/profile/3/overlay/slit/angle", 0) returns 0
21:03:36.332 00.000 90092 Changing from state 0 to 0
21:03:36.332 00.000 90092 GetBoolean("/profile/3/guider/FastRecenter", 1) returns 1
21:03:36.332 00.000 90092 GetBoolean("/profile/3/guider/ScaleImage", 1) returns 1
21:03:36.332 00.000 90092 GetDouble("/profile/3/guider/onestar/MassChangeThreshold", 0.500000) returns 0.500000
21:03:36.348 00.016 90092 GetBoolean("/profile/3/guider/onestar/MassChangeThresholdEnabled", 1) returns 1
21:03:36.348 00.000 90092 GetInt("/profile/3/guider/onestar/SearchRegion", 15) returns 15
21:03:36.348 00.000 90092 GetBoolean("/StickyLockPosition", 0) returns 0
21:03:36.348 00.000 90092 GetString("/geometry", "") returns "1;1320;784;-8;-8"
21:03:36.363 00.015 90092 GetInt("/graph/ScopeOrCameraUnits", 0) returns 0
21:03:36.363 00.000 90092 GetString("/graph/RAColor", "") returns "#6464FF"
21:03:36.363 00.000 90092 GetString("/graph/DecColor", "") returns "#FF0000"
21:03:36.379 00.016 90092 GetInt("/graph/minLength", 50) returns 50
21:03:36.379 00.000 90092 GetInt("/graph/maxLength", 400) returns 400
21:03:36.379 00.000 90092 GetInt("/graph/minHeight", 1) returns 1
21:03:36.379 00.000 90092 GetInt("/graph/maxHeight", 16) returns 16
21:03:36.379 00.000 90092 GetInt("/graph/length", 100) returns 100
21:03:36.379 00.000 90092 GetInt("/graph/height", 4) returns 4
21:03:36.379 00.000 90092 GetInt("graph/HeightUnits", 1) returns 1
21:03:36.379 00.000 90092 GetBoolean("/graph/showCorrections", 1) returns 1
21:03:36.379 00.000 90092 GetBoolean("/graph/showStarMass", 0) returns 0
21:03:36.379 00.000 90092 GetBoolean("/graph/showStarSNR", 0) returns 0
21:03:36.580 00.201 90092 GetInt("/graph_stepguider/length", 1) returns 1
21:03:36.580 00.000 90092 GetInt("/target/length", 100) returns 100
21:03:36.580 00.000 90092 GetDouble("/target/zoom", 1.000000) returns 0.500000
21:03:36.611 00.031 90092 GetBoolean("/profile/3/target/refCircleEnabled", 0) returns 0
21:03:36.611 00.000 90092 GetDouble("/profile/3/target/refCircleRadius", 2.000000) returns 2.000000
21:03:37.283 00.672 90092 GetString("/profile/1/name", "") returns "finder guider HEQ5 ASCOM"
21:03:37.283 00.000 90092 GetString("/profile/2/name", "") returns "st80 qhy5ii"
21:03:37.283 00.000 90092 GetString("/profile/3/name", "") returns "Test"
21:03:37.283 00.000 90092 GetString("/profile/4/name", "") returns "Test 2"
21:03:37.283 00.000 90092 GetString("/profile/5/name", "") returns "Test 3"
21:03:37.299 00.016 90092 GetString("/profile/3/name", "") returns "Test"
21:03:37.704 00.405 90092 GetString("/profile/3/camera/LastMenuchoice", "None") returns "Simulator"
21:03:37.704 00.000 90092 CameraFactory(Simulator)
21:03:37.719 00.015 90092 GetBoolean("/profile/3/camera/UseSubframes", 0) returns 0
21:03:37.719 00.000 90092 GetInt("/profile/3/camera/ReadDelay", 150) returns 150
21:03:37.719 00.000 90092 GetInt("/profile/3/camera/gain", 95) returns 95
21:03:37.719 00.000 90092 GetInt("/profile/3/camera/TimeoutMs", 15000) returns 15000
21:03:37.719 00.000 90092 GetDouble("/profile/3/camera/pixelsize", 0.000000) returns 0.000000
21:03:37.719 00.000 90092 GetInt("/profile/3/camera/binning", 1) returns 1
21:03:37.719 00.000 90092 Created new camera of type Simulator = 05730F30
21:03:37.719 00.000 90092 GetString("/profile/3/scope/LastMenuChoice", "None") returns "AvalonStarGo.NET (ASCOM)"
21:03:37.719 00.000 90092 ScopeFactory(AvalonStarGo.NET (ASCOM))
21:03:37.719 00.000 90092 GetInt("/profile/3/scope/CalibrationDuration", 750) returns 750
21:03:37.719 00.000 90092 GetInt("/profile/3/scope/MaxRaDuration", 2500) returns 2500
21:03:37.719 00.000 90092 GetInt("/profile/3/scope/MaxDecDuration", 2500) returns 2500
21:03:37.719 00.000 90092 GetInt("/profile/3/scope/DecGuideMode", 1) returns 1
21:03:37.719 00.000 90092 DecGuideMode set to Auto (1)
21:03:37.719 00.000 90092 GetInt("/profile/3/scope/XGuideAlgorithm", 1) returns 1
21:03:37.719 00.000 90092 GetDouble("/profile/3/scope/GuideAlgorithm/X/Hysteresis/minMove", 0.200000) returns 0.200000
21:03:37.719 00.000 90092 GetDouble("/profile/3/scope/GuideAlgorithm/X/Hysteresis/hysteresis", 0.100000) returns 0.100000
21:03:37.719 00.000 90092 GetDouble("/profile/3/scope/GuideAlgorithm/X/Hysteresis/aggression", 0.700000) returns 0.700000
21:03:37.719 00.000 90092 GetInt("/profile/3/scope/YGuideAlgorithm", 4) returns 4
21:03:37.719 00.000 90092 GetDouble("/profile/3/scope/GuideAlgorithm/Y/ResistSwitch/minMove", 0.200000) returns 0.200000
21:03:37.719 00.000 90092 GuideAlgorithmResistSwitch::SetMinMove() returns 0, m_minMove=0.20
21:03:37.719 00.000 90092 GetDouble("/profile/3/scope/GuideAlgorithm/Y/ResistSwitch/aggression", 1.000000) returns 1.000000
21:03:37.719 00.000 90092 GuideAlgorithmResistSwitch::SetAggression() returns 0, m_aggression=1.00
21:03:37.735 00.016 90092 GetBoolean("/profile/3/scope/GuideAlgorithm/Y/ResistSwitch/fastSwitch", 1) returns 1
21:03:37.735 00.000 90092 GuideAlgorithmResistSwitch::SetFastSwitchEnabled(1)
21:03:37.735 00.000 90092 GetBoolean("/profile/3/scope/CalFlipRequiresDecFlip", 0) returns 0
21:03:37.735 00.000 90092 GetBoolean("/profile/3/scope/AssumeOrthogonal", 0) returns 0
21:03:37.735 00.000 90092 GetBoolean("/profile/3/scope/UseDecComp", 1) returns 1
21:03:37.735 00.000 90092 GetInt("/profile/3/scope/DecBacklashPulse", 0) returns 0
21:03:37.735 00.000 90092 BLC: Backlash compensation is disabled
21:03:37.735 00.000 90092 GetBoolean("/profile/3/scope/StopGuidingWhenSlewing", 1) returns 0
21:03:37.735 00.000 90092 Scope: slew check disabled
21:03:37.735 00.000 90092 Created new scope of type AvalonStarGo.NET (ASCOM) = 056FB858
21:03:37.735 00.000 90092 GetString("/profile/3/scope/LastAuxMenuChoice", "None") returns "None"
21:03:37.735 00.000 90092 ScopeFactory(None)
21:03:37.735 00.000 90092 Created new aux scope of type None = 00000000
21:03:37.735 00.000 90092 Throw from C:\cygwin\home\agalasso\projects\phd2\gear_dialog.cpp:1129->OnAuxChoiceScope: m_pAuxScope == NULL
21:03:37.735 00.000 90092 GetString("/profile/3/stepguider/LastMenuChoice", "None") returns "None"
21:03:37.735 00.000 90092 StepGuiderFactory(None)
21:03:37.735 00.000 90092 Created new stepguider of type None = 00000000
21:03:37.735 00.000 90092 Throw from C:\cygwin\home\agalasso\projects\phd2\gear_dialog.cpp:1327->OnChoiceStepGuider: m_pStepGuider == NULL
21:03:37.735 00.000 90092 GetString("/profile/3/rotator/LastMenuChoice", "None") returns "None"
21:03:37.735 00.000 90092 RotatorFactory(None)
21:03:37.735 00.000 90092 Created new Rotator of type None = 00000000
21:03:37.735 00.000 90092 Throw from C:\cygwin\home\agalasso\projects\phd2\gear_dialog.cpp:1441->OnChoiceRotator: m_pRotator == NULL
21:03:37.751 00.016 90092 GetString("/profile/3/name", "") returns "Test"
21:03:37.813 00.062 90092 event server started, listening on port 4400
21:03:37.813 00.000 90092 Status Line 0: Server started
21:03:37.813 00.000 90092 Server started, listening on port 4300
21:03:37.813 00.000 90092 Status Line 0: Server started
21:03:37.829 00.016 90092 GetString("/perspective", "") returns "layout2|name=MainToolBar;caption=Main tool bar;state=2106108;dir=3;layer=10;row=0;pos=0;prop=100000;bestw=506;besth=42;minw=-1;minh=-1;maxw=-1;maxh=-1;floatx=-1;floaty=-1;floatw=-1;floath=-1|name=Guider;caption=Guider;state=768;dir=5;layer=0;row=0;pos=0;prop=100000;bestw=640;besth=512;minw=640;minh=512;maxw=-1;maxh=-1;floatx=-1;floaty=-1;floatw=-1;floath=-1|name=GraphLog;caption=History;state=2099196;dir=3;layer=0;row=1;pos=0;prop=100000;bestw=534;besth=233;minw=-1;minh=240;maxw=-1;maxh=-1;floatx=312;floaty=65;floatw=761;floath=272|name=Stats;caption=Guide Stats;state=2099198;dir=3;layer=0;row=0;pos=0;prop=100000;bestw=226;besth=340;minw=-1;minh=240;maxw=-1;maxh=-1;floatx=-1;floaty=-1;floatw=-1;floath=-1|name=AOPosition;caption=AO Position;state=2099198;dir=4;layer=0;row=0;pos=0;prop=100000;bestw=293;besth=207;minw=-1;minh=-1;maxw=-1;maxh=-1;floatx=-1;floaty=-1;floatw=-1;floath=-1|name=Profile;caption=Star Profile;state=2099196;dir=2;layer=0;row=1;pos=0;prop=70086;bestw=20;besth=20;minw=115;minh=85;maxw=-1;maxh=-1;floatx=505;floaty=103;floatw=400;floath=485|name=Target;caption=Target;state=2099196;dir=2;layer=0;row=0;pos=0;prop=129914;bestw=320;besth=207;minw=293;minh=208;maxw=-1;maxh=-1;floatx=779;floaty=299;floatw=400;floath=485|dock_size(3,10,0)=44|dock_size(5,0,0)=642|dock_size(2,0,0)=372|dock_size(3,0,1)=259|dock_size(2,0,1)=390|"
21:03:37.938 00.109 90092 Resizing image to 491,392
21:03:49.330 11.392 90092 Status Line 0: Connecting to Camera ...
21:03:49.330 00.000 90092 GetString("/profile/3/cam_hash/3c55cdad/whichCamera", "") returns ""
21:03:49.330 00.000 90092 Connecting to camera id = []
21:03:49.330 00.000 90092 GetInt("/profile/3/SimCam/nr_stars", 20) returns 20
21:03:49.330 00.000 90092 GetInt("/profile/3/SimCam/nr_hot_pixels", 8) returns 8
21:03:49.330 00.000 90092 GetDouble("/profile/3/SimCam/noise", 2.000000) returns 2.000000
21:03:49.330 00.000 90092 GetBoolean("/profile/3/SimCam/use_pe", 1) returns 1
21:03:49.330 00.000 90092 GetBoolean("/profile/3/SimCam/use_default_pe", 1) returns 1
21:03:49.330 00.000 90092 GetDouble("/profile/3/SimCam/pe_cust_amp", 2.000000) returns 2.000000
21:03:49.346 00.016 90092 GetDouble("/profile/3/SimCam/pe_cust_period", 240.000000) returns 240.000000
21:03:49.346 00.000 90092 GetDouble("/profile/3/SimCam/dec_drift", 5.000000) returns 5.000000
21:03:49.346 00.000 90092 GetDouble("/profile/3/SimCam/dec_backlash", 5.000000) returns 5.000000
21:03:49.346 00.000 90092 GetDouble("/profile/3/SimCam/pe_scale", 5.000000) returns 5.000000
21:03:49.346 00.000 90092 GetDouble("/profile/3/SimCam/seeing_scale", 2.000000) returns 2.000000
21:03:49.346 00.000 90092 GetDouble("/profile/3/SimCam/cam_angle", 15.000000) returns 15.000000
21:03:49.346 00.000 90092 GetDouble("/profile/3/SimCam/guide_rate", 15.000000) returns 15.000000
21:03:49.346 00.000 90092 GetInt("/profile/3/SimCam/pier_side", 0) returns 0
21:03:49.346 00.000 90092 GetBoolean("/profile/3/SimCam/reverse_dec_pulse_on_west_side", 1) returns 1
21:03:49.346 00.000 90092 GetBoolean("/profile/3/SimCam/show_comet", 0) returns 0
21:03:49.346 00.000 90092 GetDouble("/profile/3/SimCam/comet_rate_x", 555.000000) returns 555.000000
21:03:49.346 00.000 90092 GetDouble("/profile/3/SimCam/comet_rate_y", -123.400000) returns -123.400000
21:03:49.362 00.016 90092 Connected Camera: Simulator
21:03:49.362 00.000 90092 FullSize=(0,0)
21:03:49.362 00.000 90092 PixelSize=0.00
21:03:49.362 00.000 90092 BitsPerPixel=16
21:03:49.362 00.000 90092 HasGainControl=1
21:03:49.362 00.000 90092 GuideCameraGain=95
21:03:49.362 00.000 90092 HasShutter=1
21:03:49.362 00.000 90092 HasSubFrames=1
21:03:49.362 00.000 90092 ST4HasGuideOutput=1
21:03:49.362 00.000 90092 GetBoolean("/profile/3/camera/AutoLoadDefectMap", 1) returns 1
21:03:49.362 00.000 90092 auto-loading defect map
21:03:49.362 00.000 90092 Loading defect map file C:\Users\Andrew\AppData\Local\phd2\darks_defects\PHD2_defect_map_3.txt
21:03:49.377 00.015 90092 Defect map file not found: C:\Users\Andrew\AppData\Local\phd2\darks_defects\PHD2_defect_map_3.txt
21:03:49.377 00.000 90092 Status Line 0: Defect map not loaded
21:03:49.377 00.000 90092 GetBoolean("/profile/3/camera/AutoLoadDarks", 1) returns 1
21:03:49.377 00.000 90092 Auto-loading dark library
21:03:49.377 00.000 90092 Error thrown from C:\cygwin\home\agalasso\projects\phd2\myframe.cpp:1800->File does not exist
21:03:49.377 00.000 90092 failed to load dark frames from C:\Users\Andrew\AppData\Local\phd2\darks_defects\PHD2_dark_lib_3.fit
21:03:49.377 00.000 90092 Status Line 0: Darks not loaded
21:03:49.393 00.016 90092 Status Line 0: Camera Connected
21:03:49.393 00.000 90092 Status Line 2: Camera
21:03:49.420 00.027 90092 Status Line 4: 
21:03:49.420 00.000 90092 Connected AO:None
21:03:49.432 00.012 90092 Status Line 0: Connecting to Mount ...
21:03:49.436 00.004 90092 Connecting
21:03:49.737 00.301 90092 pScopeDriver = 0x0579EBC4
21:03:49.784 00.047 90092 Scope reports its name as Avalon Mount
21:03:49.784 00.000 90092 ASCOM scope CanSlewAsync is true
21:03:49.784 00.000 90092 Status Line 0: Avalon Mount connected
21:03:49.784 00.000 90092 Status Line 5: No cal
21:03:49.784 00.000 90092 ScopeASCOM::GetDeclination() returns 90.0
21:03:49.784 00.000 90092 ScopeASCOM::SideOfPier() returns 1
21:03:49.784 00.000 90092 Connect success
21:03:49.784 00.000 90092 Status Line 0: Mount Connected
21:03:49.784 00.000 90092 Status Line 3: Mount
21:03:49.800 00.016 90092 Connected Scope:Avalon Mount
21:03:49.800 00.000 90092 Connected AuxScope:None
21:03:49.815 00.015 90092 Status Line 4: 
21:03:49.815 00.000 90092 Connected Rotator:None
21:03:50.362 00.547 90092 GetBoolean("/profile/3/target/refCircleEnabled", 0) returns 0
21:03:50.362 00.000 90092 GetDouble("/profile/3/target/refCircleRadius", 2.000000) returns 2.000000
21:03:50.885 00.523 90092 Resizing image to 492,393
21:04:00.220 09.335 90092 StartCapturing CaptureActive=0 continueCapturing=0 exposurePending=0
21:04:00.236 00.016 90092 Status Line 0: 
21:04:00.236 00.000 90092 ScheduleExposure(1000,3,0) exposurePending=0
21:04:00.236 00.000 90092 Enqueuing Expose request
21:04:00.236 00.000 98436 Worker thread wakes up
21:04:00.236 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:00.236 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(0,0,0,0)
21:04:00.267 00.031 90092 Resizing image to 492,393
21:04:00.361 00.094 98436 ScopeASCOM::SideOfPier() returns 1
21:04:00.361 00.000 98436 ScopeASCOM::SideOfPier() returns 1
21:04:00.361 00.000 98436 Cam simulator: pointing source flipped pier side from 0 to 1

21:04:01.253 00.892 98436 Exposure complete
21:04:01.407 00.154 98436 worker thread done servicing request
21:04:01.407 00.000 90092 Processing an image
21:04:01.411 00.004 90092 UpdateGuideState(): m_state=1
21:04:01.411 00.000 90092 UpdateCurrentPosition: no star selected
21:04:01.411 00.000 90092 Throw from C:\cygwin\home\agalasso\projects\phd2\guider.cpp:1142->unable to update current position
21:04:01.411 00.000 90092 Status Line 0: No star selected
21:04:01.415 00.004 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6172, FiltMax=19289
21:04:01.533 00.118 90092 Resizing image to 509,393
21:04:01.580 00.047 90092 UpdateGuideState exits: No star selected
21:04:01.580 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:01.580 00.000 90092 ScheduleExposure(1000,3,0) exposurePending=0
21:04:01.580 00.000 90092 Enqueuing Expose request
21:04:01.580 00.000 98436 Worker thread wakes up
21:04:01.580 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:01.580 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(0,0,0,0)
21:04:01.642 00.062 98436 ScopeASCOM::SideOfPier() returns 1
21:04:02.597 00.955 98436 Exposure complete
21:04:02.800 00.203 98436 worker thread done servicing request
21:04:02.800 00.000 90092 Processing an image
21:04:02.800 00.000 90092 UpdateGuideState(): m_state=1
21:04:02.800 00.000 90092 UpdateCurrentPosition: no star selected
21:04:02.800 00.000 90092 Throw from C:\cygwin\home\agalasso\projects\phd2\guider.cpp:1142->unable to update current position
21:04:02.800 00.000 90092 Status Line 0: No star selected
21:04:02.800 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6098, FiltMax=19298
21:04:03.050 00.250 90092 Resizing image to 509,393
21:04:03.159 00.109 90092 UpdateGuideState exits: No star selected
21:04:03.159 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:03.159 00.000 90092 ScheduleExposure(1000,3,0) exposurePending=0
21:04:03.159 00.000 90092 Enqueuing Expose request
21:04:03.159 00.000 98436 Worker thread wakes up
21:04:03.159 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:03.159 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(0,0,0,0)
21:04:03.206 00.047 98436 ScopeASCOM::SideOfPier() returns 1
21:04:04.174 00.968 98436 Exposure complete
21:04:04.377 00.203 98436 worker thread done servicing request
21:04:04.377 00.000 90092 Processing an image
21:04:04.377 00.000 90092 UpdateGuideState(): m_state=1
21:04:04.377 00.000 90092 UpdateCurrentPosition: no star selected
21:04:04.377 00.000 90092 Throw from C:\cygwin\home\agalasso\projects\phd2\guider.cpp:1142->unable to update current position
21:04:04.377 00.000 90092 Status Line 0: No star selected
21:04:04.377 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6212, FiltMax=21400
21:04:04.580 00.203 90092 Resizing image to 509,393
21:04:04.643 00.063 90092 UpdateGuideState exits: No star selected
21:04:04.643 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:04.643 00.000 90092 ScheduleExposure(1000,3,0) exposurePending=0
21:04:04.643 00.000 90092 Enqueuing Expose request
21:04:04.643 00.000 98436 Worker thread wakes up
21:04:04.643 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:04.643 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(0,0,0,0)
21:04:04.705 00.062 98436 ScopeASCOM::SideOfPier() returns 1
21:04:05.659 00.954 98436 Exposure complete
21:04:05.690 00.031 90092 Star::AutoFind called with edgeAllowance = 25 searchRegion = 15
21:04:05.862 00.172 98436 worker thread done servicing request
21:04:06.159 00.297 90092 AutoFind: global mean = -0.2, stdev 3250.4
21:04:06.159 00.000 90092 AutoFind: using threshold = 0.1
21:04:06.452 00.293 90092 AutoFind: local max [712, 367] 10.1
21:04:06.452 00.000 90092 AutoFind: local max [261, 466] 9.7
21:04:06.468 00.016 90092 AutoFind: local max [323, 398] 9.1
21:04:06.468 00.000 90092 AutoFind: local max [706, 358] 8.7
21:04:06.468 00.000 90092 AutoFind: local max [699, 358] 7.2
21:04:06.468 00.000 90092 AutoFind: local max [662, 119] 6.8
21:04:06.468 00.000 90092 AutoFind: local max [341, 307] 6.6
21:04:06.468 00.000 90092 AutoFind: local max [350, 291] 5.5
21:04:06.468 00.000 90092 AutoFind: local max [88, 219] 4.2
21:04:06.468 00.000 90092 AutoFind: local max [712, 346] 4.2
21:04:06.468 00.000 90092 AutoFind: local max [148, 287] 4.0
21:04:06.468 00.000 90092 AutoFind: local max [569, 263] 3.9
21:04:06.468 00.000 90092 AutoFind: local max [498, 499] 3.9
21:04:06.468 00.000 90092 AutoFind: local max [110, 384] 3.9
21:04:06.468 00.000 90092 AutoFind: local max [331, 64] 3.9
21:04:06.468 00.000 90092 AutoFind: local max [511, 366] 3.9
21:04:06.468 00.000 90092 AutoFind: local max [233, 143] 3.8
21:04:06.468 00.000 90092 AutoFind: local max [590, 552] 3.8
21:04:06.468 00.000 90092 AutoFind: local max [378, 64] 3.8
21:04:06.468 00.000 90092 AutoFind: local max [357, 162] 3.7
21:04:06.468 00.000 90092 AutoFind: local max [380, 101] 3.7
21:04:06.468 00.000 90092 AutoFind: local max [221, 456] 3.7
21:04:06.468 00.000 90092 AutoFind: local max [274, 558] 3.7
21:04:06.468 00.000 90092 AutoFind: local max [101, 336] 3.7
21:04:06.468 00.000 90092 AutoFind: local max [702, 508] 3.7
21:04:06.468 00.000 90092 AutoFind: local max [486, 500] 3.6
21:04:06.468 00.000 90092 AutoFind: local max [483, 73] 3.6
21:04:06.468 00.000 90092 AutoFind: local max [483, 356] 3.6
21:04:06.468 00.000 90092 AutoFind: local max [194, 336] 3.6
21:04:06.468 00.000 90092 AutoFind: local max [496, 367] 3.6
21:04:06.468 00.000 90092 AutoFind: local max [230, 564] 3.6
21:04:06.468 00.000 90092 AutoFind: local max [438, 163] 3.6
21:04:06.468 00.000 90092 AutoFind: local max [344, 129] 3.5
21:04:06.468 00.000 90092 AutoFind: local max [163, 417] 3.5
21:04:06.483 00.015 90092 AutoFind: local max [157, 353] 3.5
21:04:06.483 00.000 90092 AutoFind: local max [212, 297] 3.5
21:04:06.483 00.000 90092 AutoFind: local max [389, 492] 3.5
21:04:06.483 00.000 90092 AutoFind: local max [232, 52] 3.5
21:04:06.483 00.000 90092 AutoFind: local max [466, 378] 3.5
21:04:06.483 00.000 90092 AutoFind: local max [365, 458] 3.5
21:04:06.483 00.000 90092 AutoFind: local max [44, 186] 3.5
21:04:06.483 00.000 90092 AutoFind: local max [333, 171] 3.5
21:04:06.483 00.000 90092 AutoFind: local max [481, 25] 3.5
21:04:06.483 00.000 90092 AutoFind: local max [116, 341] 3.5
21:04:06.483 00.000 90092 AutoFind: local max [611, 63] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [433, 377] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [99, 291] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [350, 138] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [96, 104] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [99, 203] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [517, 519] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [190, 159] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [523, 370] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [101, 359] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [510, 443] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [610, 207] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [671, 367] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [382, 493] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [275, 103] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [375, 229] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [146, 71] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [513, 532] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [400, 200] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [486, 515] 3.4
21:04:06.483 00.000 90092 AutoFind: local max [217, 131] 3.4
21:04:06.499 00.016 90092 AutoFind: local max [18, 227] 3.4
21:04:06.499 00.000 90092 AutoFind: local max [467, 317] 3.4
21:04:06.499 00.000 90092 AutoFind: local max [490, 89] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [68, 225] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [75, 76] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [731, 479] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [363, 133] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [117, 13] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [586, 287] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [676, 259] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [162, 344] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [616, 368] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [323, 282] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [176, 307] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [442, 195] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [86, 449] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [567, 465] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [739, 509] 3.3
21:04:06.499 00.000 90092 AutoFind: local max [734, 552] 3.2
21:04:06.499 00.000 90092 AutoFind: local max [490, 554] 3.2
21:04:06.499 00.000 90092 AutoFind: local max [225, 141] 3.2
21:04:06.499 00.000 90092 AutoFind: local max [177, 49] 3.2
21:04:06.499 00.000 90092 AutoFind: local max [348, 9] 3.2
21:04:06.499 00.000 90092 AutoFind: local max [508, 327] 3.2
21:04:06.499 00.000 90092 AutoFind: local max [723, 455] 3.2
21:04:06.499 00.000 90092 AutoFind: local max [259, 306] 3.2
21:04:06.499 00.000 90092 AutoFind: local max [163, 237] 3.2
21:04:06.499 00.000 90092 AutoFind: local max [249, 473] 3.2
21:04:06.499 00.000 90092 AutoFind: local max [179, 204] 3.2
21:04:06.499 00.000 90092 AutoFind: local max [411, 419] 3.2
21:04:06.499 00.000 90092 AutoFind: local max [554, 144] 3.2
21:04:06.499 00.000 90092 AutoFind: local max [597, 570] 3.2
21:04:06.515 00.016 90092 AutoFind: local max [19, 369] 3.2
21:04:06.515 00.000 90092 AutoFind: local max [706, 40] 3.2
21:04:06.515 00.000 90092 AutoFind: local max [545, 416] 3.2
21:04:06.515 00.000 90092 AutoFind: too close [597, 570] 3.2 - [590, 552] 3.8
21:04:06.515 00.000 90092 AutoFind: too close [249, 473] 3.2 - [261, 466] 9.7
21:04:06.515 00.000 90092 AutoFind: too close [225, 141] 3.2 - [217, 131] 3.4
21:04:06.515 00.000 90092 AutoFind: too close [225, 141] 3.2 - [233, 143] 3.8
21:04:06.515 00.000 90092 AutoFind: too close [162, 344] 3.3 - [157, 353] 3.5
21:04:06.515 00.000 90092 AutoFind: too close [363, 133] 3.3 - [350, 138] 3.4
21:04:06.515 00.000 90092 AutoFind: too close [363, 133] 3.3 - [344, 129] 3.5
21:04:06.515 00.000 90092 AutoFind: too close [68, 225] 3.3 - [88, 219] 4.2
21:04:06.515 00.000 90092 AutoFind: too close [490, 89] 3.3 - [483, 73] 3.6
21:04:06.515 00.000 90092 AutoFind: too close [217, 131] 3.4 - [233, 143] 3.8
21:04:06.515 00.000 90092 AutoFind: too close [486, 515] 3.4 - [486, 500] 3.6
21:04:06.515 00.000 90092 AutoFind: too close [486, 515] 3.4 - [498, 499] 3.9
21:04:06.515 00.000 90092 AutoFind: too close [513, 532] 3.4 - [517, 519] 3.4
21:04:06.515 00.000 90092 AutoFind: too close [382, 493] 3.4 - [389, 492] 3.5
21:04:06.515 00.000 90092 AutoFind: too close [101, 359] 3.4 - [116, 341] 3.5
21:04:06.515 00.000 90092 AutoFind: too close [523, 370] 3.4 - [511, 366] 3.9
21:04:06.515 00.000 90092 AutoFind: too close [517, 519] 3.4 - [498, 499] 3.9
21:04:06.515 00.000 90092 AutoFind: too close [99, 203] 3.4 - [88, 219] 4.2
21:04:06.515 00.000 90092 AutoFind: too close [350, 138] 3.4 - [344, 129] 3.5
21:04:06.515 00.000 90092 AutoFind: too close [116, 341] 3.5 - [101, 336] 3.7
21:04:06.515 00.000 90092 AutoFind: too close [496, 367] 3.6 - [483, 356] 3.6
21:04:06.515 00.000 90092 AutoFind: too close [496, 367] 3.6 - [511, 366] 3.9
21:04:06.515 00.000 90092 AutoFind: too close [486, 500] 3.6 - [498, 499] 3.9
21:04:06.515 00.000 90092 AutoFind: too close [712, 346] 4.2 - [699, 358] 7.2
21:04:06.515 00.000 90092 AutoFind: too close [712, 346] 4.2 - [706, 358] 8.7
21:04:06.530 00.015 90092 AutoFind: too close [350, 291] 5.5 - [341, 307] 6.6
21:04:06.530 00.000 90092 AutoFind: too close [699, 358] 7.2 - [706, 358] 8.7
21:04:06.530 00.000 90092 AutoFind: too close [699, 358] 7.2 - [712, 367] 10.1
21:04:06.530 00.000 90092 AutoFind: too close [706, 358] 8.7 - [712, 367] 10.1
21:04:06.530 00.000 90092 AutoFind: too close to edge [706, 40] 3.2
21:04:06.530 00.000 90092 AutoFind: too close to edge [19, 369] 3.2
21:04:06.530 00.000 90092 AutoFind: too close to edge [723, 455] 3.2
21:04:06.530 00.000 90092 AutoFind: too close to edge [348, 9] 3.2
21:04:06.530 00.000 90092 AutoFind: too close to edge [177, 49] 3.2
21:04:06.530 00.000 90092 AutoFind: too close to edge [490, 554] 3.2
21:04:06.530 00.000 90092 AutoFind: too close to edge [734, 552] 3.2
21:04:06.530 00.000 90092 AutoFind: too close to edge [739, 509] 3.3
21:04:06.530 00.000 90092 AutoFind: too close to edge [117, 13] 3.3
21:04:06.530 00.000 90092 AutoFind: too close to edge [731, 479] 3.3
21:04:06.530 00.000 90092 AutoFind: too close to edge [18, 227] 3.4
21:04:06.530 00.000 90092 AutoFind: too close to edge [611, 63] 3.4
21:04:06.530 00.000 90092 AutoFind: too close to edge [481, 25] 3.5
21:04:06.530 00.000 90092 AutoFind: too close to edge [44, 186] 3.5
21:04:06.530 00.000 90092 AutoFind: too close to edge [232, 52] 3.5
21:04:06.530 00.000 90092 AutoFind: too close to edge [230, 564] 3.6
21:04:06.530 00.000 90092 AutoFind: too close to edge [702, 508] 3.7
21:04:06.530 00.000 90092 AutoFind: too close to edge [274, 558] 3.7
21:04:06.530 00.000 90092 AutoFind: too close to edge [378, 64] 3.8
21:04:06.530 00.000 90092 AutoFind: too close to edge [331, 64] 3.9
21:04:06.530 00.000 90092 Star::Find(15, 323, 398, 0, (0,0,0,0))
21:04:06.546 00.016 90092 Star::Find returns 1 (0), X=322.92, Y=397.77, Mass=92077, SNR=19.1, Peak=33828 HFD=1.6
21:04:06.546 00.000 90092 Star::Find(15, 662, 119, 0, (0,0,0,0))
21:04:06.546 00.000 90092 Star::Find returns 1 (0), X=661.63, Y=118.59, Mass=59067, SNR=17.2, Peak=30370 HFD=1.2
21:04:06.546 00.000 90092 Star::Find(15, 148, 287, 0, (0,0,0,0))
21:04:06.546 00.000 90092 Star::Find returns 0 (3), X=148.00, Y=287.00, Mass=0, SNR=0.0, Peak=11996 HFD=0.0
21:04:06.546 00.000 90092 Star::Find(15, 569, 263, 0, (0,0,0,0))
21:04:06.546 00.000 90092 Star::Find returns 0 (3), X=569.00, Y=263.00, Mass=0, SNR=0.0, Peak=11990 HFD=0.0
21:04:06.546 00.000 90092 Star::Find(15, 110, 384, 0, (0,0,0,0))
21:04:06.546 00.000 90092 Star::Find returns 0 (3), X=110.00, Y=384.00, Mass=0, SNR=0.0, Peak=11998 HFD=0.0
21:04:06.546 00.000 90092 Star::Find(15, 357, 162, 0, (0,0,0,0))
21:04:06.546 00.000 90092 Star::Find returns 0 (3), X=357.00, Y=162.00, Mass=0, SNR=0.0, Peak=11992 HFD=0.0
21:04:06.546 00.000 90092 Star::Find(15, 380, 101, 0, (0,0,0,0))
21:04:06.546 00.000 90092 Star::Find returns 0 (3), X=380.00, Y=101.00, Mass=0, SNR=0.0, Peak=11998 HFD=0.0
21:04:06.546 00.000 90092 Star::Find(15, 221, 456, 0, (0,0,0,0))
21:04:06.546 00.000 90092 Star::Find returns 0 (3), X=221.00, Y=456.00, Mass=0, SNR=0.0, Peak=11998 HFD=0.0
21:04:06.546 00.000 90092 Star::Find(15, 194, 336, 0, (0,0,0,0))
21:04:06.546 00.000 90092 Star::Find returns 0 (3), X=194.00, Y=336.00, Mass=0, SNR=0.0, Peak=11974 HFD=0.0
21:04:06.546 00.000 90092 Star::Find(15, 438, 163, 0, (0,0,0,0))
21:04:06.546 00.000 90092 Star::Find returns 0 (3), X=438.00, Y=163.00, Mass=0, SNR=0.0, Peak=11996 HFD=0.0
21:04:06.546 00.000 90092 Star::Find(15, 163, 417, 0, (0,0,0,0))
21:04:06.546 00.000 90092 Star::Find returns 0 (3), X=163.00, Y=417.00, Mass=0, SNR=0.0, Peak=11988 HFD=0.0
21:04:06.546 00.000 90092 Star::Find(15, 212, 297, 0, (0,0,0,0))
21:04:06.546 00.000 90092 Star::Find returns 0 (3), X=212.00, Y=297.00, Mass=0, SNR=0.0, Peak=11996 HFD=0.0
21:04:06.546 00.000 90092 Star::Find(15, 466, 378, 0, (0,0,0,0))
21:04:06.546 00.000 90092 Star::Find returns 0 (3), X=466.00, Y=378.00, Mass=0, SNR=0.0, Peak=11998 HFD=0.0
21:04:06.546 00.000 90092 Star::Find(15, 365, 458, 0, (0,0,0,0))
21:04:06.546 00.000 90092 Star::Find returns 0 (3), X=365.00, Y=458.00, Mass=0, SNR=0.0, Peak=11996 HFD=0.0
21:04:06.562 00.016 90092 Star::Find(15, 333, 171, 0, (0,0,0,0))
21:04:06.562 00.000 90092 Star::Find returns 0 (3), X=333.00, Y=171.00, Mass=0, SNR=0.0, Peak=11982 HFD=0.0
21:04:06.562 00.000 90092 Star::Find(15, 433, 377, 0, (0,0,0,0))
21:04:06.562 00.000 90092 Star::Find returns 0 (3), X=433.00, Y=377.00, Mass=0, SNR=0.0, Peak=11998 HFD=0.0
21:04:06.562 00.000 90092 Star::Find(15, 99, 291, 0, (0,0,0,0))
21:04:06.562 00.000 90092 Star::Find returns 0 (3), X=99.00, Y=291.00, Mass=0, SNR=0.0, Peak=11994 HFD=0.0
21:04:06.562 00.000 90092 Star::Find(15, 96, 104, 0, (0,0,0,0))
21:04:06.562 00.000 90092 Star::Find returns 0 (3), X=96.00, Y=104.00, Mass=0, SNR=0.0, Peak=11990 HFD=0.0
21:04:06.562 00.000 90092 Star::Find(15, 190, 159, 0, (0,0,0,0))
21:04:06.562 00.000 90092 Star::Find returns 0 (3), X=190.00, Y=159.00, Mass=0, SNR=0.0, Peak=11996 HFD=0.0
21:04:06.562 00.000 90092 Star::Find(15, 510, 443, 0, (0,0,0,0))
21:04:06.562 00.000 90092 Star::Find returns 0 (3), X=510.00, Y=443.00, Mass=0, SNR=0.0, Peak=11998 HFD=0.0
21:04:06.562 00.000 90092 Star::Find(15, 610, 207, 0, (0,0,0,0))
21:04:06.562 00.000 90092 Star::Find returns 0 (3), X=610.00, Y=207.00, Mass=0, SNR=0.0, Peak=11998 HFD=0.0
21:04:06.562 00.000 90092 Star::Find(15, 671, 367, 0, (0,0,0,0))
21:04:06.562 00.000 90092 Star::Find returns 0 (3), X=671.00, Y=367.00, Mass=0, SNR=0.0, Peak=11998 HFD=0.0
21:04:06.562 00.000 90092 Star::Find(15, 275, 103, 0, (0,0,0,0))
21:04:06.562 00.000 90092 Star::Find returns 0 (3), X=275.00, Y=103.00, Mass=0, SNR=0.0, Peak=11976 HFD=0.0
21:04:06.562 00.000 90092 Star::Find(15, 375, 229, 0, (0,0,0,0))
21:04:06.562 00.000 90092 Star::Find returns 0 (3), X=375.00, Y=229.00, Mass=0, SNR=0.0, Peak=11996 HFD=0.0
21:04:06.562 00.000 90092 Star::Find(15, 146, 71, 0, (0,0,0,0))
21:04:06.562 00.000 90092 Star::Find returns 0 (3), X=146.00, Y=71.00, Mass=0, SNR=0.0, Peak=11988 HFD=0.0
21:04:06.562 00.000 90092 Star::Find(15, 400, 200, 0, (0,0,0,0))
21:04:06.562 00.000 90092 Star::Find returns 0 (3), X=400.00, Y=200.00, Mass=0, SNR=0.0, Peak=11998 HFD=0.0
21:04:06.562 00.000 90092 Star::Find(15, 467, 317, 0, (0,0,0,0))
21:04:06.562 00.000 90092 Star::Find returns 0 (3), X=467.00, Y=317.00, Mass=0, SNR=0.0, Peak=11980 HFD=0.0
21:04:06.562 00.000 90092 Star::Find(15, 75, 76, 0, (0,0,0,0))
21:04:06.577 00.015 90092 Star::Find returns 0 (3), X=75.00, Y=76.00, Mass=0, SNR=0.0, Peak=11992 HFD=0.0
21:04:06.577 00.000 90092 Star::Find(15, 586, 287, 0, (0,0,0,0))
21:04:06.577 00.000 90092 Star::Find returns 0 (3), X=586.00, Y=287.00, Mass=0, SNR=0.0, Peak=11998 HFD=0.0
21:04:06.577 00.000 90092 Star::Find(15, 676, 259, 0, (0,0,0,0))
21:04:06.577 00.000 90092 Star::Find returns 0 (3), X=676.00, Y=259.00, Mass=0, SNR=0.0, Peak=11986 HFD=0.0
21:04:06.577 00.000 90092 Star::Find(15, 616, 368, 0, (0,0,0,0))
21:04:06.577 00.000 90092 Star::Find returns 0 (3), X=616.00, Y=368.00, Mass=0, SNR=0.0, Peak=11988 HFD=0.0
21:04:06.577 00.000 90092 Star::Find(15, 323, 282, 0, (0,0,0,0))
21:04:06.577 00.000 90092 Star::Find returns 0 (3), X=323.00, Y=282.00, Mass=0, SNR=0.0, Peak=11996 HFD=0.0
21:04:06.577 00.000 90092 Star::Find(15, 176, 307, 0, (0,0,0,0))
21:04:06.577 00.000 90092 Star::Find returns 0 (3), X=176.00, Y=307.00, Mass=0, SNR=0.0, Peak=11994 HFD=0.0
21:04:06.577 00.000 90092 Star::Find(15, 442, 195, 0, (0,0,0,0))
21:04:06.577 00.000 90092 Star::Find returns 0 (3), X=442.00, Y=195.00, Mass=0, SNR=0.0, Peak=11992 HFD=0.0
21:04:06.577 00.000 90092 Star::Find(15, 86, 449, 0, (0,0,0,0))
21:04:06.577 00.000 90092 Star::Find returns 0 (3), X=86.00, Y=449.00, Mass=0, SNR=0.0, Peak=11990 HFD=0.0
21:04:06.577 00.000 90092 Star::Find(15, 567, 465, 0, (0,0,0,0))
21:04:06.577 00.000 90092 Star::Find returns 0 (3), X=567.00, Y=465.00, Mass=0, SNR=0.0, Peak=11994 HFD=0.0
21:04:06.577 00.000 90092 Star::Find(15, 508, 327, 0, (0,0,0,0))
21:04:06.577 00.000 90092 Star::Find returns 0 (3), X=508.00, Y=327.00, Mass=0, SNR=0.0, Peak=11990 HFD=0.0
21:04:06.577 00.000 90092 Star::Find(15, 259, 306, 0, (0,0,0,0))
21:04:06.577 00.000 90092 Star::Find returns 0 (3), X=259.00, Y=306.00, Mass=0, SNR=0.0, Peak=11992 HFD=0.0
21:04:06.577 00.000 90092 Star::Find(15, 163, 237, 0, (0,0,0,0))
21:04:06.577 00.000 90092 Star::Find returns 1 (0), X=163.00, Y=224.00, Mass=56530, SNR=31.4, Peak=65535 HFD=0.5
21:04:06.577 00.000 90092 Star::Find(15, 179, 204, 0, (0,0,0,0))
21:04:06.577 00.000 90092 Star::Find returns 0 (3), X=179.00, Y=204.00, Mass=0, SNR=0.0, Peak=11998 HFD=0.0
21:04:06.577 00.000 90092 Star::Find(15, 411, 419, 0, (0,0,0,0))
21:04:06.577 00.000 90092 Star::Find returns 0 (3), X=411.00, Y=419.00, Mass=0, SNR=0.0, Peak=11988 HFD=0.0
21:04:06.593 00.016 90092 Star::Find(15, 554, 144, 0, (0,0,0,0))
21:04:06.593 00.000 90092 Star::Find returns 0 (3), X=554.00, Y=144.00, Mass=0, SNR=0.0, Peak=11994 HFD=0.0
21:04:06.593 00.000 90092 Star::Find(15, 545, 416, 0, (0,0,0,0))
21:04:06.593 00.000 90092 Star::Find returns 0 (3), X=545.00, Y=416.00, Mass=0, SNR=0.0, Peak=11998 HFD=0.0
21:04:06.593 00.000 90092 AutoSelect: BPP = 16, saturation at 65535, thresh = 58981
21:04:06.593 00.000 90092 AutoSelect: finding best star pass 1
21:04:06.593 00.000 90092 Star::Find(15, 323, 398, 0, (0,0,0,0))
21:04:06.593 00.000 90092 Star::Find returns 1 (0), X=322.92, Y=397.77, Mass=92077, SNR=19.1, Peak=33828 HFD=1.6
21:04:06.593 00.000 90092 Autofind returns star at [323, 398] 9.1 Mass 92077 SNR 19.1
21:04:06.593 00.000 90092 Star::Find(15, 323, 398, 0, (0,0,0,0))
21:04:06.593 00.000 90092 Star::Find returns 1 (0), X=322.92, Y=397.77, Mass=92077, SNR=19.1, Peak=33828 HFD=1.6
21:04:06.593 00.000 90092 setting lock position to (322.92, 397.77)
21:04:06.593 00.000 90092 AutoSelect: state = 1, call UpdateGuideState
21:04:06.593 00.000 90092 UpdateGuideState(): m_state=1
21:04:06.593 00.000 90092 Star::Find(15, 322, 397, 0, (0,0,0,0))
21:04:06.593 00.000 90092 Star::Find returns 1 (0), X=322.92, Y=397.77, Mass=92077, SNR=19.1, Peak=33828 HFD=1.6
21:04:06.593 00.000 90092 setting lock position to (322.92, 397.77)
21:04:06.593 00.000 90092 CurrentPosition() valid, moving to STATE_SELECTED
21:04:06.593 00.000 90092 Changing from state 1 to 2
21:04:06.593 00.000 90092 Guider::SetState: clearing mount guide algorithm history
21:04:06.593 00.000 90092 Status Line 0: m=92077 SNR=19.1
21:04:06.640 00.047 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6212, FiltMax=21400
21:04:06.796 00.156 90092 Resizing image to 509,393
21:04:06.827 00.031 90092 UpdateGuideState exits: m=92077 SNR=19.1
21:04:06.827 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6212, FiltMax=21400
21:04:06.905 00.078 90092 Resizing image to 509,393
21:04:06.952 00.047 90092 Status Line 1: Auto-selected star at (322.9, 397.8)
21:04:06.952 00.000 90092 Status Line 0: m=92077 SNR=19.1
21:04:06.952 00.000 90092 Processing an image
21:04:06.952 00.000 90092 UpdateGuideState(): m_state=2
21:04:06.952 00.000 90092 Star::Find(15, 322, 397, 0, (0,0,0,0))
21:04:06.952 00.000 90092 Star::Find returns 1 (0), X=322.90, Y=398.12, Mass=87045, SNR=20.8, Peak=41033 HFD=1.4
21:04:06.952 00.000 90092 Status Line 0: m=87045 SNR=20.8
21:04:06.952 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6148, FiltMax=20176
21:04:07.046 00.094 90092 Resizing image to 509,393
21:04:07.077 00.031 90092 UpdateGuideState exits: m=87045 SNR=20.8
21:04:07.077 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:07.077 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:07.077 00.000 90092 Enqueuing Expose request
21:04:07.077 00.000 98436 Worker thread wakes up
21:04:07.077 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:07.077 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(308,383,31,31)
21:04:07.124 00.047 98436 ScopeASCOM::SideOfPier() returns 1
21:04:08.097 00.973 98436 Exposure complete
21:04:08.300 00.203 98436 worker thread done servicing request
21:04:08.300 00.000 90092 Processing an image
21:04:08.300 00.000 90092 UpdateGuideState(): m_state=2
21:04:08.300 00.000 90092 Star::Find(15, 322, 398, 0, (0,0,0,0))
21:04:08.300 00.000 90092 Star::Find returns 1 (0), X=323.11, Y=398.66, Mass=78886, SNR=17.2, Peak=30552 HFD=1.4
21:04:08.300 00.000 90092 Status Line 0: m=78886 SNR=17.2
21:04:08.300 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6194, FiltMax=20246
21:04:08.456 00.156 90092 Resizing image to 509,393
21:04:08.503 00.047 90092 UpdateGuideState exits: m=78886 SNR=17.2
21:04:08.503 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:08.503 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:08.503 00.000 90092 Enqueuing Expose request
21:04:08.503 00.000 98436 Worker thread wakes up
21:04:08.503 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:08.503 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(308,384,31,31)
21:04:08.565 00.062 98436 ScopeASCOM::SideOfPier() returns 1
21:04:09.520 00.955 98436 Exposure complete
21:04:09.708 00.188 98436 worker thread done servicing request
21:04:09.708 00.000 90092 Processing an image
21:04:09.723 00.015 90092 UpdateGuideState(): m_state=2
21:04:09.723 00.000 90092 Star::Find(15, 323, 398, 0, (0,0,0,0))
21:04:09.723 00.000 90092 Star::Find returns 1 (0), X=323.20, Y=399.12, Mass=90699, SNR=19.8, Peak=35807 HFD=1.7
21:04:09.723 00.000 90092 Status Line 0: m=90699 SNR=19.8
21:04:09.723 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6102, FiltMax=22623
21:04:09.880 00.157 90092 Resizing image to 509,393
21:04:09.942 00.062 90092 UpdateGuideState exits: m=90699 SNR=19.8
21:04:09.942 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:09.942 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:09.942 00.000 90092 Enqueuing Expose request
21:04:09.942 00.000 98436 Worker thread wakes up
21:04:09.942 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:09.942 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(308,384,31,31)
21:04:10.020 00.078 98436 ScopeASCOM::SideOfPier() returns 1
21:04:10.967 00.947 98436 Exposure complete
21:04:11.170 00.203 98436 worker thread done servicing request
21:04:11.170 00.000 90092 Processing an image
21:04:11.170 00.000 90092 UpdateGuideState(): m_state=2
21:04:11.170 00.000 90092 Star::Find(15, 323, 399, 0, (0,0,0,0))
21:04:11.170 00.000 90092 Star::Find returns 1 (0), X=323.23, Y=398.77, Mass=89956, SNR=18.2, Peak=30828 HFD=1.6
21:04:11.170 00.000 90092 Status Line 0: m=89956 SNR=18.2
21:04:11.170 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6148, FiltMax=19262
21:04:11.389 00.219 90092 Resizing image to 509,393
21:04:11.454 00.065 90092 UpdateGuideState exits: m=89956 SNR=18.2
21:04:11.454 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:11.454 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:11.469 00.015 90092 Enqueuing Expose request
21:04:11.469 00.000 98436 Worker thread wakes up
21:04:11.469 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:11.469 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(308,384,31,31)
21:04:11.532 00.063 98436 ScopeASCOM::SideOfPier() returns 1
21:04:12.486 00.954 98436 Exposure complete
21:04:12.690 00.204 98436 worker thread done servicing request
21:04:12.690 00.000 90092 Processing an image
21:04:12.690 00.000 90092 UpdateGuideState(): m_state=2
21:04:12.690 00.000 90092 Star::Find(15, 323, 398, 0, (0,0,0,0))
21:04:12.690 00.000 90092 Star::Find returns 1 (0), X=323.25, Y=399.19, Mass=71321, SNR=17.0, Peak=32427 HFD=1.4
21:04:12.690 00.000 90092 Status Line 0: m=71321 SNR=17.0
21:04:12.690 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6118, FiltMax=20740
21:04:12.940 00.250 90092 Resizing image to 509,393
21:04:13.033 00.093 90092 UpdateGuideState exits: m=71321 SNR=17.0
21:04:13.033 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:13.033 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:13.033 00.000 90092 Enqueuing Expose request
21:04:13.033 00.000 98436 Worker thread wakes up
21:04:13.033 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:13.033 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(308,384,31,31)
21:04:13.065 00.032 90092 GetInt("/profile/3/ManualGuide/duration", 750) returns 500
21:04:13.111 00.046 90092 GetInt("/profile/3/ManualGuide/DitherType", 4) returns 4
21:04:13.111 00.000 98436 ScopeASCOM::SideOfPier() returns 1
21:04:14.048 00.937 98436 Exposure complete
21:04:14.236 00.188 98436 worker thread done servicing request
21:04:14.236 00.000 90092 Processing an image
21:04:14.236 00.000 90092 UpdateGuideState(): m_state=2
21:04:14.251 00.015 90092 Star::Find(15, 323, 399, 0, (0,0,0,0))
21:04:14.251 00.000 90092 Star::Find returns 1 (0), X=323.08, Y=398.70, Mass=89340, SNR=20.6, Peak=35622 HFD=1.4
21:04:14.251 00.000 90092 Status Line 0: m=89340 SNR=20.6
21:04:14.251 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6178, FiltMax=18870
21:04:14.488 00.237 90092 Resizing image to 509,393
21:04:14.582 00.094 90092 UpdateGuideState exits: m=89340 SNR=20.6
21:04:14.582 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:14.582 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:14.582 00.000 90092 Enqueuing Expose request
21:04:14.582 00.000 98436 Worker thread wakes up
21:04:14.582 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:14.582 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(308,384,31,31)
21:04:14.644 00.062 98436 ScopeASCOM::SideOfPier() returns 1
21:04:15.594 00.950 98436 Exposure complete
21:04:15.798 00.204 98436 worker thread done servicing request
21:04:15.798 00.000 90092 Processing an image
21:04:15.798 00.000 90092 UpdateGuideState(): m_state=2
21:04:15.798 00.000 90092 Star::Find(15, 323, 398, 0, (0,0,0,0))
21:04:15.798 00.000 90092 Star::Find returns 1 (0), X=322.80, Y=399.10, Mass=85097, SNR=18.7, Peak=38968 HFD=1.6
21:04:15.798 00.000 90092 Status Line 0: m=85097 SNR=18.7
21:04:15.798 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6158, FiltMax=18377
21:04:16.016 00.218 90092 Resizing image to 509,393
21:04:16.095 00.079 90092 UpdateGuideState exits: m=85097 SNR=18.7
21:04:16.095 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:16.095 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:16.095 00.000 90092 Enqueuing Expose request
21:04:16.095 00.000 98436 Worker thread wakes up
21:04:16.095 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:16.095 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(308,384,31,31)
21:04:16.188 00.093 98436 ScopeASCOM::SideOfPier() returns 1
21:04:17.112 00.924 98436 Exposure complete
21:04:17.221 00.109 98436 worker thread done servicing request
21:04:17.221 00.000 90092 Processing an image
21:04:17.221 00.000 90092 UpdateGuideState(): m_state=2
21:04:17.221 00.000 90092 Star::Find(15, 322, 399, 0, (0,0,0,0))
21:04:17.221 00.000 90092 Star::Find returns 1 (0), X=323.23, Y=398.98, Mass=80943, SNR=17.0, Peak=32337 HFD=1.6
21:04:17.221 00.000 90092 Status Line 0: m=80943 SNR=17.0
21:04:17.237 00.016 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6156, FiltMax=19845
21:04:17.378 00.141 90092 Resizing image to 509,393
21:04:17.438 00.060 90092 UpdateGuideState exits: m=80943 SNR=17.0
21:04:17.438 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:17.438 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:17.438 00.000 90092 Enqueuing Expose request
21:04:17.438 00.000 98436 Worker thread wakes up
21:04:17.438 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:17.438 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(308,384,31,31)
21:04:17.516 00.078 98436 ScopeASCOM::SideOfPier() returns 1
21:04:18.456 00.940 98436 Exposure complete
21:04:18.612 00.156 98436 worker thread done servicing request
21:04:18.612 00.000 90092 Processing an image
21:04:18.612 00.000 90092 UpdateGuideState(): m_state=2
21:04:18.612 00.000 90092 Star::Find(15, 323, 398, 0, (0,0,0,0))
21:04:18.612 00.000 90092 Star::Find returns 1 (0), X=322.93, Y=399.73, Mass=88491, SNR=19.4, Peak=34255 HFD=1.6
21:04:18.612 00.000 90092 Status Line 0: m=88491 SNR=19.4
21:04:18.612 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6112, FiltMax=19702
21:04:18.737 00.125 90092 Resizing image to 509,393
21:04:18.784 00.047 90092 UpdateGuideState exits: m=88491 SNR=19.4
21:04:18.784 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:18.784 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:18.784 00.000 90092 Enqueuing Expose request
21:04:18.784 00.000 98436 Worker thread wakes up
21:04:18.784 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:18.784 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(308,385,31,31)
21:04:18.846 00.062 98436 ScopeASCOM::SideOfPier() returns 1
21:04:19.799 00.953 98436 Exposure complete
21:04:19.971 00.172 98436 worker thread done servicing request
21:04:19.971 00.000 90092 Processing an image
21:04:19.971 00.000 90092 UpdateGuideState(): m_state=2
21:04:19.971 00.000 90092 Star::Find(15, 322, 399, 0, (0,0,0,0))
21:04:19.971 00.000 90092 Star::Find returns 1 (0), X=323.87, Y=399.17, Mass=87301, SNR=19.6, Peak=38274 HFD=1.7
21:04:19.971 00.000 90092 Status Line 0: m=87301 SNR=19.6
21:04:19.971 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6166, FiltMax=20519
21:04:20.112 00.141 90092 Resizing image to 509,393
21:04:20.159 00.047 90092 UpdateGuideState exits: m=87301 SNR=19.6
21:04:20.159 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:20.159 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:20.159 00.000 90092 Enqueuing Expose request
21:04:20.159 00.000 98436 Worker thread wakes up
21:04:20.159 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:20.159 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(309,384,31,31)
21:04:20.222 00.063 98436 ScopeASCOM::SideOfPier() returns 1
21:04:21.184 00.962 98436 Exposure complete
21:04:21.371 00.187 98436 worker thread done servicing request
21:04:21.371 00.000 90092 Processing an image
21:04:21.371 00.000 90092 UpdateGuideState(): m_state=2
21:04:21.371 00.000 90092 Star::Find(15, 323, 399, 0, (0,0,0,0))
21:04:21.371 00.000 90092 Star::Find returns 1 (0), X=323.27, Y=399.49, Mass=81555, SNR=17.7, Peak=29335 HFD=1.2
21:04:21.371 00.000 90092 Status Line 0: m=81555 SNR=17.7
21:04:21.371 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6140, FiltMax=20555
21:04:21.517 00.146 90092 Resizing image to 509,393
21:04:21.580 00.063 90092 UpdateGuideState exits: m=81555 SNR=17.7
21:04:21.580 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:21.580 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:21.580 00.000 90092 Enqueuing Expose request
21:04:21.580 00.000 98436 Worker thread wakes up
21:04:21.580 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:21.580 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(308,384,31,31)
21:04:21.642 00.062 98436 ScopeASCOM::SideOfPier() returns 1
21:04:22.595 00.953 98436 Exposure complete
21:04:22.783 00.188 98436 worker thread done servicing request
21:04:22.798 00.015 90092 Processing an image
21:04:22.798 00.000 90092 UpdateGuideState(): m_state=2
21:04:22.798 00.000 90092 Star::Find(15, 323, 399, 0, (0,0,0,0))
21:04:22.798 00.000 90092 Star::Find returns 1 (0), X=323.62, Y=399.16, Mass=83138, SNR=18.3, Peak=32979 HFD=1.3
21:04:22.798 00.000 90092 Status Line 0: m=83138 SNR=18.3
21:04:22.798 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6180, FiltMax=21696
21:04:23.017 00.219 90092 Resizing image to 509,393
21:04:23.096 00.079 90092 UpdateGuideState exits: m=83138 SNR=18.3
21:04:23.096 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:23.096 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:23.096 00.000 90092 Enqueuing Expose request
21:04:23.096 00.000 98436 Worker thread wakes up
21:04:23.096 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:23.096 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(309,384,31,31)
21:04:23.189 00.093 98436 ScopeASCOM::SideOfPier() returns 1
21:04:24.114 00.925 98436 Exposure complete
21:04:24.301 00.187 90092 scope calibration move dir= 3 dur= 750
21:04:24.301 00.000 90092 Move(3, 750, 0)
21:04:24.301 00.000 90092 Guiding  Dir = 3, Dur = 750
21:04:24.301 00.000 90092 IsGuiding returns 0
21:04:24.317 00.016 98436 worker thread done servicing request
21:04:24.395 00.078 90092 PulseGuide returned control before completion, sleep 674
21:04:25.083 00.688 90092 IsGuiding returns 1
21:04:25.083 00.000 90092 scope still moving after pulse duration time elapsed
21:04:25.114 00.031 90092 IsGuiding returns 1
21:04:25.145 00.031 90092 IsGuiding returns 1
21:04:25.176 00.031 90092 IsGuiding returns 1
21:04:25.208 00.032 90092 IsGuiding returns 1
21:04:25.239 00.031 90092 IsGuiding returns 1
21:04:25.270 00.031 90092 IsGuiding returns 1
21:04:25.301 00.031 90092 IsGuiding returns 1
21:04:25.332 00.031 90092 IsGuiding returns 1
21:04:25.364 00.032 90092 IsGuiding returns 1
21:04:25.395 00.031 90092 IsGuiding returns 1
21:04:25.420 00.025 90092 IsGuiding returns 1
21:04:25.456 00.036 90092 IsGuiding returns 1
21:04:25.487 00.031 90092 IsGuiding returns 1
21:04:25.519 00.032 90092 IsGuiding returns 1
21:04:25.550 00.031 90092 IsGuiding returns 1
21:04:25.581 00.031 90092 IsGuiding returns 1
21:04:25.613 00.032 90092 IsGuiding returns 1
21:04:25.644 00.031 90092 IsGuiding returns 1
21:04:25.675 00.031 90092 IsGuiding returns 1
21:04:25.706 00.031 90092 IsGuiding returns 1
21:04:25.737 00.031 90092 IsGuiding returns 1
21:04:25.769 00.032 90092 IsGuiding returns 1
21:04:25.800 00.031 90092 IsGuiding returns 1
21:04:25.831 00.031 90092 IsGuiding returns 1
21:04:25.862 00.031 90092 IsGuiding returns 1
21:04:25.894 00.032 90092 IsGuiding returns 1
21:04:25.925 00.031 90092 IsGuiding returns 1
21:04:25.956 00.031 90092 IsGuiding returns 1
21:04:25.988 00.032 90092 IsGuiding returns 1
21:04:26.019 00.031 90092 IsGuiding returns 1
21:04:26.050 00.031 90092 IsGuiding returns 1
21:04:26.081 00.031 90092 IsGuiding returns 1
21:04:26.113 00.032 90092 IsGuiding returns 1
21:04:26.144 00.031 90092 IsGuiding returns 1
21:04:26.175 00.031 90092 IsGuiding returns 1
21:04:26.206 00.031 90092 IsGuiding returns 1
21:04:26.238 00.032 90092 IsGuiding returns 1
21:04:26.269 00.031 90092 IsGuiding returns 1
21:04:26.300 00.031 90092 IsGuiding returns 1
21:04:26.331 00.031 90092 IsGuiding returns 1
21:04:26.363 00.032 90092 IsGuiding returns 0
21:04:26.363 00.000 90092 scope move finished after 750 + 1303 ms
21:04:26.363 00.000 90092 Move returns status 0, amount 750
21:04:26.363 00.000 90092 Processing an image
21:04:26.363 00.000 90092 UpdateGuideState(): m_state=2
21:04:26.363 00.000 90092 Star::Find(15, 323, 399, 0, (0,0,0,0))
21:04:26.363 00.000 90092 Star::Find returns 1 (0), X=323.14, Y=399.94, Mass=101111, SNR=19.6, Peak=33773 HFD=1.8
21:04:26.363 00.000 90092 Status Line 0: m=101111 SNR=19.6
21:04:26.363 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6134, FiltMax=21061
21:04:26.613 00.250 90092 Resizing image to 509,393
21:04:26.706 00.093 90092 UpdateGuideState exits: m=101111 SNR=19.6
21:04:26.706 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:26.706 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:26.722 00.016 90092 Enqueuing Expose request
21:04:26.722 00.000 98436 Worker thread wakes up
21:04:26.722 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:26.722 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(308,385,31,31)
21:04:26.784 00.062 98436 ScopeASCOM::SideOfPier() returns 1
21:04:27.739 00.955 98436 Exposure complete
21:04:27.926 00.187 98436 worker thread done servicing request
21:04:27.926 00.000 90092 Processing an image
21:04:27.926 00.000 90092 UpdateGuideState(): m_state=2
21:04:27.926 00.000 90092 Star::Find(15, 323, 399, 0, (0,0,0,0))
21:04:27.926 00.000 90092 Star::Find returns 1 (0), X=324.07, Y=400.20, Mass=81949, SNR=18.2, Peak=31879 HFD=1.7
21:04:27.926 00.000 90092 Status Line 0: m=81949 SNR=18.2
21:04:27.942 00.016 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6156, FiltMax=20051
21:04:28.176 00.234 90092 Resizing image to 509,393
21:04:28.286 00.110 90092 UpdateGuideState exits: m=81949 SNR=18.2
21:04:28.286 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:28.286 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:28.286 00.000 90092 Enqueuing Expose request
21:04:28.286 00.000 98436 Worker thread wakes up
21:04:28.286 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:28.286 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(309,385,31,31)
21:04:28.379 00.093 98436 ScopeASCOM::SideOfPier() returns 1
21:04:29.310 00.931 98436 Exposure complete
21:04:29.502 00.192 98436 worker thread done servicing request
21:04:29.502 00.000 90092 Processing an image
21:04:29.502 00.000 90092 UpdateGuideState(): m_state=2
21:04:29.502 00.000 90092 Star::Find(15, 324, 400, 0, (0,0,0,0))
21:04:29.502 00.000 90092 Star::Find returns 1 (0), X=324.01, Y=400.51, Mass=99197, SNR=21.3, Peak=32124 HFD=1.7
21:04:29.502 00.000 90092 Status Line 0: m=99197 SNR=21.3
21:04:29.502 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6156, FiltMax=20383
21:04:29.643 00.141 90092 Resizing image to 509,393
21:04:29.690 00.047 90092 UpdateGuideState exits: m=99197 SNR=21.3
21:04:29.690 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:29.690 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:29.690 00.000 90092 Enqueuing Expose request
21:04:29.690 00.000 98436 Worker thread wakes up
21:04:29.690 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:29.690 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(309,386,31,31)
21:04:29.737 00.047 98436 ScopeASCOM::SideOfPier() returns 1
21:04:30.707 00.970 98436 Exposure complete
21:04:30.894 00.187 98436 worker thread done servicing request
21:04:30.894 00.000 90092 Processing an image
21:04:30.894 00.000 90092 UpdateGuideState(): m_state=2
21:04:30.894 00.000 90092 Star::Find(15, 324, 400, 0, (0,0,0,0))
21:04:30.910 00.016 90092 Star::Find returns 1 (0), X=323.73, Y=400.99, Mass=78039, SNR=16.9, Peak=30587 HFD=1.5
21:04:30.910 00.000 90092 Status Line 0: m=78039 SNR=16.9
21:04:30.910 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6114, FiltMax=19552
21:04:31.097 00.187 90092 Resizing image to 509,393
21:04:31.191 00.094 90092 UpdateGuideState exits: m=78039 SNR=16.9
21:04:31.191 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:31.191 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:31.191 00.000 90092 Enqueuing Expose request
21:04:31.191 00.000 98436 Worker thread wakes up
21:04:31.191 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:31.191 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(309,386,31,31)
21:04:31.300 00.109 98436 ScopeASCOM::SideOfPier() returns 1
21:04:32.208 00.908 98436 Exposure complete
21:04:32.395 00.187 98436 worker thread done servicing request
21:04:32.395 00.000 90092 Processing an image
21:04:32.395 00.000 90092 UpdateGuideState(): m_state=2
21:04:32.395 00.000 90092 Star::Find(15, 323, 400, 0, (0,0,0,0))
21:04:32.410 00.015 90092 Star::Find returns 1 (0), X=323.50, Y=401.02, Mass=80526, SNR=18.5, Peak=32993 HFD=1.0
21:04:32.410 00.000 90092 Status Line 0: m=80526 SNR=18.5
21:04:32.410 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6200, FiltMax=21075
21:04:32.614 00.204 90092 Resizing image to 509,393
21:04:32.676 00.062 90092 UpdateGuideState exits: m=80526 SNR=18.5
21:04:32.676 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:32.676 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:32.676 00.000 90092 Enqueuing Expose request
21:04:32.676 00.000 98436 Worker thread wakes up
21:04:32.676 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:32.676 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(308,386,31,31)
21:04:32.739 00.063 98436 ScopeASCOM::SideOfPier() returns 1
21:04:33.689 00.950 98436 Exposure complete
21:04:33.876 00.187 98436 worker thread done servicing request
21:04:33.876 00.000 90092 Processing an image
21:04:33.876 00.000 90092 UpdateGuideState(): m_state=2
21:04:33.876 00.000 90092 Star::Find(15, 323, 401, 0, (0,0,0,0))
21:04:33.892 00.016 90092 Star::Find returns 1 (0), X=323.49, Y=400.84, Mass=78890, SNR=17.9, Peak=33630 HFD=1.1
21:04:33.892 00.000 90092 Status Line 0: m=78890 SNR=17.9
21:04:33.892 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6194, FiltMax=20114
21:04:34.064 00.172 90092 Resizing image to 509,393
21:04:34.126 00.062 90092 UpdateGuideState exits: m=78890 SNR=17.9
21:04:34.126 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:34.126 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:34.126 00.000 90092 Enqueuing Expose request
21:04:34.126 00.000 98436 Worker thread wakes up
21:04:34.126 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:34.126 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(308,386,31,31)
21:04:34.189 00.063 98436 ScopeASCOM::SideOfPier() returns 1
21:04:34.707 00.518 90092 scope calibration move dir= 3 dur= 750
21:04:34.707 00.000 90092 Move(3, 750, 0)
21:04:34.707 00.000 90092 Guiding  Dir = 3, Dur = 750
21:04:34.723 00.016 90092 IsGuiding returns 0
21:04:34.864 00.141 90092 PulseGuide returned control before completion, sleep 612
21:04:35.145 00.281 98436 Exposure complete
21:04:35.332 00.187 98436 worker thread done servicing request
21:04:35.502 00.170 90092 IsGuiding returns 1
21:04:35.502 00.000 90092 scope still moving after pulse duration time elapsed
21:04:35.533 00.031 90092 IsGuiding returns 1
21:04:35.564 00.031 90092 IsGuiding returns 1
21:04:35.595 00.031 90092 IsGuiding returns 1
21:04:35.627 00.032 90092 IsGuiding returns 1
21:04:35.658 00.031 90092 IsGuiding returns 1
21:04:35.689 00.031 90092 IsGuiding returns 1
21:04:35.720 00.031 90092 IsGuiding returns 1
21:04:35.752 00.032 90092 IsGuiding returns 1
21:04:35.783 00.031 90092 IsGuiding returns 1
21:04:35.814 00.031 90092 IsGuiding returns 1
21:04:35.845 00.031 90092 IsGuiding returns 1
21:04:35.877 00.032 90092 IsGuiding returns 1
21:04:35.908 00.031 90092 IsGuiding returns 1
21:04:35.939 00.031 90092 IsGuiding returns 1
21:04:35.970 00.031 90092 IsGuiding returns 1
21:04:36.002 00.032 90092 IsGuiding returns 1
21:04:36.033 00.031 90092 IsGuiding returns 0
21:04:36.033 00.000 90092 scope move finished after 750 + 557 ms
21:04:36.033 00.000 90092 Move returns status 0, amount 750
21:04:36.033 00.000 90092 Processing an image
21:04:36.033 00.000 90092 UpdateGuideState(): m_state=2
21:04:36.033 00.000 90092 Star::Find(15, 323, 400, 0, (0,0,0,0))
21:04:36.033 00.000 90092 Star::Find returns 1 (0), X=323.85, Y=401.21, Mass=78649, SNR=18.5, Peak=35526 HFD=1.5
21:04:36.033 00.000 90092 Status Line 0: m=78649 SNR=18.5
21:04:36.033 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6176, FiltMax=20174
21:04:36.283 00.250 90092 Resizing image to 509,393
21:04:36.361 00.078 90092 UpdateGuideState exits: m=78649 SNR=18.5
21:04:36.361 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:36.361 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:36.361 00.000 90092 Enqueuing Expose request
21:04:36.361 00.000 98436 Worker thread wakes up
21:04:36.361 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:36.361 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(309,386,31,31)
21:04:36.429 00.068 98436 ScopeASCOM::SideOfPier() returns 1
21:04:37.379 00.950 98436 Exposure complete
21:04:37.564 00.185 98436 worker thread done servicing request
21:04:37.564 00.000 90092 Processing an image
21:04:37.564 00.000 90092 UpdateGuideState(): m_state=2
21:04:37.564 00.000 90092 Star::Find(15, 323, 401, 0, (0,0,0,0))
21:04:37.564 00.000 90092 Star::Find returns 1 (0), X=324.18, Y=401.03, Mass=85834, SNR=18.6, Peak=34498 HFD=1.7
21:04:37.564 00.000 90092 Status Line 0: m=85834 SNR=18.6
21:04:37.564 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6146, FiltMax=20167
21:04:37.689 00.125 90092 Resizing image to 509,393
21:04:37.736 00.047 90092 UpdateGuideState exits: m=85834 SNR=18.6
21:04:37.736 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:37.736 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:37.736 00.000 90092 Enqueuing Expose request
21:04:37.736 00.000 98436 Worker thread wakes up
21:04:37.736 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:37.736 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(309,386,31,31)
21:04:37.829 00.093 98436 ScopeASCOM::SideOfPier() returns 1
21:04:38.754 00.925 98436 Exposure complete
21:04:38.941 00.187 98436 worker thread done servicing request
21:04:38.941 00.000 90092 Processing an image
21:04:38.941 00.000 90092 UpdateGuideState(): m_state=2
21:04:38.941 00.000 90092 Star::Find(15, 324, 401, 0, (0,0,0,0))
21:04:38.941 00.000 90092 Star::Find returns 1 (0), X=324.86, Y=401.22, Mass=97222, SNR=19.6, Peak=32489 HFD=1.7
21:04:38.957 00.016 90092 Status Line 0: m=97222 SNR=19.6
21:04:38.957 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6188, FiltMax=21016
21:04:39.066 00.109 90092 Resizing image to 509,393
21:04:39.129 00.063 90092 UpdateGuideState exits: m=97222 SNR=19.6
21:04:39.129 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:39.129 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:39.129 00.000 90092 Enqueuing Expose request
21:04:39.129 00.000 98436 Worker thread wakes up
21:04:39.129 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:39.129 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(310,386,31,31)
21:04:39.176 00.047 98436 ScopeASCOM::SideOfPier() returns 1
21:04:40.142 00.966 98436 Exposure complete
21:04:40.329 00.187 98436 worker thread done servicing request
21:04:40.329 00.000 90092 Processing an image
21:04:40.329 00.000 90092 UpdateGuideState(): m_state=2
21:04:40.329 00.000 90092 Star::Find(15, 324, 401, 0, (0,0,0,0))
21:04:40.329 00.000 90092 Star::Find returns 1 (0), X=324.55, Y=401.82, Mass=79340, SNR=17.7, Peak=26174 HFD=1.7
21:04:40.329 00.000 90092 Status Line 0: m=79340 SNR=17.7
21:04:40.345 00.016 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6148, FiltMax=19270
21:04:40.455 00.110 90092 Resizing image to 509,393
21:04:40.502 00.047 90092 UpdateGuideState exits: m=79340 SNR=17.7
21:04:40.502 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:40.502 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:40.502 00.000 90092 Enqueuing Expose request
21:04:40.502 00.000 98436 Worker thread wakes up
21:04:40.502 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:40.502 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(310,387,31,31)
21:04:40.549 00.047 98436 ScopeASCOM::SideOfPier() returns 1
21:04:41.519 00.970 98436 Exposure complete
21:04:41.707 00.188 98436 worker thread done servicing request
21:04:41.707 00.000 90092 Processing an image
21:04:41.707 00.000 90092 UpdateGuideState(): m_state=2
21:04:41.707 00.000 90092 Star::Find(15, 324, 401, 0, (0,0,0,0))
21:04:41.707 00.000 90092 Star::Find returns 1 (0), X=324.08, Y=401.76, Mass=79086, SNR=18.6, Peak=33090 HFD=1.3
21:04:41.722 00.015 90092 Status Line 0: m=79086 SNR=18.6
21:04:41.722 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6140, FiltMax=19606
21:04:41.832 00.110 90092 Resizing image to 509,393
21:04:41.879 00.047 90092 UpdateGuideState exits: m=79086 SNR=18.6
21:04:41.879 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:41.879 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:41.879 00.000 90092 Enqueuing Expose request
21:04:41.879 00.000 98436 Worker thread wakes up
21:04:41.879 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:41.879 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(309,387,31,31)
21:04:41.926 00.047 98436 ScopeASCOM::SideOfPier() returns 1
21:04:42.904 00.978 98436 Exposure complete
21:04:43.076 00.172 98436 worker thread done servicing request
21:04:43.076 00.000 90092 Processing an image
21:04:43.076 00.000 90092 UpdateGuideState(): m_state=2
21:04:43.076 00.000 90092 Star::Find(15, 324, 401, 0, (0,0,0,0))
21:04:43.076 00.000 90092 Star::Find returns 1 (0), X=324.36, Y=401.77, Mass=72548, SNR=18.2, Peak=33537 HFD=1.2
21:04:43.076 00.000 90092 Status Line 0: m=72548 SNR=18.2
21:04:43.076 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6220, FiltMax=19792
21:04:43.326 00.250 90092 Resizing image to 509,393
21:04:43.427 00.101 90092 UpdateGuideState exits: m=72548 SNR=18.2
21:04:43.431 00.004 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:43.431 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:43.431 00.000 90092 Enqueuing Expose request
21:04:43.431 00.000 98436 Worker thread wakes up
21:04:43.431 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:43.431 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(309,387,31,31)
21:04:43.533 00.102 98436 ScopeASCOM::SideOfPier() returns 1
21:04:44.440 00.907 98436 Exposure complete
21:04:44.612 00.172 98436 worker thread done servicing request
21:04:44.612 00.000 90092 Processing an image
21:04:44.612 00.000 90092 UpdateGuideState(): m_state=2
21:04:44.612 00.000 90092 Star::Find(15, 324, 401, 0, (0,0,0,0))
21:04:44.612 00.000 90092 Star::Find returns 1 (0), X=324.01, Y=402.33, Mass=90414, SNR=19.6, Peak=34499 HFD=1.3
21:04:44.612 00.000 90092 Status Line 0: m=90414 SNR=19.6
21:04:44.612 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6150, FiltMax=22284
21:04:44.799 00.187 90092 Resizing image to 509,393
21:04:44.877 00.078 90092 UpdateGuideState exits: m=90414 SNR=19.6
21:04:44.877 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:44.877 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:44.877 00.000 90092 Enqueuing Expose request
21:04:44.877 00.000 98436 Worker thread wakes up
21:04:44.877 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:44.877 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(309,387,31,31)
21:04:44.971 00.094 98436 ScopeASCOM::SideOfPier() returns 1
21:04:45.815 00.844 90092 scope calibration move dir= 3 dur= 750
21:04:45.815 00.000 90092 Move(3, 750, 0)
21:04:45.815 00.000 90092 Guiding  Dir = 3, Dur = 750
21:04:45.815 00.000 90092 IsGuiding returns 0
21:04:45.893 00.078 98436 Exposure complete
21:04:45.956 00.063 90092 PulseGuide returned control before completion, sleep 627
21:04:46.050 00.094 98436 worker thread done servicing request
21:04:46.605 00.555 90092 IsGuiding returns 1
21:04:46.605 00.000 90092 scope still moving after pulse duration time elapsed
21:04:46.636 00.031 90092 IsGuiding returns 1
21:04:46.667 00.031 90092 IsGuiding returns 1
21:04:46.698 00.031 90092 IsGuiding returns 1
21:04:46.730 00.032 90092 IsGuiding returns 1
21:04:46.761 00.031 90092 IsGuiding returns 1
21:04:46.792 00.031 90092 IsGuiding returns 1
21:04:46.823 00.031 90092 IsGuiding returns 1
21:04:46.854 00.031 90092 IsGuiding returns 1
21:04:46.886 00.032 90092 IsGuiding returns 0
21:04:46.886 00.000 90092 scope move finished after 750 + 309 ms
21:04:46.886 00.000 90092 Move returns status 0, amount 750
21:04:46.886 00.000 90092 Processing an image
21:04:46.886 00.000 90092 UpdateGuideState(): m_state=2
21:04:46.886 00.000 90092 Star::Find(15, 324, 402, 0, (0,0,0,0))
21:04:46.886 00.000 90092 Star::Find returns 1 (0), X=324.44, Y=402.18, Mass=77939, SNR=16.8, Peak=29147 HFD=1.4
21:04:46.886 00.000 90092 Status Line 0: m=77939 SNR=16.8
21:04:46.886 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6074, FiltMax=21528
21:04:47.136 00.250 90092 Resizing image to 509,393
21:04:47.229 00.093 90092 UpdateGuideState exits: m=77939 SNR=16.8
21:04:47.229 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:47.229 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:47.229 00.000 90092 Enqueuing Expose request
21:04:47.245 00.016 98436 Worker thread wakes up
21:04:47.245 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:47.245 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(309,387,31,31)
21:04:47.354 00.109 98436 ScopeASCOM::SideOfPier() returns 1
21:04:48.253 00.899 98436 Exposure complete
21:04:48.346 00.093 98436 worker thread done servicing request
21:04:48.346 00.000 90092 Processing an image
21:04:48.346 00.000 90092 UpdateGuideState(): m_state=2
21:04:48.346 00.000 90092 Star::Find(15, 324, 402, 0, (0,0,0,0))
21:04:48.346 00.000 90092 Star::Find returns 1 (0), X=325.07, Y=402.67, Mass=83622, SNR=17.7, Peak=34444 HFD=1.3
21:04:48.346 00.000 90092 Status Line 0: m=83622 SNR=17.7
21:04:48.346 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6230, FiltMax=19854
21:04:48.466 00.120 90092 Resizing image to 509,393
21:04:48.513 00.047 90092 UpdateGuideState exits: m=83622 SNR=17.7
21:04:48.513 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:48.513 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:48.513 00.000 90092 Enqueuing Expose request
21:04:48.513 00.000 98436 Worker thread wakes up
21:04:48.529 00.016 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:48.529 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(310,388,31,31)
21:04:48.576 00.047 98436 ScopeASCOM::SideOfPier() returns 1
21:04:49.533 00.957 98436 Exposure complete
21:04:49.736 00.203 98436 worker thread done servicing request
21:04:49.736 00.000 90092 Processing an image
21:04:49.736 00.000 90092 UpdateGuideState(): m_state=2
21:04:49.736 00.000 90092 Star::Find(15, 325, 402, 0, (0,0,0,0))
21:04:49.736 00.000 90092 Star::Find returns 1 (0), X=324.95, Y=402.65, Mass=92559, SNR=19.2, Peak=36119 HFD=1.4
21:04:49.736 00.000 90092 Status Line 0: m=92559 SNR=19.2
21:04:49.736 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6224, FiltMax=20763
21:04:49.957 00.221 90092 Resizing image to 509,393
21:04:50.004 00.047 90092 UpdateGuideState exits: m=92559 SNR=19.2
21:04:50.004 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:50.004 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:50.004 00.000 90092 Enqueuing Expose request
21:04:50.004 00.000 98436 Worker thread wakes up
21:04:50.004 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:50.004 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(310,388,31,31)
21:04:50.050 00.046 98436 ScopeASCOM::SideOfPier() returns 1
21:04:51.020 00.970 98436 Exposure complete
21:04:51.224 00.204 98436 worker thread done servicing request
21:04:51.224 00.000 90092 Processing an image
21:04:51.224 00.000 90092 UpdateGuideState(): m_state=2
21:04:51.224 00.000 90092 Star::Find(15, 324, 402, 0, (0,0,0,0))
21:04:51.224 00.000 90092 Star::Find returns 1 (0), X=324.43, Y=401.96, Mass=92328, SNR=19.4, Peak=31618 HFD=1.7
21:04:51.224 00.000 90092 Status Line 0: m=92328 SNR=19.4
21:04:51.224 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6136, FiltMax=18647
21:04:51.380 00.156 90092 Resizing image to 509,393
21:04:51.403 00.023 90092 UpdateGuideState exits: m=92328 SNR=19.4
21:04:51.403 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:51.407 00.004 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:51.407 00.000 90092 Enqueuing Expose request
21:04:51.407 00.000 98436 Worker thread wakes up
21:04:51.407 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:51.407 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(309,387,31,31)
21:04:51.427 00.020 98436 ScopeASCOM::SideOfPier() returns 1
21:04:52.419 00.992 98436 Exposure complete
21:04:52.611 00.192 98436 worker thread done servicing request
21:04:52.611 00.000 90092 Processing an image
21:04:52.611 00.000 90092 UpdateGuideState(): m_state=2
21:04:52.611 00.000 90092 Star::Find(15, 324, 401, 0, (0,0,0,0))
21:04:52.611 00.000 90092 Star::Find returns 1 (0), X=324.52, Y=402.27, Mass=70351, SNR=18.8, Peak=28702 HFD=1.2
21:04:52.611 00.000 90092 Status Line 0: m=70351 SNR=18.8
21:04:52.627 00.016 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6178, FiltMax=20181
21:04:52.861 00.234 90092 Resizing image to 509,393
21:04:52.971 00.110 90092 UpdateGuideState exits: m=70351 SNR=18.8
21:04:52.971 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:52.971 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:52.971 00.000 90092 Enqueuing Expose request
21:04:52.971 00.000 98436 Worker thread wakes up
21:04:52.971 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:52.971 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(310,387,31,31)
21:04:53.080 00.109 98436 ScopeASCOM::SideOfPier() returns 1
21:04:53.986 00.906 98436 Exposure complete
21:04:54.173 00.187 98436 worker thread done servicing request
21:04:54.173 00.000 90092 Processing an image
21:04:54.173 00.000 90092 UpdateGuideState(): m_state=2
21:04:54.173 00.000 90092 Star::Find(15, 324, 402, 0, (0,0,0,0))
21:04:54.189 00.016 90092 Star::Find returns 1 (0), X=324.79, Y=402.94, Mass=78274, SNR=17.6, Peak=34105 HFD=1.6
21:04:54.189 00.000 90092 Status Line 0: m=78274 SNR=17.6
21:04:54.189 00.000 90092 UpdateImageDisplay: Size=(752,580) min=6000, max=65535, FiltMin=6174, FiltMax=20971
21:04:54.392 00.203 90092 Resizing image to 509,393
21:04:54.456 00.064 90092 UpdateGuideState exits: m=78274 SNR=17.6
21:04:54.456 00.000 90092 OnExposeCompete: CaptureActive=1 m_continueCapturing=1
21:04:54.456 00.000 90092 ScheduleExposure(1000,3,1) exposurePending=0
21:04:54.456 00.000 90092 Enqueuing Expose request
21:04:54.472 00.016 98436 Worker thread wakes up
21:04:54.472 00.000 98436 worker thread servicing REQUEST_EXPOSE 1000
21:04:54.472 00.000 98436 Handling exposure in thread, d=1000 o=3 r=(310,388,31,31)
21:04:54.534 00.062 98436 ScopeASCOM::SideOfPier() returns 1
21:04:55.331 00.797 90092 Stop button clicked
21:04:55.331 00.000 90092 StopCapturing CaptureActive=1 continueCapturing=1 exposurePending=1
21:04:55.331 00.000 90092 Status Line 0: Waiting for devices...
21:04:55.401 00.070 98436 Error thrown from C:\cygwin\home\agalasso\projects\phd2\worker_thread.cpp:157->Capture failed
21:04:55.401 00.000 98436 worker thread done servicing request
21:04:55.401 00.000 90092 Processing an image
21:04:55.401 00.000 90092 OnExposeComplete(): Capture Error reported
21:04:55.401 00.000 90092 StopCapturing CaptureActive=1 continueCapturing=0 exposurePending=0
21:04:55.401 00.000 90092 Changing from state 2 to 0
21:04:55.401 00.000 90092 Status Line 0: Stopped.
21:04:55.405 00.004 90092 Error thrown from C:\cygwin\home\agalasso\projects\phd2\myframe_events.cpp:376->Error reported capturing image
21:04:55.535 00.130 90092 Resizing image to 509,393
21:05:02.097 06.562 90092 Disconnecting
21:05:02.097 00.000 90092 Disconnected Successfully
21:05:02.097 00.000 90092 Status Line 5: No cal
21:05:02.097 00.000 90092 Error thrown from C:\cygwin\home\agalasso\projects\phd2\scope_ascom.cpp:806->ASCOM Scope: cannot get Declination when not connected to mount
21:05:02.097 00.000 90092 ScopeASCOM::GetDeclination() returns 0.0
21:05:02.112 00.015 90092 Error thrown from C:\cygwin\home\agalasso\projects\phd2\scope_ascom.cpp:1106->ASCOM Scope: cannot get side of pier when not connected
21:05:02.112 00.000 90092 ScopeASCOM::SideOfPier() returns -1
21:05:02.112 00.000 90092 Status Line 0: Mount Disconnected
21:05:02.112 00.000 90092 Status Line 3: 
21:05:02.128 00.016 90092 Error thrown from C:\cygwin\home\agalasso\projects\phd2\gear_dialog.cpp:1267->OnButtonDisconnectAuxScope called with m_pAuxScope == NULL
21:05:02.144 00.016 90092 Status Line 0: Camera Disconnected
21:05:02.144 00.000 90092 Status Line 2: 
21:05:02.175 00.031 90092 Error thrown from C:\cygwin\home\agalasso\projects\phd2\gear_dialog.cpp:1393->OnButtonDisconnectStepGuider called with m_pStepGuider == NULL
21:05:02.175 00.000 90092 Error thrown from C:\cygwin\home\agalasso\projects\phd2\gear_dialog.cpp:1507->OnButtonDisconnectRotator called with m_pRotator == NULL
21:05:04.048 01.873 90092 GetBoolean("/profile/3/target/refCircleEnabled", 0) returns 0
21:05:04.048 00.000 90092 GetDouble("/profile/3/target/refCircleRadius", 2.000000) returns 2.000000
21:05:04.298 00.250 90092 Resizing image to 509,393
21:05:05.314 01.016 90092 MyFrame::OnClose proceeding
21:05:05.330 00.016 90092 StopCapturing CaptureActive=0 continueCapturing=0 exposurePending=0
21:05:05.330 00.000 90092 StopWorkerThread(0x01232E18) begins
21:05:05.330 00.000 98436 Worker thread wakes up
21:05:05.330 00.000 98436 worker thread servicing REQUEST_TERMINATE
21:05:05.330 00.000 98436 worker thread done servicing request
21:05:05.330 00.000 98436 WorkerThread::Entry() ends
21:05:05.330 00.000 90092 StopWorkerThread() threadExitCode=0
21:05:05.330 00.000 90092 StopWorkerThread(0x01232E18) ends
21:05:05.330 00.000 90092 WorkerThread destructor called
21:05:05.330 00.000 90092 StopWorkerThread(0x012331A0) begins
21:05:05.330 00.000 99212 Worker thread wakes up
21:05:05.330 00.000 99212 worker thread servicing REQUEST_TERMINATE
21:05:05.330 00.000 99212 worker thread done servicing request
21:05:05.330 00.000 99212 WorkerThread::Entry() ends
21:05:05.330 00.000 90092 StopWorkerThread() threadExitCode=0
21:05:05.330 00.000 90092 StopWorkerThread(0x012331A0) ends
21:05:05.330 00.000 90092 WorkerThread destructor called
21:05:05.330 00.000 90092 Shutdown: forced=0
21:05:05.330 00.000 90092 Shutdown complete
21:05:05.330 00.000 90092 Server stopped
21:05:05.346 00.016 90092 event server stopped
21:05:05.346 00.000 90092 Status Line 0: Server stopped