Messages in this thread | | | Date | Tue, 2 Feb 1999 11:33:57 -0800 | From | John Kennedy <> | Subject | Re: linux syslog problems (now linux-2.2.1+glibc-2.0.112) |
| |
[me] > ... Grr. Forgot to grab my new version of strace! It bails > when I SIGPIPE it: ...
Ok, I caught it with the new strace. If I leave strace attached, it looks like it unsticks itself with one SIGPIPE so next time I'll leave it unattached.
time([917982437]) = 917982437 recvfrom(7, "\1\1\6\1\0224Vx\0\0\0\0\0\0\0\0\0"..., 1540, 0, {sin_family=AF_INET, sin_port=htons(68), sin_addr=inet_addr("132.241.58.1")}, [16]) = 300 read(8, "\0`\227\337I\25\0`/q\372@\10\0E\0"..., 1500) = 342 time([917982437]) = 917982437 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:07:17 dhcpd: BOOTR"..., 79, 0) = 79 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 time([917982437]) = 917982437 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:07:17 dhcpd: Ignor"..., 97, 0) = ? ERESTARTSYS (To be restarted)
At this point, I've SIGPIPEd it myself but look at all the other SIGPIPEs it is getting! Very different output, if I'm reading it correctly. None of them were making it to the syslog daemon, of course.
Now, this next chunk came in a wave...
--- SIGPIPE (Broken pipe) --- close(0) = 0 sigreturn() = ? (mask now []) rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 select(10, [7 8 9], [], [], NULL) = 3 (in [7 8 9]) time([917982472]) = 917982472 recvfrom(9, "E\0\0T\4\336\0\0=\1\340\273\204\361"..., 1500, 0, {sin_family=AF_INET, sin_port=htons(4288), sin_addr=inet_addr("132.241.60.35")}, [16]) = 84 recvfrom(7, "\1\1\6\0 t\0\0\0\0\257\1\0\0\0\0"..., 1540, 0, {sin_family=AF_INET, sin_port=htons(68), sin_addr=inet_addr("132.241.175.1")}, [16]) = 300 read(8, "\0`\227\337I\25\0`/q\372@\10\0E\0"..., 1500) = 342 time([917982472]) = 917982472 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 socket(PF_UNIX, SOCK_STREAM, 0) = 0 fcntl(0, F_SETFD, FD_CLOEXEC) = 0 connect(0, {sun_family=AF_UNIX, sun_path="/dev/log"}, 16) = 0 send(0, "<30>Feb 2 11:07:52 dhcpd: BOOTR"..., 80, 0) = 80 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 time([917982472]) = 917982472 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:07:52 dhcpd: Ignor"..., 98, 0) = 98 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 select(10, [7 8 9], [], [], NULL) = 3 (in [7 8 9]) time([917982472]) = 917982472 recvfrom(9, "E\0\0T\4\337\0\0=\1\340\272\204\361"..., 1500, 0, {sin_family=AF_INET, sin_port=htons(4288), sin_addr=inet_addr("132.241.60.35")}, [16]) = 84 recvfrom(7, "\1\1\6\0 t\0\0L\35\0\321\0\0\0\0"..., 1540, 0, {sin_family=AF_INET, sin_port=htons(68), sin_addr=inet_addr("132.241.175.1")}, [16]) = 300 read(8, "\0`\227\337I\25\0`/q\372@\10\0E\0"..., 1500) = 342 time([917982472]) = 917982472 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:07:52 dhcpd: BOOTR"..., 80, 0) = 80 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 time([917982472]) = 917982472 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:07:52 dhcpd: Ignor"..., 98, 0) = 98 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 select(10, [7 8 9], [], [], NULL) = 3 (in [7 8 9]) time([917982472]) = 917982472 recvfrom(9, "E\0\0T\4\340\0\0=\1\340\271\204\361"..., 1500, 0, {sin_family=AF_INET, sin_port=htons(8389), sin_addr=inet_addr("132.241.60.35")}, [16]) = 84 recvfrom(7, "\1\1\6\1\0224Vx\0\0\0\0\0\0\0\0\0"..., 1540, 0, {sin_family=AF_INET, sin_port=htons(68), sin_addr=inet_addr("132.241.58.1")}, [16]) = 300 read(8, "\0`\227\337I\25\0`/q\372@\10\0E\0"..., 1500) = 342 time([917982472]) = 917982472 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:07:52 dhcpd: BOOTR"..., 79, 0) = 79 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 time([917982472]) = 917982472 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:07:52 dhcpd: Ignor"..., 97, 0) = 97 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 select(10, [7 8 9], [], [], NULL) = 3 (in [7 8 9]) time([917982472]) = 917982472 recvfrom(9, "E\300\0i\211\357\0\0\377\0012\342"..., 1500, 0, {sin_family=AF_INET, sin_port=htons(4288), sin_addr=inet_addr("127.0.0.1")}, [16]) = 105 recvfrom(7, "\1\1\6\0 t\0\0\230:\257\1\0\0\0\0"..., 1540, 0, {sin_family=AF_INET, sin_port=htons(68), sin_addr=inet_addr("132.241.175.1")}, [16]) = 300 read(8, "\0`\227\337I\25\0`/q\372@\10\0E\0"..., 1500) = 342 time([917982472]) = 917982472 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:07:52 dhcpd: BOOTR"..., 80, 0) = 80 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 time([917982472]) = 917982472 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:07:52 dhcpd: Ignor"..., 98, 0) = 98 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 select(10, [7 8 9], [], [], NULL) = 3 (in [7 8 9]) time([917982472]) = 917982472 recvfrom(9, "E\0\0T\4\341\0\0=\1\340\270\204\361"..., 1500, 0, {sin_family=AF_INET, sin_port=htons(4288), sin_addr=inet_addr("132.241.60.35")}, [16]) = 84 recvfrom(7, "\1\1\6\0 t\0\0\344W\0\321\0\0\0\0"..., 1540, 0, {sin_family=AF_INET, sin_port=htons(68), sin_addr=inet_addr("132.241.175.1")}, [16]) = 300 read(8, "\0`\227\337I\25\0`/q\372@\10\0E\0"..., 1500) = 342 time([917982472]) = 917982472 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:07:52 dhcpd: BOOTR"..., 80, 0) = 80 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 time([917982472]) = 917982472 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:07:52 dhcpd: Ignor"..., 98, 0) = 98 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 select(10, [7 8 9], [], [], NULL) = 3 (in [7 8 9]) time([917982472]) = 917982472 recvfrom(9, "E\0\0T\4\342\0\0=\1\340\267\204\361"..., 1500, 0, {sin_family=AF_INET, sin_port=htons(4288), sin_addr=inet_addr("132.241.60.35")}, [16]) = 84 recvfrom(7, "\1\1\6\1\0224Vx\0\0\0\0\0\0\0\0\0"..., 1540, 0, {sin_family=AF_INET, sin_port=htons(68), sin_addr=inet_addr("132.241.58.1")}, [16]) = 300 read(8, "\0`\227\337I\25\0`/q\372@\10\0E\0"..., 1500) = 342 time([917982472]) = 917982472 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:07:52 dhcpd: BOOTR"..., 79, 0) = 79 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 time([917982472]) = 917982472 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:07:52 dhcpd: Ignor"..., 97, 0) = 97 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0
I have about 12 things logged for 11:07:52. 11:08:03 is a little bit more interesting because it only had two entries...
select(10, [7 8 9], [], [], NULL) = 1 (in [9]) time([917982472]) = 917982472 recvfrom(9, "E\0\0T\4\343\0\0=\1\340\266\204\361"..., 1500, 0, {sin_family=AF_INET, sin_port=htons(4288), sin_addr=inet_addr("132.241.60.35")}, [16]) = 84 select(10, [7 8 9], [], [], NULL) = 1 (in [9]) time([917982472]) = 917982472 recvfrom(9, "E\0\0T\4\344\0\0=\1\340\265\204\361"..., 1500, 0, {sin_family=AF_INET, sin_port=htons(4288), sin_addr=inet_addr("132.241.60.35")}, [16]) = 84 select(10, [7 8 9], [], [], NULL) = 1 (in [9]) time([917982472]) = 917982472 recvfrom(9, "E\0\0T\4\345\0\0=\1\340\264\204\361"..., 1500, 0, {sin_family=AF_INET, sin_port=htons(4288), sin_addr=inet_addr("132.241.60.35")}, [16]) = 84 select(10, [7 8 9], [], [], NULL) = 1 (in [9]) time([917982477]) = 917982477 recvfrom(9, "E\0\0T\4\346\0\0=\1\340\263\204\361"..., 1500, 0, {sin_family=AF_INET, sin_port=htons(4288), sin_addr=inet_addr("132.241.60.35")}, [16]) = 84 select(10, [7 8 9], [], [], NULL) = 1 (in [9]) time([917982482]) = 917982482 recvfrom(9, "E\0\0T\4\347\0\0=\1\340\262\204\361"..., 1500, 0, {sin_family=AF_INET, sin_port=htons(4288), sin_addr=inet_addr("132.241.60.35")}, [16]) = 84 select(10, [7 8 9], [], [], NULL) = 2 (in [7 8]) time([917982483]) = 917982483 recvfrom(7, "\1\1\6\1\0224Vx\0\0\0\0\0\0\0\0\0"..., 1540, 0, {sin_family=AF_INET, sin_port=htons(68), sin_addr=inet_addr("132.241.58.1")}, [16]) = 300 read(8, "\0`\227\337I\25\0`/q\372@\10\0E\0"..., 1500) = 342 time([917982483]) = 917982483 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:08:03 dhcpd: BOOTR"..., 79, 0) = 79 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0 time([917982483]) = 917982483 rt_sigaction(SIGPIPE, {0x806ceb0, [], 0}, {SIG_DFL}, 8) = 0 send(0, "<30>Feb 2 11:08:03 dhcpd: Ignor"..., 97, 0) = 97 rt_sigaction(SIGPIPE, {SIG_DFL}, NULL, 8) = 0
Those entries ended up being this:
Feb 2 11:08:03 hircine dhcpd: BOOTREQUEST from 00:00:85:00:7e:db via 132.241.58.1 Feb 2 11:08:03 hircine dhcpd: Ignoring BOOTP request from client 00:00:85:00:7e:db via 132.241.58.1
So, even though they're being sysloged, I'm getting a SIGPIPE?
- To unsubscribe from this list: send the line "unsubscribe linux-kernel" in the body of a message to majordomo@vger.rutgers.edu Please read the FAQ at http://www.tux.org/lkml/
| |