Windows Vista Tips

Windows Vista Tips > Newsgroups > Windows Vista General Discussion > w32tm debug help

Reply
Thread Tools Display Modes

w32tm debug help

 
 
Mark Pfeifer
Guest
Posts: n/a

 
      05-28-2009
I am running Vista 32-bit with SP2 and I am unable to sync the time via the
w32tm service. I just get an error on the screen with no entries in the
system event viewer. Listed below is the debug of w32tm /resync /rediscover
....

Can anyone shed any light on this? Other ntp clients work fine and I am
able to do a stripchart command against time.windows.com w/o an issue. So, I
don't think it is a firewall issue.

Any ideas? TIA
Mark

149166 22:37:38.4257189s - ---------- Log File Opened -----------------
149166 22:37:50.9993189s - RPC Caller is
(S-1-5-21-1037478806-2609463539-4057573387-1000)
149166 22:37:50.9993189s - RPC Call Attribute is local=1, kernel=0,
session=0, authentication=6, protocol=2, OpNum=0
149166 22:37:50.9993189s - RPC Call - Rediscover
149166 22:37:50.9993189s - W32TmServiceMain: Network Topology Change (RPC)
149166 22:37:50.9993189s - TimeProvCommand([NtpClient], TPC_NetTopoChange)
called.
149166 22:37:50.9993189s - NtpProvider: Network Topology Change
149166 22:37:50.9993189s - Peers reset: p-p:1 a-p:1 a-x:0
149166 22:37:50.9993189s - NtpProvider: Created 0 sockets.
149166 22:37:50.9993189s - StartListeningThread completed!
149166 22:37:50.9993189s - PeerPollingThread: waiting forever
149166 22:37:50.9993189s - StartPeerPollingThread completed!
149166 22:37:50.9993189s - W32TmServiceMain: waiting 983.204s
149166 22:37:50.9993189s - W32TmServiceMain: ********** Time Slip
Notification **********
149166 22:37:50.9993189s - PeerPollingThread: PeerListUpdated
149166 22:37:50.9993189s - PeerPollingThread: waiting forever
149166 22:37:50.9993189s - ClockDispln TimeSlip:TimeSlip LastUTC:70046
SetUnsync: LI:3 S:0 RDl:0 RDs:0 TSF:0x0
149166 22:37:50.9993189s - TimeProvCommand([NtpClient], TPC_TimeJumped)
called.
149166 22:37:50.9993189s - W32TmServiceMain: waiting i16.000s (1024.000s)
149166 22:37:50.9993189s - PeerPollingThread: PeerListUpdated
149166 22:37:50.9993189s - PeerPollingThread: waiting forever
149166 22:38:07.0049189s - W32TmServiceMain: timeout
149166 22:38:07.0049189s - W32TmServiceMain: waiting 1024.000s

 
Reply With Quote
 
 
 
 
Mark Pfeifer
Guest
Posts: n/a

 
      05-28-2009
BTW - Here is the log after the UI attempts to update

149166 22:42:17.2065189s - RPC Caller is
(S-1-5-21-1037478806-2609463539-4057573387-1000)
149166 22:42:17.2065189s - RPC Call Attribute is local=1, kernel=0,
session=0, authentication=6, protocol=2, OpNum=0
149166 22:42:17.2065189s - RPC Call - HardResync
149166 22:42:17.2065189s - W32TmServiceMain: ********** Time Slip
Notification **********
149166 22:42:17.2065189s - ClockDispln TimeSlip:TimeSlip LastUTC:87111
SetUnsync: LI:3 S:0 RDl:0 RDs:0 TSF:0x0
149166 22:42:17.2065189s - TimeProvCommand([NtpClient], TPC_TimeJumped)
called.
149166 22:42:17.2065189s - W32TmServiceMain: waiting i16.000s (1024.000s)
149166 22:42:17.2065189s - PeerPollingThread: PeerListUpdated
149166 22:42:17.2065189s - PeerPollingThread: waiting forever
149166 22:42:33.2121189s - W32TmServiceMain: timeout
149166 22:42:33.2121189s - W32TmServiceMain: waiting 1024.000s
149166 22:42:33.2121189s - RPC Call - Query provider status
149166 22:42:33.2121189s - TimeProvCommand([NtpClient], TPC_Query) called.
149166 22:42:33.2121189s - RPC Caller is
(S-1-5-21-1037478806-2609463539-4057573387-1000)
149166 22:42:33.2121189s - RPC Call Attribute is local=1, kernel=0,
session=0, authentication=6, protocol=2, OpNum=6
149166 22:42:33.2121189s - RPC Call - Query Status
149166 22:42:33.2121189s - W32TimeHandler called:
SERVICE_CONTROL_PARAMCHANGE
149166 22:42:33.2121189s - W32TmServiceMain: Param change notification
149166 22:42:33.2121189s - ReadConfig: Found provider 'NtpClient':
149166 22:42:33.2121189s - ReadConfig: 'Enabled'=0x00000001
149166 22:42:33.2121189s - ReadConfig:
'DllName'='C:\Windows\system32\w32time.dll'
149166 22:42:33.2121189s - ReadConfig:
'DllName'='C:\Windows\system32\w32time.dll'
149166 22:42:33.2121189s - ReadConfig:
'DllName'='C:\Windows\system32\w32time.dll'
149166 22:42:33.2121189s - ReadConfig: 'InputProvider'=0x00000001
149166 22:42:33.2121189s - ReadConfig: Found provider 'NtpServer':
149166 22:42:33.2121189s - ReadConfig: 'Enabled'=0x00000000
149166 22:42:33.2121189s - ReadConfig:
'DllName'='C:\Windows\system32\w32time.dll'
149166 22:42:33.2121189s - ReadConfig:
'DllName'='C:\Windows\system32\w32time.dll'
149166 22:42:33.2121189s - ReadConfig:
'DllName'='C:\Windows\system32\w32time.dll'
149166 22:42:33.2121189s - ReadConfig: 'InputProvider'=0x00000000
149166 22:42:33.2121189s - ReadConfig: 'PhaseCorrectRate'=0x00000001 (2)
149166 22:42:33.2121189s - ReadConfig: 'UpdateInterval'=0x00057E40 (2)
149166 22:42:33.2121189s - ReadConfig: 'FrequencyCorrectRate'=0x00000004 (2)
149166 22:42:33.2121189s - ReadConfig: 'PollAdjustFactor'=0x00000005 (2)
149166 22:42:33.2121189s - ReadConfig: 'LargePhaseOffset'=0x02FAF080 (2)
149166 22:42:33.2121189s - ReadConfig: 'SpikeWatchPeriod'=0x00000384 (2)
149166 22:42:33.2121189s - ReadConfig: 'HoldPeriod'=0x00000005 (2)
149166 22:42:33.2121189s - ReadConfig: 'MinPollInterval'=0x0000000A (2)
149166 22:42:33.2121189s - ReadConfig: 'MaxPollInterval'=0x0000000F (2)
149166 22:42:33.2121189s - ReadConfig: 'AnnounceFlags'=0x0000000A (2)
149166 22:42:33.2121189s - ReadConfig: 'LocalClockDispersion'=0x0000000A (2)
149166 22:42:33.2121189s - ReadConfig: 'MaxNegPhaseCorrection'=0x0000D2F0
(2)
149166 22:42:33.2121189s - ReadConfig: 'MaxPosPhaseCorrection'=0x0000D2F0
(2)
149166 22:42:33.2121189s - ReadConfig: 'EventLogFlags'=0x00000002 (2)
149166 22:42:33.2121189s - ReadConfig: 'MaxAllowedPhaseOffset'=0x00000001
(2)
149166 22:42:33.2121189s - ReadConfig: 'TimeJumpAuditOffset'=0x00007080 (2)
149166 22:42:33.2121189s - No params changed for local clock.
149166 22:42:33.2121189s - /--TimeProvider: new enabled provider list
149166 22:42:33.2121189s - | Name:NtpClient, Started:0, Input:1, Marked:0,
RefCount:0, DllName:C:\Windows\system32\w32time.dll
149166 22:42:33.2121189s - >--
149166 22:42:33.2121189s - | Total:1, Input: 1, Marked: 0
149166 22:42:33.2121189s - \--
149166 22:42:33.2121189s - /--TimeProvider: Parameter change before list is
updated
149166 22:42:33.2121189s - | Name:NtpClient, Started:1, Input:1, Marked:0,
RefCount:0, DllName:C:\Windows\system32\w32time.dll
149166 22:42:33.2121189s - >--
149166 22:42:33.2121189s - | Total:1, Input: 1, Marked: 0
149166 22:42:33.2121189s - \--
149166 22:42:33.2121189s - /--TimeProvider: new disabled provider list
149166 22:42:33.2121189s - | Name:NtpServer, Started:0, Input:0, Marked:0,
RefCount:0, DllName:C:\Windows\system32\w32time.dll
149166 22:42:33.2121189s - >--
149166 22:42:33.2121189s - | Total:1, Input: 0, Marked: 0
149166 22:42:33.2121189s - \--
149166 22:42:33.2121189s - /--TimeProvider: Parameter change before list is
updated
149166 22:42:33.2121189s - | Name:NtpServer, Started:0, Input:0, Marked:0,
RefCount:0, DllName:C:\Windows\system32\w32time.dll
149166 22:42:33.2121189s - >--
149166 22:42:33.2121189s - | Total:1, Input: 0, Marked: 0
149166 22:42:33.2121189s - \--
149166 22:42:33.2121189s - TimeProvCommand([NtpClient], TPC_UpdateConfig)
called.
149166 22:42:33.2121189s - ReadConfig:
'AllowNonstandardModeCombinations'=0x00000001 (2)
149166 22:42:33.2121189s - ReadConfig: 'CompatibilityFlags'=0x80000000 (2)
149166 22:42:33.2121189s - ReadConfig: 'SpecialPollInterval'=0x00093A80 (2)
149166 22:42:33.2121189s - ReadConfig:
'ResolvePeerBackoffMinutes'=0x0000000F (2)
149166 22:42:33.2121189s - ReadConfig:
'ResolvePeerBackoffMaxTimes'=0x00000007 (2)
149166 22:42:33.2121189s - ReadConfig: 'EventLogFlags'=0x00000001 (2)
149166 22:42:33.2121189s - ReadConfig: 'LargeSampleSkew'=0x00000003 (2)
149166 22:42:33.2121189s - ReadConfig: 'Type'=NTP (2)
149166 22:42:33.2121189s - ReadConfig: 'NtpServer'=time.windows.com,0x9 (2)
149166 22:42:33.2121189s - ReadConfig:
'ManualPeerList'(parsed)='time.windows.com,0x9'
149166 22:42:33.2121189s - ManualPeerListUpdate: add:0 del:0 noch:1
149166 22:42:33.2121189s - StartListeningThread completed!
149166 22:42:33.2121189s - PeerPollingThread: waiting forever
149166 22:42:33.2121189s - StartPeerPollingThread completed!
149166 22:42:33.2121189s - Provider list: 0 stopped, 0 started, 1 not
changed.
149166 22:42:33.2121189s - /--TimeProvider: Parameter change after list is
updated
149166 22:42:33.2121189s - | Name:NtpClient, Started:1, Input:1, Marked:0,
RefCount:0, DllName:C:\Windows\system32\w32time.dll
149166 22:42:33.2121189s - >--
149166 22:42:33.2121189s - | Total:1, Input: 1, Marked: 0
149166 22:42:33.2121189s - \--
149166 22:42:33.2121189s - W32TmServiceMain: waiting 1024.000s

"Mark Pfeifer" <> wrote in message
news:2CCD6673-2CD9-496A-96A9-...
>I am running Vista 32-bit with SP2 and I am unable to sync the time via the
>w32tm service. I just get an error on the screen with no entries in the
>system event viewer. Listed below is the debug of w32tm /resync
>/rediscover ...
>
> Can anyone shed any light on this? Other ntp clients work fine and I am
> able to do a stripchart command against time.windows.com w/o an issue. So,
> I don't think it is a firewall issue.
>
> Any ideas? TIA
> Mark
>
> 149166 22:37:38.4257189s - ---------- Log File Opened -----------------
> 149166 22:37:50.9993189s - RPC Caller is
> (S-1-5-21-1037478806-2609463539-4057573387-1000)
> 149166 22:37:50.9993189s - RPC Call Attribute is local=1, kernel=0,
> session=0, authentication=6, protocol=2, OpNum=0
> 149166 22:37:50.9993189s - RPC Call - Rediscover
> 149166 22:37:50.9993189s - W32TmServiceMain: Network Topology Change (RPC)
> 149166 22:37:50.9993189s - TimeProvCommand([NtpClient], TPC_NetTopoChange)
> called.
> 149166 22:37:50.9993189s - NtpProvider: Network Topology Change
> 149166 22:37:50.9993189s - Peers reset: p-p:1 a-p:1 a-x:0
> 149166 22:37:50.9993189s - NtpProvider: Created 0 sockets.
> 149166 22:37:50.9993189s - StartListeningThread completed!
> 149166 22:37:50.9993189s - PeerPollingThread: waiting forever
> 149166 22:37:50.9993189s - StartPeerPollingThread completed!
> 149166 22:37:50.9993189s - W32TmServiceMain: waiting 983.204s
> 149166 22:37:50.9993189s - W32TmServiceMain: ********** Time Slip
> Notification **********
> 149166 22:37:50.9993189s - PeerPollingThread: PeerListUpdated
> 149166 22:37:50.9993189s - PeerPollingThread: waiting forever
> 149166 22:37:50.9993189s - ClockDispln TimeSlip:TimeSlip LastUTC:70046
> SetUnsync: LI:3 S:0 RDl:0 RDs:0 TSF:0x0
> 149166 22:37:50.9993189s - TimeProvCommand([NtpClient], TPC_TimeJumped)
> called.
> 149166 22:37:50.9993189s - W32TmServiceMain: waiting i16.000s (1024.000s)
> 149166 22:37:50.9993189s - PeerPollingThread: PeerListUpdated
> 149166 22:37:50.9993189s - PeerPollingThread: waiting forever
> 149166 22:38:07.0049189s - W32TmServiceMain: timeout
> 149166 22:38:07.0049189s - W32TmServiceMain: waiting 1024.000s


 
Reply With Quote
Reply

Thread Tools
Display Modes

Posting Rules
You may not post new threads
You may not post replies
You may not post attachments
You may not edit your posts

BB code is On
Smilies are On
[IMG] code is On
HTML code is Off
Trackbacks are On
Pingbacks are On
Refbacks are Off


Similar Threads
Thread Thread Starter Forum Replies Last Post
w32tm Not Working with WinPE Taco Bell Windows Vista Installation 0 03-30-2009 05:44 PM
Debug Peter Windows Vista General Discussion 2 01-17-2009 05:35 PM
w32tm /tz command crash Steven Andrews Windows Vista General Discussion 1 11-05-2008 09:14 AM
debug.txt go away keepout@yahoo.com.invalid Windows Vista General Discussion 7 05-21-2008 04:21 AM
Kernel debug using 1394, debug message disappear after resume from S3 Morris Chang Windows Vista Drivers 2 07-21-2006 01:55 PM



1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 27 28 29 30 31 32 33 34 35 36 37 38 39 40 41 42 43 44 45 46 47 48 49 50 51 52 53 54 55 56 57 58 59