[ntp:questions] Re: Windows Refclock Driver

David Kuechenmeister kplus13 at yahoo.com
Thu Oct 30 16:10:06 UTC 2003


mayer at gis.net (Danny Mayer) wrote in message 
[my earlier posts deleted]
> Why not post the results you are seeing?
> 
> Danny

I guess it's a question of how much or how little to post. I hate to
innundate the newsgroup with irrelevant stuff.

Here are two different parts of what I'm seeing. The first is the
debug output. Following that, is the output from ntpq.

Thanks for any insight on problems with my driver.

David Kuechenmeister



Debug1: 2 -> 2 = 2
addto_syslog: logging to file \winnt\system32\drivers\etc\ntp.log
ntpd 4.2.0 Thu Oct 30 15:20:25 2003 (20)
Debug1: 2 -> 2 = 2
addto_syslog: logging to file \winnt\system32\drivers\etc\ntp.log

addto_syslog: ntpd 4.2.0 Thu Oct 30 15:20:25 2003 (20)

addto_syslog: Initial Clock increment 10014.0 us

addto_syslog: Adjustment rate 9.986 ppm/s

addto_syslog: set_process_priority: Leave priority alone:
priority_done is <2>

addto_syslog: System AffinityMask = 1

addto_syslog: ProcessorAffinity Mask: 1

addto_syslog: precision = 7.000 usec

create_sockets(123)
bind() fd 80, family 2, port 123, addr 0.0.0.0, flags=8
bind() fd 92, family 2, port 123, addr 127.0.0.1, flags=8
bind() fd 104, family 2, port 123, addr 172.30.59.233, flags=8
create_sockets: ninterfaces=3
interface 0:  fd=80,  bfd=-1,  name=wildcard,  flags=0x8
              sin=0.0.0.0  bcast=0.0.0.0,  mask=255.255.255.255
interface 1:  fd=92,  bfd=-1,  name=Loopback,  flags=0xd
              sin=127.0.0.1  bcast=255.255.255.255,  mask=255.0.0.0
interface 2:  fd=104,  bfd=-1,  name=TCP/IP I,  flags=0x9
              sin=172.30.59.233  bcast=255.255.255.255, 
mask=255.255.0.0
init_io: maxactivefd 0
local_clock: at 0 state 0
Debug2: 2 -> 2 = 2
addto_syslog: frequency initialized 498.094 PPM from
C:\WINNT\system32\drivers\e
tc\ntp.drift

local_clock: at 0 state 1
addto_syslog: Cannot open log file
%windir%\system32\drivers\etc\ntp.log

getnetnum given 127.127.45.0, got 127.127.45.0
key_expire: at 0
peer_clear: at 0 assoc ID 58604 refid INIT
newpeer: 127.0.0.1->127.127.45.0 mode 3 vers 4 poll 6 6 flags 0x2a1
0x1 ttl 0 ke
y 00000000
report_event: system event 'event_restart' (0x01) status 'sync_alarm,
sync_unspe
c, 1 event, event_unspec' (0xc010)
SetSystemTimeAdjustment( 50) + (100144)
refclock_transmit: at 1 127.127.45.0
pp: 303 15:46:22.001000 1
refclock_receive: at 1 127.127.45.0
peer SYNCCLOCK16(0) event 'event_reach' (0x84) status 'unreach, conf,
1 event, e
vent_reach' (0x8014)
refclock_sample: n 1 offset -0.040922 disp 0.000000 jitter 0.000000
clock_filter: n 1 off -0.040922 del 0.000000 dsp 7.937992 jit
0.000008, age 1
poll_update: at 1 127.127.45.0 flags 02a1 poll 6 burst 0 last 1 next
67
auth_agekeys: at 1 keys 1 expired 0
timer: refresh ts 0
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
receive: at 22 127.0.0.1<-127.0.0.1 restrict 000
sendpkt(fd=92 dst=127.0.0.1, src=127.0.0.1, ttl=-6, len=16)
receive: at 22 127.0.0.1<-127.0.0.1 restrict 000
sendpkt(fd=92 dst=127.0.0.1, src=127.0.0.1, ttl=-6, len=476)
sendpkt(fd=92 dst=127.0.0.1, src=127.0.0.1, ttl=-6, len=148)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
auth_agekeys: at 60 keys 1 expired 0
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
refclock_transmit: at 67 127.127.45.0
pp: 303 15:47:27.51204000 1
refclock_receive: at 67 127.127.45.0
refclock_sample: n 1 offset -0.518466 disp 0.000000 jitter 0.000000
clock_filter: popcorn 0.477544 0.000008
poll_update: at 67 127.127.45.0 flags 02a1 poll 6 burst 0 last 67 next
130
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
auth_agekeys: at 120 keys 1 expired 0
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
refclock_transmit: at 130 127.127.45.0
pp: 303 15:48:30.5838000 1
refclock_receive: at 130 127.127.45.0
refclock_sample: n 1 offset -0.685958 disp 0.000000 jitter 0.000000
clock_filter: n 3 off -0.685958 del 0.000000 dsp 1.938839 jit
0.471235, age 63
poll_update: at 130 127.127.45.0 flags 02a1 poll 6 burst 0 last 130
next 194
SetSystemTimeAdjustment( 49) + (100144)
receive: at 131 127.0.0.1<-127.0.0.1 restrict 000
sendpkt(fd=92 dst=127.0.0.1, src=127.0.0.1, ttl=-6, len=16)
receive: at 131 127.0.0.1<-127.0.0.1 restrict 000
sendpkt(fd=92 dst=127.0.0.1, src=127.0.0.1, ttl=-6, len=480)
sendpkt(fd=92 dst=127.0.0.1, src=127.0.0.1, ttl=-6, len=148)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
auth_agekeys: at 180 keys 1 expired 0
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
refclock_transmit: at 194 127.127.45.0
pp: 303 15:49:34.6129000 1
refclock_receive: at 194 127.127.45.0
refclock_sample: n 1 offset -0.809715 disp 0.000000 jitter 0.000000
clock_filter: n 4 off -0.809715 del 0.000000 dsp 0.939082 jit
0.479995, age 64
poll_update: at 194 127.127.45.0 flags 02a1 poll 6 burst 0 last 194
next 258
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
auth_agekeys: at 240 keys 1 expired 0
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
refclock_transmit: at 258 127.127.45.0
pp: 303 15:50:39.000000 1
refclock_receive: at 258 127.127.45.0
refclock_sample: n 1 offset 0.015961 disp 0.000000 jitter 0.000000
clock_filter: n 5 off 0.015961 del 0.000000 dsp 0.439233 jit 0.604831,
age 64
poll_update: at 258 127.127.45.0 flags 02a1 poll 6 burst 0 last 258
next 322
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
receive: at 288 127.0.0.1<-127.0.0.1 restrict 000
sendpkt(fd=92 dst=127.0.0.1, src=127.0.0.1, ttl=-6, len=16)
receive: at 288 127.0.0.1<-127.0.0.1 restrict 000
sendpkt(fd=92 dst=127.0.0.1, src=127.0.0.1, ttl=-6, len=476)
sendpkt(fd=92 dst=127.0.0.1, src=127.0.0.1, ttl=-6, len=144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
auth_agekeys: at 300 keys 1 expired 0
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
receive: at 314 127.0.0.1<-127.0.0.1 restrict 000
sendpkt(fd=92 dst=127.0.0.1, src=127.0.0.1, ttl=-6, len=16)
receive: at 314 127.0.0.1<-127.0.0.1 restrict 000
sendpkt(fd=92 dst=127.0.0.1, src=127.0.0.1, ttl=-6, len=476)
sendpkt(fd=92 dst=127.0.0.1, src=127.0.0.1, ttl=-6, len=144)
SetSystemTimeAdjustment( 49) + (100144)
SetSystemTimeAdjustment( 50) + (100144)
refclock_transmit: at 322 127.127.45.0
pp: 303 15:51:43.000000 1
refclock_receive: at 322 127.127.45.0
refclock_sample: n 1 offset -0.063949 disp 0.000000 jitter 0.000000
clock_filter: n 6 off -0.063949 del 0.000000 dsp 0.189324 jit
0.480950, age 64
select: prefer offset -0.063949
report_event: system event 'event_peer/strat_chg' (0x04) status
'sync_alarm, syn
c_uhf_clock, 2 events, event_restart' (0xc421)
addto_syslog: synchronized to SYNCCLOCK16(0), stratum=0

clock_update: at 322 assoc 1
local_clock: assocID 58604 offset -0.063948971 jitter 0.480949869
state 1
local_clock: at 258 state 2
local_clock: mu 258 rootjit 0.494707 stab 0.000 poll 4 count 0
report_event: system event 'event_sync_chg' (0x03) status 'leap_none,
sync_uhf_c
lock, 3 events, event_peer/strat_chg' (0x434)
report_event: system event 'event_peer/strat_chg' (0x04) status
'leap_none, sync
_uhf_clock, 4 events, event_sync_chg' (0x443)
poll_update: at 322 127.127.45.0 flags 02e1 poll 6 burst 0 last 322
next 388
SetSystemTimeAdjustment( 24) + (100144)
SetSystemTimeAdjustment( 25) + (100144)
SetSystemTimeAdjustment( 26) + (100144)
SetSystemTimeAdjustment( 25) + (100144)
SetSystemTimeAdjustment( 26) + (100144)
receive: at 329 127.0.0.1<-127.0.0.1 restrict 000
sendpkt(fd=92 dst=127.0.0.1, src=127.0.0.1, ttl=-6, len=16)
receive: at 329 127.0.0.1<-127.0.0.1 restrict 000
sendpkt(fd=92 dst=127.0.0.



C:\>ntpq -p
     remote           refid      st t when poll reach   delay   offset
 jitter
==============================================================================
 SYNCCLOCK16(0)  .IRIG.           0 l   20   64    1    0.000  -40.922
  0.008

C:\>ntpq -p
     remote           refid      st t when poll reach   delay   offset
 jitter
==============================================================================
 SYNCCLOCK16(0)  .IRIG.           0 l    1   64    7    0.000  -685.95
471.235

C:\>ntpq -p
     remote           refid      st t when poll reach   delay   offset
 jitter
==============================================================================
 SYNCCLOCK16(0)  .IRIG.           0 l   31   64   37    0.000   15.961
604.831

C:\>ntpq -p
     remote           refid      st t when poll reach   delay   offset
 jitter
==============================================================================
 SYNCCLOCK16(0)  .IRIG.           0 l   57   64   37    0.000   15.961
604.831

C:\>ntpq -p
     remote           refid      st t when poll reach   delay   offset
 jitter
==============================================================================
*SYNCCLOCK16(0)  .IRIG.           0 l    7   64   77    0.000  -63.949
480.950

C:\>ntpq -p
     remote           refid      st t when poll reach   delay   offset
 jitter
==============================================================================
*SYNCCLOCK16(0)  .IRIG.           0 l    6   64  377    0.000  -313.87
313.263

C:\>



More information about the questions mailing list