From owner-freebsd-current@FreeBSD.ORG Mon Nov 14 13:30:42 2011 Return-Path: Delivered-To: freebsd-current@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id 9ADDD1065672 for ; Mon, 14 Nov 2011 13:30:42 +0000 (UTC) (envelope-from dan@sunsaturn.com) Received: from sunsaturn.com (mail1.sunsaturn.com [IPv6:2001:49f0:4004::2]) by mx1.freebsd.org (Postfix) with ESMTP id 59A1A8FC13 for ; Mon, 14 Nov 2011 13:30:42 +0000 (UTC) Received: by sunsaturn.com (Postfix, from userid 1001) id 62970119C69; Mon, 14 Nov 2011 07:30:41 -0600 (CST) DKIM-Signature: v=1; a=rsa-sha256; c=simple/simple; d=sunsaturn.com; s=gamma; t=1321277441; bh=/7jb33TVT1yFt1Oq7DySbmvCvjXKGI2AgsgyVUqA+gY=; h=Date:From:To:Subject:In-Reply-To:Message-ID:References: MIME-Version:Content-Type; b=ZRd9nXBe1pWR1V7o+5JFNXugbYnwC2WmC8TCa6CrKXQ/DNF/5bQwiefQ1hkW3hYO0 NRXIi5vJoEz3ufZsABNEG2e2JkNRPfgm1nMVUKWE1uthFPD3A01r6oRH0L1QoEpKRk PhZOZgPI0+LTjrP5RVnOT6nTQbzmPLTbHfyMVUPs= Received: from localhost (localhost [127.0.0.1]) by sunsaturn.com (Postfix) with ESMTP id 5D6DE119C66 for ; Mon, 14 Nov 2011 07:30:41 -0600 (CST) Date: Mon, 14 Nov 2011 07:30:41 -0600 (CST) From: Dan The Man To: freebsd-current@freebsd.org In-Reply-To: Message-ID: References: <82C85C01-62C4-4E75-B3F2-59D703CA5D78@gsoft.com.au> User-Agent: Alpine 2.00 (BSF 1167 2008-08-23) MIME-Version: 1.0 Content-Type: TEXT/PLAIN; format=flowed; charset=US-ASCII Subject: Re: samba+zfs X-BeenThere: freebsd-current@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: Discussions about the use of FreeBSD-current List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Mon, 14 Nov 2011 13:30:42 -0000 Thankyou for suggestion Peter , didn't solve it, and no its not the disks , I have been monitoring gstat and its doing what it should, NFS works just fine. Here is typical NFS session from tcpdump 07:13:42.192671 IP asterisk.nfsd > desktop.kink: Flags [.], ack 19048093, win 29124, length 0 07:13:42.192673 IP desktop.kink > asterisk.nfsd: Flags [.], seq 19048093:19049553, ack 16176768, win 16178, length 1460 07:13:42.192679 IP asterisk.nfsd > desktop.kink: Flags [.], ack 19049553, win 29124, length 0 07:13:42.192680 IP desktop.kink > asterisk.nfsd: Flags [.], seq 19049553:19051013, ack 16176768, win 16178, length 1460 07:13:42.192686 IP asterisk.nfsd > desktop.kink: Flags [.], ack 19051013, win 29124, length 0 07:13:42.192765 IP desktop.kink > asterisk.nfsd: Flags [.], seq 19051013:19052473, ack 16176768, win 16178, length 1460 07:13:42.192771 IP asterisk.nfsd > desktop.kink: Flags [.], ack 19052473, win 29124, length 0 07:13:42.192772 IP desktop.kink > asterisk.nfsd: Flags [.], seq 19052473:19053933, ack 16176768, win 16178, length 1460 07:13:42.192778 IP asterisk.nfsd > desktop.kink: Flags [.], ack 19053933, win 29124, length 0 07:13:42.192780 IP desktop.kink > asterisk.nfsd: Flags [.], seq 19053933:19055393, ack 16176768, win 16178, length 1460 07:13:42.192786 IP asterisk.nfsd > desktop.kink: Flags [.], ack 19055393, win 29124, length 0 07:13:42.192787 IP desktop.kink > asterisk.nfsd: Flags [.], seq 19055393:19056853, ack 16176768, win 16178, length 1460 07:13:42.192793 IP asterisk.nfsd > desktop.kink: Flags [.], ack 19056853, win 29124, length 0 07:13:42.192795 IP desktop.kink > asterisk.nfsd: Flags [.], seq 19056853:19058313, ack 16176768, win 16178, length 1460 Its always sitting in rpcsvc around 2% cpu doing what it should. Samba on other hand what I find interesting is I tried to see what truss would show on smbd while writing today and found the following: ################################################################################# geteuid() = 0 (0x0) write(36,"[2011/11/14 07:26:07.939217, 10]"...,67) = 67 (0x43) geteuid() = 0 (0x0) write(36," Running timed event "smbd_idle"...,60) = 60 (0x3c) gettimeofday({1321277167.939372 },0x0) = 0 (0x0) geteuid() = 0 (0x0) write(36,"[2011/11/14 07:26:07.939372, 10]"...,77) = 77 (0x4d) geteuid() = 0 (0x0) write(36," smbd_idle_event_handler: idle_"...,57) = 57 (0x39) gettimeofday({1321277167.939521 },0x0) = 0 (0x0) geteuid() = 0 (0x0) write(36,"[2011/11/14 07:26:07.939521, 10]"...,77) = 77 (0x4d) geteuid() = 0 (0x0) write(36," smbd_idle_event_handler: idle_"...,62) = 62 (0x3e) gettimeofday({1321277167.939671 },0x0) = 0 (0x0) gettimeofday({1321277167.939700 },0x0) = 0 (0x0) gettimeofday({1321277167.939728 },0x0) = 0 (0x0) geteuid() = 0 (0x0) write(36,"[2011/11/14 07:26:07.939728, 10]"...,67) = 67 (0x43) geteuid() = 0 (0x0) write(36," Running timed event "smbd_idle"...,60) = 60 (0x3c) gettimeofday({1321277167.939877 },0x0) = 0 (0x0) geteuid() = 0 (0x0) write(36,"[2011/11/14 07:26:07.939877, 10]"...,77) = 77 (0x4d) geteuid() = 0 (0x0) write(36," smbd_idle_event_handler: idle_"...,61) = 61 (0x3d) gettimeofday({1321277167.940031 },0x0) = 0 (0x0) geteuid() = 0 (0x0) write(36,"[2011/11/14 07:26:07.940031, 5]"...,70) = 70 (0x46) geteuid() = 0 (0x0) write(36," housekeeping\n",15) = 15 (0xf) gettimeofday({1321277167.940177 },0x0) = 0 (0x0) geteuid() = 0 (0x0) write(36,"[2011/11/14 07:26:07.940177, 4]"...,65) = 65 (0x41) geteuid() = 0 (0x0) write(36," setting sec ctx (0, 0) - sec_c"...,49) = 49 (0x31) gettimeofday({1321277167.940327 },0x0) = 0 (0x0) geteuid() = 0 (0x0) write(36,"[2011/11/14 07:26:07.940327, 5]"...,94) = 94 (0x5e) geteuid() = 0 (0x0) write(36," Security token: (NULL)\n",25) = 25 (0x19) gettimeofday({1321277167.940475 },0x0) = 0 (0x0) geteuid() = 0 (0x0) write(36,"[2011/11/14 07:26:07.940475, 5]"...,78) = 78 (0x4e) geteuid() = 0 (0x0) write(36," UNIX token of user 0\n",23) = 23 (0x17) geteuid() = 0 (0x0) write(36," Primary group is 0 and contain"...,57) = 57 (0x39) geteuid() = 0 (0x0) getegid() = 0 (0x0) __sysctl(0x7fffffffd170,0x2,0x7fffffffd18c,0x7fffffffd180,0x0,0x0) = 0 (0x0) It actually seems to be running some timed event smbd_idle literally holding up process for many seconds all the time.... Dan, -- Dan The Man CTO/ Senior System Administrator Websites, Domains and Everything else http://www.SunSaturn.com Email: Dan@SunSaturn.com