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

Jeff Blaine jblaine@kickflop.net
Wed, 23 Jun 2010 12:32:29 -0400


On 6/23/2010 12:06 PM, Jeffrey Altman wrote:
> Which operating system version?
>
> If the service is running but it cannot be reached, it is probably an
> Microsoft SMB redirector issue.  If the OS is Windows 7, please read
> the OpenAFS for Windows release notes.

Windows 7

I'm not able to find anything in the release notes
other than the UAC "Run As Administrator" info.  Is this
what you're referring to?  What should I "Run As
Administrator"?

>
> Jeffrey Altman
>
>
>
> On 6/23/2010 11:51 AM, Jeff Blaine wrote:
>> * 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
>>
>> _______________________________________________
>> OpenAFS-info mailing list
>> OpenAFS-info@openafs.org
>> https://lists.openafs.org/mailman/listinfo/openafs-info
>>
>