[OpenAFS] Windows: aklog: ktc 7 (11862791) while obtaining tokens

Jeff Blaine jblaine@kickflop.net
Wed, 23 Jun 2010 11:51:18 -0400 

* OpenAFS 1.5.74
* MIT Kerberos for Windows 3.2.2
* rxdebug.exe to fileservers works fine
* udebug to db servers works fine
* AFS Control Panel says service IS running
* AFS Control Panel says service is not running when viewing
   the Preferences tab: "Note: These controls are disabled
   because the AFS Client service is not running"  (????)
* No file or VL servers listed on "Preferences" tab
* OpenAFS tray icon is "broken" and indicates "OpenAFS
   service cannot be reached"

c:\Program Files\OpenAFS\Client\Program>"c:\Program 
Files\MIT\Kerberos\bin\kinit.exe" jblaine@RCF.OUR.ORG
Password for jblaine@RCF.OUR.ORG:

c:\Program Files\OpenAFS\Client\Program>aklog -d
Authenticating to cell rcf.our.org.
Getting v5 tickets: afs/rcf.our.org@RCF.OUR.ORG
Getting v5 tickets: afs@RCF.OUR.ORG
About to resolve name jblaine@RCF.OUR.ORG to id
Id 26560
Set username to jblaine@RCF.OUR.ORG
Getting tokens.
aklog: ktc 7 (11862791) while obtaining tokens for cell rcf.our.org

=======================================================================
afsd_init.log

6/23/2010 11:24:42 AM: locale =  C
6/23/2010 11:24:42 AM: running on 2000+ - using RegisterServiceCtrlHandlerEx
6/23/2010 11:24:42 AM: C:\Program 
Files\OpenAFS\Client\Program\afsd_service.exe version 1.5.7400
6/23/2010 11:24:42 AM: Num of Process Modules: 57
6/23/2010 11:24:42 AM: C:\Program 
Files\OpenAFS\Client\Program\libosi.dll version 1.5.7400
6/23/2010 11:24:42 AM: C:\Program Files\OpenAFS\Common\afsrpc.dll 
version 1.5.7400
6/23/2010 11:24:42 AM: C:\Program Files\OpenAFS\Common\afspthread.dll 
version 1.5.7400
6/23/2010 11:24:42 AM: C:\Program Files\OpenAFS\Common\afsauthent.dll 
version 1.5.7400
6/23/2010 11:24:42 AM: C:\Program Files\OpenAFS\Common\libafsconf.dll 
version 1.5.7400
6/23/2010 11:24:42 AM: osi_InitDebug code 0
6/23/2010 11:24:42 AM: gethostname MM160939-PC
6/23/2010 11:24:42 AM: PriorityClass 0x80
6/23/2010 11:24:42 AM: Lock Order Validation Off
6/23/2010 11:24:42 AM: Trace Options = 0
6/23/2010 11:24:42 AM: Default trace buffer size 10000
6/23/2010 11:24:42 AM: osi_LogCreate log addr 3a7f60
6/23/2010 11:24:42 AM: SMB request monitoring is disabled
6/23/2010 11:24:42 AM: Default cache size 98304
6/23/2010 11:24:42 AM: Chunk size 262144 (18)
6/23/2010 11:24:42 AM: Block size 4096
6/23/2010 11:24:42 AM: Defaulting to 4 background daemons
6/23/2010 11:24:42 AM: Defaulting to 25 server threads
6/23/2010 11:24:42 AM: Default status cache entries: 10000
6/23/2010 11:24:42 AM: Default volume cache entries: 3333
6/23/2010 11:24:42 AM: Default cell cache entries: 1024
6/23/2010 11:24:42 AM: Logoff token transfer on
6/23/2010 11:24:42 AM: Logoff token transfer timeout 120 seconds
6/23/2010 11:24:42 AM: Default root volume name root.afs
6/23/2010 11:24:42 AM: Mount root /afs
6/23/2010 11:24:42 AM: Default cache path C:\Windows\TEMP\AFSCache
6/23/2010 11:24:42 AM: Cache type is FILE
6/23/2010 11:24:42 AM: Cache Validation on Startup
6/23/2010 11:24:42 AM: Set to trap on panic
6/23/2010 11:24:42 AM: Sys name x86_win32 i386_w2k i386_nt40
6/23/2010 11:24:42 AM: SecurityLevel is crypt
6/23/2010 11:24:42 AM: CM ForceAnonVLDB is off
6/23/2010 11:24:42 AM: DNS will not be used to find AFS cell servers
6/23/2010 11:24:42 AM: Freelance client feature is activated
6/23/2010 11:24:42 AM: SMB Server Unicode Support is enabled
6/23/2010 11:24:42 AM: Dot files/dirs will be marked hidden
6/23/2010 11:24:42 AM: Default unix mode bits for files is 00666
6/23/2010 11:24:42 AM: Default unix mode bits for directories is 00777
6/23/2010 11:24:42 AM: Maximum number of multiplexed sessions is 50
6/23/2010 11:24:42 AM: Maximum number of VCs per server is 100
6/23/2010 11:24:42 AM: SMB authentication type is EXTENDED
6/23/2010 11:24:42 AM: Rx Maximum Receive Window Size is 128
6/23/2010 11:24:42 AM: Rx Maximum Send Window Size is 128
6/23/2010 11:24:42 AM: Rx Minimum Peer Timeout is 350 ms
6/23/2010 11:24:42 AM: RX Jumbograms are disabled
6/23/2010 11:24:42 AM: RX extraPackets is 2176
6/23/2010 11:24:42 AM: RX udpbufsize is 262144
6/23/2010 11:24:42 AM: RX maximum MTU is 1200
6/23/2010 11:24:42 AM: RX Peer Statistics gathering is enabled
6/23/2010 11:24:42 AM: RX Process Statistics gathering is enabled
6/23/2010 11:24:42 AM: RX Hot Thread is enabled
6/23/2010 11:24:42 AM: CM CallBackPort is 7001
6/23/2010 11:24:42 AM: EnableServerLocks: server requested
6/23/2010 11:24:42 AM: CM DeleteReadOnly is 0
6/23/2010 11:24:42 AM: CM BPlusTrees is 1
6/23/2010 11:24:42 AM: No PrefetchExecutableExtensions
6/23/2010 11:24:42 AM: CM OfflineReadOnlyIsValid is 0
6/23/2010 11:24:42 AM: CM GiveUpAllCallBacks is 0
6/23/2010 11:24:42 AM: CM FollowBackupPath is 0
6/23/2010 11:24:42 AM: CM PerFileAccessCheck is 0
6/23/2010 11:24:42 AM: CM ReadOnlyVolumeVersioning is 0
6/23/2010 11:24:42 AM: First Network address c0a80103 SubnetMask ffffff00
6/23/2010 11:24:42 AM: lanmanworkstation : ExtSessTimeout 300
6/23/2010 11:24:42 AM: NatPingInterval is 0
6/23/2010 11:24:42 AM: ConnDeadTimeout is 50
6/23/2010 11:24:42 AM: HardDeadTimeout is 120
6/23/2010 11:24:42 AM: IdleDeadTimeout is 50
6/23/2010 11:24:42 AM: Cache File "C:\Windows\TEMP\AFSCache" already exists
6/23/2010 11:24:42 AM: Existing File Size: 00000000:0732A57C
6/23/2010 11:24:42 AM: Granularity - 10000
6/23/2010 11:24:42 AM: Reusing existing AFS Cache data:
6/23/2010 11:24:42 AM:   Base Address   = 02E40000
6/23/2010 11:24:42 AM:   stats          = 10000
6/23/2010 11:24:42 AM:   chunkSize      = 262144
6/23/2010 11:24:42 AM:   blockSize      = 4096
6/23/2010 11:24:42 AM:   bufferSize     = 120759676
6/23/2010 11:24:42 AM:   cacheType      = 1
6/23/2010 11:24:42 AM:   volumeHashTableSize  = 467
6/23/2010 11:24:42 AM:   currentVolumes = 0
6/23/2010 11:24:42 AM:   maxVolumes     = 3333
6/23/2010 11:24:42 AM:   cellHashTableSize = 139
6/23/2010 11:24:42 AM:   currentCells   = 1
6/23/2010 11:24:42 AM:   maxCells       = 1024
6/23/2010 11:24:42 AM:   scacheHashTableSize  = 4999
6/23/2010 11:24:42 AM:   currentSCaches = 1
6/23/2010 11:24:42 AM:   maxSCaches     = 10000
6/23/2010 11:24:42 AM: Validating Cache Contents
6/23/2010 11:24:42 AM: Volume Serial Number: 0x506a1e25
6/23/2010 11:24:42 AM: Machine SID: S-1-5-21-2304044506-54272331-491655338
6/23/2010 11:24:42 AM: Initializing Uuid to 
2938d998-1a64-4ccd-8bf7-69db0ac88c86
6/23/2010 11:24:42 AM: Initializing Volume Data
6/23/2010 11:24:42 AM: Initializing Cell Data
6/23/2010 11:24:42 AM: Initializing ACL Data
6/23/2010 11:24:42 AM: Initializing Stat Data
6/23/2010 11:24:42 AM: CM UseDNLC = 1
6/23/2010 11:24:42 AM: CM DebugDNLC = 0
6/23/2010 11:24:42 AM: Initializing Data Buffers
6/23/2010 11:24:42 AM: Cache Initialization Complete
6/23/2010 11:24:42 AM: cm_InitMappedMemory code 0
6/23/2010 11:24:42 AM: rx_SetNoJumbo successful
6/23/2010 11:24:42 AM: rx_SetMaxMTU 1200 successful
6/23/2010 11:24:42 AM: rx_SetUdpBufSize 262144
6/23/2010 11:24:42 AM: rx_Init code 0
6/23/2010 11:24:42 AM: rx_NewService addr 3a8518
6/23/2010 11:24:42 AM: rx_NewService addr 3a8560
6/23/2010 11:24:42 AM: rx_StartServer
6/23/2010 11:24:42 AM: cm_GetRootCellName code 0, cm_freelanceEnabled= 
1, rcn= rcf.our.org
6/23/2010 11:24:42 AM: Mountpoint[0] = rcf.our.org#rcf.our.org:root.cell.
6/23/2010 11:24:42 AM: Mountpoint[1] = .rcf.our.org%rcf.our.org:root.cell.
6/23/2010 11:24:42 AM: Mountpoint[2] = .root%rcf.our.org:root.afs.
6/23/2010 11:24:42 AM: cm_GetSCache code 0 scache 3045c38
6/23/2010 11:24:42 AM: StoreAnsiFilenames = 0
6/23/2010 11:24:42 AM: EnableSMBAsyncStore = 1
6/23/2010 11:24:42 AM: SMBAsyncStoreSize = 131072
6/23/2010 11:24:42 AM: LAN adapter number 7
6/23/2010 11:24:42 AM: Using >AFS< as SMB server name
6/23/2010 11:24:42 AM: smb_localNamep is >AFS<
6/23/2010 11:24:42 AM: RPC server listening
6/23/2010 11:24:42 AM: Netbios NCBRESET lana 7 succeeded
6/23/2010 11:24:42 AM: lana_list.length 1
6/23/2010 11:24:45 AM: Netbios NCBADDNAME lana=7 code=0 retcode=0 complete=0
6/23/2010 11:24:45 AM: Netbios NCBADDNAME added new name >AFS             <
6/23/2010 11:24:45 AM: Netbios NCBADDNAME succeeded on lana 7

6/23/2010 11:24:45 AM: smb_NetbiosInit smb_LANadapter=7
6/23/2010 11:24:45 AM: MsV1_0SetProcessOption success
6/23/2010 11:24:45 AM: Setting SMB server domain name to [MM160939-PC]
6/23/2010 11:24:45 AM: smb_StartListeners
6/23/2010 11:24:45 AM: Microsoft SMB Redirector supports Extended Timeouts
6/23/2010 11:24:45 AM: smb_Init complete
6/23/2010 11:24:45 AM: GlobalAutoMap thread completed
6/23/2010 11:24:45 AM: cm_InitDaemon complete
6/23/2010 11:24:45 AM: AutoStart 0x2
6/23/2010 11:24:45 AM: daemonCheckDownInterval is 180
6/23/2010 11:24:45 AM: daemonCheckUpInterval is 240
6/23/2010 11:24:45 AM: daemonCheckVolInterval is 3600
6/23/2010 11:24:45 AM: daemonCheckCBInterval is 60
6/23/2010 11:24:45 AM: daemonCheckVolCBInterval is 0
6/23/2010 11:24:45 AM: daemonCheckLockInterval is 60
6/23/2010 11:24:45 AM: daemonCheckTokenInterval is 180
6/23/2010 11:24:45 AM: daemonCheckOfflineVolInterval is 600
6/23/2010 11:24:45 AM: daemonRankServerInterval is 600
6/23/2010 11:24:45 AM: daemonPerformanceTuningInterval is 0
6/23/2010 11:24:45 AM: Windows Firewall Configuration succeeded