Hello Wietse,
For this day 15 times, all are postfix restarts, after parameters changes to
see what appended (activate/deactivate qmgr verbose) or when there is too many
mails in the incoming (to reduce the smtpd from 100 to 40 in the master.cf)
Oct 28 11:18:42 vador postfix/qmgr[11389]: dict_eval: const mail
Oct 28 11:25:53 vador postfix/qmgr[16544]: dict_eval: const mail
Oct 28 11:27:39 vador postfix/qmgr[17347]: dict_eval: const mail
Oct 28 11:59:27 vador postfix/qmgr[6309]: dict_eval: const mail
Oct 28 12:01:04 vador postfix/qmgr[7741]: C74BB481BA: from=<>, size=4328,
nrcpt=1 (queue active)
Oct 28 12:05:08 vador postfix/qmgr[12042]: dict_eval: const mail
Oct 28 12:11:19 vador postfix/qmgr[15251]: B3A02484E0: from=<[EMAIL
PROTECTED]>, size=8580, nrcpt=1 (queue active)
Oct 28 12:46:32 vador postfix/qmgr[16259]: 527E348896: from=<[EMAIL
PROTECTED]>, size=3218, nrcpt=1 (queue active)
Oct 28 15:03:13 vador postfix/qmgr[8000]: D4CC5485BF: from=<[EMAIL PROTECTED]>,
size=10884, nrcpt=1 (queue active)
Oct 28 15:04:20 vador postfix/qmgr[9029]: 7CBD748169: from=<[EMAIL PROTECTED]>,
size=3611, nrcpt=1 (queue active)
Oct 28 15:05:01 vador postfix/qmgr[9536]: 74406481F6: from=<[EMAIL PROTECTED]>,
size=2868, nrcpt=10 (queue active)
Oct 28 15:05:42 vador postfix/qmgr[10173]: AE4F048268: from=<[EMAIL
PROTECTED]>, size=37107, nrcpt=1 (queue active)
Oct 28 15:23:53 vador postfix/qmgr[20995]: 307AB48421: from=<[EMAIL
PROTECTED]>, size=2004, nrcpt=1 (queue active)
Oct 28 15:25:24 vador postfix/qmgr[21984]: 90C67483AE: from=<[EMAIL
PROTECTED]>, size=143536, nrcpt=1 (queue active)
Oct 28 16:11:28 vador postfix/qmgr[9223]: 5A56848492: from=<[EMAIL PROTECTED]>,
size=3253, nrcpt=1 (queue active)
Just before the two qshape I restarted postfix after removing the"
in_flow_delay = 10s" in the main.cf because this is calamitous, the mails are
stored more time in the incomming.
Below, you have a count of the files in the postfix queues.
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 07:00:01 | 499| 3| 287| 207| 2| 0|
0|
Oct 28 07:05:02 | 518| 2| 288| 208| 20| 0|
0|
Oct 28 07:10:02 | 947| 10| 282| 202| 453| 0|
0|
Oct 28 07:15:01 | 625| 6| 288| 208| 123| 0|
0|
Oct 28 07:20:02 | 723| 4| 289| 209| 221| 0|
0|
Oct 28 07:25:01 | 500| 1| 289| 209| 1| 0|
0|
Oct 28 07:30:01 | 498| 0| 289| 209| 0| 0|
0|
Oct 28 07:35:01 | 498| 0| 289| 209| 0| 0|
0|
Oct 28 07:40:01 | 499| 0| 289| 209| 1| 0|
0|
Oct 28 07:45:01 | 677| 5| 288| 208| 176| 0|
0|
Oct 28 07:50:01 | 516| 4| 288| 208| 15| 1|
0|
Oct 28 07:55:02 | 495| 1| 287| 207| 0| 0|
0|
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 08:00:01 | 497| 0| 288| 208| 1| 0|
0|
Oct 28 08:05:01 | 1394| 3| 288| 208| 895| 0|
0|
Oct 28 08:10:01 | 1455| 5| 288| 208| 954| 0|
0|
Oct 28 08:15:01 | 500| 1| 289| 209| 1| 0|
0|
Oct 28 08:20:02 | 638| 5| 289| 209| 135| 0|
0|
Oct 28 08:25:02 | 670| 6| 287| 207| 169| 1|
0|
Oct 28 08:30:01 | 494| 0| 287| 207| 0| 0|
0|
Oct 28 08:35:01 | 497| 2| 287| 207| 1| 0|
0|
Oct 28 08:40:01 | 601| 31| 287| 207| 76| 0|
0|
Oct 28 08:45:01 | 513| 6| 288| 208| 11| 0|
0|
Oct 28 08:50:02 | 501| 3| 288| 208| 2| 0|
0|
Oct 28 08:55:01 | 502| 2| 290| 210| 0| 0|
0|
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 09:00:01 | 499| 1| 289| 209| 0| 0|
0|
Oct 28 09:05:01 | 500| 3| 288| 208| 1| 0|
0|
Oct 28 09:10:01 | 498| 2| 287| 207| 2| 0|
0|
Oct 28 09:15:01 | 684| 4| 287| 207| 185| 1|
0|
Oct 28 09:20:01 | 550| 7| 293| 213| 37| 0|
0|
Oct 28 09:25:02 | 718| 7| 295| 215| 199| 2|
0|
Oct 28 09:30:02 | 950| 4| 295| 215| 436| 0|
0|
Oct 28 09:35:01 | 1202| 12| 297| 217| 675| 1|
0|
Oct 28 09:40:02 | 1397| 6| 297| 217| 877| 0|
0|
Oct 28 09:45:01 | 1772| 9| 296| 216| 1251| 0|
0|
Oct 28 09:50:01 | 1795| 8| 294| 214| 1279| 0|
0|
Oct 28 09:55:01 | 1969| 7| 293| 213| 1456| 0|
0|
Oct 28 10:00:02 | 2100| 6| 292| 212| 1590| 0|
0|
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 10:05:01 | 1359| 7| 294| 214| 844| 0|
0|
Oct 28 10:10:01 | 726| 18| 297| 217| 194| 0|
0|
Oct 28 10:15:01 | 522| 8| 297| 217| 0| 0|
0|
Oct 28 10:20:01 | 1007| 6| 295| 215| 491| 0|
0|
Oct 28 10:25:02 | 1296| 4| 295| 215| 782| 0|
0|
Oct 28 10:30:01 | 1151| 6| 292| 212| 641| 0|
0|
Oct 28 10:35:02 | 1139| 11| 291| 211| 626| 0|
0|
Oct 28 10:40:01 | 694| 11| 293| 212| 177| 1|
0|
Oct 28 10:45:01 | 543| 10| 297| 217| 19| 0|
0|
Oct 28 10:50:02 | 1154| 3| 297| 217| 637| 0|
0|
Oct 28 10:55:01 | 1008| 8| 295| 215| 490| 0|
0|
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 11:00:02 | 554| 15| 292| 212| 35| 0|
0|
Oct 28 11:05:01 | 861| 6| 292| 211| 352| 0|
0|
Oct 28 11:10:01 | 970| 8| 291| 210| 461| 0|
0|
Oct 28 11:15:02 | 531| 6| 302| 221| 2| 0|
0|
Oct 28 11:20:01 | 694| 4| 296| 216| 178| 0|
0|
Oct 28 11:25:01 | 1476| 4| 296| 215| 961| 0|
0|
Oct 28 11:30:01 | 2207| 5| 293| 213| 1696| 0|
0|
Oct 28 11:35:01 | 2920| 3| 292| 212| 2413| 0|
0|
Oct 28 11:40:01 | 3453| 5| 287| 206| 2955| 0|
0|
Oct 28 11:45:01 | 4010| 4| 287| 207| 3512| 0|
0|
Oct 28 11:50:01 | 4576| 3| 283| 203| 4087| 0|
0|
Oct 28 11:55:02 | 5108| 5| 282| 202| 4619| 0|
0|
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 12:00:01 | 5707| 3| 284| 203| 5217| 0|
0|
Oct 28 12:05:01 | 5560| 7| 284| 203| 5066| 0|
0|
Oct 28 12:10:02 | 5912| 4| 283| 201| 5424| 0|
0|
Oct 28 12:15:01 | 5615| 7| 283| 202| 5123| 0|
0|
Oct 28 12:20:01 | 4744| 13| 285| 204| 4241| 1|
0|
Oct 28 12:25:01 | 4008| 4| 288| 207| 3509| 0|
0|
Oct 28 12:30:01 | 3662| 243| 290| 210| 2919| 0|
0|
Oct 28 12:35:02 | 2631| 31| 297| 217| 2084| 2|
0|
Oct 28 12:40:01 | 2388| 23| 304| 223| 1827| 11|
0|
Oct 28 12:45:01 | 2102| 10| 306| 226| 1559| 1|
0|
Oct 28 12:50:02 | 1308| 13| 311| 230| 752| 2|
0|
Oct 28 12:55:01 | 1479| 13| 301| 219| 946| 0|
0|
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 13:00:01 | 1112| 7| 302| 221| 582| 0|
0|
Oct 28 13:05:01 | 1020| 11| 303| 223| 483| 0|
0|
Oct 28 13:10:02 | 560| 20| 298| 217| 25| 0|
0|
Oct 28 13:15:01 | 536| 19| 299| 217| 1| 0|
0|
Oct 28 13:20:01 | 526| 18| 295| 213| 0| 0|
0|
Oct 28 13:25:01 | 530| 19| 295| 213| 3| 0|
0|
Oct 28 13:30:02 | 555| 5| 295| 215| 40| 0|
0|
Oct 28 13:35:02 | 945| 9| 289| 209| 438| 0|
0|
Oct 28 13:40:02 | 1373| 4| 291| 211| 867| 0|
0|
Oct 28 13:45:02 | 1832| 5| 291| 211| 1325| 0|
0|
Oct 28 13:50:01 | 2098| 8| 288| 208| 1594| 0|
0|
Oct 28 13:55:02 | 2695| 5| 286| 206| 2198| 0|
0|
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 14:00:02 | 3026| 6| 289| 209| 2522| 0|
0|
Oct 28 14:05:01 | 2922| 8| 289| 209| 2415| 1|
0|
Oct 28 14:10:02 | 3098| 6| 286| 206| 2600| 0|
0|
Oct 28 14:15:01 | 3614| 8| 286| 206| 3113| 1|
0|
Oct 28 14:20:01 | 4034| 6| 288| 208| 3531| 1|
0|
Oct 28 14:25:01 | 3894| 5| 289| 209| 3391| 0|
0|
Oct 28 14:30:01 | 3115| 7| 292| 212| 2603| 1|
0|
Oct 28 14:35:01 | 3010| 11| 294| 214| 2491| 0|
0|
Oct 28 14:40:01 | 2640| 6| 297| 217| 2120| 0|
0|
Oct 28 14:45:02 | 2727| 13| 303| 223| 2187| 1|
0|
Oct 28 14:50:01 | 2565| 4| 305| 225| 2031| 0|
0|
Oct 28 14:55:01 | 2244| 8| 305| 225| 1706| 0|
0|
Oct 28 15:00:02 | 2047| 7| 307| 227| 1506| 0|
0|
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 15:05:01 | 1760| 3| 296| 216| 1245| 0|
0|
Oct 28 15:10:01 | 1572| 19| 310| 229| 1012| 2|
0|
Oct 28 15:15:02 | 1243| 15| 329| 248| 649| 2|
0|
Oct 28 15:20:01 | 1172| 10| 334| 253| 574| 1|
0|
Oct 28 15:25:02 | 1212| 11| 311| 230| 659| 1|
0|
Oct 28 15:30:02 | 1158| 4| 329| 249| 575| 1|
0|
Oct 28 15:35:01 | 1266| 7| 330| 250| 678| 1|
0|
Oct 28 15:40:02 | 1143| 18| 324| 244| 556| 1|
0|
Oct 28 15:45:02 | 1184| 15| 322| 242| 603| 2|
0|
Oct 28 15:50:01 | 882| 21| 320| 240| 300| 1|
0|
Oct 28 15:55:01 | 1127| 23| 310| 229| 564| 1|
0|
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 16:00:02 | 1166| 35| 309| 226| 595| 1|
0|
Oct 28 16:05:02 | 1561| 35| 304| 221| 1000| 1|
0|
Oct 28 16:10:01 | 1506| 44| 301| 217| 942| 2|
0|
Oct 28 16:15:02 | 1585| 7| 298| 214| 1064| 2|
0|
Oct 28 16:20:03 | 2006| 35| 302| 221| 1447| 1|
0|
Oct 28 16:25:02 | 2376| 9| 332| 251| 1784| 0|
0|
Oct 28 16:30:01 | 2583| 8| 331| 251| 1993| 0|
0|
Oct 28 16:35:01 | 3036| 11| 331| 250| 2444| 0|
0|
Oct 28 16:40:01 | 3429| 5| 334| 254| 2836| 0|
0|
Oct 28 16:45:02 | 3506| 5| 330| 250| 2921| 0|
0|
Oct 28 16:50:02 | 3681| 9| 331| 250| 3091| 0|
0|
Oct 28 16:55:01 | 4023| 11| 334| 253| 3425| 0|
0|
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 17:00:01 | 3973| 11| 334| 254| 3374| 0|
0|
Oct 28 17:05:02 | 4348| 8| 334| 254| 3752| 0|
0|
Oct 28 17:10:01 | 5014| 16| 333| 252| 4412| 1|
0|
Oct 28 17:15:01 | 5358| 13| 332| 251| 4760| 2|
0|
Oct 28 17:20:02 | 5416| 17| 333| 252| 4813| 1|
0|
Oct 28 17:25:02 | 4769| 12| 345| 265| 4147| 0|
0|
Oct 28 17:30:01 | 3826| 9| 350| 270| 3197| 0|
0|
Oct 28 17:35:01 | 2598| 5| 353| 273| 1967| 0|
0|
Oct 28 17:40:01 | 1522| 15| 356| 276| 875| 0|
0|
Oct 28 17:45:01 | 955| 18| 375| 294| 268| 0|
0|
Oct 28 17:50:01 | 684| 3| 380| 300| 1| 0|
0|
Oct 28 17:55:01 | 677| 1| 378| 298| 0| 0|
0|
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 18:00:01 | 677| 1| 378| 298| 0| 0|
0|
Oct 28 18:05:01 | 717| 8| 376| 296| 37| 0|
0|
Oct 28 18:10:01 | 665| 0| 372| 292| 1| 0|
0|
Oct 28 18:15:02 | 782| 10| 370| 290| 112| 0|
0|
Oct 28 18:20:01 | 666| 2| 371| 291| 2| 0|
0|
Oct 28 18:25:01 | 672| 2| 375| 295| 0| 0|
0|
Oct 28 18:30:02 | 673| 6| 373| 292| 2| 0|
0|
Oct 28 18:35:01 | 667| 4| 372| 291| 0| 0|
0|
Oct 28 18:40:01 | 820| 9| 373| 292| 146| 0|
0|
Oct 28 18:45:02 | 827| 23| 360| 278| 166| 0|
0|
Oct 28 18:50:01 | 890| 31| 356| 274| 229| 0|
0|
Oct 28 18:55:01 | 798| 32| 350| 269| 147| 0|
0|
Oct 28 19:00:02 | 899| 7| 373| 293| 226| 0|
0|
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 19:05:01 | 668| 1| 373| 293| 1| 0|
0|
Oct 28 19:10:01 | 670| 0| 374| 294| 2| 0|
0|
Oct 28 19:15:01 | 668| 1| 373| 293| 1| 0|
0|
Oct 28 19:20:01 | 703| 4| 373| 293| 33| 0|
0|
Oct 28 19:25:01 | 664| 0| 370| 290| 4| 0|
0|
Oct 28 19:30:01 | 664| 1| 370| 290| 3| 0|
0|
Oct 28 19:35:01 | 652| 1| 364| 284| 3| 0|
0|
Oct 28 19:40:01 | 645| 0| 361| 281| 3| 0|
0|
Oct 28 19:45:01 | 829| 16| 340| 260| 213| 0|
0|
Oct 28 19:50:02 | 637| 8| 340| 260| 29| 0|
0|
Oct 28 19:55:01 | 609| 2| 343| 263| 1| 0|
0|
________________|_Total__|_Active_|_Defer__|Deferred|Incoming|_Bounce_|_Corrupt|
Oct 28 20:00:01 | 609| 1| 343| 263| 2| 0|
0|
Oct 28 20:05:02 | 756| 12| 341| 261| 142| 0|
0|
Oct 28 20:10:01 | 686| 5| 320| 240| 121| 0|
0|
Oct 28 20:15:02 | 559| 0| 319| 239| 1| 0|
0|
Oct 28 20:20:01 | 554| 0| 316| 236| 2| 0|
0|
Oct 28 20:25:02 | 638| 4| 315| 235| 84| 0|
0|
Best regard.
Francis
________________________________________
De : Wietse Venema [EMAIL PROTECTED]
Date d'envoi : mardi 28 octobre 2008 19:54
À : Francis SOUYRI
Cc : postfix-users@postfix.org
Objet : Re: Big incoming queue, slow qmgr, idle system.
Francis SOUYRI:
> qshape incoming
>
> T 5 10 20 40 80 160 320 640
> 1280 1280+
> TOTAL 3201 2121 937 87 11 21 23 0 0
> 0 0
This is typical for what happens after the qmgr is restarted (with
"postfix reload" or otherwise). Mail is moved from the active queue
to the incoming queue, and is left there for some 10 minutes.
> qshape active
>
> T 5 10 20 40 80 160 320 640
> 1280 1280+
> TOTAL 32 0 0 32 0 0 0 0 0
This is also typical for what happens after qmgr is restarted.
Only mail that has been left alone for some 10 minutes will show
up in the active queue.
So, can you answer Victor's question: how often does the qmgr
process ID change in the maillog file?
Wietse
