Daily Usenet report for csiph.com

Nov 2 04:15:00 -- Nov 3 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 55160 48.3%7.9 MB 59.1%
nnrpd 33764 29.6%2.9 MB 21.6%
innd 23356 20.5%2.3 MB 17.1%
innfeed 1903 1.7%292.8 KB 2.2%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 114184 100.0%13.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 273940 45.5%
Positive hits 273714 45.5%
Do not exist 53691 8.9%
Cache misses 415 0.1%
TOTAL: 4 601760 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.461 0.0%514 0.000 2.842 18.000
article cleanup00:00:00.320 0.0%53470 0.000 0.006 0.024
article logging00:00:00.708 0.0%54000 0.000 0.013 0.030
article parse00:00:02.503 0.0%262218 0.002 0.010 0.021
article write00:00:12.941 0.0%28434 0.151 0.455 1.306
artlog/artcncl00:00:00.004 0.0%483 0.000 0.008 0.013
artlog/artparse00:00:00.009 0.0%700 0.000 0.013 1.000
data move00:00:00.308 0.0%738783 0.000 0.000 0.002
hisgrep/artcncl00:00:00.031 0.0%513 0.000 0.060 9.000
hishave/artcncl00:00:00.002 0.0%514 0.000 0.004 0.007
hishave/artparse00:00:00.003 0.0%700 0.000 0.004 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.857 0.0%605423 0.001 0.003 0.007
history sync00:00:00.605 0.0%308 0.000 1.964 4.000
history write00:00:16.818 0.0%53464 0.104 0.315 0.434
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hiswrite/artparse00:00:00.196 0.0%697 0.000 0.281 4.000
idle23:57:01.601 99.8%727981 32.243 118.439 353.367
nntp read00:00:02.312 0.0%728911 0.000 0.003 0.006
overview write00:00:19.049 0.0%28434 0.107 0.670 2.648
perl filter00:01:51.142 0.1%53464 1.003 2.079 4.127
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.494 0.0%56868 0.000 0.009 0.029
TOTAL: 24:00:28.14023:59:52.364100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.071 0.0%28525 0.000 0.002 0.022
article prepare00:00:00.001 0.0%7164 0.000 0.000 0.031
article read00:00:00.229 0.0%1332 0.000 0.172 20.667
backlog stats00:00:00.090 0.0%311289 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.301 0.0%242289 0.000 0.005 0.015
data write00:00:01.635 0.0%218695 0.001 0.007 0.016
idle23:53:49.031100.0%311289 158.644 276.364 724.974
status file00:00:00.094 0.0%203 0.000 0.463 1.000
TOTAL: 23:54:01.54323:53:52.452100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:01.551 0.0%56960 0.000 0.027 0.333
idle167:11:03.885 99.9%88751 0.000 6781.488600226.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.058 0.0%178721 0.000 0.006 0.333
readart00:00:00.025 0.0%52 0.000 0.481 18.000
TOTAL: 167:18:52.043167:11:06.519 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 4 49569 7593 38405 3571 15%24:52:17
2au2pb.net 1 31845 6651 23995 1199 20%24:47:29
3xanadu-bbs.net 0 54719 4195 42365 8159 7%24:46:33
4news-out.mixmin.net 4 35627 3425 29165 3037 9%24:15:43
5newsfeed.neva.ru 152 63589 2884 51408 9297 4%72:18:09
6newsfeeds.xmission.com 1 28140 1809 26251 80 6%22:16:10
7newsfeed.fu-berlin.de 67 37222 1489 35303 430 4%40:01:25
8nntp.pasdenom.info 12 29282 320 28829 133 1%24:35:46
9news.swapon.de 1 2685 288 2362 35 10%22:18:58
10localhost 26 0 0 0 0 0%00:00:00
TOTAL: 10 268 332678 28654 278083 25941 8%280:12:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder.eternal-september.org23.5 MB33.5 KB23.2 MB46.8 MB 50%4.3 KB
2au2pb.net17.4 MB0.0 KB6.0 MB23.4 MB 74%3.1 KB
3xanadu-bbs.net11.8 MB0.0 KB147.3 MB159.1 MB 7%13.2 KB
4news-out.mixmin.net10.6 MB0.0 KB6.1 MB16.7 MB 63%2.6 KB
5newsfeed.neva.ru9.7 MB1.4 KB83.0 MB92.7 MB 10%7.8 KB
6newsfeeds.xmission.com5.5 MB0.0 KB1.7 MB7.2 MB 76%3.9 KB
7newsfeed.fu-berlin.de3.5 MB0.0 KB1.4 MB4.9 MB 72%2.6 KB
8nntp.pasdenom.info833.8 KB0.0 KB975.2 KB1.8 MB 46%4.0 KB
9news.swapon.de740.0 KB0.0 KB2.6 MB3.3 MB 22%10.4 KB
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1083.6 MB34.9 KB272.2 MB355.9 MB 23%6.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 2 04:15:00 - 04:59:59 497 1.8% 0.181.7 MB 2.1% 0.66
Nov 2 05:00:00 - 05:59:59 970 3.4% 0.274.0 MB 4.8% 1.13
Nov 2 06:00:00 - 06:59:59 531 1.9% 0.151.5 MB 1.9% 0.44
Nov 2 07:00:00 - 07:59:59 859 3.0% 0.242.4 MB 2.9% 0.67
Nov 2 08:00:00 - 08:59:59 1105 3.9% 0.313.0 MB 3.7% 0.86
Nov 2 09:00:00 - 09:59:59 1169 4.1% 0.323.3 MB 4.0% 0.93
Nov 2 10:00:00 - 10:59:59 1239 4.4% 0.343.3 MB 4.0% 0.93
Nov 2 11:00:00 - 11:59:59 1237 4.4% 0.343.2 MB 3.9% 0.91
Nov 2 12:00:00 - 12:59:59 1222 4.3% 0.343.6 MB 4.4% 1.03
Nov 2 13:00:00 - 13:59:59 1287 4.5% 0.363.5 MB 4.3% 1.00
Nov 2 14:00:00 - 14:59:59 1456 5.1% 0.403.7 MB 4.5% 1.04
Nov 2 15:00:00 - 15:59:59 1757 6.2% 0.494.8 MB 5.9% 1.37
Nov 2 16:00:00 - 16:59:59 1695 6.0% 0.474.7 MB 5.7% 1.33
Nov 2 17:00:00 - 17:59:59 1850 6.5% 0.515.2 MB 6.3% 1.48
Nov 2 18:00:00 - 18:59:59 1811 6.4% 0.505.0 MB 6.0% 1.41
Nov 2 19:00:00 - 19:59:59 1699 6.0% 0.474.4 MB 5.3% 1.24
Nov 2 20:00:00 - 20:59:59 1422 5.0% 0.403.8 MB 4.7% 1.09
Nov 2 21:00:00 - 21:59:59 1479 5.2% 0.414.8 MB 5.8% 1.36
Nov 2 22:00:00 - 22:59:59 1263 4.4% 0.353.6 MB 4.4% 1.03
Nov 2 23:00:00 - 23:59:59 1001 3.5% 0.283.0 MB 3.7% 0.85
Nov 3 00:00:00 - 00:59:59 789 2.8% 0.222.5 MB 3.1% 0.71
Nov 3 01:00:00 - 01:59:59 629 2.2% 0.172.1 MB 2.6% 0.61
Nov 3 02:00:00 - 02:59:59 657 2.3% 0.182.1 MB 2.5% 0.59
Nov 3 03:00:00 - 03:59:59 650 2.3% 0.182.4 MB 3.0% 0.69
Nov 3 04:00:00 - 04:15:00 117 0.4% 0.13410.6 KB 0.5% 0.46
TOTAL: 24:00:00 28391 100.0% 0.3382.0 MB 100.0% 0.97
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 9274 1749 0 1 0 0 0 0 7524
2xanadu-bbs.net 8063 628 0 0 0 0 0 0 7435
3feeder.eternal-september.org 3608 407 0 5 0 0 0 0 3196
4news-out.mixmin.net 3083 10 0 0 0 0 0 0 3073
5au2pb.net 1183 1130 0 0 0 0 0 0 53
6newsfeed.fu-berlin.de 791 39 0 0 0 0 0 0 752
7nntp.pasdenom.info 131 113 0 0 0 0 0 0 18
8newsfeeds.xmission.com 87 58 0 0 0 0 0 0 29
9news.swapon.de 66 0 0 0 0 0 0 0 66
TOTAL: 9 26286 4134 0 6 0 0 0 022146

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 867
lada.talk 331
alt.politics.scorched-earth 224
ut.test 133
mailing.freebsd.pkg-fallout 83
mailing.freebsd.svn-src-all 80
mailing.freebsd.ports-bugs 79
lada.auto 78
fa.freebsd.cvs-all 78
mailing.openbsd.source-changes 69
mailing.freebsd.svn-ports-all 67
mozilla.dev.tree-alerts 67
alt.politics 60
mailing.freebsd.svn-ports-head 59
mailing.openbsd.tech 52
fa.openbsd.tech 50
mailing.openbsd.misc 49
fa.openbsd.source-changes 49
nemo.test 48
mailing.gcc.gcc-cvs 47
TOTAL: 284 4134

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 16107
EMP (phn path) 3124
EMP (phl) 1128
EMP (phn nph) 173
PFM bot misc 135
HTML Multipart 98
Too many newsgroups 67
Too many newsgroups (low_xpost) 43
Binary Image: misplaced jpg 13
HTML post 9
HTML Image Tags 9
User-issued spam cancel 6
Binary: misplaced par2 4
Binary Payload 1
Binary: misplaced JPG 1
TOTAL: 15 20918

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Huge articles
xanadu-bbs.net 553
feeder.eternal-september.org 65
au2pb.net 31
news-out.mixmin.net 19
newsfeeds.xmission.com 17
nntp.pasdenom.info 8
news.swapon.de 6
newsfeed.fu-berlin.de 3
TOTAL: 8 702
Including strange strings
newsfeed.fu-berlin.de 408
feeder.eternal-september.org 43
news.swapon.de 28
news-out.mixmin.net 19
au2pb.net 9
newsfeeds.xmission.com 7
xanadu-bbs.net 7
newsfeed.neva.ru 4
nntp.pasdenom.info 1
TOTAL: 9 526
TOTAL: 2 1228

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1au2pb 22677 268 21418 182 0 0 1%23:59:52
2usenet.pasdenom.info 32775 252 27132 692 0 154 0%23:59:52
3xanadu-bbs 26244 116 24106 57 0 13 0%23:59:52
4fu-berlin.de 26579 42 26504 33 0 0 0%23:59:52
5news.mixmin.net 26279 39 24844 0 0 0 0%23:59:49
6xmission 33674 15 26259 3 0 1 0%23:59:53
7neva.ru 26928 8 25295 60 0 0 0%23:59:41
8eternal-september 21413 6 20300 9 0 0 0%23:59:49
9news.swapon.de 2401 1 2372 9 0 0 0%23:59:40
TOTAL: 9 218970 747 198230 1045 0 168 0%215:58:20
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1au2pb1.1 MB481.4 KB1.6 MB0.0 KB/s3.6 KB23:59:52
2usenet.pasdenom.info1012.1 KB1.4 MB2.4 MB0.0 KB/s2.6 KB23:59:52
3xanadu-bbs699.1 KB107.6 KB806.7 KB0.0 KB/s4.7 KB23:59:52
4fu-berlin.de250.0 KB41.4 KB291.5 KB0.0 KB/s3.9 KB23:59:52
5news.mixmin.net186.2 KB0.0 KB186.2 KB0.0 KB/s4.8 KB23:59:49
6neva.ru52.5 KB276.6 KB329.2 KB0.0 KB/s4.8 KB23:59:41
7xmission39.9 KB8.3 KB48.2 KB0.0 KB/s2.7 KB23:59:53
8eternal-september39.1 KB12.2 KB51.3 KB0.0 KB/s3.4 KB23:59:49
9news.swapon.de5.8 KB21.2 KB26.9 KB0.0 KB/s2.7 KB23:59:40
TOTAL: 93.4 MB2.3 MB5.7 MB0.0 KB/s3.3 KB215:58:20
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1202.89.176.220 288 51172.8 KB 49 0 004:35:00
2ip68-11-166-106.br.br.cox.net 1 13.6 KB 1 0 000:02:17
TOTAL: 2 289 52176.3 KB 50 0 0167:18:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 661 51172.8 KB 49 0 0149:15:29
2*.br.br.cox.net 1 13.6 KB 1 0 000:02:17
3*.chello.nl 41 00.0 KB 0 0 015:48:52
4*.bbox.io 2 00.0 KB 0 0 000:00:56
5*.147.22.98.dynamic.ip.windstream.net 1 00.0 KB 0 0 000:00:00
6*.nielsenmedia.com 4 00.0 KB 0 0 001:05:24
7*.ip-188-165-239.eu 2 00.0 KB 0 0 000:01:08
8*.tampfl.dsl-w.verizon.net 3 00.0 KB 0 0 001:04:35
TOTAL: 8 715 52176.3 KB 50 0 0167:18:44

NNRP auth users [Top 20]:

UserConn
moussa 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
63.142.120.8 32.344 7.801 0.00089:19:31
162.212.88.214 0.575 0.768 0.00055:20:55
dhcp-089-099-203-254.chello.nl 3.419 0.642 0.00015:48:52
202.89.176.220 28.402 5.568 0.73404:35:00
challenger.nielsenmedia.com 0.304 0.062 0.00001:05:24
pool-71-98-160-84.tampfl.dsl-w.verizon.net 0.239 0.048 0.00001:04:35
ip68-11-166-106.br.br.cox.net 0.157 0.024 0.00000:02:17
ns342002.ip-188-165-239.eu 0.118 0.039 0.00000:01:08
tempe0.bbox.io 0.187 0.032 0.00000:00:56
69.160.37.54 1.972 0.322 0.00000:00:02
TOTAL: 10 67.717 15.306 0.734167:18:44

Curious NNRP server explorers [Top 20]:

SystemConn
63.142.120.8 348
dhcp-089-099-203-254.chello.nl 41
69.160.37.54 25
challenger.nielsenmedia.com 4
pool-71-98-160-84.tampfl.dsl-w.verizon.net 3
tempe0.bbox.io 2
ns342002.ip-188-165-239.eu 2
h168.147.22.98.dynamic.ip.windstream.net 1
TOTAL: 8 426

NNRP client timeouts [Top 20]:

SystemConnPeer
dhcp-089-099-203-254.chello.nl 27 0
pool-71-98-160-84.tampfl.dsl-w.verizon.net 2 0
challenger.nielsenmedia.com 2 0
TOTAL: 3 31 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 52100.0%
TOTAL: 1 52100.0%

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

NewsgroupCount
1comp.os.vms 15
2comp.sys.ibm.pc.games.war-historical 11
3comp.arch 10
4comp.sys.ibm.pc.games.action 6
5comp.sys.ibm.pc.hardware.chips 3
6comp.answers 1
7comp.arch.embedded 1
8comp.ai.philosophy 1
9comp.sys.ibm.pc.demos 1
10comp.sys.ibm.pc.games.adventure 1
11comp.sys.apple2 1
12comp.ai.neural-nets 1
TOTAL: 12 52