23:27:11.733 00.002 11996 PHD2 version 2.6.3 begins execution with: 23:27:11.734 00.001 11996 wxWidgets 3.0.2 23:27:11.734 00.000 11996 cfitsio 3.37 23:27:11.734 00.000 11996 CoInitializeEx returns 1 23:27:11.734 00.000 11996 Using Locale Dir C:\Program Files (x86)\PHDGuiding2\locale exists=1 23:27:11.734 00.000 11996 GetInt("/wxLanguage", 0) returns 0 23:27:11.864 00.130 11996 GetString("/frame/LogDir", "") returns "" 23:27:11.875 00.011 11996 GetInt("/currentProfile", 0) returns 1 23:27:11.878 00.003 11996 reset dither spiral 23:27:11.880 00.002 11996 StartWorkerThread(0x00000000) begins 23:27:11.880 00.000 11996 WorkerThread constructor called 23:27:11.880 00.000 11996 StartWorkerThread(0x00D0CB10) ends 23:27:11.881 00.001 11996 StartWorkerThread(0x00000000) begins 23:27:11.881 00.000 8792 WorkerThread::Entry() begins 23:27:11.881 00.000 11996 WorkerThread constructor called 23:27:11.881 00.000 8792 worker thread CoInitializeEx returns 0 23:27:11.881 00.000 11996 StartWorkerThread(0x00D0EE30) ends 23:27:11.881 00.000 13164 WorkerThread::Entry() begins 23:27:11.881 00.000 11996 GetBoolean("/ServerMode", 1) returns 1 23:27:11.881 00.000 13164 worker thread CoInitializeEx returns 0 23:27:11.881 00.000 11996 GetInt("/LoggedImageFormat", 0) returns 1 23:27:11.920 00.039 11996 GetInt("/profile/1/NoiseReductionMethod", 0) returns 1 23:27:11.921 00.001 11996 GetDouble("/profile/1/DitherScaleFactor", 1.000000) returns 1.000000 23:27:11.921 00.000 11996 GetBoolean("/profile/1/DitherRaOnly", 0) returns 0 23:27:11.921 00.000 11996 GetInt("/profile/1/DitherMode", 0) returns 0 23:27:11.921 00.000 11996 set dither mode 0 23:27:11.921 00.000 11996 GetInt("/profile/1/frame/timeLapse", 0) returns 0 23:27:11.922 00.001 11996 GetDouble("/profile/1/StarMinHFD", 0.000000) returns 0.000000 23:27:11.922 00.000 11996 Setting StarMinHFD = 0.00 23:27:11.922 00.000 11996 GetInt("/profile/1/AutoLoadCalibration", -1) returns 1 23:27:11.922 00.000 11996 GetInt("/profile/1/frame/focalLength", 0) returns 160 23:27:11.922 00.000 11996 GetInt("/profile/1/auto_exp/exposure_min", 1000) returns 1000 23:27:11.922 00.000 11996 GetInt("/profile/1/auto_exp/exposure_max", 5000) returns 3000 23:27:11.922 00.000 11996 GetDouble("/profile/1/auto_exp/target_snr", 6.000000) returns 15.000000 23:27:11.922 00.000 11996 AutoExp: config min = 1000 max = 3000 snr = 15.00 23:27:11.923 00.001 11996 AutoExp: reset exp to 3000 23:27:11.923 00.000 11996 GetString("/profile/1/ExposureDuration", "1.0 s") returns "0.5 s" 23:27:11.923 00.000 11996 OnExposureDurationSelected: duration = 500 23:27:11.923 00.000 11996 GetInt("/profile/1/Gamma", 100) returns 34 23:27:11.923 00.000 11996 GetBoolean("/profile/1/ImageLogger/LogFramesOverThreshRel", 0) returns 0 23:27:11.923 00.000 11996 GetBoolean("/profile/1/ImageLogger/LogFramesOverThreshPx", 0) returns 0 23:27:11.924 00.001 11996 GetBoolean("/profile/1/ImageLogger/LogFramesDropped", 0) returns 0 23:27:11.924 00.000 11996 GetDouble("/profile/1/ImageLogger/ErrorThreshRel", 4.000000) returns 4.000000 23:27:11.924 00.000 11996 GetDouble("/profile/1/ImageLogger/ErrorThreshPx", 4.000000) returns 4.000000 23:27:11.924 00.000 11996 ImgLogger: Settings Log Rel=0,0.00 Log Px=0,0.00 LogFrameDrop=0 23:27:11.926 00.002 11996 GetInt("/profile/1/overlay/slit/center.x", 376) returns 376 23:27:11.926 00.000 11996 GetInt("/profile/1/overlay/slit/center.y", 290) returns 290 23:27:11.926 00.000 11996 GetInt("/profile/1/overlay/slit/width", 8) returns 8 23:27:11.927 00.001 11996 GetInt("/profile/1/overlay/slit/height", 100) returns 100 23:27:11.927 00.000 11996 GetInt("/profile/1/overlay/slit/angle", 0) returns 0 23:27:11.927 00.000 11996 Changing from state 0 to 0 23:27:11.927 00.000 11996 GetBoolean("/profile/1/guider/FastRecenter", 1) returns 1 23:27:11.927 00.000 11996 GetBoolean("/profile/1/guider/ScaleImage", 1) returns 1 23:27:11.928 00.001 11996 GetDouble("/profile/1/guider/onestar/MassChangeThreshold", 0.500000) returns 0.500000 23:27:11.928 00.000 11996 GetBoolean("/profile/1/guider/onestar/MassChangeThresholdEnabled", 1) returns 1 23:27:11.928 00.000 11996 GetInt("/profile/1/guider/onestar/SearchRegion", 15) returns 15 23:27:11.928 00.000 11996 GetBoolean("/StickyLockPosition", 0) returns 0 23:27:11.928 00.000 11996 GetString("/geometry", "") returns "0;1022;815;12;15" 23:27:11.966 00.038 11996 GetInt("/graph/ScopeOrCameraUnits", 0) returns 0 23:27:11.966 00.000 11996 GetString("/graph/RAColor", "") returns "#0080FF" 23:27:11.966 00.000 11996 GetString("/graph/DecColor", "") returns "#FF0000" 23:27:11.966 00.000 11996 GetInt("/graph/minLength", 50) returns 50 23:27:11.967 00.001 11996 GetInt("/graph/maxLength", 400) returns 400 23:27:11.967 00.000 11996 GetInt("/graph/minHeight", 1) returns 1 23:27:11.967 00.000 11996 GetInt("/graph/maxHeight", 16) returns 16 23:27:11.967 00.000 11996 GetInt("/graph/length", 100) returns 50 23:27:11.967 00.000 11996 GetInt("/graph/height", 4) returns 2 23:27:11.967 00.000 11996 GetInt("graph/HeightUnits", 1) returns 0 23:27:11.967 00.000 11996 GetBoolean("/graph/showCorrections", 1) returns 0 23:27:11.968 00.001 11996 GetBoolean("/graph/showStarMass", 0) returns 0 23:27:11.968 00.000 11996 GetBoolean("/graph/showStarSNR", 0) returns 0 23:27:11.990 00.022 11996 GetInt("/graph_stepguider/length", 1) returns 1 23:27:11.992 00.002 11996 GetInt("/target/length", 100) returns 50 23:27:11.992 00.000 11996 GetDouble("/target/zoom", 1.000000) returns 1.000000 23:27:11.997 00.005 11996 GetBoolean("/profile/1/target/refCircleEnabled", 0) returns 1 23:27:11.997 00.000 11996 GetDouble("/profile/1/target/refCircleRadius", 2.000000) returns 2.000000 23:27:12.273 00.276 11996 GetString("/profile/1/name", "") returns "AVX/T3i/F6.3" 23:27:12.273 00.000 11996 GetString("/profile/2/name", "") returns "D1" 23:27:12.273 00.000 11996 GetString("/profile/3/name", "") returns "AVX/DSI/F3.3" 23:27:12.278 00.005 11996 GetString("/profile/1/name", "") returns "AVX/T3i/F6.3" 23:27:13.623 01.345 11996 GetString("/profile/1/camera/LastMenuchoice", "None") returns "StarShoot Autoguider" 23:27:13.623 00.000 11996 CameraFactory(StarShoot Autoguider) 23:27:13.623 00.000 11996 GetBoolean("/profile/1/camera/UseSubframes", 0) returns 0 23:27:13.623 00.000 11996 GetInt("/profile/1/camera/ReadDelay", 150) returns 150 23:27:13.624 00.001 11996 GetInt("/profile/1/camera/gain", 95) returns 90 23:27:13.624 00.000 11996 GetInt("/profile/1/camera/TimeoutMs", 15000) returns 20000 23:27:13.624 00.000 11996 GetDouble("/profile/1/camera/pixelsize", 0.000000) returns 5.200000 23:27:13.624 00.000 11996 GetInt("/profile/1/camera/binning", 1) returns 1 23:27:13.624 00.000 11996 Created new camera of type StarShoot Autoguider = 0454CB00 23:27:13.624 00.000 11996 GetString("/profile/1/scope/LastMenuChoice", "None") returns "On-camera" 23:27:13.625 00.001 11996 ScopeFactory(On-camera) 23:27:13.625 00.000 11996 GetInt("/profile/1/scope/CalibrationDuration", 750) returns 1900 23:27:13.625 00.000 11996 GetInt("/profile/1/scope/MaxRaDuration", 2500) returns 2000 23:27:13.625 00.000 11996 GetInt("/profile/1/scope/MaxDecDuration", 2500) returns 2000 23:27:13.625 00.000 11996 GetInt("/profile/1/scope/DecGuideMode", 1) returns 1 23:27:13.625 00.000 11996 DecGuideMode set to Auto (1) 23:27:13.625 00.000 11996 GetInt("/profile/1/scope/XGuideAlgorithm", 1) returns 1 23:27:13.626 00.001 11996 GetDouble("/profile/1/scope/GuideAlgorithm/X/Hysteresis/minMove", 0.200000) returns 0.150000 23:27:13.626 00.000 11996 GetDouble("/profile/1/scope/GuideAlgorithm/X/Hysteresis/hysteresis", 0.100000) returns 0.200000 23:27:13.626 00.000 11996 GetDouble("/profile/1/scope/GuideAlgorithm/X/Hysteresis/aggression", 0.700000) returns 0.450000 23:27:13.626 00.000 11996 GetInt("/profile/1/scope/YGuideAlgorithm", 4) returns 4 23:27:13.627 00.001 11996 GetDouble("/profile/1/scope/GuideAlgorithm/Y/ResistSwitch/minMove", 0.200000) returns 0.150000 23:27:13.627 00.000 11996 GuideAlgorithmResistSwitch::SetMinMove() returns 0, m_minMove=0.15 23:27:13.627 00.000 11996 GetDouble("/profile/1/scope/GuideAlgorithm/Y/ResistSwitch/aggression", 1.000000) returns 0.300000 23:27:13.627 00.000 11996 GuideAlgorithmResistSwitch::SetAggression() returns 0, m_aggression=0.30 23:27:13.627 00.000 11996 GetBoolean("/profile/1/scope/GuideAlgorithm/Y/ResistSwitch/fastSwitch", 1) returns 1 23:27:13.627 00.000 11996 GuideAlgorithmResistSwitch::SetFastSwitchEnabled(1) 23:27:13.628 00.001 11996 GetBoolean("/profile/1/scope/CalFlipRequiresDecFlip", 0) returns 0 23:27:13.628 00.000 11996 GetBoolean("/profile/1/scope/AssumeOrthogonal", 0) returns 0 23:27:13.628 00.000 11996 GetBoolean("/profile/1/scope/UseDecComp", 1) returns 1 23:27:13.628 00.000 11996 GetInt("/profile/1/scope/DecBacklashPulse", 0) returns 0 23:27:13.628 00.000 11996 BLC: Backlash compensation is disabled 23:27:13.628 00.000 11996 GetBoolean("/profile/1/scope/StopGuidingWhenSlewing", 0) returns 0 23:27:13.628 00.000 11996 Scope: slew check disabled 23:27:13.628 00.000 11996 Created new scope of type On-camera = 05DAB128 23:27:13.629 00.001 11996 GetString("/profile/1/scope/LastAuxMenuChoice", "None") returns "None" 23:27:13.629 00.000 11996 ScopeFactory(None) 23:27:13.629 00.000 11996 Created new aux scope of type None = 00000000 23:27:13.629 00.000 11996 Throw from C:\cygwin\home\agalasso\projects\phd2_b\gear_dialog.cpp:1142->OnAuxChoiceScope: m_pAuxScope == NULL 23:27:13.629 00.000 11996 GetString("/profile/1/stepguider/LastMenuChoice", "None") returns "None" 23:27:13.629 00.000 11996 StepGuiderFactory(None) 23:27:13.630 00.001 11996 Created new stepguider of type None = 00000000 23:27:13.630 00.000 11996 Throw from C:\cygwin\home\agalasso\projects\phd2_b\gear_dialog.cpp:1341->OnChoiceStepGuider: m_pStepGuider == NULL 23:27:13.630 00.000 11996 GetString("/profile/1/rotator/LastMenuChoice", "None") returns "None" 23:27:13.630 00.000 11996 RotatorFactory(None) 23:27:13.630 00.000 11996 Created new Rotator of type None = 00000000 23:27:13.630 00.000 11996 Throw from C:\cygwin\home\agalasso\projects\phd2_b\gear_dialog.cpp:1456->OnChoiceRotator: m_pRotator == NULL 23:27:13.636 00.006 11996 GetString("/profile/1/name", "") returns "AVX/T3i/F6.3" 23:27:13.697 00.061 11996 starting server 23:27:13.701 00.004 11996 event server started, listening on port 4400 23:27:13.701 00.000 11996 Server started, listening on port 4300 23:27:13.701 00.000 11996 Status Line: Server started 23:27:13.703 00.002 11996 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=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=2099196;dir=1;layer=0;row=1;pos=0;prop=100000;bestw=534;besth=233;minw=-1;minh=240;maxw=-1;maxh=-1;floatx=1032;floaty=57;floatw=550;floath=267|name=Stats;caption=Guide Stats;state=2099198;dir=2;layer=0;row=2;pos=0;prop=114504;bestw=226;besth=361;minw=-1;minh=240;maxw=-1;maxh=-1;floatx=730;floaty=515;floatw=242;floath=395|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=2;pos=0;prop=98054;bestw=20;besth=20;minw=115;minh=85;maxw=-1;maxh=-1;floatx=506;floaty=361;floatw=400;floath=250|name=Target;caption=Target;state=2099198;dir=2;layer=0;row=1;pos=0;prop=87442;bestw=320;besth=207;minw=293;minh=208;maxw=-1;maxh=-1;floatx=614;floaty=324;floatw=400;floath=250|dock_size(3,10,0)=44|dock_size(5,0,0)=642|dock_size(2,0,2)=350|dock_size(1,0,1)=259|" 23:27:13.734 00.031 11996 Resizing image to 533,427 23:27:16.262 02.528 11996 evsrv: cli 04549058 connect 23:27:17.365 01.103 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:27:17.365 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:27:17.466 00.101 11996 evsrv: cli 04549058 request: {"method":"get_profiles","id":1009} 23:27:17.466 00.000 11996 GetString("/profile/1/name", "") returns "AVX/T3i/F6.3" 23:27:17.466 00.000 11996 GetString("/profile/2/name", "") returns "D1" 23:27:17.466 00.000 11996 GetString("/profile/3/name", "") returns "AVX/DSI/F3.3" 23:27:17.467 00.001 11996 GetString("/profile/1/name", "") returns "AVX/T3i/F6.3" 23:27:17.467 00.000 11996 GetString("/profile/1/name", "") returns "AVX/T3i/F6.3" 23:27:17.467 00.000 11996 GetString("/profile/2/name", "") returns "D1" 23:27:17.467 00.000 11996 GetString("/profile/1/name", "") returns "AVX/T3i/F6.3" 23:27:17.467 00.000 11996 GetString("/profile/2/name", "") returns "D1" 23:27:17.468 00.001 11996 GetString("/profile/3/name", "") returns "AVX/DSI/F3.3" 23:27:17.468 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":[{"id":1,"name":"AVX/T3i/F6.3","selected":true},{"id":2,"name":"D1"},{"id":3,"name":"AVX/DSI/F3.3"}],"id":1009} 23:28:17.574 60.106 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:28:17.574 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:29:17.676 60.102 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:29:17.676 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:30:17.779 60.103 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:30:17.779 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:31:17.881 60.102 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:31:17.881 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:32:17.985 60.104 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:32:17.985 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:33:18.137 60.152 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:33:18.137 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:34:18.240 60.103 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:34:18.240 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:35:18.341 60.101 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:35:18.341 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:36:18.444 60.103 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:36:18.444 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:37:18.547 60.103 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:37:18.547 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:38:18.653 60.106 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:38:18.653 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:39:18.760 60.107 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:39:18.760 00.000 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:40:18.904 60.144 11996 evsrv: cli 04549058 request: {"method":"get_app_state","id":1001} 23:40:18.905 00.001 11996 evsrv: cli 04549058 response: {"jsonrpc":"2.0","result":"Stopped","id":1001} 23:40:40.135 21.230 11996 evsrv: cli 04549058 disconnect 23:44:24.910 224.775 11996 MyFrame::OnClose proceeding 23:44:24.911 00.001 11996 StopCapturing CaptureActive=0 continueCapturing=0 exposurePending=0 23:44:24.911 00.000 11996 StopWorkerThread(0x00D0CB10) begins 23:44:24.911 00.000 8792 Worker thread wakes up 23:44:24.911 00.000 8792 worker thread servicing REQUEST_TERMINATE 23:44:24.911 00.000 8792 worker thread done servicing request 23:44:24.911 00.000 8792 WorkerThread::Entry() ends 23:44:24.911 00.000 11996 StopWorkerThread() threadExitCode=0 23:44:24.911 00.000 11996 StopWorkerThread(0x00D0CB10) ends 23:44:24.911 00.000 11996 WorkerThread destructor called 23:44:24.911 00.000 11996 StopWorkerThread(0x00D0EE30) begins 23:44:24.911 00.000 13164 Worker thread wakes up 23:44:24.911 00.000 13164 worker thread servicing REQUEST_TERMINATE 23:44:24.911 00.000 13164 worker thread done servicing request 23:44:24.911 00.000 13164 WorkerThread::Entry() ends 23:44:24.912 00.001 11996 StopWorkerThread() threadExitCode=0 23:44:24.912 00.000 11996 StopWorkerThread(0x00D0EE30) ends 23:44:24.912 00.000 11996 WorkerThread destructor called 23:44:24.912 00.000 11996 Shutdown: forced=0 23:44:24.912 00.000 11996 Shutdown complete 23:44:24.912 00.000 11996 stopping server 23:44:24.912 00.000 11996 event server stopped 23:44:24.912 00.000 11996 Status Line: Server stopped 23:44:25.415 00.503 11996 MyFrame::OnClose proceeding 23:44:25.415 00.000 11996 StopCapturing CaptureActive=0 continueCapturing=0 exposurePending=0 23:44:25.415 00.000 11996 StopWorkerThread(0x00000000) begins 23:44:25.416 00.001 11996 StopWorkerThread(0x00000000) ends 23:44:25.416 00.000 11996 StopWorkerThread(0x00000000) begins 23:44:25.416 00.000 11996 StopWorkerThread(0x00000000) ends 23:44:25.416 00.000 11996 Shutdown: forced=0 23:44:25.416 00.000 11996 Shutdown complete 23:44:25.416 00.000 11996 stop server, server already stopped