Daily Usenet report for csiph.com

Sep 1 04:15:00 -- Sep 2 04:15:00

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Sep 1 05:04:04 csiph pgpverify[8315]: pgpverify: verification failed
Sep 1 07:51:46 csiph pgpverify[15696]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 52359 49.1%7.6 MB 60.7%
nnrpd 31868 29.9%2.7 MB 21.3%
innd 20623 19.3%2.0 MB 16.0%
innfeed 1885 1.8%261.5 KB 2.0%
controlchan 9 0.0%1.3 KB 0.0%
pgpverify 2 0.0%0.2 KB 0.0%
TOTAL: 6 106746 100.0%12.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 278069 47.2%
Negative hits 254679 43.2%
Do not exist 51063 8.7%
Cache misses 5464 0.9%
TOTAL: 4 589275 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.548 0.0%585 0.000 0.937 25.200
article cleanup00:00:00.288 0.0%50248 0.000 0.006 0.030
article logging00:00:00.617 0.0%50724 0.000 0.012 0.045
article parse00:00:02.898 0.0%313087 0.003 0.009 0.017
article write00:00:06.626 0.0%28583 0.148 0.232 0.352
artlog/artcncl00:00:00.008 0.0%548 0.000 0.015 0.167
artlog/artparse00:00:00.018 0.0%1091 0.000 0.016 1.000
data move00:00:00.297 0.0%795885 0.000 0.000 0.001
hisgrep/artcncl00:00:00.007 0.0%574 0.000 0.012 0.053
hishave/artcncl00:00:00.000 0.0%585 0.000 0.000 0.000
hishave/artparse00:00:00.003 0.0%1091 0.000 0.003 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.440 0.0%590650 0.001 0.002 0.006
history sync00:00:00.452 0.0%302 0.000 1.497 3.000
history write00:00:12.970 0.0%50244 0.073 0.258 0.327
hiswrite/artcncl00:00:00.001 0.0%11 0.000 0.091 0.500
hiswrite/artparse00:00:00.299 0.0%1091 0.000 0.274 2.000
idle23:57:40.249 99.8%783403 18.320 110.110 314.527
nntp read00:00:02.558 0.0%782315 0.001 0.003 0.006
overview write00:00:04.695 0.0%28583 0.089 0.164 0.489
perl filter00:01:36.670 0.1%50244 1.012 1.924 3.703
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.489 0.0%57169 0.000 0.009 0.024
TOTAL: 24:00:26.93623:59:51.133100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.072 0.0%28747 0.000 0.003 0.030
article prepare00:00:00.002 0.0%8332 0.000 0.000 0.017
article read00:00:00.224 0.0%1676 0.000 0.134 8.000
backlog stats00:00:00.092 0.0%319867 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.223 0.0%245027 0.001 0.005 0.011
data write00:00:01.872 0.0%219329 0.003 0.009 0.018
idle23:52:50.370100.0%319867 140.557 268.769 735.760
status file00:00:00.072 0.0%193 0.000 0.373 1.000
TOTAL: 23:53:00.00323:52:53.927100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:01.550 0.0%93095 0.000 0.017 0.250
idle71:09:51.172100.0%124381 1.000 2059.729600343.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.734 0.0%330660 0.000 0.005 0.500
readart00:00:00.063 0.0%50 0.000 1.260 60.000
TOTAL: 71:11:03.53071:09:54.519100.0%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
moderator@dana.de000100
us-control@lists.killfile.org000100
TOTAL001201

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feeder.eternal-september.org 6 47143 8430 36175 2538 17%25:32:51
2au2pb.net 4 32014 4684 26502 828 14%25:30:51
3xanadu-bbs.net 2 50759 4662 36424 9673 9%24:50:16
4newsfeed.neva.ru 147 64041 3165 53337 7539 4%71:56:10
5news-out.mixmin.net 7 33540 2854 29168 1518 8%24:31:21
6newsfeeds.xmission.com 1 29048 2797 25956 295 9%23:56:05
7newsfeed.fu-berlin.de 71 32760 1428 31090 242 4%36:17:38
8nntp.pasdenom.info 2 20119 335 19697 87 1%15:16:37
9news.swapon.de 1 2559 250 2307 2 9%23:37:57
10localhost 48 13627 0 13627 0 0%00:01:00
TOTAL: 10 289 325610 28605 274283 22722 8%271:30:46
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder.eternal-september.org23.4 MB10.1 KB16.9 MB40.3 MB 58%3.8 KB
2xanadu-bbs.net12.5 MB10.2 KB204.2 MB216.7 MB 5%15.5 KB
3au2pb.net11.9 MB10.1 KB3.7 MB15.6 MB 75%2.9 KB
4newsfeed.neva.ru9.7 MB0.0 KB52.5 MB62.2 MB 15%6.0 KB
5news-out.mixmin.net9.1 MB0.0 KB5.5 MB14.7 MB 62%3.4 KB
6newsfeeds.xmission.com7.9 MB10.1 KB2.4 MB10.3 MB 76%3.4 KB
7newsfeed.fu-berlin.de3.3 MB0.0 KB948.6 KB4.2 MB 78%2.6 KB
8nntp.pasdenom.info750.9 KB0.0 KB398.6 KB1.1 MB 65%2.7 KB
9news.swapon.de697.1 KB0.0 KB581.7 KB1.2 MB 54%5.1 KB
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1079.2 MB40.5 KB287.3 MB366.5 MB 21%7.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 1 04:15:00 - 04:59:59 433 1.5% 0.161.3 MB 1.6% 0.49
Sep 1 05:00:00 - 05:59:59 558 2.0% 0.151.6 MB 2.0% 0.45
Sep 1 06:00:00 - 06:59:59 869 3.0% 0.242.4 MB 3.1% 0.69
Sep 1 07:00:00 - 07:59:59 1101 3.9% 0.313.1 MB 4.0% 0.89
Sep 1 08:00:00 - 08:59:59 1228 4.3% 0.343.5 MB 4.4% 0.99
Sep 1 09:00:00 - 09:59:59 1316 4.6% 0.373.4 MB 4.3% 0.97
Sep 1 10:00:00 - 10:59:59 1336 4.7% 0.373.7 MB 4.7% 1.06
Sep 1 11:00:00 - 11:59:59 1290 4.5% 0.363.4 MB 4.2% 0.95
Sep 1 12:00:00 - 12:59:59 1346 4.7% 0.373.4 MB 4.3% 0.97
Sep 1 13:00:00 - 13:59:59 1506 5.3% 0.424.0 MB 5.0% 1.14
Sep 1 14:00:00 - 14:59:59 1564 5.5% 0.434.1 MB 5.2% 1.16
Sep 1 15:00:00 - 15:59:59 1764 6.2% 0.494.6 MB 5.8% 1.31
Sep 1 16:00:00 - 16:59:59 1543 5.4% 0.434.0 MB 5.0% 1.13
Sep 1 17:00:00 - 17:59:59 1666 5.8% 0.464.2 MB 5.3% 1.21
Sep 1 18:00:00 - 18:59:59 1825 6.4% 0.514.9 MB 6.2% 1.40
Sep 1 19:00:00 - 19:59:59 1643 5.7% 0.464.3 MB 5.5% 1.23
Sep 1 20:00:00 - 20:59:59 1446 5.1% 0.403.9 MB 5.0% 1.12
Sep 1 21:00:00 - 21:59:59 1335 4.7% 0.373.7 MB 4.7% 1.06
Sep 1 22:00:00 - 22:59:59 1052 3.7% 0.293.2 MB 4.0% 0.90
Sep 1 23:00:00 - 23:59:59 715 2.5% 0.202.1 MB 2.6% 0.60
Sep 2 00:00:00 - 00:59:59 740 2.6% 0.212.5 MB 3.1% 0.71
Sep 2 01:00:00 - 01:59:59 744 2.6% 0.212.3 MB 2.9% 0.65
Sep 2 02:00:00 - 02:59:59 526 1.8% 0.151.7 MB 2.2% 0.50
Sep 2 03:00:00 - 03:59:59 568 2.0% 0.161.7 MB 2.2% 0.49
Sep 2 04:00:00 - 04:15:00 470 1.6% 0.522.2 MB 2.7% 2.47
TOTAL: 24:00:00 28584 100.0% 0.3379.3 MB 100.0% 0.94
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1xanadu-bbs.net 9740 842 0 1 0 0 0 0 8897
2newsfeed.neva.ru 7507 1528 0 0 0 0 0 0 5979
3feeder.eternal-september.org 2573 355 0 1 0 0 0 0 2217
4news-out.mixmin.net 1539 10 0 0 0 0 0 0 1529
5au2pb.net 860 788 0 1 0 0 0 0 71
6newsfeed.fu-berlin.de 583 43 0 0 0 0 0 0 540
7newsfeeds.xmission.com 303 275 0 1 0 0 0 0 27
8nntp.pasdenom.info 108 98 0 0 0 0 0 0 10
9news.swapon.de 12 0 0 0 0 0 0 0 12
TOTAL: 9 23225 3939 0 4 0 0 0 019282

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 695
ut.test 151
lada.talk 151
alt.politics 114
it-alt.sport.calcio.juventus 105
mailing.freebsd.pkg-fallout 104
lada.auto 102
pld.cvs.commit 102
alt.politics.scorched-earth 94
mailing.freebsd.svn-ports-all 85
mailing.openbsd.source-changes 78
mailing.freebsd.svn-ports-head 72
mpc.lists.nanog 59
mailing.gcc.gcc 58
alt.windows7.general 58
mailing.freebsd.svn-src-all 53
mailing.freebsd.ports-bugs 53
fa.openbsd.source-changes 52
fa.freebsd.cvs-all 50
mailing.freebsd.svn-src-head 50
TOTAL: 384 3939

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 14299
EMP (phn path) 2306
EMP (phl) 759
EMP (phn nph) 166
HTML Multipart 62
Too many newsgroups 54
PFM bot misc 44
Binary Image: misplaced jpg 17
HTML post 4
HTML Image Tags 1
Binary: misplaced zip 1
TOTAL: 11 17713

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Huge articles
xanadu-bbs.net 940
feeder.eternal-september.org 55
news-out.mixmin.net 53
newsfeeds.xmission.com 18
au2pb.net 14
newsfeed.fu-berlin.de 8
nntp.pasdenom.info 4
news.swapon.de 1
TOTAL: 8 1093
Including strange strings
newsfeed.fu-berlin.de 329
feeder.eternal-september.org 51
au2pb.net 45
xanadu-bbs.net 18
news-out.mixmin.net 10
news.swapon.de 9
newsfeeds.xmission.com 7
nntp.pasdenom.info 4
newsfeed.neva.ru 3
TOTAL: 9 476
TOTAL: 2 1569

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1usenet.pasdenom.info 34999 387 26797 939 0 67 1%23:59:56
2au2pb 25528 248 23559 212 0 161 0%23:59:56
3xanadu-bbs 25724 98 23765 35 0 6 0%23:59:56
4fu-berlin.de 26809 60 26722 27 0 0 0%23:59:55
5news.mixmin.net 26692 17 25537 8 0 0 0%23:59:46
6xmission 30524 6 25621 1 0 0 0%23:59:56
7neva.ru 26300 6 25153 36 0 0 0%23:59:55
8eternal-september 21136 2 19740 2 0 0 0%23:59:40
9news.swapon.de 2440 0 2394 7 0 0 0%23:59:42
TOTAL: 9 220152 824 199288 1267 0 234 0%215:58:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1usenet.pasdenom.info1.3 MB2.2 MB3.5 MB0.0 KB/s2.7 KB23:59:56
2au2pb1016.6 KB926.5 KB1.9 MB0.0 KB/s4.2 KB23:59:56
3fu-berlin.de567.3 KB36.2 KB603.5 KB0.0 KB/s6.9 KB23:59:55
4xanadu-bbs560.0 KB69.5 KB629.5 KB0.0 KB/s4.7 KB23:59:56
5news.mixmin.net102.6 KB11.3 KB113.9 KB0.0 KB/s4.6 KB23:59:46
6neva.ru33.5 KB204.5 KB237.9 KB0.0 KB/s5.7 KB23:59:55
7xmission17.9 KB3.8 KB21.6 KB0.0 KB/s3.1 KB23:59:56
8eternal-september9.2 KB3.0 KB12.2 KB0.0 KB/s3.1 KB23:59:40
9news.swapon.de0.0 KB36.9 KB36.9 KB0.0 KB/s5.3 KB23:59:42
TOTAL: 93.6 MB3.4 MB7.0 MB0.0 KB/s3.4 KB215:58:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1202.89.176.220 287 47147.1 KB 44 0 004:35:26
2pool-71-98-160-84.tampfl.dsl-w.verizon.net 11 11.3 KB 1 0 001:43:42
3dhcp-089-099-203-254.chello.nl 4 12.3 KB 1 0 001:16:58
4challenger.nielsenmedia.com 9 11.3 KB 1 0 001:38:55
TOTAL: 4 311 50152.0 KB 47 0 071:10:59

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 327 47147.1 KB 44 0 041:59:37
2*.tampfl.dsl-w.verizon.net 11 11.3 KB 1 0 001:43:42
3*.chello.nl 4 12.3 KB 1 0 001:16:58
4*.nielsenmedia.com 9 11.3 KB 1 0 001:38:55
5*.bbox.io 10 00.0 KB 0 0 001:07:21
6*.dynamic.caiway.nl 8 00.0 KB 0 0 022:54:18
7*.snarked.org 2 00.0 KB 0 0 000:00:01
8*.ok.ok.cox.net 1 00.0 KB 0 0 000:30:03
TOTAL: 8 372 50152.0 KB 47 0 071:10:59

NNRP auth users [Top 20]:

UserConn
moussa 287
TOTAL: 1 287

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
041-020-158-163.dynamic.caiway.nl 2.068 2.503 0.00022:54:18
71.94.21.184 0.866 1.057 0.00021:12:39
162.212.88.198 0.947 0.369 0.00016:11:30
202.89.176.220 26.436 5.806 0.70504:35:26
pool-71-98-160-84.tampfl.dsl-w.verizon.net 0.939 0.126 0.00001:43:42
challenger.nielsenmedia.com 0.622 0.144 0.00001:38:55
dhcp-089-099-203-254.chello.nl 0.441 0.078 0.00001:16:58
tempe0.bbox.io 0.713 0.156 0.00001:07:21
ip68-14-171-134.ok.ok.cox.net 0.092 0.015 0.00000:30:03
69.160.37.54 1.981 0.279 0.00000:00:02
news.snarked.org 0.205 0.152 0.00000:00:01
TOTAL: 11 35.310 10.685 0.70571:10:59

Curious NNRP server explorers [Top 20]:

SystemConn
69.160.37.54 25
162.212.88.198 12
tempe0.bbox.io 10
041-020-158-163.dynamic.caiway.nl 8
71.94.21.184 3
news.snarked.org 2
ip68-14-171-134.ok.ok.cox.net 1
TOTAL: 7 61

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
041-020-158-163.dynamic.caiway.nl 8 0
pool-71-98-160-84.tampfl.dsl-w.verizon.net 3 0
challenger.nielsenmedia.com 3 0
tempe0.bbox.io 2 0
ip68-14-171-134.ok.ok.cox.net 1 0
dhcp-089-099-203-254.chello.nl 1 0
TOTAL: 6 18 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 50100.0%
TOTAL: 1 50100.0%

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

NewsgroupCount
1comp.arch 17
2comp.sys.ibm.pc.games.action 15
3comp.os.vms 9
4comp.lang.awk 2
5comp.ai.neural-nets 2
6comp.archives.ms-windows.discuss 1
7comp.sys.ibm.as400.misc 1
8comp.arch.embedded 1
9comp.sys.ibm.ps2.hardware 1
10comp.sys.ibm.pc.hardware.chips 1
TOTAL: 10 50