Daily Usenet report for csiph.com

Oct 3 04:15:00 -- Oct 5 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 42863 49.1%10.9 MB 65.0%
innd 36626 41.9%4.7 MB 28.3%
innfeed 6709 7.7%1009.1 KB 5.9%
nnrpd 1088 1.2%127.2 KB 0.7%
nocem 85 0.1%9.9 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 87372 100.0%16.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 614614 57.3%
Negative hits 416379 38.8%
Do not exist 41855 3.9%
Cache misses 713 0.1%
TOTAL: 4 1073561 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:06.519 0.0%205 0.000 31.800 290.000
article cleanup00:00:00.271 0.0%40139 0.000 0.007 0.030
article logging00:00:01.932 0.0%40929 0.000 0.047 3.200
article parse00:00:26.687 0.0%164728 0.000 0.162 1.151
article write00:07:49.171 0.3%32898 0.573 14.261 112.824
artlog/artcncl00:00:00.017 0.0%184 0.000 0.092 1.500
artlog/artparse00:00:00.053 0.0%1815 0.000 0.029 1.000
data move00:00:00.292 0.0%1037491 0.000 0.000 0.002
hisgrep/artcncl00:00:00.748 0.0%204 0.000 3.667 38.400
hishave/artcncl00:00:00.282 0.0%205 0.000 1.376 9.500
hishave/artparse00:00:00.004 0.0%1814 0.000 0.002 0.125
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:07:01.406 0.2%1073768 0.001 0.392 1.367
history sync00:00:05.673 0.0%719 0.000 7.890 341.000
history write00:07:50.043 0.3%40140 0.377 11.710 39.827
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hiswrite/artparse00:00:25.129 0.0%1812 0.000 13.868 386.000
idle47:15:11.161 98.4%977048 102.580 174.107 523.913
nntp read00:00:04.772 0.0%1053603 0.001 0.005 0.048
overview write00:20:19.102 0.7%32898 1.065 37.057 346.357
perl filter00:01:09.973 0.0%40134 1.240 1.743 3.928
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.578 0.0%65872 0.000 0.009 0.032
TOTAL: 48:01:44.00748:00:33.813100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.100 0.0%38038 0.000 0.003 0.027
article prepare00:00:00.006 0.0%40674 0.000 0.000 0.002
article read00:00:36.850 0.0%5892 0.000 6.254 163.000
backlog stats00:00:00.425 0.0%677795 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.871 0.0%535934 0.000 0.005 0.013
data write00:00:03.272 0.0%502318 0.000 0.007 0.015
idle47:57:50.360100.0%677795 118.649 254.753 784.626
status file00:00:02.129 0.0%557 0.000 3.822 155.000
TOTAL: 47:58:55.14447:58:36.013100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle40:48:20.545100.0%824 247.000178277.360600090.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.011 0.0%1897 0.000 0.006 0.167
readart00:00:01.598 0.0%100 0.000 15.980 66.500
TOTAL: 40:49:30.23640:48:22.154100.0%----

Control commands to INND:

CommandNumber
L 1
flush 6
flushlogs 2
go 2
logmode 2
mode 147
name 1
pause 2
paused 2
reload 4
reserve 2
TOTAL: 11 171

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.weretis.net 7 67130 6900 59750 480 10%97:53:50
2csiph-out.feeder.erje.net 2880 159457 6034 152817 606 3%237:24:32
3feeder.eternal-september.org 9 36597 4370 32070 157 11%49:31:10
4news.freedyn.net 4 40710 3380 34408 2922 8%48:18:03
5news-out.aioe.org 5 32156 2795 29335 26 8%48:09:38
6csiph-out.news.xs4all.nl 1722 37825 2490 32994 2341 6%142:52:38
7newsfeed.neva.ru 299 42735 1833 39828 1074 4%143:20:36
8newsfeed.fu-berlin.de 19 33159 1649 31135 375 4%54:37:50
9news-out.mixmin.net 4 34482 1414 32699 369 4%47:59:37
10newsfeeds.xmission.com 3 26793 1124 25656 13 4%38:44:28
11csiph-out.feed.uzoreto.com 1728 52515 432 51439 644 0%142:32:58
12news.fcku.it 19 4253 407 3824 22 9%45:22:09
13nntp.pasdenom.info 4 22667 77 22567 23 0%47:57:42
14news.swapon.de 10 2393 43 2348 2 1%47:51:57
15news.samoylyk.net 4 27371 35 27334 2 0%42:28:52
16localhost 85 24 24 0 0 100%00:00:03
17news.bbs.nz 2 32086 12 32074 0 0%47:59:42
18xanadu-bbs.net 38 1028 1 1027 0 0%45:52:31
TOTAL: 18 6842 653381 33020 611305 9056 5%1328:58:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net24.2 MB0.0 KB8.7 MB33.0 MB 73%5.1 KB
2csiph-out.news.weretis.net20.8 MB0.0 KB11.9 MB32.7 MB 63%4.5 KB
3feeder.eternal-september.org11.3 MB0.0 KB1.6 MB12.9 MB 87%2.9 KB
4news.freedyn.net8.6 MB0.0 KB138.4 MB147.0 MB 5%23.9 KB
5csiph-out.news.xs4all.nl6.7 MB0.0 KB26.1 MB32.8 MB 20%6.9 KB
6news-out.aioe.org6.2 MB0.0 KB61.9 KB6.3 MB 99%2.3 KB
7newsfeed.fu-berlin.de4.3 MB0.0 KB1.0 MB5.3 MB 80%2.7 KB
8newsfeed.neva.ru4.2 MB0.0 KB3.5 MB7.6 MB 54%2.7 KB
9news-out.mixmin.net4.1 MB0.0 KB671.7 KB4.7 MB 86%2.7 KB
10newsfeeds.xmission.com3.4 MB0.0 KB688.4 KB4.1 MB 83%3.7 KB
11csiph-out.feed.uzoreto.com1.5 MB0.0 KB12.8 MB14.4 MB 10%13.7 KB
12news.fcku.it676.6 KB0.0 KB28.5 KB705.1 KB 95%1.6 KB
13nntp.pasdenom.info182.1 KB0.0 KB43.0 KB225.1 KB 80%2.3 KB
14news.samoylyk.net127.8 KB0.0 KB135.6 KB263.4 KB 48%7.1 KB
15news.swapon.de113.3 KB0.0 KB103.2 KB216.5 KB 52%4.8 KB
16localhost35.1 KB0.0 KB0.0 KB35.1 KB100%1.5 KB
17news.bbs.nz18.3 KB0.0 KB0.0 KB18.3 KB100%1.5 KB
18xanadu-bbs.net2.9 KB0.0 KB0.0 KB2.9 KB100%2.9 KB
TOTAL: 1896.4 MB0.0 KB205.7 MB302.1 MB 31%7.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 3 04:15:00 - 04:59:59 313 1.0% 0.121.4 MB 1.5% 0.54
Oct 3 05:00:00 - 05:59:59 368 1.1% 0.101.0 MB 1.0% 0.29
Oct 3 06:00:00 - 06:59:59 553 1.7% 0.152.2 MB 2.3% 0.64
Oct 3 07:00:00 - 07:59:59 594 1.8% 0.171.7 MB 1.8% 0.48
Oct 3 08:00:00 - 08:59:59 786 2.4% 0.222.1 MB 2.2% 0.59
Oct 3 09:00:00 - 09:59:59 796 2.4% 0.222.1 MB 2.1% 0.59
Oct 3 10:00:00 - 10:59:59 744 2.3% 0.211.8 MB 1.9% 0.52
Oct 3 11:00:00 - 11:59:59 874 2.7% 0.242.4 MB 2.5% 0.67
Oct 3 12:00:00 - 12:59:59 824 2.5% 0.232.0 MB 2.1% 0.56
Oct 3 13:00:00 - 13:59:59 889 2.7% 0.252.5 MB 2.6% 0.70
Oct 3 14:00:00 - 14:59:59 936 2.8% 0.262.4 MB 2.5% 0.69
Oct 3 15:00:00 - 15:59:59 992 3.0% 0.283.7 MB 3.8% 1.04
Oct 3 16:00:00 - 16:59:59 948 2.9% 0.262.7 MB 2.8% 0.77
Oct 3 17:00:00 - 17:59:59 931 2.8% 0.262.8 MB 2.9% 0.80
Oct 3 18:00:00 - 18:59:59 903 2.7% 0.252.4 MB 2.5% 0.69
Oct 3 19:00:00 - 19:59:59 859 2.6% 0.242.4 MB 2.5% 0.68
Oct 3 20:00:00 - 20:59:59 821 2.5% 0.232.3 MB 2.4% 0.66
Oct 3 21:00:00 - 21:59:59 729 2.2% 0.202.0 MB 2.1% 0.57
Oct 3 22:00:00 - 22:59:59 568 1.7% 0.161.8 MB 1.9% 0.52
Oct 3 23:00:00 - 23:59:59 399 1.2% 0.111.2 MB 1.3% 0.35
Oct 4 00:00:00 - 00:59:59 355 1.1% 0.101.2 MB 1.2% 0.34
Oct 4 01:00:00 - 01:59:59 341 1.0% 0.091.0 MB 1.1% 0.29
Oct 4 02:00:00 - 02:59:59 463 1.4% 0.131.6 MB 1.7% 0.46
Oct 4 03:00:00 - 03:59:59 304 0.9% 0.08956.7 KB 1.0% 0.27
Oct 4 04:00:00 - 04:59:59 345 1.1% 0.101.5 MB 1.6% 0.43
Oct 4 05:00:00 - 05:59:59 404 1.2% 0.112.0 MB 2.1% 0.58
Oct 4 06:00:00 - 06:59:59 593 1.8% 0.161.8 MB 1.9% 0.51
Oct 4 07:00:00 - 07:59:59 712 2.2% 0.201.9 MB 2.0% 0.55
Oct 4 08:00:00 - 08:59:59 756 2.3% 0.212.0 MB 2.0% 0.56
Oct 4 09:00:00 - 09:59:59 867 2.6% 0.242.3 MB 2.4% 0.64
Oct 4 10:00:00 - 10:59:59 814 2.5% 0.232.0 MB 2.1% 0.58
Oct 4 11:00:00 - 11:59:59 882 2.7% 0.242.4 MB 2.5% 0.69
Oct 4 12:00:00 - 12:59:59 827 2.5% 0.232.1 MB 2.2% 0.59
Oct 4 13:00:00 - 13:59:59 814 2.5% 0.232.0 MB 2.1% 0.56
Oct 4 14:00:00 - 14:59:59 896 2.7% 0.252.4 MB 2.5% 0.68
Oct 4 15:00:00 - 15:59:59 1009 3.1% 0.283.3 MB 3.5% 0.95
Oct 4 16:00:00 - 16:59:59 940 2.9% 0.262.6 MB 2.7% 0.73
Oct 4 17:00:00 - 17:59:59 952 2.9% 0.262.6 MB 2.7% 0.73
Oct 4 18:00:00 - 18:59:59 927 2.8% 0.263.0 MB 3.1% 0.85
Oct 4 19:00:00 - 19:59:59 777 2.4% 0.222.1 MB 2.2% 0.60
Oct 4 20:00:00 - 20:59:59 739 2.2% 0.212.2 MB 2.3% 0.62
Oct 4 21:00:00 - 21:59:59 718 2.2% 0.202.0 MB 2.1% 0.57
Oct 4 22:00:00 - 22:59:59 646 2.0% 0.181.9 MB 2.0% 0.55
Oct 4 23:00:00 - 23:59:59 518 1.6% 0.141.8 MB 1.9% 0.51
Oct 5 00:00:00 - 00:59:59 358 1.1% 0.101018.1 KB 1.0% 0.28
Oct 5 01:00:00 - 01:59:59 341 1.0% 0.09914.6 KB 0.9% 0.25
Oct 5 02:00:00 - 02:59:59 376 1.1% 0.101.3 MB 1.3% 0.36
Oct 5 03:00:00 - 03:59:59 290 0.9% 0.08987.1 KB 1.0% 0.27
Oct 5 04:00:00 - 04:15:00 66 0.2% 0.07183.6 KB 0.2% 0.20
TOTAL: 48:00:00 32857 100.0% 0.1995.8 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.freedyn.net 2926 27 0 0 0 0 0 0 2899
2csiph-out.news.xs4all.nl 2393 39 0 0 0 0 0 0 2354
3newsfeed.neva.ru 1079 211 0 0 0 0 0 0 868
4newsfeed.fu-berlin.de 985 51 0 0 0 0 0 0 934
5csiph-out.feed.uzoreto.com 649 15 0 0 0 0 0 0 634
6csiph-out.feeder.erje.net 610 131 0 0 0 0 0 0 479
7csiph-out.news.weretis.net 517 220 0 0 0 0 0 0 297
8news-out.mixmin.net 391 0 0 0 0 0 0 0 391
9feeder.eternal-september.org 160 30 0 0 2 0 0 0 128
10news-out.aioe.org 41 24 0 0 0 0 0 0 17
11nntp.pasdenom.info 23 0 0 0 0 0 0 0 23
12news.fcku.it 23 22 0 0 0 0 0 0 1
13newsfeeds.xmission.com 16 0 0 0 0 0 0 0 16
14news.swapon.de 9 0 0 0 0 0 0 0 9
15news.samoylyk.net 2 0 0 0 0 0 0 0 2
TOTAL: 15 9824 770 0 0 2 0 0 0 9052

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 144
it-alt.sport.calcio.juventus 67
mozilla.support.thunderbird 59
spline.eisfair 43
lada.auto 37
mozilla.support.seamonkey 29
alt.bbs.synchronet 26
mozilla.dev.security.policy 22
oesterreich.tratsch 18
mozilla.general 16
alt.binaries.pictures.purebeauty 13
alt.binaries.ebooks 12
mozilla.support.firefox 12
mozilla.dev.platform 10
alt.religion 9
att.jobs 8
rocksolid.shared.entertainment 8
alt.tv.star-trek 8
alt.politics.usa 8
aus.jobs 8
TOTAL: 119 770

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
alt.snl 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5115
EMP (phn path) 412
EMP (phl) 272
EMP (phn nph) 236
Too many newsgroups 187
HTML Multipart 78
User-issued cancel 38
Binary: misplaced rar 29
Binary Payload 13
Scoring filter (12) 13
Scoring filter (8) 13
User-issued spam cancel 9
Scoring filter (16) 8
Too many newsgroups (meow) 7
Scoring filter (10) 7
Scoring filter (9) 5
Scoring filter (13) 4
HTML Image Tags 3
U2 violation - invalid distribution 1
HTML post 1
TOTAL: 21 6452

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com4805151
TOTAL: 148285151

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 95
csiph-out.news.xs4all.nl 1
csiph-out.feed.uzoreto.com 1
TOTAL: 3 97
Huge articles
news.freedyn.net 1134
csiph-out.news.xs4all.nl 231
csiph-out.feeder.erje.net 142
csiph-out.news.weretis.net 140
csiph-out.feed.uzoreto.com 134
newsfeeds.xmission.com 13
feeder.eternal-september.org 6
news.swapon.de 2
news.samoylyk.net 2
newsfeed.fu-berlin.de 2
TOTAL: 10 1806
Including strange strings
newsfeed.fu-berlin.de 621
csiph-out.news.xs4all.nl 64
csiph-out.news.weretis.net 46
news-out.aioe.org 15
news-out.mixmin.net 14
news.swapon.de 7
csiph-out.feeder.erje.net 6
news.freedyn.net 4
csiph-out.feed.uzoreto.com 4
feeder.eternal-september.org 3
TOTAL: 12 788
No colon-space in header
csiph-out.news.xs4all.nl 1
TOTAL: 1 1
TOTAL: 4 2692

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.samoylyk.net 34242 4942 27811 135 5 5041 14%48:06:47
2xanadu-bbs 36896 1097 31793 0 0 35 2%48:02:58
3news.freedyn.net 30034 931 28488 40 0 0 3%48:09:33
4fu-berlin.de 30994 877 30117 0 0 0 2%48:09:25
5news.bbs.nz 58829 382 31598 19 0 0 0%48:01:55
6usenet.pasdenom.info 33573 162 31717 918 0 16 0%48:01:37
7aioe 28629 68 27616 3 0 0 0%48:00:47
8newsfeed.xs4all.nl 31128 54 29396 8 0 94 0%48:00:03
9neva.ru 30245 35 29435 214 0 0 0%48:09:33
10erje 27071 29 26719 7 0 0 0%48:07:30
11news.mixmin.net 30867 29 30140 0 0 0 0%48:02:44
12news.swapon.de 2543 27 2475 0 0 0 1%47:34:16
13xmission 35209 24 30721 0 0 0 0%48:09:27
14news.uzoreto.com 32254 24 31718 105 0 0 0%48:05:09
15weretis.net 25968 24 24842 0 0 0 0%48:06:06
16eternal-september 28246 24 27379 0 0 0 0%48:06:26
17news.redatomik.org 0 0 0 0 0 32002 0%47:59:59
18news.fcku.it 3673 0 3647 0 0 0 0%44:17:13
TOTAL: 18 500401 8729 445612 1449 5 37188 1%861:11:28
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.samoylyk.net19.7 MB341.6 KB20.0 MB0.1 KB/s4.0 KB48:06:47
2xanadu-bbs10.1 MB0.0 KB10.1 MB0.1 KB/s9.4 KB48:02:58
3news.freedyn.net9.9 MB59.3 KB10.0 MB0.1 KB/s10.5 KB48:09:33
4fu-berlin.de9.7 MB0.0 KB9.7 MB0.1 KB/s11.3 KB48:09:25
5news.bbs.nz959.3 KB116.5 KB1.1 MB0.0 KB/s2.7 KB48:01:55
6usenet.pasdenom.info467.9 KB9.7 MB10.1 MB0.1 KB/s9.6 KB48:01:37
7newsfeed.xs4all.nl198.3 KB35.6 KB233.9 KB0.0 KB/s3.8 KB48:00:03
8aioe134.8 KB5.7 KB140.5 KB0.0 KB/s2.0 KB48:00:47
9neva.ru62.0 KB538.4 KB600.4 KB0.0 KB/s2.4 KB48:09:33
10news.uzoreto.com53.4 KB410.0 KB463.4 KB0.0 KB/s3.6 KB48:05:09
11news.mixmin.net43.9 KB0.0 KB43.9 KB0.0 KB/s1.5 KB48:02:44
12erje43.9 KB30.6 KB74.5 KB0.0 KB/s2.1 KB48:07:30
13news.swapon.de43.2 KB0.0 KB43.2 KB0.0 KB/s1.6 KB47:34:16
14xmission35.2 KB0.0 KB35.2 KB0.0 KB/s1.5 KB48:09:27
15weretis.net35.2 KB0.0 KB35.2 KB0.0 KB/s1.5 KB48:06:06
16eternal-september35.2 KB0.0 KB35.2 KB0.0 KB/s1.5 KB48:06:26
17news.redatomik.org0.0 KB0.0 KB0.0 KB0.0 KB/s047:59:59
18news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s044:17:13
TOTAL: 1851.5 MB11.2 MB62.6 MB0.0 KB/s6.3 KB861:11:28
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1a131033.upc-a.chello.nl 75 5079.3 KB 16 0 015:33:46
266-188-82-154.dhcp.mdsn.wi.charter.com 72 4369.4 KB 34 24 2122:42:56
3208-71-239-109.cust.centrio.cz 4 714.2 KB 3 0 002:02:03
TOTAL: 3 151 100162.9 KB 53 24 2140:49:08

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.upc-a.chello.nl 75 5079.3 KB 16 0 015:33:46
2*.dhcp.mdsn.wi.charter.com 72 4369.4 KB 34 24 2122:42:56
3*.cust.centrio.cz 4 714.2 KB 3 0 002:02:03
4unresolved 12 00.0 KB 0 0 000:00:20
5*.hsd1.wa.comcast.net 1 00.0 KB 0 0 000:30:01
TOTAL: 5 164 100162.9 KB 53 24 2140:49:08

NNRP auth users [Top 20]:

UserConn
ohlandl 21
ctomczyk 4
TOTAL: 2 25

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66-188-82-154.dhcp.mdsn.wi.charter.com 6.581 1.071 0.27522:42:56
a131033.upc-a.chello.nl 6.367 1.178 0.00015:33:46
208-71-239-109.cust.centrio.cz 0.413 0.065 0.02502:02:03
c-73-140-175-55.hsd1.wa.comcast.net 0.077 0.008 0.00000:30:01
94.165.242.93 0.245 0.078 0.00000:00:05
112.64.199.58 0.077 0.009 0.00000:00:04
94.162.234.38 0.219 0.032 0.00000:00:03
106.75.92.239 0.062 0.023 0.00000:00:02
94.164.153.9 0.075 0.008 0.00000:00:01
5.86.28.208 0.065 0.016 0.00000:00:01
94.166.220.116 0.073 0.008 0.00000:00:01
TOTAL: 11 14.254 2.496 0.30040:49:08

Curious NNRP server explorers [Top 20]:

SystemConn
94.165.242.93 4
94.162.234.38 3
106.75.92.239 1
c-73-140-175-55.hsd1.wa.comcast.net 1
5.86.28.208 1
94.166.220.116 1
112.64.199.58 1
94.164.153.9 1
TOTAL: 8 13

NNRP client timeouts [Top 20]:

SystemConnPeer
66-188-82-154.dhcp.mdsn.wi.charter.com 30 0
208-71-239-109.cust.centrio.cz 4 0
c-73-140-175-55.hsd1.wa.comcast.net 1 0
TOTAL: 3 35 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 97 97.0%
2pl 3 3.0%
TOTAL: 2 100100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1comp.sys.ibm.ps2.hardware 93
2comp.lang.javascript 4
3pl.comp.www 3
TOTAL: 3 100