Daily Usenet report for csiph.com

Aug 21 04:15:00 -- Aug 22 04:15:00

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 21 09:03:12 csiph nnrpd[31441]: cpc73515-shef13-2-0-cust748.17-1.cable.virginm.net noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
inn 59019 64.8%8.1 MB 71.4%
innd 29782 32.7%2.9 MB 25.5%
innfeed 1850 2.0%310.6 KB 2.7%
nnrpd 383 0.4%43.8 KB 0.4%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 5 91035 100.0%11.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 259375 45.3%
Positive hits 250664 43.8%
Do not exist 58810 10.3%
Cache misses 3684 0.6%
TOTAL: 4 572533 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.213 0.0%265 0.000 0.804 70.000
article cleanup00:00:00.308 0.0%55454 0.000 0.006 0.033
article logging00:00:00.659 0.0%55692 0.000 0.012 0.031
article parse00:00:07.113 0.0%888416 0.001 0.008 0.016
article write00:00:06.430 0.0%27048 0.180 0.238 0.407
artlog/artcncl00:00:00.002 0.0%228 0.000 0.009 1.000
artlog/artparse00:00:00.040 0.0%3028 0.000 0.013 1.000
data move00:00:00.574 0.0%1312991 0.000 0.000 0.001
hisgrep/artcncl00:00:00.002 0.0%246 0.000 0.008 0.125
hishave/artcncl00:00:00.000 0.0%265 0.000 0.000 0.000
hishave/artparse00:00:00.011 0.0%3028 0.000 0.004 0.019
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.268 0.0%570350 0.000 0.002 0.006
history sync00:00:00.469 0.0%324 0.000 1.448 3.000
history write00:00:12.994 0.0%55451 0.071 0.234 0.355
hiswrite/artcncl00:00:00.003 0.0%19 0.000 0.158 0.300
hiswrite/artparse00:00:00.851 0.0%3026 0.000 0.281 3.000
idle23:56:57.795 99.8%1284794 11.361 67.106 328.187
nntp read00:00:03.828 0.0%1286179 0.001 0.003 0.006
overview write00:00:04.594 0.0%27048 0.106 0.170 0.464
perl filter00:02:14.880 0.2%55451 0.986 2.432 4.252
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.516 0.0%54096 0.000 0.010 0.031
TOTAL: 24:00:31.58923:59:52.550100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.072 0.0%26963 0.000 0.003 0.025
article prepare00:00:00.000 0.0%7888 0.000 0.000 0.000
article read00:00:00.292 0.0%1606 0.000 0.182 7.833
backlog stats00:00:00.129 0.0%302517 0.000 0.000 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.244 0.0%230710 0.000 0.005 0.014
data write00:00:01.782 0.0%206360 0.001 0.009 0.018
idle23:54:15.404100.0%302517 159.628 284.465 758.277
status file00:00:00.088 0.0%181 0.000 0.486 1.000
TOTAL: 23:54:22.71823:54:19.011100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.458 0.0%21135 0.000 0.022 0.500
idle27:10:06.995100.0%21259 0.000 4600.734600156.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.228 0.0%42575 0.000 0.005 0.333
readart00:00:00.081 0.0%1 81.000 81.000 81.000
TOTAL: 27:10:26.57627:10:07.762100.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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feeder.eternal-september.org 3 51813 6915 38399 6499 13%24:15:27
2xanadu-bbs.net 8 55324 4507 41331 9486 8%25:09:32
3au2pb.net 2 28425 4371 23425 629 15%23:26:39
4news-out.mixmin.net 3 30725 4245 24597 1883 13%24:09:31
5newsfeed.neva.ru 144 74154 3065 59844 11245 4%71:51:09
6newsfeeds.xmission.com 1 26999 2990 23647 362 11%24:07:34
7news.swapon.de 1 2241 467 1769 5 20%24:47:49
8nntp.pasdenom.info 4 26112 443 25616 53 1%22:46:33
9localhost 48 10246 0 10246 0 0%00:00:57
TOTAL: 9 214 306039 27003 248874 30162 8%240:35:11
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder.eternal-september.org21.3 MB10.9 KB80.5 MB101.8 MB 20%7.8 KB
2xanadu-bbs.net13.9 MB0.0 KB506.5 MB520.4 MB 2%38.1 KB
3news-out.mixmin.net13.4 MB14.4 KB5.6 MB19.0 MB 70%3.2 KB
4au2pb.net11.6 MB0.0 KB5.3 MB16.9 MB 68%3.5 KB
5newsfeed.neva.ru9.6 MB18.0 KB99.5 MB109.2 MB 8%7.8 KB
6newsfeeds.xmission.com8.6 MB0.0 KB3.0 MB11.5 MB 74%3.5 KB
7news.swapon.de1.2 MB0.0 KB28.5 KB1.2 MB 97%2.6 KB
8nntp.pasdenom.info1016.3 KB0.0 KB384.6 KB1.4 MB 72%2.8 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 980.6 MB43.3 KB700.7 MB781.4 MB 10%14.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 21 04:15:00 - 04:59:59 424 1.6% 0.161.3 MB 1.6% 0.50
Aug 21 05:00:00 - 05:59:59 601 2.2% 0.172.2 MB 2.7% 0.63
Aug 21 06:00:00 - 06:59:59 844 3.1% 0.233.2 MB 4.0% 0.91
Aug 21 07:00:00 - 07:59:59 1202 4.4% 0.334.7 MB 5.9% 1.35
Aug 21 08:00:00 - 08:59:59 1343 5.0% 0.373.6 MB 4.5% 1.02
Aug 21 09:00:00 - 09:59:59 1494 5.5% 0.414.3 MB 5.3% 1.21
Aug 21 10:00:00 - 10:59:59 1266 4.7% 0.353.5 MB 4.4% 1.00
Aug 21 11:00:00 - 11:59:59 1460 5.4% 0.414.1 MB 5.1% 1.18
Aug 21 12:00:00 - 12:59:59 1498 5.5% 0.424.0 MB 5.0% 1.15
Aug 21 13:00:00 - 13:59:59 1447 5.4% 0.404.0 MB 5.0% 1.14
Aug 21 14:00:00 - 14:59:59 1449 5.4% 0.403.9 MB 4.8% 1.10
Aug 21 15:00:00 - 15:59:59 1487 5.5% 0.414.1 MB 5.1% 1.17
Aug 21 16:00:00 - 16:59:59 1360 5.0% 0.383.8 MB 4.8% 1.09
Aug 21 17:00:00 - 17:59:59 1662 6.2% 0.464.9 MB 6.1% 1.39
Aug 21 18:00:00 - 18:59:59 1392 5.2% 0.393.8 MB 4.6% 1.07
Aug 21 19:00:00 - 19:59:59 1446 5.4% 0.405.2 MB 6.4% 1.47
Aug 21 20:00:00 - 20:59:59 1352 5.0% 0.383.8 MB 4.7% 1.08
Aug 21 21:00:00 - 21:59:59 1140 4.2% 0.323.3 MB 4.0% 0.92
Aug 21 22:00:00 - 22:59:59 1016 3.8% 0.282.8 MB 3.5% 0.81
Aug 21 23:00:00 - 23:59:59 792 2.9% 0.222.5 MB 3.1% 0.72
Aug 22 00:00:00 - 00:59:59 675 2.5% 0.191.9 MB 2.4% 0.55
Aug 22 01:00:00 - 01:59:59 532 2.0% 0.151.8 MB 2.3% 0.52
Aug 22 02:00:00 - 02:59:59 492 1.8% 0.141.8 MB 2.3% 0.52
Aug 22 03:00:00 - 03:59:59 492 1.8% 0.141.6 MB 1.9% 0.44
Aug 22 04:00:00 - 04:15:00 149 0.6% 0.17497.5 KB 0.6% 0.55
TOTAL: 24:00:00 27015 100.0% 0.3180.7 MB 100.0% 0.96
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 11287 1360 0 1 0 0 0 0 9926
2xanadu-bbs.net 10810 685 0 0 0 0 0 010125
3feeder.eternal-september.org 6564 238 0 1 0 0 0 0 6325
4news-out.mixmin.net 1923 11 0 1 0 0 0 0 1911
5au2pb.net 665 586 0 0 0 0 0 0 79
6newsfeeds.xmission.com 364 333 0 0 0 0 0 0 31
7news.swapon.de 94 0 0 0 0 0 0 0 94
8nntp.pasdenom.info 71 62 0 0 0 0 0 0 9
TOTAL: 8 31778 3275 0 3 0 0 0 028500

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 540
lada.talk 223
ut.test 183
lada.auto 119
mailing.freebsd.pkg-fallout 109
alt.politics 107
mailing.freebsd.svn-ports-all 98
mailing.freebsd.svn-ports-head 95
mailing.freebsd.ports-bugs 84
alt.politics.scorched-earth 80
alt.job 69
mpc.lists.freebsd.ports.bugs 66
mozilla.dev.tree-alerts 53
mailing.gcc.gcc 53
pld.cvs.commit 39
alt.windows7.general 36
mailing.gcc.gcc-cvs 35
fa.freebsd.cvs-all 35
mailing.freebsd.svn-src-all 35
mailing.freebsd.svn-src-head 34
TOTAL: 251 3275

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 21259
EMP (phn path) 3057
EMP (phl) 697
Too many newsgroups 57
HTML Multipart 48
Binary Image: misplaced jpg 23
Binary: non-binary distribution 3
Too many newsgroups (low_xpost) 2
HTML Image Tags 1
HTML post 1
Binary Image: misplaced gif 1
Binary Payload 1
TOTAL: 12 25150

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Huge articles
xanadu-bbs.net 2859
feeder.eternal-september.org 135
news-out.mixmin.net 49
au2pb.net 36
newsfeeds.xmission.com 29
nntp.pasdenom.info 4
TOTAL: 6 3112
Including strange strings
news.swapon.de 91
feeder.eternal-september.org 63
news-out.mixmin.net 32
au2pb.net 30
xanadu-bbs.net 12
newsfeed.neva.ru 6
nntp.pasdenom.info 3
newsfeeds.xmission.com 1
TOTAL: 8 238
TOTAL: 2 3350

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1usenet.pasdenom.info 32697 402 25338 834 0 5 1%23:59:58
2au2pb 23943 196 22174 207 0 0 0%23:59:58
3xanadu-bbs 24904 96 22346 88 0 0 0%23:59:40
4fu-berlin.de 25513 43 25436 34 0 0 0%23:59:42
5xmission 28030 14 23874 0 0 0 0%23:59:58
6news.mixmin.net 23512 7 22546 7 0 0 0%23:59:56
7eternal-september 21337 3 19681 2 0 0 0%23:59:58
8news.swapon.de 2051 1 2019 1 0 0 0%23:55:26
9neva.ru 25064 1 23703 38 0 0 0%23:59:57
TOTAL: 9 207051 763 187117 1211 0 5 0%215:54:33
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1usenet.pasdenom.info1.2 MB1.9 MB3.1 MB0.0 KB/s2.6 KB23:59:58
2au2pb936.2 KB705.3 KB1.6 MB0.0 KB/s4.1 KB23:59:58
3xanadu-bbs640.6 KB173.0 KB813.5 KB0.0 KB/s4.4 KB23:59:40
4fu-berlin.de308.9 KB43.4 KB352.3 KB0.0 KB/s4.6 KB23:59:42
5news.mixmin.net46.0 KB10.6 KB56.6 KB0.0 KB/s4.0 KB23:59:56
6xmission31.5 KB0.0 KB31.5 KB0.0 KB/s2.2 KB23:59:58
7eternal-september10.4 KB3.1 KB13.5 KB0.0 KB/s2.7 KB23:59:58
8neva.ru3.9 KB221.4 KB225.3 KB0.0 KB/s5.8 KB23:59:57
9news.swapon.de2.1 KB4.4 KB6.5 KB0.0 KB/s3.2 KB23:55:26
TOTAL: 93.2 MB3.0 MB6.2 MB0.0 KB/s3.2 KB215:54:33
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
162.146.127.176.dynamic.wline.res.cust.swisscom.ch 2 13.0 KB 1 0 000:30:15
2cpc73515-shef13-2-0-cust748.17-1.cable.virginm.net 2 00.0 KB 0 0 100:00:03
TOTAL: 2 4 13.0 KB 1 0 127:10:25

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.146.127.176.dynamic.wline.res.cust.swisscom.ch 2 13.0 KB 1 0 000:30:15
2*.17-1.cable.virginm.net 2 00.0 KB 0 0 100:00:03
3*.ip-188-165-239.eu 2 00.0 KB 0 0 000:06:39
4*.chello.nl 3 00.0 KB 0 0 001:05:33
5*.br.br.cox.net 1 00.0 KB 0 0 000:00:34
6unresolved 55 00.0 KB 0 0 024:27:08
7*.nielsenmedia.com 3 00.0 KB 0 0 001:00:11
TOTAL: 7 68 13.0 KB 1 0 127:10:25

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
162.212.88.198 0.404 0.536 0.00021:37:26
71.94.21.184 2.525 0.735 0.00002:49:40
dhcp-089-099-203-254.chello.nl 0.260 0.023 0.00001:05:33
challenger.nielsenmedia.com 0.234 0.047 0.00001:00:11
62.146.127.176.dynamic.wline.res.cust.swisscom.ch 0.223 0.024 0.00000:30:15
ns342002.ip-188-165-239.eu 0.143 0.140 0.00000:06:39
ip70-172-227-76.br.br.cox.net 0.122 0.015 0.00000:00:34
cpc73515-shef13-2-0-cust748.17-1.cable.virginm.net 0.177 0.016 0.00000:00:03
69.160.37.54 2.070 0.313 0.00000:00:02
TOTAL: 9 6.158 1.849 0.00027:10:25

Curious NNRP server explorers [Top 20]:

SystemConn
71.94.21.184 30
69.160.37.54 25
dhcp-089-099-203-254.chello.nl 3
challenger.nielsenmedia.com 3
ns342002.ip-188-165-239.eu 2
ip70-172-227-76.br.br.cox.net 1
TOTAL: 6 64

NNRP unrecognized commands (by host):

SystemConn
71.94.21.184 30
TOTAL: 1 30

NNRP unrecognized commands (by command):

CommandCount
XFEATURE COMPRESS GZIP 30
TOTAL: 1 30

NNRP client timeouts [Top 20]:

SystemConnPeer
dhcp-089-099-203-254.chello.nl 2 0
challenger.nielsenmedia.com 2 0
62.146.127.176.dynamic.wline.res.cust.swisscom.ch 1 0
TOTAL: 3 5 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 1100.0%
TOTAL: 1 1100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 1
TOTAL: 1 1