Daily Usenet report for csiph.com

May 3 04:15:00 -- May 4 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 21404 49.2%5.5 MB 64.3%
innd 17641 40.5%2.3 MB 27.3%
innfeed 3508 8.1%630.5 KB 7.2%
nnrpd 968 2.2%106.1 KB 1.2%
nocem 25 0.1%2.9 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 43547 100.0%8.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 330349 56.2%
Negative hits 236606 40.2%
Do not exist 20613 3.5%
Cache misses 332 0.1%
TOTAL: 4 587900 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.270 0.0%29 0.000 9.310 18.600
article cleanup00:00:00.114 0.0%20442 0.000 0.006 0.029
article logging00:00:00.278 0.0%21093 0.000 0.013 0.107
article parse00:00:00.646 0.0%59167 0.000 0.011 0.047
article write00:00:08.102 0.0%16976 0.152 0.477 17.239
artlog/artcncl00:00:00.000 0.0%29 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%262 0.000 0.000 0.000
data move00:00:00.159 0.0%545520 0.000 0.000 0.002
hisgrep/artcncl00:00:00.027 0.0%29 0.000 0.931 2.200
hishave/artcncl00:00:00.006 0.0%29 0.000 0.207 0.600
hishave/artparse00:00:00.000 0.0%257 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.879 0.0%589536 0.002 0.007 0.097
history sync00:00:00.888 0.0%352 0.000 2.523 11.333
history write00:00:10.372 0.0%20414 0.049 0.508 4.407
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.110 0.0%257 0.000 0.428 5.000
idle23:56:54.620 99.7%554186 84.610 155.570 454.815
nntp read00:00:02.098 0.0%554322 0.001 0.004 0.008
overview write00:02:19.657 0.2%16976 0.074 8.227 1981.196
perl filter00:00:26.548 0.0%20409 1.045 1.301 1.932
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.273 0.0%33977 0.000 0.008 0.035
TOTAL: 24:00:42.07724:00:08.047100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.038 0.0%17275 0.000 0.002 0.021
article prepare00:00:00.000 0.0%12220 0.000 0.000 0.000
article read00:00:00.242 0.0%1455 0.000 0.166 11.000
backlog stats00:00:00.203 0.0%393337 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.414 0.0%310852 0.001 0.005 0.009
data write00:00:01.713 0.0%296883 0.001 0.006 0.014
idle23:54:32.060100.0%393337 107.916 218.825 656.369
status file00:00:00.179 0.0%273 0.000 0.656 2.000
TOTAL: 23:54:45.41623:54:35.849100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle47:29:40.418 99.8%617 207.000277115.750600168.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.012 0.0%1453 0.000 0.008 0.167
readart00:00:00.338 0.0%57 0.000 5.930 42.000
TOTAL: 47:34:29.22647:29:40.768 99.8%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 140
pause 2
paused 2
reload 2
reserve 2
TOTAL: 10 160

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 3 16336 4169 12105 62 25%24:08:43
2newsfeeds.xmission.com 2 17439 3850 13467 122 22%24:44:13
3feeder.eternal-september.org 4 19057 2473 16313 271 12%24:09:49
4csiph-out.feeder.erje.net 1440 85144 1422 83309 413 1%118:45:30
5csiph-out.news.xs4all.nl 860 19040 1019 16966 1055 5%71:26:54
6newsfeed.fu-berlin.de 14 16491 919 15301 271 5%24:42:47
7news-out.mixmin.net 3 18794 915 17524 355 4%25:59:23
8csiph-out.news.weretis.net 3 20800 663 20019 118 3%32:07:30
9newsfeed.neva.ru 145 16314 581 15375 358 3%71:39:34
10csiph-out.news.tnetconsulting.net 2 10668 313 10333 22 2%15:00:23
11csiph-out.feed.uzoreto.com 864 27205 305 26294 606 1%70:34:22
12news.fcku.it 14 1527 127 1398 2 8%21:47:50
13news-out.neodome.net 1 18671 119 18534 18 0%23:59:54
14nntp.pasdenom.info 2 11480 83 11372 25 0%23:59:39
15news.swapon.de 5 1794 40 1754 0 2%24:56:34
16news.bbs.nz 1 16638 11 16627 0 0%23:59:53
17localhost 31 5 5 0 0 100%00:00:04
18news.samoylyk.net 2 17050 2 17040 8 0%24:06:46
19xanadu-bbs.net 10 636 0 636 0 0%24:07:55
TOTAL: 19 3406 335089 17016 314367 3706 5%670:17:43
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeeds.xmission.com11.5 MB0.0 KB3.2 MB14.7 MB 78%3.8 KB
2news-out.aioe.org10.6 MB4.4 KB175.4 KB10.8 MB 98%2.6 KB
3csiph-out.feeder.erje.net7.7 MB30.6 KB6.4 MB14.1 MB 54%7.8 KB
4feeder.eternal-september.org6.8 MB5.6 KB1.2 MB8.0 MB 85%3.0 KB
5news-out.mixmin.net3.0 MB4.5 KB690.7 KB3.7 MB 81%3.0 KB
6csiph-out.news.xs4all.nl2.7 MB0.0 KB6.2 MB9.0 MB 30%4.4 KB
7csiph-out.news.weretis.net2.2 MB1.9 KB2.5 MB4.6 MB 46%6.1 KB
8newsfeed.fu-berlin.de2.1 MB0.0 KB782.7 KB2.9 MB 73%2.5 KB
9newsfeed.neva.ru1.6 MB10.9 KB1.2 MB2.8 MB 56%3.1 KB
10csiph-out.feed.uzoreto.com1.0 MB3.7 KB6.8 MB7.8 MB 13%8.8 KB
11csiph-out.news.tnetconsulting.net918.1 KB2.0 KB125.4 KB1.0 MB 87%3.1 KB
12news-out.neodome.net514.3 KB4.5 KB148.4 KB667.2 KB 77%4.9 KB
13news.fcku.it227.2 KB2.6 KB4.6 KB234.3 KB 96%1.8 KB
14nntp.pasdenom.info171.8 KB0.0 KB31.7 KB203.5 KB 84%1.9 KB
15news.swapon.de101.8 KB0.0 KB0.0 KB101.8 KB100%2.5 KB
16news.bbs.nz31.0 KB0.0 KB0.0 KB31.0 KB100%2.8 KB
17news.samoylyk.net8.4 KB4.5 KB418.6 KB431.5 KB 1%43.1 KB
18localhost7.6 KB0.0 KB0.0 KB7.6 KB100%1.5 KB
19xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1951.1 MB75.2 KB29.8 MB81.0 MB 63%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 3 04:15:00 - 04:59:59 239 1.4% 0.09825.2 KB 1.6% 0.31
May 3 05:00:00 - 05:59:59 372 2.2% 0.101.4 MB 2.8% 0.41
May 3 06:00:00 - 06:59:59 461 2.7% 0.131.3 MB 2.6% 0.38
May 3 07:00:00 - 07:59:59 658 3.9% 0.182.3 MB 4.4% 0.64
May 3 08:00:00 - 08:59:59 817 4.8% 0.232.2 MB 4.3% 0.63
May 3 09:00:00 - 09:59:59 777 4.6% 0.221.9 MB 3.8% 0.55
May 3 10:00:00 - 10:59:59 833 4.9% 0.232.6 MB 5.1% 0.75
May 3 11:00:00 - 11:59:59 904 5.3% 0.252.5 MB 4.8% 0.70
May 3 12:00:00 - 12:59:59 802 4.7% 0.222.3 MB 4.4% 0.64
May 3 13:00:00 - 13:59:59 1022 6.0% 0.283.2 MB 6.3% 0.92
May 3 14:00:00 - 14:59:59 917 5.4% 0.253.0 MB 5.8% 0.84
May 3 15:00:00 - 15:59:59 983 5.8% 0.272.8 MB 5.4% 0.79
May 3 16:00:00 - 16:59:59 1021 6.0% 0.283.0 MB 5.9% 0.85
May 3 17:00:00 - 17:59:59 1109 6.5% 0.313.1 MB 6.0% 0.87
May 3 18:00:00 - 18:59:59 952 5.6% 0.262.6 MB 5.0% 0.73
May 3 19:00:00 - 19:59:59 1003 5.9% 0.282.8 MB 5.4% 0.79
May 3 20:00:00 - 20:59:59 796 4.7% 0.222.3 MB 4.5% 0.66
May 3 21:00:00 - 21:59:59 704 4.1% 0.202.3 MB 4.6% 0.67
May 3 22:00:00 - 22:59:59 670 3.9% 0.192.5 MB 4.8% 0.70
May 3 23:00:00 - 23:59:59 444 2.6% 0.121.3 MB 2.6% 0.38
May 4 00:00:00 - 00:59:59 375 2.2% 0.101.2 MB 2.4% 0.34
May 4 01:00:00 - 01:59:59 344 2.0% 0.101.1 MB 2.1% 0.30
May 4 02:00:00 - 02:59:59 339 2.0% 0.091.2 MB 2.4% 0.35
May 4 03:00:00 - 03:59:59 328 1.9% 0.091.0 MB 2.0% 0.29
May 4 04:00:00 - 04:15:00 105 0.6% 0.12488.1 KB 0.9% 0.54
TOTAL: 24:00:00 16975 100.0% 0.2051.1 MB 100.0% 0.61
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1069 21 0 0 0 0 0 0 1048
2newsfeed.fu-berlin.de 734 15 0 0 0 0 0 0 719
3csiph-out.feed.uzoreto.com 621 4 0 2 0 0 0 0 615
4csiph-out.feeder.erje.net 421 46 0 10 0 0 0 0 365
5news-out.mixmin.net 362 0 0 2 0 0 0 0 360
6newsfeed.neva.ru 359 33 0 5 0 0 0 0 321
7feeder.eternal-september.org 277 24 0 3 0 0 0 0 250
8news-out.aioe.org 218 42 0 2 0 0 0 0 174
9csiph-out.news.weretis.net 130 37 0 2 0 0 0 0 91
10newsfeeds.xmission.com 120 1 0 0 0 0 0 0 119
11csiph-out.news.tnetconsulting.net 29 25 0 2 0 0 0 0 2
12nntp.pasdenom.info 25 0 0 0 0 0 0 0 25
13news-out.neodome.net 19 3 0 2 0 0 0 0 14
14news.samoylyk.net 8 0 0 2 0 0 0 0 6
15news.swapon.de 6 0 0 0 0 0 0 0 6
16news.fcku.it 2 1 0 1 0 0 0 0 0
TOTAL: 16 4400 252 0 33 0 0 0 0 4115

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.windows7.general 19
spline.eisfair 18
alt.bbs.synchronet 18
lada.talk 15
alt.binaries.pictures.purebeauty 15
mozilla.dev.security.policy 13
oesterreich.tratsch 13
alt.survival 9
mozilla.test 9
alt.politics.usa 8
mozilla.support.seamonkey 8
alt.philosophy 7
alt.paranormal.spells 6
mozilla.general 6
lada.auto 5
newsguy.test.m 5
it-alt.comp.software.mozilla 5
alt.politics 4
mozilla.support.thunderbird 4
free.metaphysics 3
TOTAL: 66 252

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2150
EMP (phn path) 452
EMP (phl) 251
EMP (phn nph) 114
Too many newsgroups 90
0 71
Binary Payload 34
HTML Multipart 16
Binary: misplaced binary 8
Scoring filter 6
HTML post 2
TOTAL: 11 3194

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 45
TOTAL: 1 45
Huge articles
csiph-out.feeder.erje.net 108
newsfeeds.xmission.com 43
csiph-out.feed.uzoreto.com 37
csiph-out.news.xs4all.nl 28
csiph-out.news.weretis.net 27
feeder.eternal-september.org 7
news.samoylyk.net 5
news-out.mixmin.net 3
news-out.neodome.net 2
newsfeed.fu-berlin.de 2
TOTAL: 11 263
Including strange strings
newsfeed.fu-berlin.de 448
news-out.aioe.org 155
csiph-out.feed.uzoreto.com 12
csiph-out.news.weretis.net 12
csiph-out.news.xs4all.nl 7
news-out.mixmin.net 6
news.swapon.de 6
csiph-out.feeder.erje.net 3
newsfeeds.xmission.com 2
feeder.eternal-september.org 1
TOTAL: 11 653
No colon-space in header
csiph-out.news.xs4all.nl 5
TOTAL: 1 5
TOTAL: 4 966

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 20007 1062 15910 2 0 0 5%23:59:42
2fu-berlin.de 15888 564 15324 0 0 0 3%23:59:53
3news.samoylyk.net 17757 556 16405 12 0 243 3%23:59:52
4news.bbs.nz 31954 346 16012 9 0 0 1%23:59:16
5tnet 17482 77 16293 0 0 0 0%23:59:50
6news.freedyn.net 17296 63 16912 0 0 0 0%23:59:53
7neva.ru 15769 48 15562 60 0 0 0%23:59:52
8newsfeed.xs4all.nl 16295 48 15719 19 0 101 0%23:59:52
9erje 18101 23 15278 94 0 0 0%23:59:52
10aioe 11895 22 11275 3 0 0 0%23:59:53
11eternal-september 14112 7 13712 0 0 0 0%23:59:53
12neodome.net 17233 7 16782 1 0 0 0%23:59:38
13news.mixmin.net 15501 7 15108 0 0 0 0%23:59:53
14xmission 14148 7 12553 0 0 0 0%23:59:42
15usenet.pasdenom.info 16864 7 16277 0 0 0 0%23:59:43
16news.uzoreto.com 16282 6 16072 18 0 0 0%23:59:52
17news.swapon.de 1838 5 1812 0 0 0 0%23:48:33
18weretis.net 15793 5 15528 0 0 0 0%23:59:53
19news.fcku.it 1296 0 1295 0 0 0 0%21:07:17
TOTAL: 19 295511 2860 263829 218 0 344 0%452:52:19
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs6.7 MB10.0 KB6.7 MB0.1 KB/s6.5 KB23:59:42
2fu-berlin.de5.5 MB0.0 KB5.5 MB0.1 KB/s9.9 KB23:59:53
3news.samoylyk.net5.5 MB38.1 KB5.5 MB0.1 KB/s9.9 KB23:59:52
4news.bbs.nz1.0 MB36.0 KB1.0 MB0.0 KB/s3.0 KB23:59:16
5news.freedyn.net721.2 KB0.0 KB721.2 KB0.0 KB/s11.4 KB23:59:53
6tnet233.6 KB0.0 KB233.6 KB0.0 KB/s3.0 KB23:59:50
7newsfeed.xs4all.nl191.5 KB112.5 KB303.9 KB0.0 KB/s4.5 KB23:59:52
8neva.ru127.0 KB202.6 KB329.6 KB0.0 KB/s3.1 KB23:59:52
9aioe68.1 KB10.3 KB78.4 KB0.0 KB/s3.1 KB23:59:53
10erje54.8 KB680.0 KB734.8 KB0.0 KB/s6.3 KB23:59:52
11usenet.pasdenom.info22.8 KB0.0 KB22.8 KB0.0 KB/s3.3 KB23:59:43
12eternal-september15.8 KB0.0 KB15.8 KB0.0 KB/s2.2 KB23:59:53
13news.mixmin.net12.9 KB0.0 KB12.9 KB0.0 KB/s1.8 KB23:59:53
14neodome.net12.5 KB1.5 KB14.0 KB0.0 KB/s1.8 KB23:59:38
15xmission12.2 KB0.0 KB12.2 KB0.0 KB/s1.7 KB23:59:42
16news.uzoreto.com9.3 KB157.7 KB167.0 KB0.0 KB/s7.0 KB23:59:52
17news.swapon.de7.6 KB0.0 KB7.6 KB0.0 KB/s1.5 KB23:48:33
18weretis.net7.6 KB0.0 KB7.6 KB0.0 KB/s1.5 KB23:59:53
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:07:17
TOTAL: 1920.1 MB1.2 MB21.4 MB0.0 KB/s7.1 KB452:52:19
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1a131033.upc-a.chello.nl 56 2034.1 KB 6 0 016:23:55
2ppp-2-84-163-204.home.otenet.gr 8 1626.3 KB 2 0 000:00:17
3047-035-184-003.res.spectrum.com 22 1628.6 KB 8 5 507:00:19
462.74.5.54 1 56.4 KB 1 0 000:00:03
TOTAL: 4 87 5795.4 KB 17 5 547:34:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.upc-a.chello.nl 56 2034.1 KB 6 0 016:23:55
2*.res.spectrum.com 22 1628.6 KB 8 5 507:00:19
3*.home.otenet.gr 8 1626.3 KB 2 0 000:00:17
4unresolved 78 56.4 KB 1 0 023:39:54
5*.hsd1.wa.comcast.net 1 00.0 KB 0 0 000:30:00
TOTAL: 5 165 5795.4 KB 17 5 547:34:28

NNRP auth users [Top 20]:

UserConn
ohlandl 5
TOTAL: 1 5

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 4.932 1.202 0.00023:39:44
a131033.upc-a.chello.nl 3.966 0.934 0.00016:23:55
047-035-184-003.res.spectrum.com 1.680 0.388 0.02607:00:19
c-73-140-175-55.hsd1.wa.comcast.net 0.063 0.016 0.00000:30:00
ppp-2-84-163-204.home.otenet.gr 0.577 0.133 0.00000:00:17
5.86.29.149 0.166 0.064 0.00000:00:03
62.74.5.54 0.117 0.000 0.00000:00:03
94.167.237.178 0.056 0.024 0.00000:00:01
94.162.167.139 0.070 0.008 0.00000:00:01
TOTAL: 9 11.627 2.769 0.02647:34:28

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 72
5.86.29.149 3
c-73-140-175-55.hsd1.wa.comcast.net 1
94.167.237.178 1
94.162.167.139 1
TOTAL: 5 78

NNRP client timeouts [Top 20]:

SystemConnPeer
047-035-184-003.res.spectrum.com 9 0
c-73-140-175-55.hsd1.wa.comcast.net 1 0
TOTAL: 2 10 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 57100.0%
TOTAL: 1 57100.0%

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

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