Daily Usenet report for csiph.com

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

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

May 3 09:57:55 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[93227]: unable to get certificate from '/usr/local/news/etc/cert.pem'
May 3 09:57:55 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[93227]: error initializing TLS: [CA_file: ] [CA_path: /usr/local/news/etc] [cert_file: /usr/local/news/etc/cert.pem] [key_file: /usr/local/news/etc/key.pem]

Log entries by program:

Program nameLines%LinesSize%Size
innd 22844 42.9%3.7 MB 36.4%
inn 17920 33.7%4.6 MB 45.2%
nnrpd 8856 16.6%1.2 MB 11.6%
innfeed 3626 6.8%705.4 KB 6.8%
TOTAL: 4 53246 100.0%10.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 281972 53.5%
Negative hits 227185 43.1%
Do not exist 17459 3.3%
Cache misses 266 0.1%
TOTAL: 4 526882 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.420 0.0%25 0.000 16.800 59.000
article cleanup00:00:00.129 0.0%17050 0.000 0.008 0.097
article logging00:00:01.261 0.0%17510 0.000 0.072 1.182
article parse00:00:02.265 0.0%54580 0.000 0.041 0.793
article write00:01:49.049 0.1%14353 0.123 7.598 42.284
artlog/artcncl00:00:00.001 0.0%25 0.000 0.040 0.111
artlog/artparse00:00:00.053 0.0%388 0.000 0.137 12.000
data move00:00:00.152 0.0%487452 0.000 0.000 0.002
hisgrep/artcncl00:00:00.028 0.0%23 0.000 1.217 15.000
hishave/artcncl00:00:00.009 0.0%25 0.000 0.360 1.000
hishave/artparse00:00:00.001 0.0%387 0.000 0.003 0.071
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:55.160 0.1%528885 0.003 0.104 0.366
history sync00:00:01.454 0.0%373 0.000 3.898 47.500
history write00:01:19.001 0.1%17047 0.223 4.634 22.452
hiswrite/artcncl00:00:00.001 0.0%2 0.000 0.500 1.000
hiswrite/artparse00:00:01.779 0.0%387 0.000 4.597 48.600
idle23:42:54.231 98.7%488037 96.322 174.934 727.797
nntp read00:00:02.323 0.0%500688 0.002 0.005 0.012
overview write00:12:30.531 0.9%14353 0.158 52.291 1964.614
perl filter00:00:23.916 0.0%17046 1.049 1.403 3.438
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.267 0.0%28706 0.000 0.009 0.058
TOTAL: 24:01:02.89524:00:02.031 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.035 0.0%14403 0.000 0.002 0.025
article prepare00:00:00.002 0.0%5684 0.000 0.000 0.062
article read00:00:00.398 0.0%1243 0.000 0.320 7.250
backlog stats00:00:00.152 0.0%282571 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.926 0.0%218339 0.000 0.004 0.015
data write00:00:01.354 0.0%205340 0.000 0.007 0.017
idle23:54:00.906100.0%282571 157.764 304.493 1047.800
status file00:00:00.375 0.0%354 0.000 1.059 33.000
TOTAL: 23:54:15.79523:54:04.148100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle31:26:17.974 99.8%10333 0.000 10953.060209206.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.154 0.0%21965 0.000 0.007 3.286
readart00:00:00.061 0.0%54 0.000 1.130 40.000
TOTAL: 31:30:04.32831:26:18.189 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.xs4all.nl 2398 16408 4604 9733 2071 28%122:36:35
2feeder.eternal-september.org 15 4784 2163 2481 140 45%27:04:41
3newsfeeds.xmission.com 2 13724 1611 12106 7 11%26:12:39
4csiph-out.feeder.erje.net 1440 72679 1150 70895 634 1%118:41:30
5news-out.mixmin.net 2 14892 1071 13666 155 7%23:59:04
6newsfeed.fu-berlin.de 13 15136 971 14030 135 6%29:05:41
7csiph-out.news.weretis.net 3 27194 568 26602 24 2%47:59:40
8newsfeed.neva.ru 145 16833 429 16292 112 2%71:53:23
9nntp.pasdenom.info 3 16342 348 15990 4 2%46:13:29
10csiph-out.news.tnetconsulting.net 1 11384 343 11036 5 3%19:36:19
11news-out.aioe.org 2 13096 320 12753 23 2%23:59:48
12news.fcku.it 11 2043 318 1723 2 15%21:14:09
13news-out.neodome.net 2 15397 246 15129 22 1%23:59:46
14csiph-out.feed.uzoreto.com 864 25872 131 25658 83 0%71:16:01
15news.freedyn.net 1 16156 112 15998 46 0%23:59:57
16news.swapon.de 8 1371 37 1334 0 2%23:28:51
17news.bbs.nz 1 13503 16 13486 1 0%23:59:51
18localhost 26 0 0 0 0 0%00:00:00
TOTAL: 18 4937 296814 14438 278912 3464 4%745:21:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.xs4all.nl12.7 MB0.0 KB18.8 MB31.5 MB 40%4.8 KB
2csiph-out.feeder.erje.net8.3 MB19.7 KB5.4 MB13.8 MB 60%7.9 KB
3feeder.eternal-september.org5.7 MB0.0 KB4.9 MB10.5 MB 53%4.7 KB
4newsfeeds.xmission.com4.4 MB0.0 KB421.7 KB4.8 MB 91%3.0 KB
5news-out.mixmin.net2.4 MB0.0 KB465.8 KB2.8 MB 83%2.4 KB
6newsfeed.fu-berlin.de2.3 MB0.0 KB1.7 MB4.0 MB 57%3.7 KB
7csiph-out.news.weretis.net1.6 MB0.0 KB783.8 KB2.4 MB 67%4.1 KB
8news-out.aioe.org1.3 MB0.0 KB35.1 KB1.3 MB 97%4.0 KB
9newsfeed.neva.ru1.1 MB0.0 KB362.0 KB1.5 MB 76%2.8 KB
10csiph-out.news.tnetconsulting.net1.1 MB0.0 KB23.4 KB1.1 MB 97%3.2 KB
11news-out.neodome.net753.0 KB12.8 KB80.8 KB846.6 KB 88%3.2 KB
12nntp.pasdenom.info648.3 KB0.0 KB9.9 KB658.2 KB 98%1.9 KB
13news.fcku.it533.8 KB0.0 KB3.4 KB537.2 KB 99%1.7 KB
14news.freedyn.net458.7 KB13.9 KB354.5 KB827.1 KB 55%5.2 KB
15csiph-out.feed.uzoreto.com315.1 KB0.0 KB1.0 MB1.4 MB 22%6.5 KB
16news.swapon.de73.7 KB0.0 KB0.0 KB73.7 KB100%2.0 KB
17news.bbs.nz25.4 KB0.0 KB2.0 KB27.4 KB 92%1.6 KB
18localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1843.5 MB46.3 KB34.3 MB77.9 MB 55%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 3 04:15:00 - 04:59:59 260 1.8% 0.102.2 MB 5.1% 0.83
May 3 05:00:00 - 05:59:59 331 2.3% 0.091.6 MB 3.7% 0.46
May 3 06:00:00 - 06:59:59 446 3.1% 0.121.2 MB 2.7% 0.33
May 3 07:00:00 - 07:59:59 637 4.4% 0.181.6 MB 3.8% 0.46
May 3 08:00:00 - 08:59:59 742 5.2% 0.212.2 MB 5.1% 0.64
May 3 09:00:00 - 09:59:59 769 5.4% 0.212.0 MB 4.5% 0.56
May 3 10:00:00 - 10:59:59 785 5.5% 0.222.2 MB 5.0% 0.61
May 3 11:00:00 - 11:59:59 727 5.1% 0.202.0 MB 4.6% 0.57
May 3 12:00:00 - 12:59:59 693 4.8% 0.191.8 MB 4.1% 0.50
May 3 13:00:00 - 13:59:59 791 5.5% 0.221.9 MB 4.4% 0.55
May 3 14:00:00 - 14:59:59 889 6.2% 0.253.1 MB 7.1% 0.88
May 3 15:00:00 - 15:59:59 974 6.8% 0.272.9 MB 6.6% 0.81
May 3 16:00:00 - 16:59:59 860 6.0% 0.242.7 MB 6.2% 0.76
May 3 17:00:00 - 17:59:59 731 5.1% 0.202.3 MB 5.4% 0.67
May 3 18:00:00 - 18:59:59 763 5.3% 0.212.5 MB 5.9% 0.72
May 3 19:00:00 - 19:59:59 661 4.6% 0.181.9 MB 4.4% 0.55
May 3 20:00:00 - 20:59:59 590 4.1% 0.161.7 MB 3.9% 0.48
May 3 21:00:00 - 21:59:59 594 4.1% 0.171.4 MB 3.2% 0.40
May 3 22:00:00 - 22:59:59 432 3.0% 0.121.3 MB 3.0% 0.37
May 3 23:00:00 - 23:59:59 411 2.9% 0.111.1 MB 2.6% 0.32
May 4 00:00:00 - 00:59:59 327 2.3% 0.09928.7 KB 2.1% 0.26
May 4 01:00:00 - 01:59:59 321 2.2% 0.09951.6 KB 2.1% 0.26
May 4 02:00:00 - 02:59:59 254 1.8% 0.07835.2 KB 1.9% 0.23
May 4 03:00:00 - 03:59:59 273 1.9% 0.08768.7 KB 1.7% 0.21
May 4 04:00:00 - 04:15:00 85 0.6% 0.09398.4 KB 0.9% 0.44
TOTAL: 24:00:00 14346 100.0% 0.1743.4 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 2165 217 0 0 0 0 0 0 1948
2newsfeed.fu-berlin.de 404 10 0 0 0 0 0 0 394
3csiph-out.feeder.erje.net 303 97 0 1 0 0 0 0 205
4news-out.mixmin.net 164 3 0 0 0 0 0 0 161
5feeder.eternal-september.org 150 65 0 0 0 0 0 0 85
6newsfeed.neva.ru 121 33 0 0 0 0 0 0 88
7csiph-out.feed.uzoreto.com 85 10 0 0 0 0 0 0 75
8csiph-out.news.weretis.net 36 7 0 0 0 0 0 0 29
9news.freedyn.net 36 1 0 2 0 0 0 0 33
10news-out.aioe.org 26 19 0 0 0 0 0 0 7
11news-out.neodome.net 21 1 0 1 0 0 0 0 19
12news.swapon.de 14 0 0 0 0 0 0 0 14
13newsfeeds.xmission.com 12 0 0 0 0 0 0 0 12
14csiph-out.news.tnetconsulting.net 8 8 0 0 0 0 0 0 0
15nntp.pasdenom.info 2 0 0 0 0 0 0 0 2
16news.fcku.it 2 2 0 0 0 0 0 0 0
17news.bbs.nz 1 1 0 0 0 0 0 0 0
TOTAL: 17 3550 474 0 4 0 0 0 0 3072

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 127
alt.news.misc 52
it-alt.sport.calcio.juventus 40
alt.binaries.by-hash.shv1 34
alt.windows7.general 17
lada.talk 15
alt.blah 15
alt.job 14
alt.bbs.synchronet 14
alt.finance 10
alt.computer.hardware 7
alt.binaries.pictures.purebeauty 7
alt.politics.usa 7
alt.binaries.kindle 6
alt.va.personals 6
ba.forsale 5
alt.binaries.ebook 5
alt.tv.comedy-central.daily-show 4
alt.christian.bible 4
demos.local.lists.cgp-russian 4
TOTAL: 70 474

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1469
Too many newsgroups 282
EMP (phn nph) 161
EMP (phl) 87
EMP (phn path) 81
Binary Payload 69
Binary: misplaced binary 30
0 24
Scoring filter 12
HTML Multipart 6
Too many newsgroups (meow) 1
TOTAL: 11 2222

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Huge articles
csiph-out.news.xs4all.nl 209
csiph-out.feeder.erje.net 75
feeder.eternal-september.org 71
csiph-out.feed.uzoreto.com 11
csiph-out.news.weretis.net 11
newsfeeds.xmission.com 6
news-out.mixmin.net 4
news.freedyn.net 2
TOTAL: 8 389
Including strange strings
newsfeed.fu-berlin.de 319
csiph-out.news.xs4all.nl 91
news.swapon.de 14
news-out.mixmin.net 9
csiph-out.news.weretis.net 9
newsfeed.neva.ru 7
newsfeeds.xmission.com 5
csiph-out.feed.uzoreto.com 2
csiph-out.feeder.erje.net 2
news-out.aioe.org 1
TOTAL: 11 460
No colon-space in header
csiph-out.news.xs4all.nl 1
TOTAL: 1 1
TOTAL: 3 850

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1fu-berlin.de 13198 505 12693 0 0 0 3%23:59:50
2erje 15052 257 12334 261 0 11 1%23:55:25
3news.bbs.nz 26430 126 13515 28 0 0 0%23:51:03
4xmission 16532 83 12010 7 0 0 0%23:59:50
5newsfeed.xs4all.nl 9627 31 9259 2 0 73 0%23:54:21
6tnet 14651 24 13646 2 0 0 0%23:50:10
7news.uzoreto.com 13359 7 13250 4 0 0 0%23:57:31
8usenet.pasdenom.info 13627 6 13435 16 0 0 0%23:59:50
9news.mixmin.net 12470 3 12346 1 0 0 0%23:59:50
10weretis.net 13317 2 12872 5 0 0 0%23:50:10
11aioe 11861 2 11645 0 0 0 0%23:50:10
12news.freedyn.net 14254 2 14082 40 0 0 0%23:55:08
13neodome.net 14211 2 14017 0 0 1 0%23:56:34
14neva.ru 13149 2 13060 11 0 0 0%23:59:45
15eternal-september 0 0 0 0 0 11447 0%23:59:50
16xanadu-bbs 0 0 0 0 0 14346 0%23:58:43
17news.fcku.it 1637 0 1636 0 0 7 0%20:56:48
18news.swapon.de 1334 0 1330 0 0 0 0%23:32:57
19news.samoylyk.net 0 0 0 0 0 14296 0%23:50:06
TOTAL: 19 204709 1052 181130 377 0 40181 0%451:18:01
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1fu-berlin.de5.7 MB0.0 KB5.7 MB0.1 KB/s11.6 KB23:59:50
2erje766.0 KB802.6 KB1.5 MB0.0 KB/s3.0 KB23:55:25
3news.bbs.nz350.7 KB98.1 KB448.8 KB0.0 KB/s2.9 KB23:51:03
4xmission236.6 KB19.3 KB255.9 KB0.0 KB/s2.8 KB23:59:50
5newsfeed.xs4all.nl74.3 KB2.5 KB76.8 KB0.0 KB/s2.3 KB23:54:21
6tnet60.8 KB4.0 KB64.8 KB0.0 KB/s2.5 KB23:50:10
7news.uzoreto.com14.7 KB34.9 KB49.6 KB0.0 KB/s4.5 KB23:57:31
8usenet.pasdenom.info13.8 KB26.9 KB40.7 KB0.0 KB/s1.9 KB23:59:50
9aioe8.1 KB0.0 KB8.1 KB0.0 KB/s4.0 KB23:50:10
10neva.ru7.5 KB17.8 KB25.3 KB0.0 KB/s1.9 KB23:59:45
11news.mixmin.net4.6 KB1.3 KB5.9 KB0.0 KB/s1.5 KB23:59:50
12news.freedyn.net3.8 KB703.7 KB707.5 KB0.0 KB/s16.8 KB23:55:08
13weretis.net2.5 KB29.9 KB32.4 KB0.0 KB/s4.6 KB23:50:10
14neodome.net2.0 KB0.0 KB2.0 KB0.0 KB/s1.0 KB23:56:34
15eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:50
16xanadu-bbs0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:43
17news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s020:56:48
18news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:32:57
19news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:06
TOTAL: 197.2 MB1.7 MB8.9 MB0.0 KB/s6.4 KB451:18:01
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1217-121-77-183.cable.dynamic.v4.ziggo.nl 119 53128.0 KB 46 0 000:27:29
2a131033.upc-a.chello.nl 39 12.4 KB 1 0 006:02:10
TOTAL: 2 158 54130.4 KB 47 0 031:29:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cable.dynamic.v4.ziggo.nl 119 53128.0 KB 46 0 000:27:29
2*.upc-a.chello.nl 39 12.4 KB 1 0 006:02:10
3*.security.ipip.net 1 00.0 KB 0 0 000:00:02
4*.163.24.10.ip.us.as30241.net 2 00.0 KB 0 0 001:00:15
5unresolved 289 00.0 KB 0 0 023:59:49
TOTAL: 5 450 54130.4 KB 47 0 031:29:46

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 17.253 4.351 0.00023:54:00
a131033.upc-a.chello.nl 2.443 0.486 0.00006:02:10
192.163.24.10.ip.us.as30241.net 0.182 0.056 0.00001:00:15
217-121-77-183.cable.dynamic.v4.ziggo.nl 12.198 2.181 0.00000:27:29
81.145.97.98 0.057 0.019 0.00000:05:48
scan-141.security.ipip.net 0.061 0.015 0.00000:00:02
TOTAL: 6 32.194 7.108 0.00031:29:46

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 288
192.163.24.10.ip.us.as30241.net 2
81.145.97.98 1
scan-141.security.ipip.net 1
TOTAL: 4 292

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
Connection: close 1
GET / HTTP/1.1 1
Host: 69.160.37.58:119 1
User-Agent: HTTP Banner Detection (https... 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
192.163.24.10.ip.us.as30241.net 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1free 43 79.6%
2rec 8 14.8%
3misc 2 3.7%
4comp 1 1.9%
TOTAL: 4 54100.0%

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

NewsgroupCount
1free.usenet 28
2free.pt 14
3rec.arts.tv 8
4misc.news.internet.discuss 2
5comp.sys.ibm.ps2.hardware 1
6free.willey 1
TOTAL: 6 54
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: admin@kev009.com