Daily Usenet report for csiph.com

Oct 3 04:15:00 -- Oct 4 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 42676 45.8%6.3 MB 57.8%
nnrpd 31543 33.9%2.6 MB 24.2%
innd 17097 18.3%1.7 MB 15.6%
innfeed 1865 2.0%268.5 KB 2.4%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 93182 100.0%10.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 232755 48.3%
Negative hits 202537 42.0%
Do not exist 42018 8.7%
Cache misses 4842 1.0%
TOTAL: 4 482152 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.621 0.0%610 0.000 1.018 19.000
article cleanup00:00:00.261 0.0%41132 0.000 0.006 0.021
article logging00:00:00.534 0.0%41565 0.000 0.013 0.032
article parse00:00:01.666 0.0%202008 0.001 0.008 0.017
article write00:00:06.424 0.0%23795 0.143 0.270 0.456
artlog/artcncl00:00:00.004 0.0%462 0.000 0.009 0.250
artlog/artparse00:00:00.007 0.0%682 0.000 0.010 0.500
data move00:00:00.232 0.0%615833 0.000 0.000 0.002
hisgrep/artcncl00:00:00.054 0.0%315 0.000 0.171 11.500
hishave/artcncl00:00:00.001 0.0%610 0.000 0.002 0.003
hishave/artparse00:00:00.003 0.0%682 0.000 0.004 0.200
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.364 0.0%481769 0.000 0.003 0.021
history sync00:00:00.605 0.0%357 0.000 1.695 3.333
history write00:00:12.358 0.0%41122 0.066 0.301 1.294
hiswrite/artcncl00:00:00.054 0.0%295 0.183 0.183 0.183
hiswrite/artparse00:00:00.135 0.0%682 0.000 0.198 5.500
idle23:58:25.213 99.8%600861 33.952 143.636 460.153
nntp read00:00:01.958 0.0%599644 0.000 0.003 0.006
overview write00:00:17.283 0.0%23795 0.106 0.726 2.962
perl filter00:01:15.714 0.1%41122 1.088 1.841 3.328
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.443 0.0%47590 0.000 0.009 0.044
TOTAL: 24:00:55.49324:00:24.934100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.065 0.0%23821 0.000 0.003 0.026
article prepare00:00:00.000 0.0%8212 0.000 0.000 0.000
article read00:00:00.237 0.0%1560 0.000 0.152 8.800
backlog stats00:00:00.093 0.0%272865 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.075 0.0%206123 0.000 0.005 0.012
data write00:00:01.624 0.0%185519 0.002 0.009 0.021
idle23:54:44.426100.0%272865 133.333 315.484 929.065
status file00:00:00.076 0.0%180 0.000 0.422 1.000
TOTAL: 23:54:51.19623:54:47.596100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.050 0.0%1381 0.003 0.036 0.056
idle15:50:47.498 99.9%32488 0.000 1755.956600085.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:06.705 0.0%159982 0.000 0.042 0.067
readart00:00:00.010 0.0%57 0.000 0.175 1.000
TOTAL: 15:51:42.73515:50:54.263 99.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feeder.eternal-september.org 14 37780 6419 28566 2795 16%26:31:35
2au2pb.net 1 24707 4956 19150 601 20%23:02:25
3xanadu-bbs.net 1 41643 3726 30160 7757 8%24:03:31
4news-out.mixmin.net 3 29896 3160 24271 2465 10%24:09:27
5newsfeed.neva.ru 145 51737 2374 45555 3808 4%72:12:56
6newsfeeds.xmission.com 1 23378 1531 21662 185 6%22:28:52
7newsfeed.fu-berlin.de 40 26568 1074 25149 345 4%29:17:11
8nntp.pasdenom.info 2 19820 92 19709 19 0%17:24:12
9localhost 51 15662 1 15661 0 0%00:01:04
10news.swapon.de 1 17 0 17 0 0%00:55:41
TOTAL: 10 259 271208 23333 229900 17975 8%240:06:54
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder.eternal-september.org17.5 MB30.7 KB11.0 MB28.5 MB 61%3.2 KB
2au2pb.net13.8 MB1.4 KB3.3 MB17.0 MB 80%3.1 KB
3news-out.mixmin.net11.1 MB1.7 KB6.6 MB17.7 MB 62%3.2 KB
4xanadu-bbs.net10.3 MB0.0 KB111.5 MB121.8 MB 8%10.9 KB
5newsfeed.neva.ru9.0 MB29.0 KB20.4 MB29.4 MB 30%4.9 KB
6newsfeeds.xmission.com4.8 MB0.0 KB1.8 MB6.6 MB 73%3.9 KB
7newsfeed.fu-berlin.de2.5 MB0.0 KB947.7 KB3.4 MB 72%2.5 KB
8nntp.pasdenom.info201.1 KB5.6 KB91.9 KB298.6 KB 67%2.7 KB
9localhost1.0 KB0.0 KB0.0 KB1.0 KB100%1.0 KB
10news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1069.2 MB68.3 KB155.6 MB224.8 MB 30%5.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 3 04:15:00 - 04:59:59 318 1.3% 0.121.1 MB 1.6% 0.42
Oct 3 05:00:00 - 05:59:59 562 2.4% 0.161.9 MB 2.7% 0.55
Oct 3 06:00:00 - 06:59:59 789 3.3% 0.223.2 MB 4.5% 0.90
Oct 3 07:00:00 - 07:59:59 898 3.8% 0.252.4 MB 3.5% 0.69
Oct 3 08:00:00 - 08:59:59 1151 4.8% 0.323.3 MB 4.7% 0.94
Oct 3 09:00:00 - 09:59:59 1145 4.8% 0.323.3 MB 4.6% 0.92
Oct 3 10:00:00 - 10:59:59 1130 4.8% 0.313.1 MB 4.5% 0.90
Oct 3 11:00:00 - 11:59:59 1133 4.8% 0.313.1 MB 4.4% 0.87
Oct 3 12:00:00 - 12:59:59 1100 4.6% 0.313.1 MB 4.4% 0.88
Oct 3 13:00:00 - 13:59:59 1151 4.8% 0.323.1 MB 4.4% 0.87
Oct 3 14:00:00 - 14:59:59 1146 4.8% 0.323.0 MB 4.3% 0.85
Oct 3 15:00:00 - 15:59:59 1359 5.7% 0.384.6 MB 6.6% 1.31
Oct 3 16:00:00 - 16:59:59 1369 5.8% 0.383.6 MB 5.1% 1.03
Oct 3 17:00:00 - 17:59:59 1456 6.1% 0.404.1 MB 5.9% 1.17
Oct 3 18:00:00 - 18:59:59 1460 6.1% 0.414.0 MB 5.7% 1.15
Oct 3 19:00:00 - 19:59:59 1244 5.2% 0.353.3 MB 4.7% 0.93
Oct 3 20:00:00 - 20:59:59 1365 5.7% 0.384.6 MB 6.6% 1.32
Oct 3 21:00:00 - 21:59:59 1061 4.5% 0.293.2 MB 4.6% 0.92
Oct 3 22:00:00 - 22:59:59 932 3.9% 0.262.6 MB 3.7% 0.74
Oct 3 23:00:00 - 23:59:59 676 2.8% 0.192.1 MB 2.9% 0.58
Oct 4 00:00:00 - 00:59:59 632 2.7% 0.182.1 MB 3.0% 0.60
Oct 4 01:00:00 - 01:59:59 676 2.8% 0.192.2 MB 3.1% 0.61
Oct 4 02:00:00 - 02:59:59 440 1.9% 0.121.6 MB 2.2% 0.44
Oct 4 03:00:00 - 03:59:59 456 1.9% 0.131.3 MB 1.8% 0.36
Oct 4 04:00:00 - 04:15:00 134 0.6% 0.15400.1 KB 0.6% 0.44
TOTAL: 24:00:00 23783 100.0% 0.2870.1 MB 100.0% 0.83
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1xanadu-bbs.net 7789 672 0 0 0 0 0 0 7117
2newsfeed.neva.ru 3795 815 0 4 0 0 0 0 2976
3feeder.eternal-september.org 2816 292 0 3 0 0 0 0 2521
4news-out.mixmin.net 2475 5 0 1 0 0 0 0 2469
5newsfeed.fu-berlin.de 716 29 0 0 0 0 0 0 687
6au2pb.net 621 567 0 1 0 0 0 0 53
7newsfeeds.xmission.com 183 165 0 0 0 0 0 0 18
8news.swapon.de 19 0 0 0 0 0 0 0 19
9nntp.pasdenom.info 18 9 0 1 0 0 0 0 8
TOTAL: 9 18432 2554 0 10 0 0 0 015868

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 280
mailing.freebsd.svn-src-all 116
ut.test 114
fa.freebsd.cvs-all 113
alt.politics 110
mailing.freebsd.svn-ports-all 107
mailing.freebsd.svn-ports-head 105
it-alt.sport.calcio.juventus 100
alt.politics.scorched-earth 99
lada.talk 70
mailing.freebsd.svn-src-stable 65
mozilla.dev.tree-alerts 64
mailing.freebsd.svn-src-stable-10 63
pld.cvs.commit 59
alt.survival 52
mailing.freebsd.svn-src-head 51
free.it.calcio.juventus 50
mailing.openbsd.source-changes 46
mpc.lists.nanog 42
mailing.freebsd.pkg-fallout 36
TOTAL: 209 2554

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 10800
EMP (phn path) 2326
EMP (phl) 916
EMP (phn nph) 316
PFM bot misc 226
Too many newsgroups 55
Too many newsgroups (low_xpost) 37
HTML Multipart 32
Binary Image: misplaced jpg 25
HTML post 14
HTML Image Tags 2
User-issued spam cancel 1
Binary: misplaced arj 1
TOTAL: 13 14751

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Huge articles
xanadu-bbs.net 554
news-out.mixmin.net 38
feeder.eternal-september.org 38
au2pb.net 37
newsfeeds.xmission.com 11
nntp.pasdenom.info 5
newsfeed.fu-berlin.de 1
TOTAL: 7 684
Including strange strings
newsfeed.fu-berlin.de 348
feeder.eternal-september.org 33
news.swapon.de 19
au2pb.net 12
news-out.mixmin.net 10
xanadu-bbs.net 5
newsfeed.neva.ru 3
newsfeeds.xmission.com 3
TOTAL: 8 433
TOTAL: 2 1117

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1usenet.pasdenom.info 30218 347 22408 897 0 70 1%23:59:44
2au2pb 19825 276 18277 165 0 0 1%23:59:44
3xanadu-bbs 21973 141 19867 58 0 5 0%23:59:58
4fu-berlin.de 22405 37 22346 22 0 0 0%23:59:13
5xmission 27984 10 21959 1 0 0 0%23:59:58
6news.mixmin.net 21411 10 20485 8 0 0 0%23:59:57
7neva.ru 22277 5 21233 73 0 0 0%23:59:56
8eternal-september 18147 3 17047 1 0 0 0%23:59:56
9news.swapon.de 1730 0 1716 2 0 0 0%23:53:40
TOTAL: 9 185970 829 165338 1227 0 75 0%215:52:06
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1usenet.pasdenom.info1.4 MB1.8 MB3.2 MB0.0 KB/s2.6 KB23:59:44
2au2pb1.0 MB477.8 KB1.5 MB0.0 KB/s3.5 KB23:59:44
3xanadu-bbs793.7 KB130.0 KB923.6 KB0.0 KB/s4.6 KB23:59:58
4fu-berlin.de166.6 KB30.4 KB197.0 KB0.0 KB/s3.3 KB23:59:13
5news.mixmin.net62.9 KB14.2 KB77.0 KB0.0 KB/s4.3 KB23:59:57
6eternal-september29.3 KB1.0 KB30.3 KB0.0 KB/s7.6 KB23:59:56
7xmission28.0 KB3.2 KB31.3 KB0.0 KB/s2.8 KB23:59:58
8neva.ru15.3 KB272.9 KB288.1 KB0.0 KB/s3.7 KB23:59:56
9news.swapon.de0.0 KB3.3 KB3.3 KB0.0 KB/s1.6 KB23:53:40
TOTAL: 93.5 MB2.8 MB6.2 MB0.0 KB/s3.1 KB215:52:06
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1202.89.176.220 286 55144.8 KB 52 0 006:02:46
2tempe0.bbox.io 9 24.4 KB 4 1 002:14:07
TOTAL: 2 295 57149.3 KB 56 1 015:51:39

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 319 55144.8 KB 52 0 010:50:53
2*.tampfl.dsl-w.verizon.net 6 00.0 KB 0 0 002:46:38
TOTAL: 2 325 57149.3 KB 56 1 013:37:32

NNRP auth users [Top 20]:

UserConn
moussa 286
kev009 4
TOTAL: 2 290

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
202.89.176.220 25.768 6.115 0.70706:02:46
162.212.88.198 0.406 0.107 0.00004:48:04
pool-71-98-160-84.tampfl.dsl-w.verizon.net 0.487 0.127 0.00002:46:38
tempe0.bbox.io 1.222 0.981 0.00702:14:07
69.160.37.54 1.937 0.428 0.00000:00:02
TOTAL: 5 29.820 7.758 0.71415:51:39

Curious NNRP server explorers [Top 20]:

SystemConn
69.160.37.54 25
162.212.88.198 8
pool-71-98-160-84.tampfl.dsl-w.verizon.net 6
TOTAL: 3 39

NNRP no permission clients:

SystemConn
tempe0.bbox.io 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
pool-71-98-160-84.tampfl.dsl-w.verizon.net 5 0
tempe0.bbox.io 3 0
TOTAL: 2 8 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 63 86.3%
2news 10 13.7%
TOTAL: 2 73100.0%

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

NewsgroupCount
1comp.sys.ibm.pc.hardware.storage 14
2comp.arch.fpga 10
3news.software.nntp 10
4comp.sys.ibm.pc.games.action 9
5comp.os.vms 8
6comp.unix.aix 8
7comp.arch.embedded 5
8comp.arch 4
9comp.sys.ibm.ps2.hardware 2
10comp.os.linux.networking 1
11comp.sys.ibm.pc.demos 1
12comp.answers 1
TOTAL: 12 73