Daily Usenet report for csiph.com

Aug 30 04:15:00 -- Aug 31 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 42019 44.9%6.1 MB 56.5%
nnrpd 31870 34.1%2.6 MB 24.6%
innd 17755 19.0%1.7 MB 16.3%
innfeed 1856 2.0%287.0 KB 2.6%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 93501 100.0%10.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 224066 47.0%
Negative hits 207693 43.6%
Do not exist 41224 8.6%
Cache misses 3704 0.8%
TOTAL: 4 476687 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.167 0.0%348 0.000 0.480 18.000
article cleanup00:00:00.238 0.0%40585 0.000 0.006 0.020
article logging00:00:00.489 0.0%41072 0.000 0.012 0.040
article parse00:00:01.765 0.0%213738 0.002 0.008 0.016
article write00:00:05.410 0.0%22599 0.160 0.239 0.347
artlog/artcncl00:00:00.001 0.0%259 0.000 0.004 0.023
artlog/artparse00:00:00.008 0.0%694 0.000 0.012 0.250
data move00:00:00.224 0.0%603894 0.000 0.000 0.001
hisgrep/artcncl00:00:00.004 0.0%343 0.000 0.012 0.071
hishave/artcncl00:00:00.000 0.0%348 0.000 0.000 0.000
hishave/artparse00:00:00.003 0.0%694 0.000 0.004 0.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.198 0.0%476508 0.001 0.003 0.006
history sync00:00:00.454 0.0%306 0.000 1.484 3.000
history write00:00:09.932 0.0%40579 0.085 0.245 0.314
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
hiswrite/artparse00:00:00.171 0.0%694 0.000 0.246 3.000
idle23:58:05.632 99.8%596697 30.653 144.605 375.290
nntp read00:00:02.060 0.0%595298 0.001 0.003 0.006
overview write00:00:03.884 0.0%22599 0.097 0.172 0.432
perl filter00:01:22.520 0.1%40579 0.863 2.034 3.789
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.433 0.0%45198 0.000 0.010 0.027
TOTAL: 24:00:28.22223:59:54.593100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.060 0.0%22547 0.000 0.003 0.027
article prepare00:00:00.001 0.0%7288 0.000 0.000 0.013
article read00:00:00.207 0.0%1439 0.000 0.144 5.625
backlog stats00:00:00.092 0.0%256334 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.998 0.0%196000 0.000 0.005 0.013
data write00:00:01.499 0.0%174849 0.001 0.009 0.018
idle23:54:51.703100.0%256334 198.652 335.858 1002.407
status file00:00:00.088 0.0%177 0.000 0.497 1.000
TOTAL: 23:54:57.96023:54:54.648100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.032 0.0%1592 0.015 0.020 0.046
idle17:56:25.743 99.9%32937 0.000 1960.887600141.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.426 0.0%66681 0.000 0.006 0.032
readart00:00:00.071 0.0%56 0.000 1.268 13.000
TOTAL: 17:57:34.12617:56:26.272 99.9%----

Control commands to INND:

CommandNumber
L 1
flush 4
flushlogs 2
go 2
logmode 2
mode 147
pause 2
paused 2
reload 2
reserve 2
TOTAL: 10 166

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feeder.eternal-september.org 3 38058 6277 29861 1920 16%24:13:26
2au2pb.net 1 24982 4939 19264 779 19%25:18:37
3xanadu-bbs.net 2 40924 3811 29369 7744 9%23:39:21
4news-out.mixmin.net 4 27821 2941 22745 2135 10%24:11:31
5newsfeeds.xmission.com 1 22906 1477 21301 128 6%24:29:04
6newsfeed.neva.ru 143 50616 1383 43664 5569 2%72:06:05
7newsfeed.fu-berlin.de 37 29059 1280 27308 471 4%34:11:39
8nntp.pasdenom.info 2 20253 404 19781 68 1%22:46:49
9news.swapon.de 1 2680 203 2457 20 7%24:47:49
10localhost 50 12308 0 12308 0 0%00:01:01
TOTAL: 10 244 269607 22715 228058 18834 8%275:45:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder.eternal-september.org16.6 MB10.5 KB13.9 MB30.4 MB 54%3.8 KB
2au2pb.net12.9 MB0.0 KB4.3 MB17.3 MB 74%3.1 KB
3xanadu-bbs.net10.5 MB25.6 KB118.4 MB129.0 MB 8%11.4 KB
4news-out.mixmin.net8.3 MB0.0 KB6.5 MB14.8 MB 55%3.0 KB
5newsfeeds.xmission.com4.4 MB10.5 KB1.2 MB5.6 MB 78%3.6 KB
6newsfeed.neva.ru4.2 MB45.3 KB44.4 MB48.7 MB 8%7.2 KB
7newsfeed.fu-berlin.de2.8 MB0.0 KB846.9 KB3.7 MB 77%2.1 KB
8nntp.pasdenom.info933.4 KB0.0 KB315.1 KB1.2 MB 74%2.6 KB
9news.swapon.de536.6 KB0.0 KB829.8 KB1.3 MB 39%6.1 KB
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1061.2 MB91.9 KB190.7 MB252.0 MB 24%6.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 30 04:15:00 - 04:59:59 342 1.5% 0.131.1 MB 1.7% 0.40
Aug 30 05:00:00 - 05:59:59 426 1.9% 0.121.3 MB 2.1% 0.37
Aug 30 06:00:00 - 06:59:59 584 2.6% 0.161.6 MB 2.6% 0.45
Aug 30 07:00:00 - 07:59:59 696 3.1% 0.191.7 MB 2.8% 0.48
Aug 30 08:00:00 - 08:59:59 908 4.0% 0.252.1 MB 3.5% 0.60
Aug 30 09:00:00 - 09:59:59 1062 4.7% 0.292.8 MB 4.5% 0.79
Aug 30 10:00:00 - 10:59:59 981 4.3% 0.272.6 MB 4.2% 0.73
Aug 30 11:00:00 - 11:59:59 971 4.3% 0.272.5 MB 4.1% 0.72
Aug 30 12:00:00 - 12:59:59 1072 4.7% 0.303.6 MB 5.9% 1.02
Aug 30 13:00:00 - 13:59:59 983 4.4% 0.272.5 MB 4.1% 0.72
Aug 30 14:00:00 - 14:59:59 1099 4.9% 0.312.8 MB 4.6% 0.80
Aug 30 15:00:00 - 15:59:59 1296 5.7% 0.363.3 MB 5.5% 0.95
Aug 30 16:00:00 - 16:59:59 1299 5.7% 0.363.3 MB 5.5% 0.95
Aug 30 17:00:00 - 17:59:59 1333 5.9% 0.373.5 MB 5.7% 0.99
Aug 30 18:00:00 - 18:59:59 1278 5.7% 0.353.1 MB 5.0% 0.87
Aug 30 19:00:00 - 19:59:59 1394 6.2% 0.393.6 MB 5.9% 1.02
Aug 30 20:00:00 - 20:59:59 1327 5.9% 0.373.1 MB 5.0% 0.87
Aug 30 21:00:00 - 21:59:59 1321 5.8% 0.373.1 MB 5.2% 0.90
Aug 30 22:00:00 - 22:59:59 935 4.1% 0.262.8 MB 4.6% 0.80
Aug 30 23:00:00 - 23:59:59 715 3.2% 0.202.4 MB 3.9% 0.67
Aug 31 00:00:00 - 00:59:59 682 3.0% 0.191.9 MB 3.1% 0.54
Aug 31 01:00:00 - 01:59:59 574 2.5% 0.161.8 MB 3.0% 0.52
Aug 31 02:00:00 - 02:59:59 586 2.6% 0.162.2 MB 3.7% 0.64
Aug 31 03:00:00 - 03:59:59 557 2.5% 0.151.6 MB 2.7% 0.47
Aug 31 04:00:00 - 04:15:00 175 0.8% 0.19651.4 KB 1.0% 0.72
TOTAL: 24:00:00 22596 100.0% 0.2661.0 MB 100.0% 0.72
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1xanadu-bbs.net 7663 660 0 2 0 0 0 0 7001
2newsfeed.neva.ru 5584 631 0 2 0 0 0 0 4951
3news-out.mixmin.net 2153 3 0 0 0 0 0 0 2150
4feeder.eternal-september.org 2002 304 0 1 0 0 0 0 1697
5au2pb.net 771 688 0 0 0 0 0 0 83
6newsfeed.fu-berlin.de 750 28 0 0 0 0 0 0 722
7newsfeeds.xmission.com 129 115 0 1 0 0 0 0 13
8nntp.pasdenom.info 79 74 0 0 0 0 0 0 5
9news.swapon.de 33 0 0 0 0 0 0 0 33
TOTAL: 9 19164 2503 0 6 0 0 0 016655

Unwanted newsgroups [Top 20]:

NewsgroupCount
it-alt.sport.calcio.juventus 257
mailing.freebsd.pkg-fallout 200
ut.test 173
fa.linux.kernel 159
free.it.calcio.juventus 125
alt.politics 102
alt.politics.scorched-earth 101
alt.survival 64
mailing.freebsd.svn-ports-all 55
mailing.freebsd.ports-bugs 54
lada.talk 52
mailing.freebsd.svn-ports-head 51
mailing.openbsd.ports-changes 41
mailing.openbsd.source-changes 39
fa.openbsd.source-changes 37
lada.auto 37
mailing.freebsd.questions 37
pld.cvs.commit 28
fa.openbsd.tech 26
mailing.openbsd.tech 26
TOTAL: 214 2503

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 11668
EMP (phn path) 2694
EMP (phl) 737
EMP (phn nph) 144
PFM bot misc 113
Too many newsgroups 52
HTML Multipart 32
Binary Image: misplaced jpg 22
HTML post 5
Too many newsgroups (meow) 4
U2 violation - invalid distribution 1
Binary: non-binary distribution 1
HTML Image Tags 1
TOTAL: 13 15474

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Huge articles
xanadu-bbs.net 542
news-out.mixmin.net 51
feeder.eternal-september.org 50
au2pb.net 33
newsfeeds.xmission.com 10
news.swapon.de 5
nntp.pasdenom.info 2
newsfeed.fu-berlin.de 1
TOTAL: 8 694
Including strange strings
newsfeed.fu-berlin.de 318
feeder.eternal-september.org 83
au2pb.net 37
news-out.mixmin.net 21
news.swapon.de 12
newsfeed.neva.ru 7
xanadu-bbs.net 5
newsfeeds.xmission.com 3
nntp.pasdenom.info 1
TOTAL: 9 487
TOTAL: 2 1181

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1usenet.pasdenom.info 27868 305 20893 954 0 8 1%23:59:58
2au2pb 18378 179 17462 115 0 0 0%23:59:58
3xanadu-bbs 19698 87 18580 29 0 10 0%23:59:53
4fu-berlin.de 21137 24 21087 25 0 1 0%23:59:57
5news.mixmin.net 20227 15 19563 13 0 1 0%23:59:49
6eternal-september 16850 8 15890 6 0 1 0%23:59:58
7xmission 26187 5 21062 3 0 0 0%23:59:51
8neva.ru 21766 1 21051 56 0 0 0%23:59:40
9news.swapon.de 2402 1 2374 2 0 0 0%23:56:51
TOTAL: 9 174513 625 157962 1203 0 21 0%215:55:55
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1usenet.pasdenom.info1022.3 KB2.0 MB3.0 MB0.0 KB/s2.4 KB23:59:58
2au2pb685.2 KB354.0 KB1.0 MB0.0 KB/s3.5 KB23:59:58
3xanadu-bbs463.8 KB54.5 KB518.3 KB0.0 KB/s4.5 KB23:59:53
4fu-berlin.de139.8 KB33.8 KB173.7 KB0.0 KB/s3.5 KB23:59:57
5news.mixmin.net80.8 KB22.1 KB103.0 KB0.0 KB/s3.7 KB23:59:49
6eternal-september31.1 KB6.2 KB37.3 KB0.0 KB/s2.7 KB23:59:58
7xmission11.2 KB7.8 KB18.9 KB0.0 KB/s2.4 KB23:59:51
8news.swapon.de2.8 KB5.7 KB8.5 KB0.0 KB/s2.8 KB23:56:51
9neva.ru2.4 KB369.4 KB371.7 KB0.0 KB/s6.5 KB23:59:40
TOTAL: 92.4 MB2.8 MB5.2 MB0.0 KB/s2.9 KB215:55:55
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1202.89.176.220 288 3492.8 KB 31 0 004:32:21
2pool-71-98-160-84.tampfl.dsl-w.verizon.net 15 1020.2 KB 3 0 002:33:29
3challenger.nielsenmedia.com 6 1020.2 KB 3 0 001:30:40
4dhcp-089-099-203-254.chello.nl 10 11.6 KB 1 0 003:19:48
5tempe0.bbox.io 9 11.6 KB 1 0 001:31:23
TOTAL: 5 328 56136.3 KB 39 0 017:57:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 320 3492.8 KB 31 0 008:00:52
2*.nielsenmedia.com 6 1020.2 KB 3 0 001:30:40
3*.tampfl.dsl-w.verizon.net 15 1020.2 KB 3 0 002:33:29
4*.bbox.io 9 11.6 KB 1 0 001:31:23
5*.chello.nl 10 11.6 KB 1 0 003:19:48
6*.br.br.cox.net 2 00.0 KB 0 0 000:01:07
7*.ok.ok.cox.net 2 00.0 KB 0 0 001:00:08
TOTAL: 7 364 56136.3 KB 39 0 017:57:30

NNRP auth users [Top 20]:

UserConn
moussa 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
202.89.176.220 26.073 5.608 0.70704:32:21
71.94.21.184 0.184 0.111 0.00003:28:28
dhcp-089-099-203-254.chello.nl 0.818 0.109 0.00003:19:48
pool-71-98-160-84.tampfl.dsl-w.verizon.net 1.543 0.240 0.00002:33:29
tempe0.bbox.io 0.693 0.111 0.00001:31:23
challenger.nielsenmedia.com 0.591 0.113 0.00001:30:40
ip68-14-171-134.ok.ok.cox.net 0.136 0.048 0.00001:00:08
ip70-186-189-146.br.br.cox.net 0.190 0.033 0.00000:01:07
69.160.37.54 1.907 0.470 0.00000:00:02
TOTAL: 9 32.135 6.843 0.70717:57:30

Curious NNRP server explorers [Top 20]:

SystemConn
69.160.37.54 25
162.212.88.198 4
71.94.21.184 3
ip68-14-171-134.ok.ok.cox.net 2
ip70-186-189-146.br.br.cox.net 2
TOTAL: 5 36

NNRP unrecognized commands (by host):

SystemConn
71.94.21.184 3
TOTAL: 1 3

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP 3
TOTAL: 1 3

NNRP client timeouts [Top 20]:

SystemConnPeer
dhcp-089-099-203-254.chello.nl 5 0
pool-71-98-160-84.tampfl.dsl-w.verizon.net 4 0
challenger.nielsenmedia.com 3 0
tempe0.bbox.io 3 0
ip68-14-171-134.ok.ok.cox.net 2 0
71.94.21.184 2 0
TOTAL: 6 19 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 55 98.2%
2news 1 1.8%
TOTAL: 2 56100.0%

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

NewsgroupCount
1comp.lang.awk 20
2comp.os.vms 14
3comp.arch 8
4comp.ai.neural-nets 5
5comp.sys.ibm.ps2.hardware 2
6comp.sys.ibm.pc.games.war-historical 2
7comp.arch.embedded 1
8comp.sys.ibm.pc.games.action 1
9comp.sys.ibm.pc.games.flight-sim 1
10comp.os.msdos.misc 1
11news.admin.peering 1
TOTAL: 11 56