Daily Usenet report for csiph.com

Dec 16 04:15:00 -- Dec 17 04:15:00

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Dec 16 10:07:29 csiph nnrpd[9328]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 16 10:07:29 csiph nnrpd[9328]: 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]
Dec 16 14:45:20 csiph nnrpd[24203]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 16 14:45:20 csiph nnrpd[24203]: 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]
Dec 16 20:22:25 csiph nnrpd[41524]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 16 20:22:25 csiph nnrpd[41524]: 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]
Dec 17 00:01:06 csiph nnrpd[52646]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 17 00:01:06 csiph nnrpd[52646]: 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
inn 19053 48.5%4.8 MB 63.3%
innd 15898 40.5%2.1 MB 27.6%
innfeed 3511 8.9%618.1 KB 8.0%
nnrpd 769 2.0%82.9 KB 1.1%
nocem 15 0.0%1.8 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 39247 100.0%7.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 300416 54.2%
Negative hits 234928 42.4%
Do not exist 18536 3.3%
Cache misses 245 0.0%
TOTAL: 4 554125 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.258 0.0%36 0.000 7.167 29.500
article cleanup00:00:00.101 0.0%18177 0.000 0.006 0.026
article logging00:00:00.312 0.0%18674 0.000 0.017 0.450
article parse00:00:00.788 0.0%56519 0.000 0.014 0.113
article write00:00:14.586 0.0%15006 0.159 0.972 66.946
artlog/artcncl00:00:00.000 0.0%36 0.000 0.000 0.000
artlog/artparse00:00:00.014 0.0%359 0.000 0.039 1.600
data move00:00:00.165 0.0%524898 0.000 0.000 0.003
hisgrep/artcncl00:00:00.013 0.0%36 0.000 0.361 1.000
hishave/artcncl00:00:00.001 0.0%36 0.000 0.028 0.100
hishave/artparse00:00:00.001 0.0%342 0.000 0.003 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.209 0.0%555167 0.001 0.018 0.171
history sync00:00:00.880 0.0%371 0.000 2.372 12.500
history write00:00:16.350 0.0%18194 0.178 0.899 6.582
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.272 0.0%342 0.000 0.795 10.000
idle23:58:12.819 99.8%530684 81.385 162.607 520.980
nntp read00:00:02.026 0.0%532608 0.001 0.004 0.008
overview write00:01:01.093 0.1%15006 0.048 4.071 306.175
perl filter00:00:25.671 0.0%18177 1.083 1.412 2.096
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.249 0.0%30027 0.000 0.008 0.038
TOTAL: 24:00:59.69924:00:25.808100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.033 0.0%15033 0.000 0.002 0.028
article prepare00:00:00.001 0.0%12004 0.000 0.000 0.015
article read00:00:00.223 0.0%1366 0.000 0.163 45.000
backlog stats00:00:00.215 0.0%333428 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.262 0.0%261183 0.000 0.005 0.011
data write00:00:01.486 0.0%248738 0.000 0.006 0.015
idle23:54:50.043100.0%333428 121.255 258.197 1043.111
status file00:00:00.173 0.0%279 0.000 0.620 2.000
TOTAL: 23:55:00.21223:54:53.436100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle30:48:55.155 99.8%423 69.000262258.050600243.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.010 0.0%1089 0.000 0.009 0.167
readart00:00:00.167 0.0%11 0.000 15.182 42.000
TOTAL: 30:52:34.98230:48:55.332 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 4 14209 2968 11110 131 20%24:09:12
2newsfeeds.xmission.com 2 14424 2749 11631 44 19%25:07:53
3feeder.eternal-september.org 12 5976 2223 3683 70 37%26:55:46
4csiph-out.news.xs4all.nl 514 17636 2005 14175 1456 11%67:33:39
5newsfeed.fu-berlin.de 14 16531 1015 15285 231 6%28:45:10
6csiph-out.feeder.erje.net 1440 74748 870 73612 266 1%118:44:03
7news-out.mixmin.net 2 16290 840 15121 329 5%23:59:49
8csiph-out.news.weretis.net 3 30025 835 28988 202 2%47:59:44
9newsfeed.neva.ru 150 14795 616 13860 319 4%71:48:18
10csiph-out.feed.uzoreto.com 864 23777 278 23064 435 1%71:16:29
11news.fcku.it 10 1584 257 1325 2 16%21:27:23
12news-out.neodome.net 1 16643 233 16386 24 1%23:59:53
13nntp.pasdenom.info 1 9884 107 9721 56 1%23:59:54
14news.swapon.de 5 1625 42 1580 3 2%23:42:21
15csiph-out.news.tnetconsulting.net 1 14277 37 14209 31 0%23:59:56
16news.freedyn.net 1 17715 18 17669 28 0%23:59:58
17news.samoylyk.net 2 14646 11 14629 6 0%24:57:02
18localhost 30 4 4 0 0 100%00:00:01
19news.bbs.nz 2 13907 0 13906 1 0%23:59:45
20xanadu-bbs.net 23 472 0 472 0 0%22:31:15
TOTAL: 20 3081 319168 15108 300426 3634 4%718:57:31
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeeds.xmission.com8.3 MB0.0 KB2.0 MB10.3 MB 80%3.8 KB
2news-out.aioe.org7.2 MB0.0 KB515.3 KB7.7 MB 93%2.5 KB
3csiph-out.feeder.erje.net6.6 MB0.0 KB1.9 MB8.5 MB 77%7.7 KB
4feeder.eternal-september.org5.9 MB0.0 KB259.7 KB6.2 MB 95%2.8 KB
5csiph-out.news.xs4all.nl5.0 MB0.0 KB9.5 MB14.5 MB 34%4.3 KB
6newsfeed.fu-berlin.de2.4 MB0.0 KB567.1 KB3.0 MB 81%2.4 KB
7news-out.mixmin.net2.2 MB0.0 KB652.0 KB2.8 MB 77%2.5 KB
8csiph-out.news.weretis.net2.1 MB11.9 KB2.8 MB5.0 MB 42%4.9 KB
9newsfeed.neva.ru1.5 MB0.0 KB1.8 MB3.4 MB 45%3.7 KB
10csiph-out.feed.uzoreto.com944.5 KB0.0 KB9.5 MB10.4 MB 8%15.0 KB
11news-out.neodome.net688.9 KB0.0 KB245.8 KB934.7 KB 73%3.6 KB
12news.fcku.it375.8 KB0.0 KB2.4 KB378.2 KB 99%1.5 KB
13nntp.pasdenom.info220.6 KB0.0 KB69.4 KB290.0 KB 76%1.8 KB
14csiph-out.news.tnetconsulting.net166.4 KB0.0 KB59.4 KB225.8 KB 73%3.3 KB
15news.swapon.de96.4 KB0.0 KB6.3 KB102.7 KB 93%2.3 KB
16news.freedyn.net67.9 KB0.0 KB921.2 KB989.1 KB 6%21.5 KB
17news.samoylyk.net33.6 KB0.0 KB13.2 KB46.9 KB 71%2.8 KB
18localhost6.2 KB0.0 KB0.0 KB6.2 KB100%1.6 KB
19news.bbs.nz0.0 KB0.0 KB2.7 KB2.7 KB 0%2.7 KB
20xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2043.8 MB11.9 KB30.8 MB74.6 MB 58%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 16 04:15:00 - 04:59:59 194 1.3% 0.07594.8 KB 1.3% 0.22
Dec 16 05:00:00 - 05:59:59 330 2.2% 0.092.3 MB 5.3% 0.65
Dec 16 06:00:00 - 06:59:59 329 2.2% 0.091.1 MB 2.6% 0.32
Dec 16 07:00:00 - 07:59:59 389 2.6% 0.111.1 MB 2.6% 0.33
Dec 16 08:00:00 - 08:59:59 514 3.4% 0.141.4 MB 3.1% 0.39
Dec 16 09:00:00 - 09:59:59 792 5.3% 0.221.9 MB 4.4% 0.54
Dec 16 10:00:00 - 10:59:59 721 4.8% 0.201.8 MB 4.2% 0.52
Dec 16 11:00:00 - 11:59:59 777 5.2% 0.222.4 MB 5.4% 0.67
Dec 16 12:00:00 - 12:59:59 758 5.1% 0.211.9 MB 4.3% 0.54
Dec 16 13:00:00 - 13:59:59 791 5.3% 0.222.0 MB 4.6% 0.57
Dec 16 14:00:00 - 14:59:59 766 5.1% 0.211.9 MB 4.4% 0.55
Dec 16 15:00:00 - 15:59:59 1042 7.0% 0.293.4 MB 7.9% 0.98
Dec 16 16:00:00 - 16:59:59 880 5.9% 0.242.4 MB 5.5% 0.68
Dec 16 17:00:00 - 17:59:59 853 5.7% 0.243.2 MB 7.4% 0.91
Dec 16 18:00:00 - 18:59:59 833 5.6% 0.232.3 MB 5.4% 0.66
Dec 16 19:00:00 - 19:59:59 843 5.6% 0.232.2 MB 5.1% 0.63
Dec 16 20:00:00 - 20:59:59 873 5.8% 0.242.4 MB 5.4% 0.67
Dec 16 21:00:00 - 21:59:59 764 5.1% 0.212.0 MB 4.5% 0.56
Dec 16 22:00:00 - 22:59:59 723 4.8% 0.202.1 MB 4.7% 0.59
Dec 16 23:00:00 - 23:59:59 502 3.4% 0.141.4 MB 3.3% 0.41
Dec 17 00:00:00 - 00:59:59 348 2.3% 0.10978.3 KB 2.2% 0.27
Dec 17 01:00:00 - 01:59:59 298 2.0% 0.08813.9 KB 1.8% 0.23
Dec 17 02:00:00 - 02:59:59 272 1.8% 0.08830.3 KB 1.9% 0.23
Dec 17 03:00:00 - 03:59:59 327 2.2% 0.091002.9 KB 2.2% 0.28
Dec 17 04:00:00 - 04:15:00 66 0.4% 0.07190.4 KB 0.4% 0.21
TOTAL: 24:00:00 14985 100.0% 0.1743.6 MB 100.0% 0.52
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1469 53 0 0 0 0 0 0 1416
2newsfeed.fu-berlin.de 601 26 0 0 0 0 0 0 575
3csiph-out.feed.uzoreto.com 437 32 0 0 0 0 0 0 405
4news-out.mixmin.net 333 0 0 0 0 0 0 0 333
5newsfeed.neva.ru 321 71 0 0 0 0 0 0 250
6csiph-out.news.weretis.net 232 71 0 0 0 0 0 0 161
7news-out.aioe.org 191 117 0 0 0 0 0 0 74
8csiph-out.feeder.erje.net 149 62 0 0 0 0 0 0 87
9feeder.eternal-september.org 70 41 0 0 0 0 0 0 29
10nntp.pasdenom.info 56 0 0 0 0 0 0 0 56
11newsfeeds.xmission.com 54 6 0 0 0 0 0 0 48
12csiph-out.news.tnetconsulting.net 32 32 0 0 0 0 0 0 0
13news.freedyn.net 30 0 0 0 0 0 0 0 30
14news.swapon.de 26 0 0 0 0 0 0 0 26
15news-out.neodome.net 23 5 0 0 0 0 0 0 18
16news.samoylyk.net 6 0 0 0 0 0 0 0 6
17news.fcku.it 2 2 0 0 0 0 0 0 0
TOTAL: 17 4032 518 0 0 0 0 0 0 3514

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 164
lada.talk 44
alt.tv.comedy-central.daily-show 43
alt.binaries.pictures.purebeauty 26
spline.eisfair 22
it-alt.sport.calcio.juventus 20
alt.bbs.synchronet 20
scinet.stats 17
mozilla.support.firefox 14
alt.politics 10
lada.auto 10
at.jobs 10
mozilla.support.seamonkey 7
lada.photo 7
alt.windows7.general 7
oesterreich.tratsch 5
mozilla.support.thunderbird 5
alt.job 5
alt.survival 4
alt.binaries.sounds.radio.bbc.highspeed 4
TOTAL: 73 518

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1932
EMP (phn path) 313
EMP (phl) 171
EMP (phn nph) 81
0 78
Too many newsgroups 53
HTML Multipart 14
Binary: misplaced binary 8
Scoring filter 6
HTML post 2
Too many newsgroups (meow) 1
TOTAL: 11 2659

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 60
TOTAL: 1 60
Huge articles
csiph-out.feed.uzoreto.com 122
csiph-out.news.xs4all.nl 97
newsfeeds.xmission.com 35
csiph-out.feeder.erje.net 34
csiph-out.news.weretis.net 30
news.freedyn.net 17
news-out.neodome.net 3
news-out.mixmin.net 2
newsfeed.fu-berlin.de 1
feeder.eternal-september.org 1
TOTAL: 10 342
Including strange strings
newsfeed.fu-berlin.de 380
news-out.aioe.org 62
news.swapon.de 23
newsfeeds.xmission.com 13
csiph-out.news.xs4all.nl 8
csiph-out.news.weretis.net 3
news-out.mixmin.net 3
csiph-out.feeder.erje.net 1
feeder.eternal-september.org 1
csiph-out.feed.uzoreto.com 1
TOTAL: 11 496
No colon-space in header
csiph-out.news.xs4all.nl 16
csiph-out.feed.uzoreto.com 1
TOTAL: 2 17
TOTAL: 4 915

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 17381 845 14137 1 0 0 4%23:59:55
2fu-berlin.de 13857 576 13281 0 0 0 4%23:59:55
3news.samoylyk.net 15426 572 14395 7 0 56 3%23:59:55
4news.bbs.nz 28272 281 14089 17 0 0 0%23:59:55
5newsfeed.xs4all.nl 13574 109 12758 2 0 15 0%23:59:55
6xmission 13043 69 11614 2 0 0 0%23:59:40
7neva.ru 13430 68 13192 34 0 0 0%23:59:55
8usenet.pasdenom.info 14645 63 14203 15 0 0 0%23:59:53
9tnet 15680 42 14347 2 0 0 0%23:59:35
10erje 16833 34 13786 116 0 0 0%23:59:55
11news.uzoreto.com 14442 14 14222 37 0 0 0%23:59:53
12news.freedyn.net 14467 11 14179 55 0 0 0%23:59:50
13news.mixmin.net 13451 9 13190 0 0 0 0%23:59:55
14aioe 10965 7 10608 0 0 6 0%23:59:55
15news.swapon.de 1628 6 1610 0 0 0 0%23:51:23
16neodome.net 14982 6 14600 0 0 0 0%23:59:51
17weretis.net 13963 4 13475 3 0 0 0%23:59:39
18eternal-september 0 0 0 0 0 12083 0%23:59:55
19news.fcku.it 1272 0 1262 0 0 0 0%20:47:04
TOTAL: 19 247311 2716 218948 291 0 12160 1%452:35:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs6.4 MB4.7 KB6.5 MB0.1 KB/s7.8 KB23:59:55
2fu-berlin.de5.8 MB0.0 KB5.8 MB0.1 KB/s10.2 KB23:59:55
3news.samoylyk.net5.7 MB29.1 KB5.8 MB0.1 KB/s10.2 KB23:59:55
4news.bbs.nz747.8 KB70.0 KB817.9 KB0.0 KB/s2.7 KB23:59:55
5newsfeed.xs4all.nl390.4 KB70.7 KB461.1 KB0.0 KB/s4.2 KB23:59:55
6xmission178.9 KB8.8 KB187.7 KB0.0 KB/s2.6 KB23:59:40
7neva.ru147.8 KB71.9 KB219.6 KB0.0 KB/s2.2 KB23:59:55
8usenet.pasdenom.info143.7 KB37.7 KB181.4 KB0.0 KB/s2.3 KB23:59:53
9news.freedyn.net126.6 KB670.2 KB796.8 KB0.0 KB/s12.1 KB23:59:50
10news.mixmin.net121.1 KB0.0 KB121.1 KB0.0 KB/s13.5 KB23:59:55
11tnet99.5 KB5.9 KB105.4 KB0.0 KB/s2.4 KB23:59:35
12erje90.8 KB525.9 KB616.7 KB0.0 KB/s4.1 KB23:59:55
13neodome.net32.3 KB0.0 KB32.3 KB0.0 KB/s5.4 KB23:59:51
14news.uzoreto.com30.8 KB252.1 KB282.9 KB0.0 KB/s5.5 KB23:59:53
15aioe11.4 KB0.0 KB11.4 KB0.0 KB/s1.6 KB23:59:55
16news.swapon.de8.7 KB0.0 KB8.7 KB0.0 KB/s1.4 KB23:51:23
17weretis.net6.2 KB6.0 KB12.3 KB0.0 KB/s1.8 KB23:59:39
18eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s020:47:04
TOTAL: 1920.0 MB1.7 MB21.8 MB0.0 KB/s7.4 KB452:35:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1a131033.upc-a.chello.nl 27 58.4 KB 3 0 006:40:29
2ip-78-102-198-192.net.upcbroadband.cz 29 34.7 KB 3 2 208:09:50
391.187.33.87 54 34.8 KB 3 2 215:49:56
TOTAL: 3 110 1118.0 KB 9 4 430:52:34

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.upc-a.chello.nl 27 58.4 KB 3 0 006:40:29
2unresolved 62 34.8 KB 3 2 215:50:07
3*.net.upcbroadband.cz 29 34.7 KB 3 2 208:09:50
4*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:01
5*.range31-50.btcentralplus.com 3 00.0 KB 0 0 000:12:04
TOTAL: 5 123 1118.0 KB 9 4 430:52:34

NNRP auth users [Top 20]:

UserConn
slavotinek 4
TOTAL: 1 4

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 3.630 0.787 0.00615:49:56
ip-78-102-198-192.net.upcbroadband.cz 1.970 0.433 0.00508:09:50
a131033.upc-a.chello.nl 1.866 0.408 0.00006:40:29
host31-50-220-99.range31-50.btcentralplus.com 0.202 0.039 0.00000:12:04
192.241.238.163 0.069 0.008 0.00000:00:09
139.59.142.56 0.421 0.127 0.00000:00:01
scanner-09.ch1.censys-scanner.com 0.137 0.023 0.00000:00:01
TOTAL: 7 8.295 1.825 0.01130:52:34

Curious NNRP server explorers [Top 20]:

SystemConn
139.59.142.56 7
host31-50-220-99.range31-50.btcentralplus.com 3
scanner-09.ch1.censys-scanner.com 2
192.241.238.163 1
TOTAL: 4 13

NNRP unrecognized commands (by host):

SystemConn
139.59.142.56 36
scanner-09.ch1.censys-scanner.com 1
TOTAL: 2 37

NNRP unrecognized commands (by command):

CommandCount
Accept: */* 6
Accept-Encoding: gzip, deflate 6
Host: 69.160.37.58:119 6
User-Agent: Mozilla/5.0 (Windows NT 10.0... 6
Connection: keep-alive 6
EHLO www.censys.io 1
GET /streaming/clients_live.php HTTP/1.1 1
GET /c/version.js HTTP/1.1 1
GET /stalker_portal/c/ HTTP/1.1 1
GET /client_area/ HTTP/1.1 1
GET /system_api.php HTTP/1.1 1
GET /stalker_portal/c/version.js HTTP/1.... 1
TOTAL: 12 37

NNRP client timeouts [Top 20]:

SystemConnPeer
ip-78-102-198-192.net.upcbroadband.cz 6 0
91.187.33.87 4 0
TOTAL: 2 10 1

Newsgroup request counts (by category):

CategoryCountPct
1comp 11100.0%
TOTAL: 1 11100.0%

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

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