Daily Usenet report for csiph.com

Apr 15 04:15:00 -- Apr 16 04:15:00

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Apr 15 06:09:52 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[73699]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Apr 15 06:09:52 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[73699]: 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]
Apr 15 08:46:47 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[81743]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Apr 15 08:46:47 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[81743]: 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]
Apr 15 16:50:26 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[8701]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Apr 15 16:50:26 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[8701]: 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 22272 37.6%3.7 MB 33.0%
inn 19120 32.3%4.9 MB 43.5%
innfeed 15483 26.1%2.3 MB 20.6%
nnrpd 2358 4.0%328.1 KB 2.8%
nocem 10 0.0%1.4 KB 0.0%
TOTAL: 5 59243 100.0%11.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 296515 53.2%
Negative hits 241712 43.4%
Do not exist 18519 3.3%
Cache misses 400 0.1%
TOTAL: 4 557146 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.840 0.0%33 0.000 25.455 128.500
article cleanup00:00:00.110 0.0%18309 0.000 0.006 0.034
article logging00:00:01.404 0.0%18791 0.000 0.075 1.371
article parse00:00:01.132 0.0%55090 0.000 0.021 0.153
article write00:01:54.711 0.1%15490 0.169 7.405 53.253
artlog/artcncl00:00:00.000 0.0%33 0.000 0.000 0.000
artlog/artparse00:00:00.011 0.0%256 0.000 0.043 1.200
data move00:00:00.229 0.0%511025 0.000 0.000 0.021
hisgrep/artcncl00:00:00.031 0.0%32 0.000 0.969 5.000
hishave/artcncl00:00:00.038 0.0%33 0.000 1.152 12.000
hishave/artparse00:00:00.001 0.0%249 0.000 0.004 0.200
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:38.366 0.0%558170 0.003 0.069 0.237
history sync00:00:01.513 0.0%367 0.000 4.123 56.333
history write00:01:06.566 0.1%18306 0.233 3.636 9.794
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hiswrite/artparse00:00:00.675 0.0%249 0.000 2.711 26.000
idle23:34:18.393 98.6%512656 88.979 165.527 445.250
nntp read00:00:02.403 0.0%524330 0.001 0.005 0.014
overview write00:15:19.114 1.1%15490 0.152 59.336 22673.962
perl filter00:00:26.516 0.0%18299 0.964 1.449 7.000
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.272 0.0%30990 0.000 0.009 0.037
TOTAL: 23:54:56.97823:53:52.325 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.040 0.0%17426 0.000 0.002 0.018
article prepare00:00:00.001 0.0%4188 0.000 0.000 0.018
article read00:00:03.089 0.0%906 0.000 3.409 60.500
backlog stats00:00:00.195 0.0%310766 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.092 0.0%238731 0.000 0.005 0.016
data write00:00:01.490 0.0%225781 0.001 0.007 0.015
idle23:53:49.840100.0%310766 132.605 276.832 1407.555
status file00:00:03.511 0.0%5341 0.368 0.657 5.174
TOTAL: 23:54:11.97023:53:59.258100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle38:27:00.640 99.9%1268 0.000109164.543600017.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.423 0.0%3055 0.000 0.138 9.944
readart00:00:00.299 0.0%14 0.000 21.357 42.000
TOTAL: 38:29:03.62938:27:01.362 99.9%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 123
pause 2
paused 2
reload 4
reserve 2
TOTAL: 10 145

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.xs4all.nl 2233 17849 4588 11189 2072 25%127:18:09
2feeder.eternal-september.org 14 5245 2068 3078 99 39%27:05:20
3newsfeeds.xmission.com 3 13085 1353 11725 7 10%21:41:13
4news-out.aioe.org 1 13672 1291 12347 34 9%23:59:58
5newsfeed.fu-berlin.de 15 15243 1013 14193 37 6%27:17:00
6csiph-out.feeder.erje.net 1440 74314 998 72949 367 1%119:07:20
7news-out.mixmin.net 2 15976 894 14927 155 5%23:45:34
8csiph-out.news.weretis.net 4 17026 654 16327 45 3%30:00:27
9newsfeed.neva.ru 147 18321 535 17553 233 2%71:48:44
10nntp.pasdenom.info 5 10653 487 10165 1 4%28:50:52
11news.freedyn.net 2 17649 440 17086 123 2%23:59:57
12news-out.neodome.net 5 15763 333 15416 14 2%21:47:18
13news.fcku.it 10 1976 304 1664 8 15%22:26:13
14csiph-out.feed.uzoreto.com 864 25985 185 25679 121 0%71:26:32
15csiph-out.news.tnetconsulting.net 2 3029 37 2991 1 1%07:00:34
16news.swapon.de 4 1304 34 1270 0 2%23:43:16
17news.bbs.nz 2 4870 1 4869 0 0%09:49:24
18localhost 26 0 0 0 0 0%00:00:03
TOTAL: 18 4779 271960 15215 253428 3317 5%681:07:54
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.xs4all.nl12.2 MB0.0 KB19.2 MB31.4 MB 38%4.8 KB
2csiph-out.feeder.erje.net7.3 MB29.1 KB1.8 MB9.1 MB 79%6.8 KB
3feeder.eternal-september.org5.7 MB0.0 KB2.2 MB7.9 MB 71%3.7 KB
4newsfeeds.xmission.com3.8 MB0.0 KB310.5 KB4.1 MB 92%3.1 KB
5news-out.aioe.org3.3 MB14.8 KB111.3 KB3.4 MB 96%2.6 KB
6newsfeed.fu-berlin.de2.4 MB0.0 KB397.5 KB2.8 MB 86%2.8 KB
7news-out.mixmin.net2.1 MB17.3 KB391.7 KB2.5 MB 83%2.4 KB
8csiph-out.news.weretis.net1.9 MB2.3 KB1022.8 KB2.9 MB 65%4.2 KB
9news.freedyn.net1.2 MB14.9 KB1.1 MB2.3 MB 52%4.2 KB
10newsfeed.neva.ru1.2 MB1.3 KB636.0 KB1.8 MB 65%2.4 KB
11nntp.pasdenom.info970.7 KB0.0 KB0.8 KB971.5 KB 99%2.0 KB
12news-out.neodome.net792.9 KB25.9 KB91.9 KB910.8 KB 87%2.6 KB
13csiph-out.feed.uzoreto.com723.4 KB0.0 KB2.7 MB3.4 MB 20%11.3 KB
14news.fcku.it481.1 KB0.0 KB8.7 KB489.8 KB 98%1.6 KB
15csiph-out.news.tnetconsulting.net94.3 KB0.0 KB9.7 KB104.1 KB 90%2.7 KB
16news.swapon.de71.2 KB0.0 KB0.0 KB71.2 KB100%2.1 KB
17news.bbs.nz1.5 KB0.0 KB0.0 KB1.5 KB100%1.5 KB
18localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1844.1 MB105.6 KB29.9 MB74.1 MB 59%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 15 04:15:00 - 04:59:59 251 1.6% 0.091.9 MB 4.2% 0.73
Apr 15 05:00:00 - 05:59:59 390 2.5% 0.111.2 MB 2.6% 0.34
Apr 15 06:00:00 - 06:59:59 486 3.1% 0.141.2 MB 2.7% 0.34
Apr 15 07:00:00 - 07:59:59 664 4.3% 0.181.6 MB 3.5% 0.45
Apr 15 08:00:00 - 08:59:59 705 4.5% 0.201.9 MB 4.1% 0.53
Apr 15 09:00:00 - 09:59:59 691 4.5% 0.191.6 MB 3.5% 0.45
Apr 15 10:00:00 - 10:59:59 786 5.1% 0.221.9 MB 4.2% 0.54
Apr 15 11:00:00 - 11:59:59 728 4.7% 0.201.6 MB 3.6% 0.46
Apr 15 12:00:00 - 12:59:59 805 5.2% 0.222.5 MB 5.4% 0.70
Apr 15 13:00:00 - 13:59:59 850 5.5% 0.242.3 MB 5.0% 0.65
Apr 15 14:00:00 - 14:59:59 876 5.6% 0.243.0 MB 6.7% 0.85
Apr 15 15:00:00 - 15:59:59 946 6.1% 0.262.7 MB 5.9% 0.76
Apr 15 16:00:00 - 16:59:59 827 5.3% 0.232.3 MB 5.1% 0.66
Apr 15 17:00:00 - 17:59:59 992 6.4% 0.282.9 MB 6.5% 0.83
Apr 15 18:00:00 - 18:59:59 866 5.6% 0.242.6 MB 5.8% 0.74
Apr 15 19:00:00 - 19:59:59 782 5.0% 0.222.1 MB 4.6% 0.59
Apr 15 20:00:00 - 20:59:59 746 4.8% 0.212.2 MB 4.9% 0.63
Apr 15 21:00:00 - 21:59:59 656 4.2% 0.181.7 MB 3.9% 0.50
Apr 15 22:00:00 - 22:59:59 554 3.6% 0.151.7 MB 3.8% 0.48
Apr 15 23:00:00 - 23:59:59 440 2.8% 0.121.4 MB 3.1% 0.40
Apr 16 00:00:00 - 00:59:59 398 2.6% 0.111.2 MB 2.6% 0.34
Apr 16 01:00:00 - 01:59:59 329 2.1% 0.091.1 MB 2.3% 0.30
Apr 16 02:00:00 - 02:59:59 327 2.1% 0.091.1 MB 2.4% 0.31
Apr 16 03:00:00 - 03:59:59 328 2.1% 0.09980.2 KB 2.1% 0.27
Apr 16 04:00:00 - 04:15:00 100 0.6% 0.11570.0 KB 1.2% 0.63
TOTAL: 24:00:00 15523 100.0% 0.1845.1 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 2174 202 0 0 0 0 0 0 1972
2newsfeed.fu-berlin.de 371 3 0 0 0 0 0 0 368
3newsfeed.neva.ru 234 56 0 1 0 0 0 0 177
4news-out.mixmin.net 160 22 0 2 0 0 0 0 136
5csiph-out.feeder.erje.net 134 50 0 2 0 0 0 0 82
6csiph-out.feed.uzoreto.com 123 15 0 0 0 0 0 0 108
7news.freedyn.net 123 0 0 1 0 0 0 0 122
8feeder.eternal-september.org 84 41 0 0 0 0 0 0 43
9csiph-out.news.weretis.net 52 17 0 1 0 0 0 0 34
10news-out.aioe.org 38 26 0 1 0 0 0 0 11
11news-out.neodome.net 26 1 0 2 0 0 0 0 23
12news.swapon.de 18 0 0 0 0 0 0 0 18
13newsfeeds.xmission.com 13 1 0 0 0 0 0 0 12
14news.fcku.it 8 8 0 0 0 0 0 0 0
15csiph-out.news.tnetconsulting.net 4 3 0 0 0 0 0 0 1
16nntp.pasdenom.info 1 0 0 0 0 0 0 0 1
TOTAL: 16 3563 445 0 10 0 0 0 0 3108

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 153
alt.news.misc 50
lada.talk 34
it-alt.sport.calcio.juventus 23
alt.binaries.pictures.purebeauty 17
alt.job 15
alt.computer.hardware 11
alt.politics.usa 9
lada.movies 9
alt.bbs.synchronet 8
alt.testing 7
mozilla.support.seamonkey 6
alt.finance 6
alt.support.chronic.pain 5
alt.slack.goathead 4
lada.auto 4
alt.politics 4
alt.windows7.general 3
alt.binaries.ebook 3
free.virginmedia.binaries.test 3
TOTAL: 71 445

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1989
Too many newsgroups 252
EMP (phl) 45
0 30
Scoring filter 23
Binary: misplaced binary 18
HTML Multipart 10
Too many newsgroups (meow) 1
HTML post 1
TOTAL: 9 2369

INND misc events:

EventsCount
CCreader 1
TOTAL: 1 1

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 45
TOTAL: 1 45
Huge articles
csiph-out.news.xs4all.nl 139
csiph-out.feeder.erje.net 32
feeder.eternal-september.org 25
csiph-out.feed.uzoreto.com 20
news.freedyn.net 12
csiph-out.news.weretis.net 9
newsfeeds.xmission.com 5
news-out.mixmin.net 3
newsfeed.fu-berlin.de 3
csiph-out.news.tnetconsulting.net 1
TOTAL: 10 249
Including strange strings
newsfeed.fu-berlin.de 334
csiph-out.news.xs4all.nl 103
news.swapon.de 18
csiph-out.news.weretis.net 6
newsfeeds.xmission.com 6
news-out.aioe.org 5
csiph-out.feed.uzoreto.com 3
csiph-out.feeder.erje.net 3
news-out.mixmin.net 3
newsfeed.neva.ru 1
TOTAL: 11 483
No colon-space in header
csiph-out.news.xs4all.nl 6
csiph-out.feeder.erje.net 1
TOTAL: 2 7
TOTAL: 4 784

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1fu-berlin.de 14248 419 13829 0 0 0 2%23:50:07
2news.bbs.nz 28814 174 14731 45 0 0 0%23:50:07
3xmission 18089 143 13319 34 0 0 0%23:52:36
4tnet 16125 47 14900 10 0 0 0%23:50:07
5newsfeed.xs4all.nl 11037 30 10557 0 0 120 0%23:54:25
6weretis.net 14637 11 13991 28 0 0 0%23:50:07
7neodome.net 15428 8 15138 1 0 124 0%23:58:06
8usenet.pasdenom.info 14682 8 14492 0 0 3 0%23:59:54
9news.freedyn.net 15132 5 14918 39 0 0 0%23:54:07
10erje 14310 4 14227 18 0 0 0%23:57:30
11news.mixmin.net 13912 2 13760 2 0 0 0%23:50:07
12aioe 13197 1 12952 1 0 0 0%23:54:13
13news.swapon.de 1350 1 1335 0 0 0 0%23:37:22
14news.uzoreto.com 14441 1 14306 13 0 0 0%23:50:26
15news.samoylyk.net 0 0 0 0 0 15469 0%23:50:06
16xanadu-bbs 1698 0 0 0 0 17220 0%23:59:37
17neva.ru 14046 0 13927 2 0 0 0%23:50:07
18eternal-september 0 0 0 0 0 12778 0%23:50:07
19news.fcku.it 1512 0 1510 0 0 0 0%22:09:34
TOTAL: 19 222658 854 197892 193 0 45714 0%451:48:45
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1fu-berlin.de4.5 MB0.0 KB4.5 MB0.1 KB/s11.1 KB23:50:07
2news.bbs.nz493.1 KB139.4 KB632.5 KB0.0 KB/s2.9 KB23:50:07
3xmission391.9 KB90.3 KB482.3 KB0.0 KB/s2.7 KB23:52:36
4newsfeed.xs4all.nl147.2 KB0.0 KB147.2 KB0.0 KB/s4.9 KB23:54:25
5tnet88.7 KB24.2 KB112.9 KB0.0 KB/s2.0 KB23:50:07
6neodome.net60.2 KB2.5 KB62.7 KB0.0 KB/s7.0 KB23:58:06
7erje54.2 KB143.2 KB197.4 KB0.0 KB/s9.0 KB23:57:30
8usenet.pasdenom.info52.5 KB0.0 KB52.5 KB0.0 KB/s6.6 KB23:59:54
9weretis.net19.4 KB193.0 KB212.4 KB0.0 KB/s5.4 KB23:50:07
10news.freedyn.net18.4 KB708.5 KB726.9 KB0.0 KB/s16.5 KB23:54:07
11news.mixmin.net13.9 KB5.4 KB19.3 KB0.0 KB/s4.8 KB23:50:07
12news.swapon.de13.0 KB0.0 KB13.0 KB0.0 KB/s13.0 KB23:37:22
13news.uzoreto.com9.0 KB97.9 KB106.9 KB0.0 KB/s7.6 KB23:50:26
14aioe7.4 KB2.5 KB9.9 KB0.0 KB/s5.0 KB23:54:13
15news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:06
16xanadu-bbs0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:37
17neva.ru0.0 KB3.2 KB3.2 KB0.0 KB/s1.6 KB23:50:07
18eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:07
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s022:09:34
TOTAL: 195.9 MB1.4 MB7.2 MB0.0 KB/s7.1 KB451:48:45
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1208.72.53.129 14 959.2 KB 10 0 005:03:49
2a131033.upc-a.chello.nl 52 415.4 KB 4 0 009:43:54
3p2e5b5739.dip0.t-ipconnect.de 1 11.6 KB 1 0 000:00:06
TOTAL: 3 67 1476.2 KB 15 0 038:28:45

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 318 959.2 KB 10 0 028:44:45
2*.upc-a.chello.nl 52 415.4 KB 4 0 009:43:54
3*.dip0.t-ipconnect.de 1 11.6 KB 1 0 000:00:06
TOTAL: 3 371 1476.2 KB 15 0 038:28:45

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 17.352 3.890 0.00023:39:40
a131033.upc-a.chello.nl 3.336 0.748 0.00009:43:54
208.72.53.129 1.150 0.177 0.00005:03:49
81.145.97.98 0.185 0.038 0.00000:01:03
p2e5b5739.dip0.t-ipconnect.de 0.102 0.039 0.00000:00:06
151.38.46.13 0.118 0.030 0.00000:00:04
139.59.239.120 0.537 0.108 0.00000:00:03
151.34.146.52 0.084 0.000 0.00000:00:03
212.90.61.180 0.061 0.008 0.00000:00:01
TOTAL: 9 22.925 5.038 0.00038:28:45

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 288
139.59.239.120 9
81.145.97.98 3
151.38.46.13 2
151.34.146.52 1
212.90.61.180 1
TOTAL: 6 304

NNRP unrecognized commands (by host):

SystemConn
139.59.239.120 48
TOTAL: 1 48

NNRP unrecognized commands (by command):

CommandCount
Host: 69.160.37.58:119 8
Accept-Encoding: gzip, deflate 8
Accept: */* 8
Connection: keep-alive 8
User-Agent: Mozilla/5.0 (Windows NT 10.0... 7
GET /system_api.php HTTP/1.1 2
GET /client_area/ HTTP/1.1 1
GET /streaming/clients_live.php HTTP/1.1 1
GET /stalker_portal/c/version.js HTTP/1.... 1
GET /c/version.js HTTP/1.1 1
GET /stream/live.php HTTP/1.1 1
GET /stalker_portal/c/ HTTP/1.1 1
User-Agent: Mozilla/5.0 (Windows NT 6.1;... 1
TOTAL: 13 48

NNRP client timeouts [Top 20]:

SystemConnPeer
208.72.53.129 5 0
TOTAL: 1 5 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 14 93.3%
2de 1 6.7%
TOTAL: 2 15100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 11
2comp.unix.aix 2
3de.alt.folklore.computer 1
4comp.sys.powerpc.tech 1
TOTAL: 4 15
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: admin@kev009.com