Daily Usenet report for csiph.com

Dec 20 04:15:00 -- Dec 21 04:15:00

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Dec 20 18:34:16 csiph nnrpd[38916]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 20 18:34:16 csiph nnrpd[38916]: 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 21 02:57:12 csiph nnrpd[65017]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 21 02:57:12 csiph nnrpd[65017]: 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 18276 47.0%4.6 MB 61.8%
innd 16047 41.2%2.1 MB 28.4%
innfeed 3677 9.4%641.5 KB 8.5%
nnrpd 874 2.2%95.2 KB 1.3%
nocem 44 0.1%5.2 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 38919 100.0%7.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 283935 53.2%
Negative hits 231566 43.4%
Do not exist 17611 3.3%
Cache misses 290 0.1%
TOTAL: 4 533402 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.152 0.0%28 0.000 5.429 14.250
article cleanup00:00:00.105 0.0%17269 0.000 0.006 0.031
article logging00:00:00.303 0.0%17888 0.000 0.017 0.604
article parse00:00:01.146 0.0%52089 0.000 0.022 0.371
article write00:00:11.220 0.0%14130 0.111 0.794 21.764
artlog/artcncl00:00:00.000 0.0%28 0.000 0.000 0.000
artlog/artparse00:00:00.005 0.0%370 0.000 0.014 0.500
data move00:00:00.162 0.0%504940 0.000 0.000 0.002
hisgrep/artcncl00:00:00.005 0.0%28 0.000 0.179 1.000
hishave/artcncl00:00:00.004 0.0%28 0.000 0.143 0.500
hishave/artparse00:00:00.002 0.0%370 0.000 0.005 0.143
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:18.044 0.0%534086 0.001 0.034 0.336
history sync00:00:01.145 0.0%378 0.000 3.029 70.667
history write00:00:20.607 0.0%17269 0.049 1.193 11.156
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.644 0.0%370 0.000 1.741 9.450
idle23:57:46.769 99.8%509624 95.441 169.275 571.013
nntp read00:00:02.003 0.0%511896 0.002 0.004 0.011
overview write00:01:17.054 0.1%14130 0.068 5.453 836.520
perl filter00:00:24.290 0.0%17269 1.092 1.407 2.162
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.209 0.0%28303 0.000 0.007 0.033
TOTAL: 24:00:59.94124:00:23.869100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.030 0.0%14264 0.000 0.002 0.022
article prepare00:00:00.001 0.0%12328 0.000 0.000 0.003
article read00:00:00.271 0.0%1533 0.000 0.177 22.000
backlog stats00:00:00.212 0.0%315147 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.189 0.0%246327 0.001 0.005 0.010
data write00:00:01.443 0.0%233683 0.001 0.006 0.024
idle23:53:53.467100.0%315147 152.059 272.995 817.929
status file00:00:00.246 0.0%342 0.000 0.719 2.000
TOTAL: 23:54:05.25123:53:56.859100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle47:23:42.120 99.8%504 70.000338535.952600310.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.256 0.0%32235 0.000 0.008 0.167
readart00:00:01.022 0.0%29 0.000 35.241 42.000
TOTAL: 47:28:40.26347:23:43.398 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 13433 3304 9923 206 24%24:08:57
2newsfeeds.xmission.com 2 13939 2444 11468 27 17%26:22:20
3feeder.eternal-september.org 14 5341 2176 3035 130 40%26:52:44
4csiph-out.news.xs4all.nl 549 16716 1605 13834 1277 9%67:20:31
5newsfeed.fu-berlin.de 7 15207 929 14021 257 6%27:00:25
6news-out.mixmin.net 1 15634 887 14429 318 5%23:59:52
7csiph-out.feeder.erje.net 1440 72365 811 71239 315 1%118:46:35
8csiph-out.news.weretis.net 3 22035 694 21154 187 3%39:14:44
9newsfeed.neva.ru 148 12481 462 11786 233 3%71:32:01
10csiph-out.feed.uzoreto.com 864 23058 354 22215 489 1%71:16:35
11news-out.neodome.net 2 15932 322 15592 18 2%23:59:42
12news.fcku.it 15 1340 140 1194 6 10%21:44:19
13nntp.pasdenom.info 3 9149 90 9051 8 0%23:58:38
14news.swapon.de 5 1479 47 1427 5 3%23:30:35
15csiph-out.news.tnetconsulting.net 2 13575 31 13527 17 0%23:59:55
16news.freedyn.net 2 16882 21 16718 143 0%23:59:49
17localhost 27 1 1 0 0 100%00:00:01
18news.samoylyk.net 2 13620 1 13619 0 0%23:58:56
19xanadu-bbs.net 32 348 0 348 0 0%18:04:10
20news.bbs.nz 2 13403 0 13403 0 0%23:59:45
TOTAL: 20 3123 295938 14319 277983 3636 4%703:50:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeeds.xmission.com8.0 MB0.0 KB1.2 MB9.1 MB 87%3.8 KB
2news-out.aioe.org7.5 MB0.0 KB600.0 KB8.1 MB 92%2.4 KB
3csiph-out.feeder.erje.net7.3 MB0.0 KB2.7 MB10.0 MB 72%9.1 KB
4feeder.eternal-september.org5.4 MB0.0 KB1.1 MB6.5 MB 82%2.9 KB
5csiph-out.news.xs4all.nl4.0 MB0.0 KB4.6 MB8.6 MB 46%3.1 KB
6news-out.mixmin.net2.4 MB0.0 KB700.6 KB3.1 MB 77%2.6 KB
7newsfeed.fu-berlin.de2.1 MB0.0 KB772.2 KB2.9 MB 73%2.5 KB
8csiph-out.news.weretis.net1.9 MB0.0 KB1.8 MB3.7 MB 52%4.3 KB
9csiph-out.feed.uzoreto.com1.4 MB0.0 KB7.3 MB8.7 MB 16%10.6 KB
10newsfeed.neva.ru1.2 MB0.0 KB776.2 KB2.0 MB 62%2.9 KB
11news-out.neodome.net907.3 KB0.0 KB40.3 KB947.6 KB 95%2.8 KB
12news.fcku.it220.8 KB0.0 KB7.4 KB228.3 KB 96%1.6 KB
13nntp.pasdenom.info191.4 KB0.0 KB21.3 KB212.7 KB 89%2.2 KB
14csiph-out.news.tnetconsulting.net114.6 KB0.0 KB27.9 KB142.5 KB 80%3.0 KB
15news.swapon.de112.9 KB0.0 KB9.2 KB122.1 KB 92%2.3 KB
16news.freedyn.net110.4 KB0.0 KB5.1 MB5.2 MB 2%32.7 KB
17localhost1.2 KB0.0 KB0.0 KB1.2 KB100%1.2 KB
18news.samoylyk.net0.6 KB0.0 KB0.0 KB0.6 KB100%0.6 KB
19xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
20news.bbs.nz0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2042.9 MB0.0 KB26.7 MB69.5 MB 61%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 20 04:15:00 - 04:59:59 206 1.5% 0.08641.4 KB 1.5% 0.24
Dec 20 05:00:00 - 05:59:59 260 1.8% 0.07881.9 KB 2.0% 0.24
Dec 20 06:00:00 - 06:59:59 282 2.0% 0.08980.0 KB 2.3% 0.27
Dec 20 07:00:00 - 07:59:59 400 2.8% 0.111.2 MB 2.8% 0.34
Dec 20 08:00:00 - 08:59:59 496 3.5% 0.142.4 MB 5.7% 0.69
Dec 20 09:00:00 - 09:59:59 698 4.9% 0.192.0 MB 4.8% 0.57
Dec 20 10:00:00 - 10:59:59 879 6.2% 0.242.4 MB 5.7% 0.69
Dec 20 11:00:00 - 11:59:59 702 5.0% 0.201.8 MB 4.3% 0.52
Dec 20 12:00:00 - 12:59:59 690 4.9% 0.192.2 MB 5.2% 0.62
Dec 20 13:00:00 - 13:59:59 739 5.2% 0.212.5 MB 5.8% 0.70
Dec 20 14:00:00 - 14:59:59 702 5.0% 0.201.8 MB 4.4% 0.52
Dec 20 15:00:00 - 15:59:59 909 6.4% 0.252.3 MB 5.4% 0.65
Dec 20 16:00:00 - 16:59:59 879 6.2% 0.242.8 MB 6.6% 0.80
Dec 20 17:00:00 - 17:59:59 980 6.9% 0.273.2 MB 7.6% 0.91
Dec 20 18:00:00 - 18:59:59 738 5.2% 0.201.9 MB 4.5% 0.55
Dec 20 19:00:00 - 19:59:59 678 4.8% 0.191.8 MB 4.4% 0.52
Dec 20 20:00:00 - 20:59:59 647 4.6% 0.181.8 MB 4.3% 0.52
Dec 20 21:00:00 - 21:59:59 689 4.9% 0.191.9 MB 4.6% 0.55
Dec 20 22:00:00 - 22:59:59 662 4.7% 0.181.8 MB 4.3% 0.52
Dec 20 23:00:00 - 23:59:59 517 3.7% 0.141.5 MB 3.4% 0.41
Dec 21 00:00:00 - 00:59:59 375 2.7% 0.101.2 MB 2.7% 0.33
Dec 21 01:00:00 - 01:59:59 303 2.1% 0.08897.7 KB 2.1% 0.25
Dec 21 02:00:00 - 02:59:59 336 2.4% 0.091.3 MB 3.0% 0.37
Dec 21 03:00:00 - 03:59:59 279 2.0% 0.08898.2 KB 2.1% 0.25
Dec 21 04:00:00 - 04:15:00 82 0.6% 0.09219.9 KB 0.5% 0.24
TOTAL: 24:00:00 14128 100.0% 0.1642.3 MB 100.0% 0.50
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1295 56 0 0 0 0 0 0 1239
2newsfeed.fu-berlin.de 676 10 0 0 0 0 0 0 666
3csiph-out.feed.uzoreto.com 489 36 0 0 0 0 0 0 453
4news-out.mixmin.net 322 4 0 0 0 0 0 0 318
5news-out.aioe.org 316 158 0 0 0 0 0 0 158
6newsfeed.neva.ru 235 33 0 0 0 0 0 0 202
7csiph-out.news.weretis.net 228 48 0 0 0 0 0 0 180
8csiph-out.feeder.erje.net 166 47 0 0 0 0 0 0 119
9news.freedyn.net 148 0 0 0 0 0 0 0 148
10feeder.eternal-september.org 131 84 0 0 0 0 0 0 47
11newsfeeds.xmission.com 43 7 0 0 0 0 0 0 36
12news.swapon.de 27 0 0 0 0 0 0 0 27
13news-out.neodome.net 17 5 0 0 0 0 0 0 12
14csiph-out.news.tnetconsulting.net 13 12 0 0 0 0 0 0 1
15nntp.pasdenom.info 8 0 0 0 0 0 0 0 8
16news.fcku.it 6 5 0 0 0 0 0 0 1
TOTAL: 16 4120 505 0 0 0 0 0 0 3615

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 247
scinet.stats 32
it-alt.sport.calcio.juventus 25
lada.talk 19
alt.binaries.pictures.purebeauty 17
mozilla.support.thunderbird 14
alt.bbs.synchronet 11
alt.survival 11
spline.eisfair 10
mozilla.general 10
mozilla.support.firefox 8
alt.tv.comedy-central.daily-show 7
alt.politics 7
oesterreich.tratsch 6
alt.windows7.general 5
free.it.religioni.scientology 5
mozilla.dev.security.policy 4
cakewalk.audio 4
alt.christian.bible 4
al.christnet.bible 3
TOTAL: 65 505

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1607
EMP (phn path) 456
EMP (phn nph) 246
EMP (phl) 166
Binary Payload 63
0 36
Too many newsgroups 33
Binary: misplaced binary 10
HTML Multipart 6
Too many newsgroups (meow) 3
HTML post 2
HTML Image Tags 1
U2 violation - invalid distribution 1
TOTAL: 13 2630

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 50
csiph-out.feed.uzoreto.com 1
csiph-out.news.xs4all.nl 1
TOTAL: 3 52
Huge articles
csiph-out.feed.uzoreto.com 140
news.freedyn.net 72
csiph-out.news.xs4all.nl 51
csiph-out.feeder.erje.net 51
csiph-out.news.weretis.net 20
newsfeeds.xmission.com 20
feeder.eternal-september.org 5
newsfeed.fu-berlin.de 4
news-out.mixmin.net 3
csiph-out.news.tnetconsulting.net 1
TOTAL: 10 367
Including strange strings
newsfeed.fu-berlin.de 422
news-out.aioe.org 113
csiph-out.news.xs4all.nl 25
news.swapon.de 22
newsfeeds.xmission.com 16
csiph-out.news.weretis.net 10
feeder.eternal-september.org 4
news-out.mixmin.net 4
csiph-out.feed.uzoreto.com 2
newsfeed.neva.ru 1
TOTAL: 10 619
TOTAL: 3 1038

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 16424 806 13315 4 0 1 4%23:59:48
2news.samoylyk.net 14423 561 13563 3 0 0 3%23:59:53
3fu-berlin.de 13033 559 12474 0 0 0 4%23:59:53
4news.bbs.nz 26576 338 13179 23 0 2 1%23:59:51
5xmission 13377 88 11129 9 0 0 0%23:59:53
6erje 14791 83 12843 218 0 0 0%23:59:44
7tnet 14613 60 13479 3 0 0 0%23:59:53
8newsfeed.xs4all.nl 13224 57 12414 4 0 158 0%23:59:53
9neva.ru 12942 14 12811 59 0 0 0%23:59:53
10news.mixmin.net 12464 8 12276 1 0 0 0%23:59:53
11usenet.pasdenom.info 13748 6 13435 9 0 15 0%23:59:53
12neodome.net 14083 5 13774 0 0 0 0%23:59:30
13news.freedyn.net 13678 5 13326 144 0 0 0%23:59:53
14news.uzoreto.com 13565 2 13360 9 0 0 0%23:59:53
15weretis.net 12802 2 12547 0 0 0 0%23:59:26
16aioe 9616 1 9385 0 0 0 0%23:59:19
17news.swapon.de 1398 1 1390 0 0 0 0%23:26:06
18eternal-september 0 0 0 0 0 11300 0%23:59:53
19news.fcku.it 1130 0 1129 0 0 0 0%21:14:47
TOTAL: 19 231887 2596 205829 486 0 11476 1%452:37:14
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs7.3 MB19.7 KB7.4 MB0.1 KB/s9.3 KB23:59:48
2fu-berlin.de6.6 MB0.0 KB6.6 MB0.1 KB/s12.2 KB23:59:53
3news.samoylyk.net6.6 MB19.4 KB6.7 MB0.1 KB/s12.1 KB23:59:53
4news.bbs.nz988.4 KB103.2 KB1.1 MB0.0 KB/s3.0 KB23:59:51
5erje231.3 KB920.6 KB1.1 MB0.0 KB/s3.8 KB23:59:44
6newsfeed.xs4all.nl206.0 KB99.8 KB305.8 KB0.0 KB/s5.0 KB23:59:53
7tnet172.5 KB3.6 KB176.1 KB0.0 KB/s2.8 KB23:59:53
8xmission139.4 KB15.8 KB155.2 KB0.0 KB/s1.6 KB23:59:53
9news.mixmin.net75.1 KB4.7 KB79.8 KB0.0 KB/s8.9 KB23:59:53
10neodome.net74.5 KB0.0 KB74.5 KB0.0 KB/s14.9 KB23:59:30
11neva.ru49.7 KB207.4 KB257.2 KB0.0 KB/s3.5 KB23:59:53
12news.freedyn.net46.0 KB2.9 MB3.0 MB0.0 KB/s20.4 KB23:59:53
13usenet.pasdenom.info41.3 KB9.8 KB51.1 KB0.0 KB/s3.4 KB23:59:53
14news.uzoreto.com5.0 KB134.1 KB139.1 KB0.0 KB/s12.6 KB23:59:53
15weretis.net2.1 KB0.0 KB2.1 KB0.0 KB/s1.1 KB23:59:26
16aioe1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:59:19
17news.swapon.de1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:26:06
18eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:14:47
TOTAL: 1922.6 MB4.4 MB27.0 MB0.0 KB/s9.0 KB452:37:14
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1lfbn-poi-1-714-63.w82-125.abo.wanadoo.fr 1 2239.2 KB 1 0 000:00:16
2a131033.upc-a.chello.nl 72 511.0 KB 3 0 022:25:58
391.187.33.87 77 23.9 KB 2 1 125:01:07
TOTAL: 3 150 2954.1 KB 6 1 147:28:39

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.w82-125.abo.wanadoo.fr 1 2239.2 KB 1 0 000:00:16
2*.upc-a.chello.nl 72 511.0 KB 3 0 022:25:58
3unresolved 78 23.9 KB 2 1 125:01:08
4*.range31-50.btcentralplus.com 2 00.0 KB 0 0 000:01:16
TOTAL: 4 153 2954.1 KB 6 1 147:28:39

NNRP auth users [Top 20]:

UserConn
slavotinek 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 4.865 1.178 0.00325:01:07
a131033.upc-a.chello.nl 4.650 1.026 0.00022:25:58
host31-50-220-99.range31-50.btcentralplus.com 0.138 0.024 0.00000:01:16
lfbn-poi-1-714-63.w82-125.abo.wanadoo.fr 0.268 1.229 0.00000:00:16
91.241.19.60 0.068 0.009 0.00000:00:00
TOTAL: 5 9.989 3.466 0.00347:28:39

Curious NNRP server explorers [Top 20]:

SystemConn
host31-50-220-99.range31-50.btcentralplus.com 2
91.241.19.60 1
TOTAL: 2 3

NNRP unrecognized commands (by host):

SystemConn
91.241.19.60 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
^C 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
91.187.33.87 6 0
91.241.19.60 1 1
TOTAL: 2 7 1

Newsgroup request counts (by category):

CategoryCountPct
1fr 22 75.9%
2comp 7 24.1%
TOTAL: 2 29100.0%

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

NewsgroupCount
1fr.comp.os.mac-os.x 22
2comp.sys.ibm.ps2.hardware 7
TOTAL: 2 29