[OpenAFS] Delays starting AFS client 1.5.5400/1.5.5403 for Windows XP

[Jeffrey Altman]

This is a cryptographically signed message in MIME format.

--------------ms080902020305060801030801
Content-Type: text/plain; charset=ISO-8859-1
Content-Transfer-Encoding: 7bit

John:

Quite simple really.

You have \\afs\cs.wisc.edu\s\std\bin in the PATH environment variable
under which the afsd_service.exe is started.  The end result is that
every time afsd_service.exe tries to load a dll the computer tries to
access \\afs\cs.wisc.edu\s\std\bin and times out because "guess what?"
the afs service has not yet started.

Jeffrey Altman
Secure Endpoints Inc.


John Perkins wrote:
> We've seen a handful of computers at our site get stuck during the 
> AFS initialization sequence.  Here is a snippet from the afsd_init.log:
> 
> 10/23/2008 3:07:31 PM: cm_GetRootCellName code 0, cm_freelanceEnabled= 1, rcn= c
> s.wisc.edu
> 10/23/2008 3:07:31 PM: Mountpoint[0] = .cs%cs.wisc.edu:root.cell.
> 10/23/2008 3:07:31 PM: Mountpoint[1] = .cs.wisc.edu%cs.wisc.edu:root.cell.
> 10/23/2008 3:07:31 PM: Mountpoint[2] = cs.wisc.edu#cs.wisc.edu:root.cell.
> 10/23/2008 3:07:31 PM: Mountpoint[3] = @cell#cs.wisc.edu:root.cell.
> 10/23/2008 3:07:31 PM: Mountpoint[4] = cs#cs.wisc.edu:root.cell.
> 10/23/2008 3:07:31 PM: Mountpoint[5] = .@cell%cs.wisc.edu:root.cell.
> 10/23/2008 3:07:31 PM: cm_GetSCache code 0 scache 2a1f408
> 10/23/2008 3:07:31 PM: cm_InitDaemon complete
> 10/23/2008 3:07:31 PM: RPC server listening
> 10/23/2008 3:07:31 PM: MpsSvc Service could not be opened for query: 0x424
> 10/23/2008 3:07:31 PM: StoreAnsiFilenames = 0
> 10/23/2008 3:07:31 PM: EnableSMBAsyncStore = 1
> 10/23/2008 3:07:31 PM: AutoStart 0x2
> 10/23/2008 3:07:31 PM: SMBAsyncStoreSize = 131072
> 10/23/2008 3:07:31 PM: daemonCheckDownInterval is 180
> 10/23/2008 3:07:31 PM: LAN adapter number 3
> 10/23/2008 3:07:31 PM: daemonCheckUpInterval is 240
> 10/23/2008 3:07:31 PM: Using >AFS< as SMB server name
> 10/23/2008 3:07:31 PM: daemonCheckVolInterval is 3600
> 10/23/2008 3:07:31 PM: smb_localNamep is >AFS<
> 10/23/2008 3:07:31 PM: daemonCheckCBInterval is 60
> 10/23/2008 3:07:31 PM: Netbios NCBRESET lana 3 succeeded
> 10/23/2008 3:07:31 PM: daemonCheckVolCBInterval is 0
> 10/23/2008 3:07:31 PM: lana_list.length 1
> 10/23/2008 3:07:31 PM: daemonCheckLockInterval is 60
> 10/23/2008 3:07:31 PM: daemonCheckTokenInterval is 180
> 10/23/2008 3:07:31 PM: daemonCheckOfflineVolInterval is 600
> 10/23/2008 3:07:31 PM: daemonPerformanceTuningInterval is 0
> 10/23/2008 3:07:34 PM: Netbios NCBADDNAME lana=3 code=0 retcode=0 complete=0
> 10/23/2008 3:07:34 PM: Netbios NCBADDNAME added new name >AFS             <
> 10/23/2008 3:07:34 PM: Netbios NCBADDNAME succeeded on lana 3
> 
> 10/23/2008 3:07:34 PM: smb_NetbiosInit smb_LANadapter=3
> 10/23/2008 3:07:34 PM: Setting SMB server domain name to [RACHEL]
> 10/23/2008 3:07:34 PM: smb_StartListeners
> 10/23/2008 3:07:34 PM: smb_Init complete
> 10/23/2008 3:07:34 PM: Windows Firewall Configuration succeeded
> 10/23/2008 3:07:34 PM: GlobalAutoMap thread completed
> 10/23/2008 3:28:23 PM: Mountpoint[0] = .cs%cs.wisc.edu:root.cell.
> 10/23/2008 3:28:23 PM: Mountpoint[1] = .cs.wisc.edu%cs.wisc.edu:root.cell.
> 10/23/2008 3:28:23 PM: Mountpoint[2] = cs.wisc.edu#cs.wisc.edu:root.cell.
> 10/23/2008 3:28:23 PM: Mountpoint[3] = @cell#cs.wisc.edu:root.cell.
> 10/23/2008 3:28:23 PM: Mountpoint[4] = cs#cs.wisc.edu:root.cell.
> 10/23/2008 3:28:23 PM: Mountpoint[5] = .@cell%cs.wisc.edu:root.cell.
> 
> Once we see the Mountpoint[x] entries show up, the AFS client is 
> running properly.  My question is what would cause this to wait 20 
> minutes before this continues on.  
> 
> I did collect an "fs trace" log (trace starting when server starts) in 
> /afs/cs.wisc.edu/u/j/o/john/public/html/winafs-logs/1.5.5403-delay
> 
> If anyone can shed some light on what might be causing this delay, 
> please enlighten me.
> 

--------------ms080902020305060801030801
Content-Type: application/x-pkcs7-signature; name="smime.p7s"
Content-Transfer-Encoding: base64
Content-Disposition: attachment; filename="smime.p7s"
Content-Description: S/MIME Cryptographic Signature

MIAGCSqGSIb3DQEHAqCAMIACAQExCzAJBgUrDgMCGgUAMIAGCSqGSIb3DQEHAQAAoIIJeTCC
AxcwggKAoAMCAQICEDsE+kRcmomW1hYG6BoqhGEwDQYJKoZIhvcNAQEFBQAwYjELMAkGA1UE
BhMCWkExJTAjBgNVBAoTHFRoYXd0ZSBDb25zdWx0aW5nIChQdHkpIEx0ZC4xLDAqBgNVBAMT
I1RoYXd0ZSBQZXJzb25hbCBGcmVlbWFpbCBJc3N1aW5nIENBMB4XDTA4MDUzMDE5MTUyOVoX
DTA5MDUzMDE5MTUyOVowczEPMA0GA1UEBBMGQWx0bWFuMRUwEwYDVQQqEwxKZWZmcmV5IEVy
aWMxHDAaBgNVBAMTE0plZmZyZXkgRXJpYyBBbHRtYW4xKzApBgkqhkiG9w0BCQEWHGphbHRt
YW5Ac2VjdXJlLWVuZHBvaW50cy5jb20wggEiMA0GCSqGSIb3DQEBAQUAA4IBDwAwggEKAoIB
AQCtf5bVJdYFtHIrV2XALpA5oaMu7FPYU7RP7vJhd8Cu9Kd9ud2crX2pHK4avuPaYb4Vg9qI
zPrPadePhJ3OWwNt1ZlUlpc5URnOfpg/I9iymZBUSnCFVLuIvoncacqyUlzqdYEF8XGEoEL6
6bj8uoCSX0D7ZjZiAS8993NvgiPYpf10acMyWQ4max+P7Wg9T03Nw2F6EsmP6gWxBRsekTXe
N6QjJdvaK0846lDqeBFoCEzIUMQXj2kiXVPCPEdxPc/L1sDMYf0GLaDIg8qyThpGd0X6DwfK
3RWcMy8DV7Q5Z+jSEdPn5X0l4anOTrjr3IwE57MC3bVs0EEpUODTzftnAgMBAAGjOTA3MCcG
A1UdEQQgMB6BHGphbHRtYW5Ac2VjdXJlLWVuZHBvaW50cy5jb20wDAYDVR0TAQH/BAIwADAN
BgkqhkiG9w0BAQUFAAOBgQA9kndmeLrdQOUbhNGGms/FnfDyraH4OjA4PIIMOCbGWK0YXczs
/Fqn4XkT70SG4s8v4Zg6TaAcJrZBVcZQXyzrhlF2Zev/g69zZMHQe+2r4i/3FBVKAtFCoea1
vgwJ5TfZYlKvt4D0Z4zexu9Y0VwCIR4plWjVD76zC2CGB/2fhjCCAxcwggKAoAMCAQICEDsE
+kRcmomW1hYG6BoqhGEwDQYJKoZIhvcNAQEFBQAwYjELMAkGA1UEBhMCWkExJTAjBgNVBAoT
HFRoYXd0ZSBDb25zdWx0aW5nIChQdHkpIEx0ZC4xLDAqBgNVBAMTI1RoYXd0ZSBQZXJzb25h
bCBGcmVlbWFpbCBJc3N1aW5nIENBMB4XDTA4MDUzMDE5MTUyOVoXDTA5MDUzMDE5MTUyOVow
czEPMA0GA1UEBBMGQWx0bWFuMRUwEwYDVQQqEwxKZWZmcmV5IEVyaWMxHDAaBgNVBAMTE0pl
ZmZyZXkgRXJpYyBBbHRtYW4xKzApBgkqhkiG9w0BCQEWHGphbHRtYW5Ac2VjdXJlLWVuZHBv
aW50cy5jb20wggEiMA0GCSqGSIb3DQEBAQUAA4IBDwAwggEKAoIBAQCtf5bVJdYFtHIrV2XA
LpA5oaMu7FPYU7RP7vJhd8Cu9Kd9ud2crX2pHK4avuPaYb4Vg9qIzPrPadePhJ3OWwNt1ZlU
lpc5URnOfpg/I9iymZBUSnCFVLuIvoncacqyUlzqdYEF8XGEoEL66bj8uoCSX0D7ZjZiAS89
93NvgiPYpf10acMyWQ4max+P7Wg9T03Nw2F6EsmP6gWxBRsekTXeN6QjJdvaK0846lDqeBFo
CEzIUMQXj2kiXVPCPEdxPc/L1sDMYf0GLaDIg8qyThpGd0X6DwfK3RWcMy8DV7Q5Z+jSEdPn
5X0l4anOTrjr3IwE57MC3bVs0EEpUODTzftnAgMBAAGjOTA3MCcGA1UdEQQgMB6BHGphbHRt
YW5Ac2VjdXJlLWVuZHBvaW50cy5jb20wDAYDVR0TAQH/BAIwADANBgkqhkiG9w0BAQUFAAOB
gQA9kndmeLrdQOUbhNGGms/FnfDyraH4OjA4PIIMOCbGWK0YXczs/Fqn4XkT70SG4s8v4Zg6
TaAcJrZBVcZQXyzrhlF2Zev/g69zZMHQe+2r4i/3FBVKAtFCoea1vgwJ5TfZYlKvt4D0Z4ze
xu9Y0VwCIR4plWjVD76zC2CGB/2fhjCCAz8wggKooAMCAQICAQ0wDQYJKoZIhvcNAQEFBQAw
gdExCzAJBgNVBAYTAlpBMRUwEwYDVQQIEwxXZXN0ZXJuIENhcGUxEjAQBgNVBAcTCUNhcGUg
VG93bjEaMBgGA1UEChMRVGhhd3RlIENvbnN1bHRpbmcxKDAmBgNVBAsTH0NlcnRpZmljYXRp
b24gU2VydmljZXMgRGl2aXNpb24xJDAiBgNVBAMTG1RoYXd0ZSBQZXJzb25hbCBGcmVlbWFp
bCBDQTErMCkGCSqGSIb3DQEJARYccGVyc29uYWwtZnJlZW1haWxAdGhhd3RlLmNvbTAeFw0w
MzA3MTcwMDAwMDBaFw0xMzA3MTYyMzU5NTlaMGIxCzAJBgNVBAYTAlpBMSUwIwYDVQQKExxU
aGF3dGUgQ29uc3VsdGluZyAoUHR5KSBMdGQuMSwwKgYDVQQDEyNUaGF3dGUgUGVyc29uYWwg
RnJlZW1haWwgSXNzdWluZyBDQTCBnzANBgkqhkiG9w0BAQEFAAOBjQAwgYkCgYEAxKY8VXNV
+065yplaHmjAdQRwnd/p/6Me7L3N9VvyGna9fww6YfK/Uc4B1OVQCjDXAmNaLIkVcI7dyfAr
hVqqP3FWy688Cwfn8R+RNiQqE88r1fOCdz0Dviv+uxg+B79AgAJk16emu59l0cUqVIUPSAR/
p7bRPGEEQB5kGXJgt/sCAwEAAaOBlDCBkTASBgNVHRMBAf8ECDAGAQH/AgEAMEMGA1UdHwQ8
MDowOKA2oDSGMmh0dHA6Ly9jcmwudGhhd3RlLmNvbS9UaGF3dGVQZXJzb25hbEZyZWVtYWls
Q0EuY3JsMAsGA1UdDwQEAwIBBjApBgNVHREEIjAgpB4wHDEaMBgGA1UEAxMRUHJpdmF0ZUxh
YmVsMi0xMzgwDQYJKoZIhvcNAQEFBQADgYEASIzRUIPqCy7MDaNmrGcPf6+svsIXoUOWlJ1/
TCG4+DYfqi2fNi/A9BxQIJNwPP2t4WFiw9k6GX6EsZkbAMUaC4J0niVQlGLH2ydxVyWN3amc
OY6MIE9lX5Xa9/eH1sYITq726jTlEBpbNU1341YheILcIRk13iSx0x1G/11fZU8xggNkMIID
YAIBATB2MGIxCzAJBgNVBAYTAlpBMSUwIwYDVQQKExxUaGF3dGUgQ29uc3VsdGluZyAoUHR5
KSBMdGQuMSwwKgYDVQQDEyNUaGF3dGUgUGVyc29uYWwgRnJlZW1haWwgSXNzdWluZyBDQQIQ
OwT6RFyaiZbWFgboGiqEYTAJBgUrDgMCGgUAoIIBwzAYBgkqhkiG9w0BCQMxCwYJKoZIhvcN
AQcBMBwGCSqGSIb3DQEJBTEPFw0wODEwMjQwMjA3NDdaMCMGCSqGSIb3DQEJBDEWBBSCyeBa
V21I0hxjWUg2AUbr7YU1iDBSBgkqhkiG9w0BCQ8xRTBDMAoGCCqGSIb3DQMHMA4GCCqGSIb3
DQMCAgIAgDANBggqhkiG9w0DAgIBQDAHBgUrDgMCBzANBggqhkiG9w0DAgIBKDCBhQYJKwYB
BAGCNxAEMXgwdjBiMQswCQYDVQQGEwJaQTElMCMGA1UEChMcVGhhd3RlIENvbnN1bHRpbmcg
KFB0eSkgTHRkLjEsMCoGA1UEAxMjVGhhd3RlIFBlcnNvbmFsIEZyZWVtYWlsIElzc3Vpbmcg
Q0ECEDsE+kRcmomW1hYG6BoqhGEwgYcGCyqGSIb3DQEJEAILMXigdjBiMQswCQYDVQQGEwJa
QTElMCMGA1UEChMcVGhhd3RlIENvbnN1bHRpbmcgKFB0eSkgTHRkLjEsMCoGA1UEAxMjVGhh
d3RlIFBlcnNvbmFsIEZyZWVtYWlsIElzc3VpbmcgQ0ECEDsE+kRcmomW1hYG6BoqhGEwDQYJ
KoZIhvcNAQEBBQAEggEAbaYJ2hdsbqIlDv3DnX+WX/cS2ZShB7J14nHsFaHYu++M5wfqx4kz
Tid+RXndwJrdVNCGTA8M+j74PENsTsLi7Dj2lP4pQna3jqNgTKXtl0RpqjoqbgP2ev8ZAqvP
bUEZD7/pJYMAI2WiUYBBYDpFEJgG++05Myn0VQtM0YEBiMMSwncRTSYnld6JH0AYN5nIOpYZ
do+r8Bj05vHnP3FuixNGvkv76vsJaVoWCA/UAkmPPv3wRMLBwIPIJebIptlwuCBSxyHQmEfQ
239TPfGiR/f/Nc5aI/4zjhIVjKfY8lTCACFSo7kYMvk7j45RWt1fEDxIFs7c5+VHW8IjY5MU
JQAAAAAAAA==
--------------ms080902020305060801030801--