On Thu, Sep 25, 2014 at 11:27:29PM -0700, Will Yardley wrote:
> On Thu, Sep 25, 2014 at 09:59:44PM -0700, Will Yardley wrote:
> > I will try running strace on an smtpd process and see if that helps
> > identify anything.
>
> Notice the nanosleep() call here, and the jump from 23:17:21.642640 to
> 23:17:22.642808 -- exactly a second.
>
> 23:17:21.608881 read(9, "RCPT TO:<xx...@example.com>\r\n", 4096) = 31
> <0.000009>
> [...]
> 23:17:21.642026 read(13,
> "flags\0000\0transport\0local\0nexthop\0XXXX.example.com\0recipient\0xx...@example.com\0flags\000256\0\0",
> 4096) = 92 <0.000012>
> [...]
> 23:17:21.642517 flock(21, LOCK_UN) = 0 <0.000007>
> 23:17:21.642546 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 <0.000008>
> 23:17:21.642582 rt_sigaction(SIGCHLD, NULL, {SIG_DFL, [], 0}, 8) = 0
> <0.000008>
> 23:17:21.642615 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 <0.000008>
> 23:17:21.642640 nanosleep({1, 0}, 0x7fffbf08c600) = 0 <1.000107>
> 23:17:22.642808 flock(23, LOCK_SH) = 0 <0.000010>
> 23:17:22.643090 flock(23, LOCK_UN) = 0 <0.000008>
Can you provide a bit more context from that trace. Replace the "..." with
20 or so more lines above the "flock(21, LOCK_UN)"
--
Viktor.
