14:00:18.427 00.000 788 PHD2 version 2.6.11 begins execution with:
14:00:18.427 00.000 788    Windows 10 (build 19044), 64-bit edition
14:00:18.427 00.000 788    wxWidgets 3.0.5
14:00:18.427 00.000 788    cfitsio 3.47
14:00:18.427 00.000 788 GetString("/frame/LogDir", "") returns ""
14:00:18.427 00.000 788 CoInitializeEx returns 1
14:00:18.427 00.000 788 locale: using dir C:\Program Files (x86)\PHDGuiding2\locale exists=1
14:00:18.427 00.000 788 GetInt("/wxLanguage", 0) returns 60
14:00:18.442 00.015 788 locale: initialized with lang id 60 (r=1)
14:00:18.442 00.000 788 locale: wxTranslations language set to 60
14:00:18.442 00.000 788 GetInt("/currentProfile", 0) returns 2
14:00:18.464 00.022 788 reset dither spiral
14:00:18.464 00.000 788 StartWorkerThread(00000000) begins
14:00:18.464 00.000 788 WorkerThread constructor called
14:00:18.464 00.000 788 StartWorkerThread(00522468) ends
14:00:18.464 00.000 3324 WorkerThread::Entry() begins
14:00:18.464 00.000 788 StartWorkerThread(00000000) begins
14:00:18.464 00.000 3324 worker thread CoInitializeEx returns 0
14:00:18.464 00.000 788 WorkerThread constructor called
14:00:18.464 00.000 788 StartWorkerThread(00521F58) ends
14:00:18.464 00.000 1908 WorkerThread::Entry() begins
14:00:18.464 00.000 788 GetBoolean("/ServerMode", 1) returns 1
14:00:18.480 00.016 1908 worker thread CoInitializeEx returns 0
14:00:18.565 00.085 788 GetInt("/profile/2/NoiseReductionMethod", 0) returns 0
14:00:18.565 00.000 788 GetDouble("/profile/2/DitherScaleFactor", 1.000000) returns 1.000000
14:00:18.565 00.000 788 GetBoolean("/profile/2/DitherRaOnly", 0) returns 0
14:00:18.565 00.000 788 GetInt("/profile/2/DitherMode", 0) returns 0
14:00:18.565 00.000 788 set dither mode 0
14:00:18.565 00.000 788 GetInt("/profile/2/frame/timeLapse", 0) returns 0
14:00:18.580 00.015 788 GetInt("/profile/2/AutoLoadCalibration", -1) returns 0
14:00:18.580 00.000 788 GetInt("/profile/2/frame/focalLength", 0) returns 120
14:00:18.580 00.000 788 GetInt("/profile/2/auto_exp/exposure_min", 1000) returns 1000
14:00:18.580 00.000 788 GetInt("/profile/2/auto_exp/exposure_max", 5000) returns 5000
14:00:18.580 00.000 788 GetDouble("/profile/2/auto_exp/target_snr", 6.000000) returns 6.000000
14:00:18.580 00.000 788 AutoExp: config min = 1000 max = 5000 snr = 6.00
14:00:18.580 00.000 788 AutoExp: reset exp to 5000
14:00:18.580 00.000 788 GetInt("/profile/2/CustomExposureDuration", 30000) returns 30000
14:00:18.580 00.000 788 GetInt("/profile/2/ExposureDurationMs", 1000) returns 1000
14:00:18.596 00.016 788 OnExposureDurationSelected: duration = 1000
14:00:18.596 00.000 788 GetBoolean("/profile/2/BeepForLostStar", 1) returns 1
14:00:18.596 00.000 788 GetInt("/profile/2/Gamma", 100) returns 100
14:00:18.596 00.000 788 GetBoolean("/profile/2/ImageLogger/LoggingEnabled", 0) returns 0
14:00:18.596 00.000 788 GetBoolean("/profile/2/ImageLogger/LogFramesOverThreshRel", 0) returns 0
14:00:18.596 00.000 788 GetBoolean("/profile/2/ImageLogger/LogFramesOverThreshPx", 0) returns 0
14:00:18.596 00.000 788 GetBoolean("/profile/2/ImageLogger/LogFramesDropped", 0) returns 0
14:00:18.596 00.000 788 GetBoolean("/profile/2/ImageLogger/LogAutoSelectFrames", 0) returns 0
14:00:18.596 00.000 788 GetDouble("/profile/2/ImageLogger/ErrorThreshRel", 4.000000) returns 4.000000
14:00:18.611 00.015 788 GetDouble("/profile/2/ImageLogger/ErrorThreshPx", 4.000000) returns 4.000000
14:00:18.611 00.000 788 ImgLogger: Settings LogEnabled=0 Log Rel=0, 0.00 Log Px=0, 0.00 LogFrameDrop=0 LogAutoSel=0 NextN=0
14:00:18.611 00.000 788 GetBoolean("/profile/2/indi/VerboseLogging", 0) returns 0
14:00:18.611 00.000 788 guider state => UNINITIALIZED
14:00:18.611 00.000 788 GetInt("/profile/2/overlay/slit/center.x", 376) returns 376
14:00:18.611 00.000 788 GetInt("/profile/2/overlay/slit/center.y", 290) returns 290
14:00:18.611 00.000 788 GetInt("/profile/2/overlay/slit/width", 8) returns 8
14:00:18.627 00.016 788 GetInt("/profile/2/overlay/slit/height", 100) returns 100
14:00:18.627 00.000 788 GetInt("/profile/2/overlay/slit/angle", 0) returns 0
14:00:18.627 00.000 788 Changing from state UNINITIALIZED to UNINITIALIZED
14:00:18.627 00.000 788 guider state => SELECTING
14:00:18.627 00.000 788 GetBoolean("/profile/2/guider/FastRecenter", 1) returns 1
14:00:18.627 00.000 788 GetBoolean("/profile/2/guider/ScaleImage", 1) returns 1
14:00:18.627 00.000 788 GetDouble("/profile/2/guider/StarMinHFD", 1.500000) returns 1.500000
14:00:18.627 00.000 788 Setting StarMinHFD = 1.50
14:00:18.627 00.000 788 GetDouble("/profile/2/guider/StarMinSNR", 6.000000) returns 6.000000
14:00:18.643 00.016 788 Setting StarMinSNR = 6.0
14:00:18.643 00.000 788 GetInt("/profile/2/guider/AutoSelDownsample", 0) returns 0
14:00:18.643 00.000 788 Setting AutoSelDownsample = 0
14:00:18.643 00.000 788 GetString("/profile/2/guider/bookmarks", "") returns ""
14:00:18.643 00.000 788 GetDouble("/profile/2/guider/onestar/MassChangeThreshold", 0.500000) returns 0.500000
14:00:18.643 00.000 788 GetBoolean("/profile/2/guider/onestar/MassChangeThresholdEnabled", 1) returns 1
14:00:18.643 00.000 788 GetBoolean("/profile/2/guider/onestar/TolerateJumpsEnabled", 0) returns 0
14:00:18.643 00.000 788 GetDouble("/profile/2/guider/onestar/TolerateJumpsThreshold", 4.000000) returns 4.000000
14:00:18.643 00.000 788 GetInt("/profile/2/guider/onestar/SearchRegion", 15) returns 15
14:00:18.643 00.000 788 GetBoolean("/profile/2/guider/multistar/enabled", 0) returns 1
14:00:18.658 00.015 788 MultiStar mode enabled
14:00:18.658 00.000 788 GetBoolean("/StickyLockPosition", 0) returns 0
14:00:18.665 00.007 788 GetString("/geometry", "") returns "0;800;600;336;86"
14:00:18.781 00.116 788 GetInt("/graph/ScopeOrCameraUnits", 0) returns 0
14:00:18.796 00.015 788 GetString("/graph/RAColor", "") returns "#6464FF"
14:00:18.796 00.000 788 GetString("/graph/DecColor", "") returns "#FF0000"
14:00:18.796 00.000 788 GetInt("/graph/minLength", 50) returns 50
14:00:18.796 00.000 788 GetInt("/graph/maxLength", 400) returns 400
14:00:18.796 00.000 788 GetInt("/graph/minHeight", 1) returns 1
14:00:18.796 00.000 788 GetInt("/graph/maxHeight", 16) returns 16
14:00:18.796 00.000 788 GetInt("/graph/length", 100) returns 50
14:00:18.796 00.000 788 GraphStats window size = 50
14:00:18.796 00.000 788 GetInt("/graph/height", 4) returns 1
14:00:18.812 00.016 788 GetInt("graph/HeightUnits", 1) returns 1
14:00:18.812 00.000 788 GetBoolean("/graph/showCorrections", 1) returns 1
14:00:18.812 00.000 788 GetBoolean("/graph/showStarMass", 0) returns 0
14:00:18.812 00.000 788 GetBoolean("/graph/showStarSNR", 0) returns 0
14:00:18.812 00.000 788 GetBoolean("/graph/correctionsToScale", 0) returns 0
14:00:18.865 00.053 788 GetInt("/graph_stepguider/length", 1) returns 1
14:00:18.865 00.000 788 GetInt("/target/length", 100) returns 100
14:00:18.865 00.000 788 GetDouble("/target/zoom", 1.000000) returns 1.000000
14:00:18.881 00.016 788 GetBoolean("/profile/2/target/refCircleEnabled", 0) returns 0
14:00:18.881 00.000 788 GetDouble("/profile/2/target/refCircleRadius", 2.000000) returns 2.000000
14:00:19.329 00.448 788 GetString("/profile/2/name", "") returns "Test"
14:00:19.329 00.000 788 GetString("/profile/2/name", "") returns "Test"
14:00:19.545 00.216 788 GetString("/profile/2/indi/INDIcam", "") returns ""
14:00:19.567 00.022 788 GetString("/profile/2/indi/INDImount", "") returns ""
14:00:19.583 00.016 788 GetString("/profile/2/indi/INDImount", "") returns ""
14:00:19.583 00.000 788 GetString("/profile/2/camera/LastMenuChoice", "None") returns "ZWO ASI Camera"
14:00:19.599 00.016 788 CameraFactory(ZWO ASI Camera)
14:00:19.599 00.000 788 GetBoolean("/profile/2/camera/UseSubframes", 0) returns 0
14:00:19.599 00.000 788 GetInt("/profile/2/camera/ReadDelay", 150) returns 150
14:00:19.599 00.000 788 GetInt("/profile/2/camera/gain", 95) returns 48
14:00:19.599 00.000 788 GetInt("/profile/2/camera/TimeoutMs", 15000) returns 15000
14:00:19.599 00.000 788 GetInt("/profile/2/camera/SaturationADU", 0) returns 0
14:00:19.599 00.000 788 GetBoolean("/profile/2/camera/SaturationByADU", 1) returns 1
14:00:19.599 00.000 788 GetDouble("/profile/2/camera/pixelsize", 0.000000) returns 3.750000
14:00:19.614 00.015 788 GetInt("/profile/2/camera/binning", 1) returns 1
14:00:19.614 00.000 788 GetInt("/profile/2/camera/ZWO/bpp", 8) returns 8
14:00:19.614 00.000 788 Created new camera of type ZWO ASI Camera = 0BE51E20
14:00:19.614 00.000 788 GetString("/profile/2/camera/LastMenuChoice", "") returns "ZWO ASI Camera"
14:00:19.614 00.000 788 GetString("/profile/2/scope/LastMenuChoice", "None") returns "EQMOD HEQ5/6 (ASCOM)"
14:00:19.614 00.000 788 ScopeFactory(EQMOD HEQ5/6 (ASCOM))
14:00:19.614 00.000 788 GetInt("/profile/2/scope/CalibrationDuration", 750) returns 1000
14:00:19.614 00.000 788 GetInt("/profile/2/scope/CalibrationDistance", 25) returns 25
14:00:19.630 00.016 788 GetInt("/profile/2/scope/MaxRaDuration", 2500) returns 2500
14:00:19.630 00.000 788 GetInt("/profile/2/scope/MaxDecDuration", 2500) returns 2500
14:00:19.630 00.000 788 GetInt("/profile/2/scope/DecGuideMode", 1) returns 1
14:00:19.630 00.000 788 DecGuideMode set to Auto (1)
14:00:19.630 00.000 788 GetInt("/profile/2/scope/XGuideAlgorithm", 1) returns 1
14:00:19.630 00.000 788 GetDouble("/profile/2/scope/GuideAlgorithm/X/Hysteresis/minMove", 0.200000) returns 0.175516
14:00:19.630 00.000 788 GetDouble("/profile/2/scope/GuideAlgorithm/X/Hysteresis/hysteresis", 0.100000) returns 0.100000
14:00:19.630 00.000 788 GetDouble("/profile/2/scope/GuideAlgorithm/X/Hysteresis/aggression", 0.700000) returns 0.700000
14:00:19.645 00.015 788 GetInt("/profile/2/scope/YGuideAlgorithm", 4) returns 4
14:00:19.645 00.000 788 GetDouble("/profile/2/scope/GuideAlgorithm/Y/ResistSwitch/minMove", 0.200000) returns 0.175516
14:00:19.645 00.000 788 GuideAlgorithmResistSwitch::SetMinMove() returns 0, m_minMove=0.18
14:00:19.645 00.000 788 GetDouble("/profile/2/scope/GuideAlgorithm/Y/ResistSwitch/aggression", 1.000000) returns 1.000000
14:00:19.645 00.000 788 GuideAlgorithmResistSwitch::SetAggression() returns 0, m_aggression=1.00
14:00:19.645 00.000 788 GetBoolean("/profile/2/scope/GuideAlgorithm/Y/ResistSwitch/fastSwitch", 1) returns 1
14:00:19.645 00.000 788 GuideAlgorithmResistSwitch::SetFastSwitchEnabled(1)
14:00:19.645 00.000 788 GetBoolean("/profile/2/scope/CalFlipRequiresDecFlip", 0) returns 0
14:00:19.661 00.016 788 GetBoolean("/profile/2/scope/AssumeOrthogonal", 0) returns 0
14:00:19.661 00.000 788 GetBoolean("/profile/2/scope/UseDecComp", 1) returns 1
14:00:19.661 00.000 788 GetInt("/profile/2/scope/DecBacklashPulse", 0) returns 0
14:00:19.661 00.000 788 GetInt("/profile/2/scope/DecBacklashFloor", 0) returns 0
14:00:19.668 00.007 788 GetInt("/profile/2/scope/DecBacklashCeiling", 0) returns 0
14:00:19.668 00.000 788 BLC: Backlash compensation is disabled
14:00:19.668 00.000 788 GetBoolean("/profile/2/scope/StopGuidingWhenSlewing", 1) returns 1
14:00:19.668 00.000 788 Scope: enabling slew check, guiding will stop when slew is detected
14:00:19.668 00.000 788 Created new scope of type EQMOD HEQ5/6 (ASCOM) = 0BEC2098
14:00:19.668 00.000 788 GetString("/profile/2/scope/LastMenuChoice", "") returns "EQMOD HEQ5/6 (ASCOM)"
14:00:19.668 00.000 788 GetString("/profile/2/scope/LastAuxMenuChoice", "None") returns "None"
14:00:19.668 00.000 788 ScopeFactory(None)
14:00:19.683 00.015 788 Created new aux scope of type None = 00000000
14:00:19.683 00.000 788 GetString("/profile/2/scope/LastAuxMenuChoice", "") returns "None"
14:00:19.683 00.000 788 Throw from C:\cygwin\home\agalasso\projects\phd2\gear_dialog.cpp:1351->OnAuxChoiceScope: m_pAuxScope == NULL
14:00:19.683 00.000 788 GetString("/profile/2/stepguider/LastMenuChoice", "None") returns "None"
14:00:19.683 00.000 788 StepGuiderFactory(None)
14:00:19.683 00.000 788 Created new stepguider of type None = 00000000
14:00:19.683 00.000 788 GetString("/profile/2/stepguider/LastMenuChoice", "") returns "None"
14:00:19.683 00.000 788 Throw from C:\cygwin\home\agalasso\projects\phd2\gear_dialog.cpp:1577->OnChoiceStepGuider: m_pStepGuider == NULL
14:00:19.699 00.016 788 GetString("/profile/2/rotator/LastMenuChoice", "None") returns "None"
14:00:19.699 00.000 788 RotatorFactory(None)
14:00:19.699 00.000 788 Created new Rotator of type None = 00000000
14:00:19.699 00.000 788 GetString("/profile/2/rotator/LastMenuChoice", "") returns "None"
14:00:19.699 00.000 788 Throw from C:\cygwin\home\agalasso\projects\phd2\gear_dialog.cpp:1715->OnChoiceRotator: m_pRotator == NULL
14:00:19.714 00.015 788 GetString("/profile/2/name", "") returns "Test"
14:00:19.730 00.016 788 SetupHelpFile: langid=60, locale-specific help = C:\Program Files (x86)\PHDGuiding2\locale\en_US\PHD2GuideHelp.zip
14:00:19.730 00.000 788 SetupHelpFile: using default help C:\Program Files (x86)\PHDGuiding2\PHD2GuideHelp.zip
14:00:19.768 00.038 788 starting server
14:00:19.768 00.000 788 event server started, listening on port 4400
14:00:19.768 00.000 788 Server started, listening on port 4300
14:00:19.768 00.000 788 Status Line: Server started
14:00:19.768 00.000 788 GetString("/perspective", "") returns "layout2|name=MainToolBar;caption=Main tool bar;state=2106108;dir=3;layer=10;row=0;pos=0;prop=100000;bestw=567;besth=42;minw=-1;minh=-1;maxw=-1;maxh=-1;floatx=-1;floaty=-1;floatw=-1;floath=-1|name=Guider;caption=Guider;state=256;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=2099198;dir=3;layer=0;row=0;pos=0;prop=100000;bestw=534;besth=233;minw=-1;minh=240;maxw=-1;maxh=-1;floatx=-1;floaty=-1;floatw=-1;floath=-1|name=Stats;caption=Guide Stats;state=2099198;dir=4;layer=0;row=0;pos=0;prop=100000;bestw=245;besth=424;minw=-1;minh=-1;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=2099198;dir=4;layer=0;row=0;pos=0;prop=100000;bestw=20;besth=20;minw=-1;minh=-1;maxw=-1;maxh=-1;floatx=-1;floaty=-1;floatw=-1;floath=-1|name=Target;caption=Target;state=2099198;dir=4;layer=0;row=0;pos=0;prop=100000;bestw=320;besth=207;minw=-1;minh=-1;maxw=-1;maxh=-1;floatx=-1;floaty=-1;floatw=-1;floath=-1|dock_size(3,10,0)=44|dock_size(5,0,0)=642|"
14:00:19.815 00.047 788 GetString("/profile/2/camera/LastMenuChoice", "None") returns "ZWO ASI Camera"
14:00:19.815 00.000 788 GetString("/profile/2/scope/LastMenuChoice", "None") returns "EQMOD HEQ5/6 (ASCOM)"
14:00:19.815 00.000 788 GetBoolean("/Update/enabled", 1) returns 0
14:00:19.830 00.015 788 GetInt("/Update/series", 0) returns 1
14:00:27.178 07.348 788 GetString("/profile/2/camera/LastMenuChoice", "None") returns "ZWO ASI Camera"
14:00:27.178 00.000 788 GetString("/profile/2/scope/LastMenuChoice", "None") returns "EQMOD HEQ5/6 (ASCOM)"
14:00:33.028 05.850 788 gear_dialog: OnButtonConnectScope
14:00:33.028 00.000 788 Status Line: Connecting to Mount ...
14:00:33.038 00.010 788 Connecting to mount [EQMOD HEQ5/6 (ASCOM)]
14:00:33.038 00.000 788 ASCOM Scope: Connecting
14:00:33.038 00.000 788 Create ASCOM Scope: choice 'EQMOD HEQ5/6 (ASCOM)' progid EQMOD.Telescope
14:00:33.954 00.916 788 pScopeDriver = 0x0BF23AE4
14:00:34.819 00.865 788 Scope reports its name as EQMOD HEQ5/6 (ASCOM)
14:00:34.821 00.002 788 ASCOM scope CanSlewAsync is true
14:00:34.821 00.000 788 EQMOD HEQ5/6 (ASCOM) connected
14:00:34.829 00.008 788 ScopeASCOM::GetDeclination() returns 0.0
14:00:34.831 00.002 788 ScopeASCOM::SideOfPier() returns 1
14:00:34.831 00.000 788 ASCOM Scope: Connect success
14:00:34.831 00.000 788 Status Line: Mount Connected
14:00:34.841 00.010 788 Connected Scope:EQMOD HEQ5/6 (ASCOM)
14:00:37.448 02.607 788 GetBoolean("/profile/2/target/refCircleEnabled", 0) returns 0
14:00:37.448 00.000 788 GetDouble("/profile/2/target/refCircleRadius", 2.000000) returns 2.000000
14:00:37.981 00.533 788 GetBoolean("/profile/2/ShowDecModeWarning", 1) returns 1
14:04:35.935 237.954 788 GetInt("/profile/2/ManualGuide/duration", 1000) returns 5000
14:04:35.951 00.016 788 GetInt("/profile/2/ManualGuide/DitherType", 4) returns 4
14:04:44.475 08.524 788 Manual Guide: North 5000 ms
14:04:44.475 00.000 788 GuideStep: 0.0 px 0 ms WEST, 0.0 px 5000 ms NORTH
14:04:44.475 00.000 788 Enqueuing Calibration Move request for direction 0
14:04:44.491 00.016 3324 Worker thread wakes up
14:04:44.491 00.000 3324 worker thread servicing REQUEST_MOVE scope dir N(0) 5000 opts 0x10
14:04:44.491 00.000 3324 Handling axis move in thread for scope dir=0 dur=5000
14:04:44.491 00.000 3324 scope move axis dir= 0 dur= 5000 opts= 0x10
14:04:44.491 00.000 3324 MoveAxis(N, 5000, M)
14:04:44.491 00.000 3324 Guiding  Dir = 0, Dur = 5000
14:04:44.506 00.015 3324 IsSlewing returns 0
14:04:44.506 00.000 3324 IsGuiding returns 0
14:04:44.576 00.070 3324 PulseGuide returned control before completion, sleep 4931
14:04:49.521 04.945 3324 IsGuiding returns 1
14:04:49.521 00.000 3324 scope still moving after pulse duration time elapsed
14:04:49.552 00.031 3324 IsSlewing returns 0
14:04:49.552 00.000 3324 IsGuiding returns 1
14:04:49.606 00.054 3324 IsSlewing returns 0
14:04:49.606 00.000 3324 IsGuiding returns 0
14:04:49.606 00.000 3324 scope move finished after 5000 + 110 ms
14:04:49.606 00.000 3324 Move returns status 0, amount 5000
14:04:49.606 00.000 3324 move complete, result=0
14:04:49.606 00.000 3324 worker thread done servicing request
14:04:49.606 00.000 788 Manual Move completed, result = 0
14:07:10.721 141.115 788 Manual Guide: West 5000 ms
14:07:10.721 00.000 788 GuideStep: 0.0 px 5000 ms WEST, 0.0 px 0 ms NORTH
14:07:10.736 00.015 788 Enqueuing Calibration Move request for direction 3
14:07:10.736 00.000 3324 Worker thread wakes up
14:07:10.736 00.000 3324 worker thread servicing REQUEST_MOVE scope dir W(3) 5000 opts 0x10
14:07:10.736 00.000 3324 Handling axis move in thread for scope dir=3 dur=5000
14:07:10.736 00.000 3324 scope move axis dir= 3 dur= 5000 opts= 0x10
14:07:10.736 00.000 3324 MoveAxis(W, 5000, M)
14:07:10.736 00.000 3324 Guiding  Dir = 3, Dur = 5000
14:07:10.736 00.000 3324 IsSlewing returns 0
14:07:10.736 00.000 3324 IsGuiding returns 0
14:07:10.752 00.016 3324 PulseGuide returned control before completion, sleep 4990
14:07:15.767 05.015 3324 IsGuiding returns 0
14:07:15.767 00.000 3324 Move returns status 0, amount 5000
14:07:15.767 00.000 3324 move complete, result=0
14:07:15.767 00.000 3324 worker thread done servicing request
14:07:15.767 00.000 788 Manual Move completed, result = 0