Ok, Squid was down, so:
in IDLE, no POSTMAP:
------------------------------------------------------------------------
# iostat -c 40
tty mlxd0 cd0 sa0 cpu
tin tout KB/t tps MB/s KB/t tps MB/s KB/t tps MB/s us ni sy in id
0 1 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 4 0 1 0 94
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 0 0 2 0 98
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 1 0 0 0 99
0 76 15.33 6 0.09 0.00 0 0.00 0.00 0 0.00 1 0 0 2 97
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 0 0 1 0 99
0 76 16.00 4 0.06 0.00 0 0.00 0.00 0 0.00 3 0 0 2 95
0 76 16.00 1 0.02 0.00 0 0.00 0.00 0 0.00 0 0 2 1 98
0 76 16.00 2 0.03 0.00 0 0.00 0.00 0 0.00 0 0 1 0 99
0 76 16.00 12 0.19 0.00 0 0.00 0.00 0 0.00 0 0 0 0100
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 1 0 2 0 98
0 76 16.00 1 0.02 0.00 0 0.00 0.00 0 0.00 19 0 2 0 80
0 76 11.38 13 0.14 0.00 0 0.00 0.00 0 0.00 32 0 5 2 62
0 76 16.00 3 0.05 0.00 0 0.00 0.00 0 0.00 0 0 0 0100
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 26 0 0 0 74
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 0 0 1 0 99
0 76 16.00 3 0.05 0.00 0 0.00 0.00 0 0.00 1 0 1 0 98
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 30 0 1 1 68
0 76 18.29 7 0.12 0.00 0 0.00 0.00 0 0.00 2 0 5 1 93
0 76 18.22 9 0.16 0.00 0 0.00 0.00 0 0.00 26 0 2 2 71
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 2 0 1 0 98
tty mlxd0 cd0 sa0 cpu
tin tout KB/t tps MB/s KB/t tps MB/s KB/t tps MB/s us ni sy in id
0 229 7.18 34 0.24 0.00 0 0.00 0.00 0 0.00 2 0 0 1 98
0 76 16.00 1 0.02 0.00 0 0.00 0.00 0 0.00 0 0 0 0100
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 16 0 1 0 83
0 76 10.80 5 0.05 0.00 0 0.00 0.00 0 0.00 1 0 2 0 98
0 76 37.33 3 0.11 0.00 0 0.00 0.00 0 0.00 2 0 1 1 96
0 76 13.14 7 0.09 0.00 0 0.00 0.00 0 0.00 1 0 2 0 98
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 1 0 1 0 98
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 0 0 0 0100
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 0 0 0 1 99
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 1 0 1 0 98
0 76 16.00 1 0.02 0.00 0 0.00 0.00 0 0.00 12 0 2 0 85
0 75 10.00 8 0.08 0.00 0 0.00 0.00 0 0.00 12 0 3 1 84
0 76 16.89 9 0.15 0.00 0 0.00 0.00 0 0.00 44 0 3 0 53
0 76 15.50 12 0.18 0.00 0 0.00 0.00 0 0.00 42 0 4 1 53
0 76 12.38 26 0.31 0.00 0 0.00 0.00 0 0.00 25 0 3 1 72
0 76 16.00 2 0.03 0.00 0 0.00 0.00 0 0.00 2 0 2 1 96
0 76 16.00 4 0.06 0.00 0 0.00 0.00 0 0.00 0 0 0 0100
0 76 21.33 6 0.12 0.00 0 0.00 0.00 0 0.00 0 0 1 0 99
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 0 0 0 0100
0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 0 0 2 0 98
#
Now POSTMAP running:
# top
last pid: 3310; load averages: 1.34, 0.48, 0.28
up 188+02:00:24 10:40:05
88 processes: 1 running, 87 sleeping
CPU states: 3.0% user, 0.0% nice, 6.0% system, 0.7% interrupt, 90.3%
idle
Mem: 49M Active, 33M Inact, 62M Wired, 9160K Cache, 35M Buf, 94M Free
Swap: 200M Total, 3560K Used, 196M Free, 1% Inuse
PID USERNAME PRI NICE SIZE RES STATE TIME WCPU CPU COMMAND
3305 root -2 0 17444K 17072K getblk 0:04 18.83% 11.18% postmap
3310 root 29 0 2024K 1068K RUN 0:00 4.10% 0.39% top
2888 postfix 18 0 1140K 860K lockf 0:09 0.05% 0.05% cleanup
86965 root 10 0 3076K 1600K nanslp 453:59 0.00% 0.00% perl
154 root 2 0 1048K 640K select 242:45 0.00% 0.00% master
65 root 2 0 948K 496K select 82:09 0.00% 0.00% syslogd
83093 postfix 2 0 2380K 2072K select 20:33 0.00% 0.00% nqmgr
76 root 2 0 3008K 928K select 3:00 0.00% 0.00% sshd
72 root 2 0 1096K 520K select 2:37 0.00% 0.00% inetd
539 root 2 0 4128K 976K select 1:56 0.00% 0.00% snmpd
74 root 10 0 1024K 612K nanslp 1:21 0.00% 0.00% cron
68900 postfix 2 0 1204K 856K select 0:45 0.00% 0.00%
trivial-rewrit
69010 postfix 2 0 1132K 784K select 0:39 0.00% 0.00%
trivial-rewrit
2912 postfix 18 0 1140K 860K lockf 0:10 0.00% 0.00% cleanup
2870 postfix 18 0 1140K 860K lockf 0:09 0.00% 0.00% cleanup
2920 postfix 18 0 1148K 868K lockf 0:09 0.00% 0.00% cleanup
2921 postfix 18 0 1140K 860K lockf 0:09 0.00% 0.00% cleanup
2889 postfix 2 0 1152K 872K select 0:09 0.00% 0.00% cleanup
2938 postfix 18 0 1140K 860K lockf 0:09 0.00% 0.00% cleanup
2891 postfix 2 0 1140K 860K select 0:09 0.00% 0.00% cleanup
2908 postfix 18 0 1140K 860K lockf 0:08 0.00% 0.00% cleanup
2914 postfix 18 0 1140K 860K lockf 0:08 0.00% 0.00% cleanup
2923 postfix 18 0 1148K 868K lockf 0:08 0.00% 0.00% cleanup
2915 postfix 18 0 1156K 876K lockf 0:08 0.00% 0.00% cleanup
2916 postfix 18 0 1140K 860K lockf 0:08 0.00% 0.00% cleanup
2941 postfix 18 0 1148K 868K lockf 0:08 0.00% 0.00% cleanup
2868 postfix 18 0 1140K 860K lockf 0:08 0.00% 0.00% cleanup
2887 postfix 18 0 1140K 860K lockf 0:07 0.00% 0.00% cleanup
2897 postfix 18 0 1140K 860K lockf 0:07 0.00% 0.00% cleanup
2932 postfix 18 0 1148K 868K lockf 0:07 0.00% 0.00% cleanup
2940 postfix 18 0 1140K 860K lockf 0:07 0.00% 0.00% cleanup
2893 postfix 18 0 1148K 868K lockf 0:07 0.00% 0.00% cleanup
2894 postfix 18 0 1140K 860K lockf 0:07 0.00% 0.00% cleanup
2927 postfix 18 0 1144K 864K lockf 0:07 0.00% 0.00% cleanup
2896 postfix 2 0 1140K 860K select 0:07 0.00% 0.00% cleanup
2906 postfix 18 0 1140K 860K lockf 0:07 0.00% 0.00% cleanup
2872 postfix 18 0 1148K 868K lockf 0:07 0.00% 0.00% cleanup
2892 postfix 18 0 1140K 860K lockf 0:07 0.00% 0.00% cleanup
2935 postfix 2 0 1140K 860K select 0:07 0.00% 0.00% cleanup
2903 postfix 18 0 1140K 860K lockf 0:06 0.00% 0.00% cleanup
#
#
#
# sockstat -4
USER COMMAND PID FD PROTO LOCAL ADDRESS FOREIGN ADDRESS
root smtpd 3306 6 tcp4 *:25 *:*
postfix smtpd 2926 6 tcp4 *:25 *:*
postfix smtpd 2926 9 tcp4 200.16.193.34:25 200.42.99.13:24899
postfix smtpd 2867 6 tcp4 *:25 *:*
postfix smtpd 2867 9 tcp4 200.16.193.34:25 200.63.153.83:4449
postfix smtpd 2867 23 udp4 *:3718 *:*
root sshd 2384 5 tcp4 200.16.193.34:22
200.16.193.48:53236
root sshd 2223 5 tcp4 200.16.193.34:22
200.16.193.48:52938
root snmpd 539 13 udp4 *:161 *:*
root master 154 11 tcp4 *:25 *:*
root sshd 76 4 tcp4 *:22 *:*
root inetd 72 4 tcp4 *:5660 *:*
root syslogd 65 5 udp4 *:514 *:*
#
#
# uptime
10:40AM up 188 days, 2:01, 2 users, load averages: 0.63, 0.41, 0.27
#
#
# sockstat -4
USER COMMAND PID FD PROTO LOCAL ADDRESS FOREIGN ADDRESS
postfix smtp 3319 11 tcp4 200.16.193.34:3234 62.129.136.113:25
postfix smtp 3317 11 tcp4 200.16.193.34:3247 64.201.107.244:25
postfix smtp 3315 11 tcp4 200.16.193.34:3230 200.42.0.180:25
root smtpd 3306 6 tcp4 *:25 *:*
postfix smtp 3041 11 tcp4 200.16.193.34:3249 149.174.40.136:25
postfix smtp 3036 11 tcp4 200.16.193.34:3239 217.114.167.203:25
postfix smtp 3024 11 tcp4 200.16.193.34:3246 212.249.0.123:25
postfix smtp 3017 11 tcp4 200.16.193.34:3244 206.251.228.150:25
postfix smtp 2999 11 tcp4 200.16.193.34:3243 206.251.228.150:25
postfix smtp 2944 11 tcp4 200.16.193.34:3241 67.96.63.112:25
postfix smtpd 2926 6 tcp4 *:25 *:*
postfix smtpd 2926 9 tcp4 200.16.193.34:25 200.42.99.13:24899
postfix smtpd 2867 6 tcp4 *:25 *:*
postfix smtpd 2867 9 tcp4 200.16.193.34:25 200.63.153.83:4449
postfix smtp 2818 11 tcp4 200.16.193.34:3223 202.54.1.235:25
root sshd 2384 5 tcp4 200.16.193.34:22
200.16.193.48:53236
root sshd 2223 5 tcp4 200.16.193.34:22
200.16.193.48:52938
root snmpd 539 13 udp4 *:161 *:*
root master 154 11 tcp4 *:25 *:*
root sshd 76 4 tcp4 *:22 *:*
root inetd 72 4 tcp4 *:5660 *:*
root syslogd 65 5 udp4 *:514 *:*
#
#
#
# iostat -c 40
tty mlxd0 cd0 sa0 cpu
tin tout KB/t tps MB/s KB/t tps MB/s KB/t tps MB/s us ni sy in id
0 1 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 4 0 1 0 94
0 76 16.88 72 1.19 0.00 0 0.00 0.00 0 0.00 0 0 0 1 99
0 76 16.34 93 1.49 0.00 0 0.00 0.00 0 0.00 2 0 6 1 91
0 76 16.72 68 1.12 0.00 0 0.00 0.00 0 0.00 1 0 2 0 98
0 76 16.05 81 1.27 0.00 0 0.00 0.00 0 0.00 0 0 2 1 98
0 76 16.51 125 2.01 0.00 0 0.00 0.00 0 0.00 21 0 11 0 68
0 76 16.44 80 1.29 0.00 0 0.00 0.00 0 0.00 2 0 3 0 95
0 76 16.79 80 1.31 0.00 0 0.00 0.00 0 0.00 23 0 22 1 53
0 76 16.55 86 1.39 0.00 0 0.00 0.00 0 0.00 1 0 3 0 96
0 76 17.31 49 0.82 0.00 0 0.00 0.00 0 0.00 0 0 5 0 95
0 76 16.12 146 2.29 0.00 0 0.00 0.00 0 0.00 0 0 5 0 95
0 76 16.36 89 1.42 0.00 0 0.00 0.00 0 0.00 2 0 4 0 95
0 76 16.40 79 1.27 0.00 0 0.00 0.00 0 0.00 3 0 2 0 95
0 76 16.37 86 1.38 0.00 0 0.00 0.00 0 0.00 1 0 5 0 95
0 76 16.30 106 1.69 0.00 0 0.00 0.00 0 0.00 1 0 3 0 96
0 76 16.17 92 1.45 0.00 0 0.00 0.00 0 0.00 0 0 2 2 97
0 76 16.88 90 1.49 0.00 0 0.00 0.00 0 0.00 1 0 9 0 91
0 76 16.32 100 1.59 0.00 0 0.00 0.00 0 0.00 1 0 3 2 95
0 76 17.07 59 0.99 0.00 0 0.00 0.00 0 0.00 0 0 2 0 98
0 76 16.33 97 1.55 0.00 0 0.00 0.00 0 0.00 2 0 7 0 91
tty mlxd0 cd0 sa0 cpu
tin tout KB/t tps MB/s KB/t tps MB/s KB/t tps MB/s us ni sy in id
0 227 17.15 110 1.84 0.00 0 0.00 0.00 0 0.00 2 0 5 1 93
0 76 16.71 89 1.46 0.00 0 0.00 0.00 0 0.00 1 0 3 0 96
0 76 16.18 87 1.38 0.00 0 0.00 0.00 0 0.00 0 0 0 0100
0 76 16.27 119 1.89 0.00 0 0.00 0.00 0 0.00 2 0 9 1 88
0 76 16.18 86 1.36 0.00 0 0.00 0.00 0 0.00 0 0 2 0 98
0 76 16.46 104 1.67 0.00 0 0.00 0.00 0 0.00 1 0 2 0 98
0 76 16.34 93 1.49 0.00 0 0.00 0.00 0 0.00 1 0 9 1 89
0 76 16.25 63 1.01 0.00 0 0.00 0.00 0 0.00 0 0 3 0 97
0 76 16.28 112 1.78 0.00 0 0.00 0.00 0 0.00 1 0 2 0 97
0 76 16.29 68 1.09 0.00 0 0.00 0.00 0 0.00 0 0 0 1 99
0 76 16.31 101 1.61 0.00 0 0.00 0.00 0 0.00 0 0 5 0 95
0 76 16.38 84 1.35 0.00 0 0.00 0.00 0 0.00 0 0 4 0 96
0 76 16.25 103 1.63 0.00 0 0.00 0.00 0 0.00 0 0 2 2 97
0 76 16.22 71 1.13 0.00 0 0.00 0.00 0 0.00 1 0 0 0 99
0 76 16.00 124 1.93 0.00 0 0.00 0.00 0 0.00 0 0 5 0 95
0 76 16.00 22 0.34 0.00 0 0.00 0.00 0 0.00 0 0 2 0 98
0 76 16.24 124 1.96 0.00 0 0.00 0.00 0 0.00 5 0 12 0 84
0 76 16.96 66 1.10 0.00 0 0.00 0.00 0 0.00 2 0 4 0 95
0 76 16.46 104 1.67 0.00 0 0.00 0.00 0 0.00 0 0 3 0 97
0 76 16.05 83 1.30 0.00 0 0.00 0.00 0 0.00 0 0 5 0 95
#
#
#
Finally, from another tty:
# time /usr/sbin/postmap /var/Postfix/from_senders_slet.map
1177.14 real 9.45 user 39.34 sys
#
And all the time, squid was not there.
Andres.-
----- Mensaje original -----
De: "Len Conrad" <[EMAIL PROTECTED]>
Para: <[EMAIL PROTECTED]>
Enviado: lunes, 17 de noviembre de 2003 09:58
Asunto: [IMGate] Re: Postmap hogs SMTP
>
>
> >
> >This command I show'd was during the postmap, in another tty, at the time
of
> >the WUPG alert.
> >But the new telnet/ssh also showed slowly, even a 'man' was sloooow down.
>
>
> ># uptime
> > 9:13AM up 188 days, 34 mins, 2 users, load averages: 0.09, 0.30, 0.20
>
> so the machine isn't loaded
>
> >...
> >CPU: Pentium II/Pentium II Xeon/Celeron (348.21-MHz 686-class CPU)
> > Origin = "GenuineIntel" Id = 0x652 Stepping = 2
>
> while this machine is fine for low volumes and IMGAte only, it can be slow
> with highvolumes, lots of POSIX regex scanning, plus whatever
>
> but 15+ minutes for postmap is still way too long
>
> >uring the postmap, is:
> >
> >--------------------------------------------------------------------
> ># iostat -c 40
> > tty mlxd0 cd0 sa0
cpu
> > tin tout KB/t tps MB/s KB/t tps MB/s KB/t tps MB/s us ni sy in
id
> > 0 1 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 4 0 1 0
94
> > 0 77 18.18 66 1.17 0.00 0 0.00 0.00 0 0.00 0 0 5 0
95
> > 0 37 17.27 83 1.41 0.00 0 0.00 0.00 0 0.00 0 1 3 0
96
> > 0 76 16.79 80 1.31 0.00 0 0.00 0.00 0 0.00 0 0 2 0
98
> > 0 76 16.80 99 1.62 0.00 0 0.00 0.00 0 0.00 0 0 2 0
98
> > 0 76 16.96 66 1.10 0.00 0 0.00 0.00 0 0.00 0 1 5 0
94
>
> ok, I think you problem is there. the disk is very active (CPU not because
> it's waiting on disk) but I don't know why postmap would add so much i/o.
>
>
> >a few minutes before the postmap, was:
> >--------------------------------------------------------------------
> ># iostat -c 40
> > tty mlxd0 cd0 sa0
cpu
> > tin tout KB/t tps MB/s KB/t tps MB/s KB/t tps MB/s us ni sy in
id
> > 0 1 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 4 0 1 0
94
> > 0 76 2.00 1 0.00 0.00 0 0.00 0.00 0 0.00 2 0 3 0
95
> > 0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 1 0 2 0
98
> > 0 76 5.67 36 0.20 0.00 0 0.00 0.00 0 0.00 2 0 3 0
95
> > 0 76 16.00 2 0.03 0.00 0 0.00 0.00 0 0.00 8 0 2 0
91
> > 0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 0 0 0
0100
> > 0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 2 0 1 0
97
> > 0 76 0.00 0 0.00 0.00 0 0.00 0.00 0 0.00 5 0 1 0
95
> > 0 76 9.75 8 0.08 0.00 0 0.00 0.00 0 0.00 22 0 4 0
74
> > 0 76 16.00 13 0.20 0.00 0 0.00 0.00 0 0.00 33 0 4 2
61
> > 0 76 14.00 22 0.30 0.00 0 0.00 0.00 0 0.00 27 0 8 2
62
> > 0 76 15.08 24 0.35 0.00 0 0.00 0.00 0 0.00 41 0 5 2
51
> > 0 76 13.04 25 0.32 0.00 0 0.00 0.00 0 0.00 88 0 10 2
0
> > 0 75 12.73 40 0.50 0.00 0 0.00 0.00 0 0.00 89 0 10 2
0
> > 0 76 13.67 48 0.64 0.00 0 0.00 0.00 0 0.00 73 0 23 4
0
> > 0 74 11.56 35 0.39 0.00 0 0.00 0.00 0 0.00 81 0 18 1
0
> > 0 76 12.55 33 0.40 0.00 0 0.00 0.00 0 0.00 87 0 12 1
0
> > 0 67 13.68 32 0.43 0.00 0 0.00 0.00 0 0.00 88 0 11 1
0
> > 0 75 14.16 36 0.50 0.00 0 0.00 0.00 0 0.00 84 0 13 3
0
> > 0 74 10.04 91 0.90 0.00 0 0.00 0.00 0 0.00 82 0 15 3
0
> > tty mlxd0 cd0 sa0
cpu
> > tin tout KB/t tps MB/s KB/t tps MB/s KB/t tps MB/s us ni sy in
id
> > 0 221 16.60 41 0.67 0.00 0 0.00 0.00 0 0.00 85 0 13 2
0
> > 0 76 14.43 60 0.84 0.00 0 0.00 0.00 0 0.00 77 0 20 3
0
> > 0 76 15.14 28 0.41 0.00 0 0.00 0.00 0 0.00 86 0 12 2
0
> > 0 76 19.00 30 0.55 0.00 0 0.00 0.00 0 0.00 27 0 14 2
57
> > 0 76 13.83 23 0.31 0.00 0 0.00 0.00 0 0.00 41 0 8 0
51
> > 0 76 14.00 11 0.15 0.00 0 0.00 0.00 0 0.00 3 0 9 1
88
> > 0 76 27.33 6 0.16 0.00 0 0.00 0.00 0 0.00 2 0 5 2
90
> > 0 76 64.00 1 0.06 0.00 0 0.00 0.00 0 0.00 3 0 5 0
91
> > 0 76 23.38 13 0.29 0.00 0 0.00 0.00 0 0.00 0 0 4 2
95
> > 0 76 64.00 1 0.06 0.00 0 0.00 0.00 0 0.00 2 0 3 1
95
> > 0 76 19.09 11 0.20 0.00 0 0.00 0.00 0 0.00 22 0 1 2
75
> > 0 76 22.29 7 0.15 0.00 0 0.00 0.00 0 0.00 5 0 5 3
87
> > 0 76 29.67 6 0.17 0.00 0 0.00 0.00 0 0.00 5 0 2 3
91
> > 0 76 40.00 2 0.08 0.00 0 0.00 0.00 0 0.00 2 0 3 1
94
> > 0 76 18.50 16 0.29 0.00 0 0.00 0.00 0 0.00 31 0 3 1
65
> > 0 76 15.18 22 0.32 0.00 0 0.00 0.00 0 0.00 27 0 8 2
63
> > 0 76 64.00 2 0.12 0.00 0 0.00 0.00 0 0.00 5 0 5 0
89
> > 0 76 64.00 1 0.06 0.00 0 0.00 0.00 0 0.00 2 0 2 3
93
> > 0 76 22.00 6 0.13 0.00 0 0.00 0.00 0 0.00 2 0 1 2
96
> > 0 76 64.00 2 0.12 0.00 0 0.00 0.00 0 0.00 2 0 2 2
95
>
> you can your disk can stay quite busy even without postmap. So I think
the
> disk is quite loaded. can you stop squid for 20 minutes to see if it's
> disk i/o is the problem?
>
> Len
>
>
>
