Daily Usenet report for csiph.com

Nov 29 04:15:00 -- Nov 30 04:15:00

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Nov 29 12:08:15 csiph nnrpd[2273]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 29 12:08:15 csiph nnrpd[2273]: 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]
Nov 29 18:01:06 csiph nnrpd[20393]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 29 18:01:06 csiph nnrpd[20393]: 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]
Nov 29 20:10:08 csiph nnrpd[27178]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 29 20:10:08 csiph nnrpd[27178]: 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]
Nov 29 22:04:56 csiph nnrpd[33217]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 29 22:04:56 csiph nnrpd[33217]: 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]
Nov 29 22:05:05 csiph nnrpd[33226]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 29 22:05:05 csiph nnrpd[33226]: 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 17872 45.9%4.5 MB 61.0%
innd 16642 42.8%2.2 MB 29.6%
innfeed 3475 8.9%618.3 KB 8.2%
nnrpd 887 2.3%95.0 KB 1.3%
nocem 37 0.1%4.5 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 38914 100.0%7.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 279520 52.0%
Negative hits 224410 41.8%
Do not exist 17290 3.2%
Cache misses 15883 3.0%
TOTAL: 4 537103 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.297 0.0%35 0.000 8.486 18.857
article cleanup00:00:00.096 0.0%17028 0.000 0.006 0.045
article logging00:00:00.246 0.0%17566 0.000 0.014 0.095
article parse00:00:00.918 0.0%52715 0.000 0.017 0.205
article write00:00:07.014 0.0%14103 0.151 0.497 19.550
artlog/artcncl00:00:00.000 0.0%35 0.000 0.000 0.000
artlog/artparse00:00:00.001 0.0%273 0.000 0.004 0.167
data move00:00:00.167 0.0%499712 0.000 0.000 0.002
hisgrep/artcncl00:00:00.013 0.0%33 0.000 0.394 1.000
hishave/artcncl00:00:00.002 0.0%35 0.000 0.057 0.333
hishave/artparse00:00:00.000 0.0%264 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.234 0.0%537126 0.001 0.008 0.110
history sync00:00:01.114 0.0%387 0.000 2.879 32.000
history write00:00:10.655 0.0%17037 0.032 0.625 9.688
hiswrite/artcncl00:00:00.006 0.0%2 2.000 3.000 4.000
hiswrite/artparse00:00:00.415 0.0%262 0.000 1.584 9.125
idle23:58:36.275 99.8%507871 84.814 169.957 585.381
nntp read00:00:01.987 0.0%507918 0.001 0.004 0.012
overview write00:01:05.854 0.1%14103 0.069 4.670 512.697
perl filter00:00:24.177 0.0%17028 1.095 1.420 2.267
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.244 0.0%28243 0.000 0.009 0.031
TOTAL: 24:01:10.24224:00:33.715100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.028 0.0%14102 0.000 0.002 0.049
article prepare00:00:00.001 0.0%11336 0.000 0.000 0.015
article read00:00:00.196 0.0%1127 0.000 0.174 15.000
backlog stats00:00:00.204 0.0%308979 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.165 0.0%244471 0.000 0.005 0.011
data write00:00:01.554 0.0%231550 0.000 0.007 0.019
idle23:54:36.513100.0%308979 145.421 278.584 922.773
status file00:00:00.189 0.0%270 0.000 0.700 2.000
TOTAL: 23:54:48.73423:54:39.850100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle38:58:21.274 99.8%544 211.667257906.754600162.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.011 0.0%1350 0.000 0.008 0.167
readart00:00:00.000 0.0%2 0.000 0.000 0.000
TOTAL: 39:02:54.87838:58:21.285 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 2 13325 3411 9820 94 25%24:09:57
2newsfeeds.xmission.com 2 13197 2307 10847 43 17%23:35:49
3csiph-out.news.xs4all.nl 518 16517 2119 12870 1528 12%67:29:32
4feeder.eternal-september.org 236 4789 2040 2620 129 42%49:17:13
5newsfeed.fu-berlin.de 3 16173 908 15031 234 5%26:24:03
6csiph-out.feeder.erje.net 1440 71286 845 70317 124 1%118:43:08
7news-out.mixmin.net 2 15465 679 14589 197 4%23:59:48
8csiph-out.news.weretis.net 4 16453 576 15782 95 3%29:32:36
9newsfeed.neva.ru 143 10765 431 10217 117 4%71:52:20
10news-out.neodome.net 1 16006 234 15685 87 1%23:59:55
11csiph-out.feed.uzoreto.com 864 38210 176 37654 380 0%71:20:57
12news.fcku.it 12 1329 150 1176 3 11%22:18:22
13nntp.pasdenom.info 1 9307 112 9193 2 1%23:59:54
14news.freedyn.net 1 16539 41 16419 79 0%23:59:56
15news.swapon.de 9 1307 36 1271 0 2%23:36:44
16csiph-out.news.tnetconsulting.net 1 14018 31 13969 18 0%23:59:58
17news.samoylyk.net 1 13565 4 13558 3 0%23:59:55
18news.bbs.nz 1 13438 3 13435 0 0%23:59:52
19localhost 28 2 2 0 0 100%00:00:01
20xanadu-bbs.net 39 381 0 381 0 0%20:35:04
TOTAL: 20 3308 302072 14105 284834 3133 4%716:55:04
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org8.3 MB0.0 KB288.4 KB8.6 MB 96%2.5 KB
2newsfeeds.xmission.com7.4 MB0.0 KB2.6 MB10.0 MB 74%4.4 KB
3csiph-out.feeder.erje.net6.8 MB0.0 KB2.8 MB9.6 MB 71%10.1 KB
4feeder.eternal-september.org5.7 MB0.0 KB843.9 KB6.5 MB 87%3.1 KB
5csiph-out.news.xs4all.nl5.6 MB0.0 KB9.7 MB15.3 MB 36%4.3 KB
6newsfeed.fu-berlin.de2.0 MB0.0 KB603.9 KB2.5 MB 76%2.3 KB
7news-out.mixmin.net1.8 MB0.0 KB303.2 KB2.1 MB 85%2.4 KB
8csiph-out.news.weretis.net1.5 MB0.0 KB496.1 KB1.9 MB 75%3.0 KB
9newsfeed.neva.ru1.1 MB0.0 KB317.2 KB1.4 MB 77%2.6 KB
10news-out.neodome.net803.0 KB0.0 KB1.2 MB1.9 MB 40%6.2 KB
11csiph-out.feed.uzoreto.com636.9 KB0.0 KB4.8 MB5.4 MB 11%10.0 KB
12nntp.pasdenom.info243.2 KB0.0 KB2.1 KB245.3 KB 99%2.2 KB
13news.fcku.it237.8 KB0.0 KB9.3 KB247.1 KB 96%1.6 KB
14news.freedyn.net119.6 KB0.0 KB763.1 KB882.7 KB 13%7.4 KB
15csiph-out.news.tnetconsulting.net116.1 KB0.0 KB41.0 KB157.1 KB 73%3.2 KB
16news.swapon.de77.4 KB0.0 KB0.0 KB77.4 KB100%2.1 KB
17news.samoylyk.net13.6 KB0.0 KB189.0 KB202.6 KB 6%28.9 KB
18news.bbs.nz5.9 KB0.0 KB0.0 KB5.9 KB100%2.0 KB
19localhost3.0 KB0.0 KB0.0 KB3.0 KB100%1.5 KB
20xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2042.4 MB0.0 KB24.8 MB67.1 MB 63%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 29 04:15:00 - 04:59:59 160 1.1% 0.06464.2 KB 1.1% 0.17
Nov 29 05:00:00 - 05:59:59 295 2.1% 0.081.1 MB 2.6% 0.31
Nov 29 06:00:00 - 06:59:59 283 2.0% 0.08957.8 KB 2.2% 0.27
Nov 29 07:00:00 - 07:59:59 403 2.9% 0.111.6 MB 3.7% 0.44
Nov 29 08:00:00 - 08:59:59 608 4.3% 0.172.7 MB 6.4% 0.77
Nov 29 09:00:00 - 09:59:59 648 4.6% 0.182.2 MB 5.2% 0.63
Nov 29 10:00:00 - 10:59:59 717 5.1% 0.201.7 MB 4.1% 0.50
Nov 29 11:00:00 - 11:59:59 662 4.7% 0.181.7 MB 3.9% 0.47
Nov 29 12:00:00 - 12:59:59 740 5.2% 0.211.9 MB 4.5% 0.54
Nov 29 13:00:00 - 13:59:59 736 5.2% 0.201.8 MB 4.2% 0.51
Nov 29 14:00:00 - 14:59:59 691 4.9% 0.192.0 MB 4.7% 0.57
Nov 29 15:00:00 - 15:59:59 759 5.4% 0.212.3 MB 5.5% 0.67
Nov 29 16:00:00 - 16:59:59 912 6.5% 0.253.3 MB 7.7% 0.93
Nov 29 17:00:00 - 17:59:59 837 5.9% 0.232.6 MB 6.1% 0.74
Nov 29 18:00:00 - 18:59:59 803 5.7% 0.222.1 MB 4.9% 0.59
Nov 29 19:00:00 - 19:59:59 841 6.0% 0.232.3 MB 5.3% 0.64
Nov 29 20:00:00 - 20:59:59 785 5.6% 0.222.2 MB 5.2% 0.63
Nov 29 21:00:00 - 21:59:59 702 5.0% 0.202.1 MB 5.0% 0.60
Nov 29 22:00:00 - 22:59:59 601 4.3% 0.171.6 MB 3.9% 0.46
Nov 29 23:00:00 - 23:59:59 519 3.7% 0.141.6 MB 3.8% 0.46
Nov 30 00:00:00 - 00:59:59 369 2.6% 0.101.2 MB 2.8% 0.34
Nov 30 01:00:00 - 01:59:59 337 2.4% 0.09979.8 KB 2.3% 0.27
Nov 30 02:00:00 - 02:59:59 341 2.4% 0.09996.8 KB 2.3% 0.28
Nov 30 03:00:00 - 03:59:59 288 2.0% 0.08863.3 KB 2.0% 0.24
Nov 30 04:00:00 - 04:15:00 62 0.4% 0.07201.0 KB 0.5% 0.22
TOTAL: 24:00:00 14099 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 1542 80 0 0 0 0 0 0 1462
2newsfeed.fu-berlin.de 540 25 0 0 0 0 0 0 515
3csiph-out.feed.uzoreto.com 391 19 0 0 0 0 0 0 372
4news-out.aioe.org 226 81 0 0 0 0 0 0 145
5csiph-out.news.weretis.net 208 48 0 0 0 0 0 0 160
6news-out.mixmin.net 200 2 0 0 0 0 0 0 198
7feeder.eternal-september.org 131 40 0 0 0 0 0 0 91
8csiph-out.feeder.erje.net 130 44 0 0 0 0 0 0 86
9newsfeed.neva.ru 114 30 0 0 0 0 0 0 84
10news-out.neodome.net 83 2 0 0 0 0 0 0 81
11news.freedyn.net 78 0 0 0 0 0 0 0 78
12newsfeeds.xmission.com 58 9 0 0 0 0 0 0 49
13news.swapon.de 20 0 0 0 0 0 0 0 20
14csiph-out.news.tnetconsulting.net 9 7 0 0 0 0 0 0 2
15news.fcku.it 3 3 0 0 0 0 0 0 0
16news.samoylyk.net 3 0 0 0 0 0 0 0 3
17nntp.pasdenom.info 2 0 0 0 0 0 0 0 2
TOTAL: 17 3738 390 0 0 0 0 0 0 3348

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 87
spline.eisfair 30
alt.windows7.general 24
scinet.stats 24
lada.talk 20
mozilla.general 18
free.it.religioni.scientology 16
mozilla.support.thunderbird 16
it-alt.sport.calcio.juventus 12
alt.politics 12
alt.binaries.pictures.purebeauty 11
mozilla.support.seamonkey 9
alt.bbs.synchronet 9
it-alt.comp.software.openoffice 7
0.test 6
alt.politics.usa 6
lada.auto 4
mozilla.community.mexico 4
alt.binaries.ebook 4
alt.forsale.seattle 3
TOTAL: 69 390

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1651
EMP (phn path) 441
EMP (phl) 165
EMP (phn nph) 142
0 60
Too many newsgroups 56
Scoring filter 9
Binary: misplaced binary 5
HTML Multipart 3
Too many newsgroups (meow) 1
Binary Payload 1
HTML post 1
TOTAL: 12 2535

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.news.xs4all.nl 84
csiph-out.feed.uzoreto.com 52
csiph-out.feeder.erje.net 51
newsfeeds.xmission.com 35
news-out.neodome.net 16
news.freedyn.net 9
feeder.eternal-september.org 7
csiph-out.news.weretis.net 4
newsfeed.fu-berlin.de 3
news.samoylyk.net 3
TOTAL: 11 266
Including strange strings
newsfeed.fu-berlin.de 335
news-out.aioe.org 131
news.swapon.de 20
newsfeeds.xmission.com 14
csiph-out.news.xs4all.nl 13
csiph-out.feed.uzoreto.com 8
csiph-out.news.weretis.net 7
csiph-out.feeder.erje.net 6
newsfeed.neva.ru 1
news-out.neodome.net 1
TOTAL: 12 538
No colon-space in header
csiph-out.news.xs4all.nl 8
csiph-out.feeder.erje.net 1
TOTAL: 2 9
TOTAL: 4 865

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 16952 791 13302 6 0 0 4%23:59:53
2fu-berlin.de 13087 583 12504 0 0 0 4%23:59:53
3news.samoylyk.net 14472 580 13513 2 0 0 4%23:59:53
4news.bbs.nz 26404 398 13083 19 0 0 1%23:59:53
5tnet 14490 136 13367 0 0 0 0%23:59:53
6neva.ru 12947 117 12698 30 0 0 0%23:59:53
7newsfeed.xs4all.nl 12225 23 11826 1 0 16 0%23:59:53
8usenet.pasdenom.info 13843 14 13377 0 0 0 0%23:59:53
9news.uzoreto.com 13815 11 13520 40 0 0 0%23:59:48
10news.freedyn.net 13712 7 13392 21 0 0 0%23:59:53
11news.mixmin.net 12816 6 12532 0 0 0 0%23:59:53
12neodome.net 14118 5 13760 0 0 0 0%23:59:52
13news.swapon.de 1302 5 1291 0 0 0 0%23:44:04
14xmission 12250 4 11036 0 0 0 0%23:58:20
15aioe 9771 3 9371 0 0 0 0%23:59:46
16erje 12908 2 12747 29 0 0 0%23:59:45
17weretis.net 13030 2 12736 0 0 0 0%23:59:53
18eternal-september 0 0 0 0 0 11240 0%23:59:53
19news.fcku.it 1070 0 1069 0 0 0 0%21:07:15
TOTAL: 19 229212 2687 205124 148 0 11256 1%452:47:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs6.6 MB25.2 KB6.6 MB0.1 KB/s8.5 KB23:59:53
2fu-berlin.de6.0 MB0.0 KB6.0 MB0.1 KB/s10.6 KB23:59:53
3news.samoylyk.net6.0 MB39.4 KB6.0 MB0.1 KB/s10.6 KB23:59:53
4news.bbs.nz1.1 MB89.6 KB1.2 MB0.0 KB/s2.9 KB23:59:53
5tnet391.7 KB0.0 KB391.7 KB0.0 KB/s2.9 KB23:59:53
6neva.ru323.5 KB85.4 KB408.9 KB0.0 KB/s2.8 KB23:59:53
7newsfeed.xs4all.nl72.8 KB36.4 KB109.2 KB0.0 KB/s4.5 KB23:59:53
8usenet.pasdenom.info30.8 KB0.0 KB30.8 KB0.0 KB/s2.2 KB23:59:53
9news.uzoreto.com29.9 KB187.9 KB217.9 KB0.0 KB/s4.3 KB23:59:48
10news.swapon.de24.9 KB0.0 KB24.9 KB0.0 KB/s5.0 KB23:44:04
11news.mixmin.net17.4 KB0.0 KB17.4 KB0.0 KB/s2.9 KB23:59:53
12news.freedyn.net14.9 KB305.1 KB320.0 KB0.0 KB/s11.4 KB23:59:53
13neodome.net11.7 KB0.0 KB11.7 KB0.0 KB/s2.3 KB23:59:52
14aioe9.7 KB0.0 KB9.7 KB0.0 KB/s3.2 KB23:59:46
15xmission8.2 KB0.0 KB8.2 KB0.0 KB/s2.1 KB23:58:20
16erje5.5 KB151.6 KB157.1 KB0.0 KB/s5.1 KB23:59:45
17weretis.net3.1 KB0.0 KB3.1 KB0.0 KB/s1.5 KB23:59:53
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:07:15
TOTAL: 1920.6 MB920.6 KB21.5 MB0.0 KB/s7.8 KB452:47:26
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1071-013-248-064.res.spectrum.com 28 24.6 KB 3 1 208:05:45
TOTAL: 1 28 24.6 KB 3 1 239:02:53

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 28 24.6 KB 3 1 208:05:45
2*.range5-81.btcentralplus.com 5 00.0 KB 0 0 000:03:44
3*.home.otenet.gr 1 00.0 KB 0 0 000:00:01
4*.ph.ph.cox.net 4 00.0 KB 0 0 002:00:13
5unresolved 72 00.0 KB 0 0 023:59:47
6*.upc-a.chello.nl 24 00.0 KB 0 0 003:53:19
7*.hsd1.wa.comcast.net 2 00.0 KB 0 0 001:00:01
TOTAL: 7 136 24.6 KB 3 1 239:02:53

NNRP auth users [Top 20]:

UserConn
ohlandl 2
TOTAL: 1 2

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 4.504 1.160 0.00023:59:47
071-013-248-064.res.spectrum.com 1.701 0.441 0.00308:05:45
a131033.upc-a.chello.nl 1.493 0.330 0.00003:53:19
ip72-222-200-117.ph.ph.cox.net 0.424 0.069 0.00002:00:13
c-73-140-175-55.hsd1.wa.comcast.net 0.138 0.017 0.00001:00:01
host5-81-219-132.range5-81.btcentralplus.com 0.333 0.074 0.00000:03:44
ppp-2-84-166-125.home.otenet.gr 0.054 0.023 0.00000:00:01
TOTAL: 7 8.647 2.114 0.00339:02:53

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 72
a131033.upc-a.chello.nl 24
host5-81-219-132.range5-81.btcentralplus.com 5
ip72-222-200-117.ph.ph.cox.net 4
c-73-140-175-55.hsd1.wa.comcast.net 2
ppp-2-84-166-125.home.otenet.gr 1
TOTAL: 6 108

NNRP client timeouts [Top 20]:

SystemConnPeer
071-013-248-064.res.spectrum.com 6 0
ip72-222-200-117.ph.ph.cox.net 4 0
c-73-140-175-55.hsd1.wa.comcast.net 2 0
TOTAL: 3 12 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 3100.0%
TOTAL: 1 3100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 3
TOTAL: 1 3
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: admin@kev009.com