From owner-freebsd-current Wed Nov 13 16:41:47 2002 Delivered-To: freebsd-current@freebsd.org Received: from mx1.FreeBSD.org (mx1.freebsd.org [216.136.204.125]) by hub.freebsd.org (Postfix) with ESMTP id 7396F37B401; Wed, 13 Nov 2002 16:41:45 -0800 (PST) Received: from citusc.usc.edu (citusc.usc.edu [128.125.38.123]) by mx1.FreeBSD.org (Postfix) with ESMTP id 1492643E6E; Wed, 13 Nov 2002 16:41:45 -0800 (PST) (envelope-from kris@citusc.usc.edu) Received: (from kris@localhost) by citusc.usc.edu (8.11.6/8.11.2) id gAE0fiJ05073; Wed, 13 Nov 2002 16:41:44 -0800 Date: Wed, 13 Nov 2002 16:41:43 -0800 From: Kris Kennaway To: current@FreeBSD.org Cc: alfred@FreeBSD.org Subject: rpc.lockd problems Message-ID: <20021113164143.C4476@citusc.usc.edu> Mime-Version: 1.0 Content-Type: text/plain; charset=us-ascii Content-Disposition: inline User-Agent: Mutt/1.2.5.1i Sender: owner-freebsd-current@FreeBSD.ORG Precedence: bulk List-ID: List-Archive: (Web Archive) List-Help: (List Instructions) List-Subscribe: List-Unsubscribe: X-Loop: FreeBSD.ORG A few months ago I posted about rpc.lockd interop problems I am having between my 5.0 NFS client and a Redhat 7.1 server. Both are running rpc.lockd, but when I send a lock request to the server it hangs forever blocked on the /var/run/lock socket. tcpdump shows that the lock RPC request is being sent, and answered by the server. I have the complete tcpdump trace if anyone is interested. 16:27:25.828109 citusc17.usc.edu.641493192 > citusc.usc.edu.nfs: 140 access fh 0,1/117442560 003f 16:27:25.828897 citusc.usc.edu.nfs > citusc17.usc.edu.641493192: reply ok 120 access c 0003 (DF) 16:27:25.829031 citusc17.usc.edu.641493193 > citusc.usc.edu.nfs: 96 access fh Unknown/1 003f 16:27:25.829706 citusc.usc.edu.nfs > citusc17.usc.edu.641493193: reply ok 120 access c 001f (DF) 16:27:25.829801 citusc17.usc.edu.641493194 > citusc.usc.edu.nfs: 96 access fh Unknown/1 003f 16:27:25.830483 citusc.usc.edu.nfs > citusc17.usc.edu.641493194: reply ok 120 access c 001f (DF) 16:27:28.257514 citusc17.usc.edu.641493195 > citusc.usc.edu.nfs: 140 access fh 0,1/117442560 003f 16:27:28.258283 citusc.usc.edu.nfs > citusc17.usc.edu.641493195: reply ok 120 access c 0003 (DF) 16:27:28.258427 citusc17.usc.edu.641493196 > citusc.usc.edu.nfs: 96 access fh Unknown/1 003f 16:27:28.259107 citusc.usc.edu.nfs > citusc17.usc.edu.641493196: reply ok 120 access c 001f (DF) 16:27:28.259317 citusc17.usc.edu.641493197 > citusc.usc.edu.nfs: 104 lookup fh Unknown/1 "incoming" 16:27:28.260202 citusc.usc.edu.nfs > citusc17.usc.edu.641493197: reply ok 232 lookup fh Unknown/1 (DF) 16:27:28.260344 citusc17.usc.edu.641493198 > citusc.usc.edu.nfs: 96 access fh Unknown/1 003f 16:27:28.261022 citusc.usc.edu.nfs > citusc17.usc.edu.641493198: reply ok 120 access c 001f (DF) 16:27:28.261119 citusc17.usc.edu.641493199 > citusc.usc.edu.nfs: 100 access fh Unknown/1 003f 16:27:28.261808 citusc.usc.edu.nfs > citusc17.usc.edu.641493199: reply ok 120 access c 000d (DF) 16:27:28.261918 citusc17.usc.edu.641493200 > citusc.usc.edu.nfs: 100 access fh Unknown/1 003f 16:27:28.262608 citusc.usc.edu.nfs > citusc17.usc.edu.641493200: reply ok 120 access c 000d (DF) 16:27:28.263888 citusc17.usc.edu.641493201 > citusc.usc.edu.nfs: 140 setattr fh Unknown/1 16:27:28.264646 citusc.usc.edu.nfs > citusc17.usc.edu.641493201: reply ok 120 setattr (DF) 16:27:28.285259 citusc17.usc.edu.641493202 > citusc.usc.edu.nfs: 104 lookup fh Unknown/1 "incoming" 16:27:28.286179 citusc.usc.edu.nfs > citusc17.usc.edu.641493202: reply ok 232 lookup fh Unknown/1 (DF) 16:27:28.287395 citusc17.usc.edu.55771 > citusc.usc.edu.sunrpc: udp 56 16:27:28.288491 citusc.usc.edu.sunrpc > citusc17.usc.edu.55771: udp 28 (DF) 16:27:28.289631 citusc17.usc.edu.55772 > citusc.usc.edu.49437: udp 200 16:27:28.290549 citusc.usc.edu.49437 > citusc17.usc.edu.55772: udp 28 (DF) Here is what rpc.lockd -d 10 shows: Nov 13 16:39:51 citusc17 rpc.lockd: process ID: 10865 Nov 13 16:39:51 citusc17 rpc.lockd: fh_len 24, fh \01\00\00\02\00\08\00\07\02\00\00\00\40\a0\0e\00\73\09\c6\11\2a\a0\0e\00 Nov 13 16:39:51 citusc17 rpc.lockd: start 0; len 0; pid 1; type 1; whence 0 Nov 13 16:39:51 citusc17 rpc.lockd: wait was not set Nov 13 16:39:51 citusc17 rpc.lockd: lock request: V4: read to 128.125.38.123 Nov 13 16:39:51 citusc17 rpc.lockd: Found CLIENT* in cache Nov 13 16:40:11 citusc17 rpc.lockd: process ID: 10865 Nov 13 16:40:11 citusc17 rpc.lockd: fh_len 24, fh \01\00\00\02\00\08\00\07\02\00\00\00\40\a0\0e\00\73\09\c6\11\2a\a0\0e\00 Nov 13 16:40:11 citusc17 rpc.lockd: start 0; len 0; pid 1; type 1; whence 0 Nov 13 16:40:11 citusc17 rpc.lockd: wait was not set Nov 13 16:40:11 citusc17 rpc.lockd: lock request: V4: read to 128.125.38.123 Nov 13 16:40:11 citusc17 rpc.lockd: Found CLIENT* in cache Nov 13 16:40:31 citusc17 rpc.lockd: process ID: 10865 Nov 13 16:40:31 citusc17 rpc.lockd: fh_len 24, fh \01\00\00\02\00\08\00\07\02\00\00\00\40\a0\0e\00\73\09\c6\11\2a\a0\0e\00 Nov 13 16:40:31 citusc17 rpc.lockd: start 0; len 0; pid 1; type 1; whence 0 Nov 13 16:40:31 citusc17 rpc.lockd: wait was not set Nov 13 16:40:31 citusc17 rpc.lockd: lock request: V4: read to 128.125.38.123 Nov 13 16:40:31 citusc17 rpc.lockd: Found CLIENT* in cache (this repeats every 20 seconds) Kris To Unsubscribe: send mail to majordomo@FreeBSD.org with "unsubscribe freebsd-current" in the body of the message