Daily Usenet report for csiph.com

Nov 4 04:15:00 -- Nov 5 04:15:00

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Nov 4 07:50:50 csiph nnrpd[12484]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 4 07:50:50 csiph nnrpd[12484]: 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 4 09:34:47 csiph nnrpd[17324]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 4 09:34:47 csiph nnrpd[17324]: 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 4 11:55:07 csiph nnrpd[24483]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 4 11:55:07 csiph nnrpd[24483]: 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 4 13:23:07 csiph nnrpd[28595]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 4 13:23:07 csiph nnrpd[28595]: 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 4 18:25:29 csiph nnrpd[42382]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 4 18:25:29 csiph nnrpd[42382]: 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 4 19:07:44 csiph nnrpd[44383]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 4 19:07:44 csiph nnrpd[44383]: 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 18943 48.5%4.8 MB 63.2%
innd 15543 39.8%2.0 MB 27.0%
innfeed 3546 9.1%642.8 KB 8.3%
nnrpd 1007 2.6%115.5 KB 1.5%
nocem 35 0.1%4.0 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 39075 100.0%7.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 308615 54.4%
Negative hits 239399 42.2%
Do not exist 18236 3.2%
Cache misses 1050 0.2%
TOTAL: 4 567300 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.430 0.0%29 0.000 14.828 51.500
article cleanup00:00:00.109 0.0%18007 0.000 0.006 0.038
article logging00:00:00.302 0.0%18603 0.000 0.016 0.095
article parse00:00:01.019 0.0%55058 0.000 0.019 0.109
article write00:00:24.459 0.0%15011 0.173 1.629 65.488
artlog/artcncl00:00:00.047 0.0%29 0.000 1.621 23.500
artlog/artparse00:00:00.011 0.0%303 0.000 0.036 1.000
data move00:00:00.487 0.0%534335 0.000 0.001 0.066
hisgrep/artcncl00:00:00.031 0.0%29 0.000 1.069 3.375
hishave/artcncl00:00:00.002 0.0%29 0.000 0.069 0.250
hishave/artparse00:00:00.000 0.0%296 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:22.434 0.0%568690 0.002 0.039 0.200
history sync00:00:00.880 0.0%385 0.000 2.286 8.667
history write00:00:44.097 0.1%17996 0.205 2.450 12.455
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.497 0.0%296 0.000 1.679 19.000
idle23:56:49.171 99.7%538336 90.724 160.140 546.252
nntp read00:00:02.456 0.0%542549 0.001 0.005 0.053
overview write00:01:36.791 0.1%15011 0.232 6.448 1033.344
perl filter00:00:26.972 0.0%17989 1.184 1.499 3.157
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.247 0.0%30057 0.000 0.008 0.032
TOTAL: 24:01:06.52624:00:30.442100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.162 0.0%192163 0.000 0.001 0.021
article prepare00:00:00.001 0.0%10960 0.000 0.000 0.013
article read00:00:00.573 0.0%1223 0.000 0.469 18.167
backlog stats00:00:00.353 0.0%592943 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.085 0.0%414715 0.001 0.005 0.011
data write00:00:02.087 0.0%394407 0.001 0.005 0.015
idle23:53:48.452100.0%592943 48.872 145.087 653.129
status file00:00:00.247 0.0%289 0.000 0.855 12.000
TOTAL: 23:54:05.54423:53:53.960100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle47:50:50.716 99.8%612 0.000281455.418600186.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.015 0.0%1549 0.000 0.010 0.167
readart00:00:00.083 0.0%21 0.000 3.952 42.000
TOTAL: 47:55:47.81547:50:50.814 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.mixmin.net 3 16118 2521 13049 548 15%24:08:45
2csiph-out.news.xs4all.nl 469 17599 2488 13861 1250 14%68:23:52
3newsfeeds.xmission.com 3 14804 2294 12487 23 15%25:57:26
4feeder.eternal-september.org 1 16975 2142 14751 82 12%24:01:34
5news-out.aioe.org 2 14428 1231 13078 119 8%24:09:03
6csiph-out.feeder.erje.net 1440 75752 955 74671 126 1%119:01:39
7csiph-out.news.weretis.net 2 29720 866 28740 114 2%46:14:04
8newsfeed.fu-berlin.de 10 14884 839 13826 219 5%25:27:14
9newsfeed.neva.ru 153 11168 550 10248 370 4%71:19:25
10news.fcku.it 12 2156 418 1729 9 19%22:13:59
11news-out.neodome.net 3 16365 218 16131 16 1%24:05:54
12csiph-out.feed.uzoreto.com 864 23968 157 23560 251 0%71:10:02
13nntp.pasdenom.info 2 10167 85 10057 25 0%23:58:55
14news.swapon.de 6 1378 57 1320 1 4%23:26:03
15csiph-out.news.tnetconsulting.net 1 14906 26 14867 13 0%23:59:58
16news.bbs.nz 1 14505 5 14499 1 0%23:59:53
17localhost 30 4 4 0 0 100%00:00:02
18news.samoylyk.net 1 14614 3 14608 3 0%23:59:53
19news.freedyn.net 6 17287 1 17194 92 0%18:30:31
20xanadu-bbs.net 25 359 0 359 0 0%20:34:52
TOTAL: 20 3034 327157 14860 309035 3262 4%704:43:04
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeeds.xmission.com6.5 MB0.0 KB1.4 MB7.9 MB 82%3.5 KB
2csiph-out.news.xs4all.nl6.4 MB2.8 KB12.6 MB19.0 MB 33%5.2 KB
3feeder.eternal-september.org5.3 MB7.9 KB521.4 KB5.8 MB 91%2.7 KB
4csiph-out.feeder.erje.net4.9 MB11.0 KB1.8 MB6.7 MB 73%6.3 KB
5news-out.mixmin.net4.8 MB5.2 KB1.1 MB5.9 MB 81%2.0 KB
6news-out.aioe.org4.0 MB5.1 KB332.2 KB4.3 MB 92%3.3 KB
7csiph-out.news.weretis.net2.4 MB2.8 KB2.3 MB4.7 MB 50%4.9 KB
8newsfeed.fu-berlin.de1.9 MB1.9 KB532.7 KB2.5 MB 78%2.4 KB
9newsfeed.neva.ru1.5 MB8.4 KB891.0 KB2.3 MB 62%2.6 KB
10news.fcku.it687.2 KB0.0 KB10.9 KB698.1 KB 98%1.6 KB
11csiph-out.feed.uzoreto.com642.5 KB0.0 KB10.4 MB11.0 MB 5%27.6 KB
12news-out.neodome.net549.7 KB2.8 KB98.2 KB650.7 KB 84%2.8 KB
13nntp.pasdenom.info185.0 KB0.0 KB31.6 KB216.6 KB 85%2.0 KB
14news.swapon.de130.4 KB2.8 KB2.8 KB136.0 KB 95%2.3 KB
15csiph-out.news.tnetconsulting.net75.6 KB0.0 KB90.2 KB165.9 KB 45%4.3 KB
16news.bbs.nz11.1 KB0.0 KB1.4 KB12.5 KB 89%2.1 KB
17localhost5.5 KB0.0 KB0.0 KB5.5 KB100%1.4 KB
18news.samoylyk.net5.1 KB2.8 KB199.2 KB207.1 KB 2%34.5 KB
19news.freedyn.net2.5 KB0.0 KB3.9 MB3.9 MB 0%43.0 KB
20xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2039.8 MB53.5 KB36.1 MB76.0 MB 52%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 4 04:15:00 - 04:59:59 183 1.2% 0.07681.1 KB 1.6% 0.25
Nov 4 05:00:00 - 05:59:59 363 2.4% 0.102.1 MB 5.2% 0.59
Nov 4 06:00:00 - 06:59:59 401 2.7% 0.111.2 MB 2.9% 0.34
Nov 4 07:00:00 - 07:59:59 443 3.0% 0.121.4 MB 3.5% 0.41
Nov 4 08:00:00 - 08:59:59 616 4.1% 0.171.4 MB 3.5% 0.41
Nov 4 09:00:00 - 09:59:59 691 4.6% 0.191.6 MB 3.9% 0.44
Nov 4 10:00:00 - 10:59:59 660 4.4% 0.181.6 MB 3.9% 0.45
Nov 4 11:00:00 - 11:59:59 697 4.6% 0.191.8 MB 4.5% 0.52
Nov 4 12:00:00 - 12:59:59 602 4.0% 0.171.5 MB 3.6% 0.42
Nov 4 13:00:00 - 13:59:59 676 4.5% 0.191.9 MB 4.6% 0.53
Nov 4 14:00:00 - 14:59:59 827 5.5% 0.232.3 MB 5.6% 0.64
Nov 4 15:00:00 - 15:59:59 899 6.0% 0.252.8 MB 6.8% 0.78
Nov 4 16:00:00 - 16:59:59 974 6.5% 0.272.3 MB 5.7% 0.66
Nov 4 17:00:00 - 17:59:59 885 5.9% 0.252.0 MB 5.0% 0.57
Nov 4 18:00:00 - 18:59:59 950 6.3% 0.262.4 MB 6.0% 0.69
Nov 4 19:00:00 - 19:59:59 962 6.4% 0.272.3 MB 5.8% 0.66
Nov 4 20:00:00 - 20:59:59 782 5.2% 0.222.1 MB 5.2% 0.60
Nov 4 21:00:00 - 21:59:59 700 4.7% 0.191.8 MB 4.4% 0.50
Nov 4 22:00:00 - 22:59:59 694 4.6% 0.191.8 MB 4.5% 0.51
Nov 4 23:00:00 - 23:59:59 582 3.9% 0.161.6 MB 3.9% 0.45
Nov 5 00:00:00 - 00:59:59 395 2.6% 0.11956.9 KB 2.3% 0.27
Nov 5 01:00:00 - 01:59:59 312 2.1% 0.09884.3 KB 2.1% 0.25
Nov 5 02:00:00 - 02:59:59 370 2.5% 0.101.1 MB 2.7% 0.32
Nov 5 03:00:00 - 03:59:59 283 1.9% 0.08863.5 KB 2.1% 0.24
Nov 5 04:00:00 - 04:15:00 67 0.4% 0.07187.6 KB 0.5% 0.21
TOTAL: 24:00:00 15014 100.0% 0.1740.3 MB 100.0% 0.48
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1303 90 0 1 0 0 0 0 1212
2newsfeed.fu-berlin.de 630 18 0 1 0 0 0 0 611
3news-out.mixmin.net 604 34 0 2 0 0 0 0 568
4newsfeed.neva.ru 388 118 0 3 0 0 0 0 267
5csiph-out.feed.uzoreto.com 253 8 0 0 0 0 0 0 245
6news-out.aioe.org 154 117 0 1 0 0 0 0 36
7csiph-out.feeder.erje.net 130 57 0 4 0 0 0 0 69
8csiph-out.news.weretis.net 124 48 0 1 0 0 0 0 75
9news.freedyn.net 92 0 0 0 0 0 0 0 92
10feeder.eternal-september.org 83 43 0 2 0 0 0 0 38
11csiph-out.news.tnetconsulting.net 33 27 0 0 0 0 0 0 6
12newsfeeds.xmission.com 29 6 0 0 0 0 0 0 23
13nntp.pasdenom.info 25 0 0 0 0 0 0 0 25
14news.swapon.de 22 0 0 1 0 0 0 0 21
15news-out.neodome.net 18 12 0 1 0 0 0 0 5
16news.fcku.it 9 9 0 0 0 0 0 0 0
17news.samoylyk.net 3 0 0 1 0 0 0 0 2
TOTAL: 17 3900 587 0 18 0 0 0 0 3295

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 132
lada.talk 111
alt.bbs.synchronet 30
it-alt.sport.calcio.juventus 29
scinet.stats 29
alt.binaries.pictures.purebeauty 20
spline.eisfair 20
mozilla.support.thunderbird 18
it-alt.comp.software.mozilla 16
alt.politics 12
att.jobs 11
alt.tv.comedy-central.daily-show 11
at.jobs 11
alt.politics.usa 10
mozilla.general 9
nntp4net.test 9
alt.job 7
alt.testing 5
free.it.religioni.scientology 5
oesterreich.tratsch 5
TOTAL: 63 587

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1740
EMP (phn path) 211
EMP (phl) 173
Too many newsgroups 88
EMP (phn nph) 66
0 66
Binary Payload 41
HTML Multipart 5
Binary: misplaced binary 3
Scoring filter 2
U2 violation - invalid distribution 1
TOTAL: 11 2396

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 164
csiph-out.feed.uzoreto.com 27
csiph-out.news.xs4all.nl 26
TOTAL: 3 217
Huge articles
csiph-out.news.xs4all.nl 89
csiph-out.feed.uzoreto.com 84
news.freedyn.net 46
csiph-out.feeder.erje.net 31
newsfeeds.xmission.com 19
csiph-out.news.weretis.net 18
feeder.eternal-september.org 3
newsfeed.fu-berlin.de 2
news-out.mixmin.net 2
news.samoylyk.net 2
TOTAL: 11 297
Including strange strings
newsfeed.fu-berlin.de 419
news-out.mixmin.net 59
csiph-out.news.xs4all.nl 52
news-out.aioe.org 27
news.swapon.de 21
csiph-out.news.weretis.net 5
csiph-out.feeder.erje.net 4
newsfeeds.xmission.com 4
feeder.eternal-september.org 2
news-out.neodome.net 1
TOTAL: 12 596
No colon-space in header
csiph-out.news.xs4all.nl 7
TOTAL: 1 7
TOTAL: 4 1117

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 17300 690 14320 3 0 0 3%23:59:48
2fu-berlin.de 13932 427 13505 0 0 0 3%23:59:50
3news.bbs.nz 28372 421 14113 26 0 0 1%23:59:54
4news.samoylyk.net 15644 417 14590 4 0 0 2%23:59:50
5news.freedyn.net 634396 149 14805 45 0 177122 0%23:59:55
6neva.ru 13822 122 13542 79 0 0 0%23:59:49
7tnet 15717 79 14485 0 0 0 0%23:59:26
8newsfeed.xs4all.nl 12858 57 12350 4 0 15 0%23:59:54
9xmission 13256 24 12130 0 0 0 0%23:59:53
10usenet.pasdenom.info 15043 19 14458 0 0 8 0%23:59:55
11neodome.net 15173 10 14745 0 0 0 0%23:59:55
12aioe 11413 9 10808 0 0 0 0%23:59:38
13news.mixmin.net 12129 7 11815 0 0 0 0%23:59:53
14news.uzoreto.com 14119 5 13800 16 0 0 0%23:59:54
15news.swapon.de 1394 5 1380 0 0 0 0%23:46:08
16weretis.net 13833 5 13617 0 0 0 0%23:59:55
17erje 13473 4 13240 110 0 0 0%23:59:55
18eternal-september 12724 4 12319 1 0 0 0%23:59:50
19news.fcku.it 1658 1 1655 0 0 0 0%21:46:32
TOTAL: 19 876256 2455 231677 288 0 177145 0%453:29:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs4.1 MB34.0 KB4.1 MB0.0 KB/s6.1 KB23:59:48
2fu-berlin.de3.4 MB0.0 KB3.4 MB0.0 KB/s8.2 KB23:59:50
3news.samoylyk.net3.4 MB4.3 KB3.4 MB0.0 KB/s8.3 KB23:59:50
4news.bbs.nz1.1 MB120.3 KB1.2 MB0.0 KB/s2.7 KB23:59:54
5news.freedyn.net451.1 KB479.7 KB930.9 KB0.0 KB/s4.8 KB23:59:55
6neva.ru310.0 KB228.5 KB538.5 KB0.0 KB/s2.7 KB23:59:49
7newsfeed.xs4all.nl211.9 KB13.5 KB225.4 KB0.0 KB/s3.7 KB23:59:54
8tnet165.8 KB0.0 KB165.8 KB0.0 KB/s2.1 KB23:59:26
9usenet.pasdenom.info104.6 KB0.0 KB104.6 KB0.0 KB/s5.5 KB23:59:55
10xmission82.0 KB0.0 KB82.0 KB0.0 KB/s3.4 KB23:59:53
11news.mixmin.net41.2 KB0.0 KB41.2 KB0.0 KB/s5.9 KB23:59:53
12neodome.net26.1 KB0.0 KB26.1 KB0.0 KB/s2.6 KB23:59:55
13aioe17.5 KB0.0 KB17.5 KB0.0 KB/s1.9 KB23:59:38
14news.uzoreto.com9.3 KB99.0 KB108.4 KB0.0 KB/s5.2 KB23:59:54
15news.swapon.de7.7 KB0.0 KB7.7 KB0.0 KB/s1.5 KB23:46:08
16erje6.9 KB321.8 KB328.7 KB0.0 KB/s2.9 KB23:59:55
17weretis.net6.5 KB0.0 KB6.5 KB0.0 KB/s1.3 KB23:59:55
18eternal-september5.5 KB0.8 KB6.3 KB0.0 KB/s1.3 KB23:59:50
19news.fcku.it1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB21:46:32
TOTAL: 1913.4 MB1.3 MB14.7 MB0.0 KB/s5.5 KB453:29:54
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ip72-222-200-117.ph.ph.cox.net 9 79.0 KB 8 0 003:23:39
2a131033.upc-a.chello.nl 45 68.2 KB 3 0 012:49:50
3131.93.179.252 22 68.1 KB 5 4 406:54:41
45-203-248-106.pat.nym.cosmote.net 2 21.9 KB 1 0 000:00:03
TOTAL: 4 78 2127.1 KB 17 4 447:55:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ph.ph.cox.net 9 79.0 KB 8 0 003:23:39
2unresolved 95 68.1 KB 5 4 430:54:34
3*.upc-a.chello.nl 45 68.2 KB 3 0 012:49:50
4*.pat.nym.cosmote.net 2 21.9 KB 1 0 000:00:03
5*.us-west-1.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
6*.range81-135.btcentralplus.com 2 00.0 KB 0 0 000:00:39
7*.range81-153.btcentralplus.com 4 00.0 KB 0 0 000:46:58
TOTAL: 7 158 2127.1 KB 17 4 447:55:46

NNRP auth users [Top 20]:

UserConn
ohlandl 4
TOTAL: 1 4

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 4.710 1.348 0.00023:59:43
a131033.upc-a.chello.nl 3.015 0.675 0.00012:49:50
131.93.179.252 1.542 0.378 0.01106:54:41
ip72-222-200-117.ph.ph.cox.net 0.757 0.171 0.00003:23:39
host81-153-177-82.range81-153.btcentralplus.com 0.271 0.115 0.00000:46:58
host81-135-1-153.range81-135.btcentralplus.com 0.131 0.033 0.00000:00:39
192.241.210.65 0.056 0.120 0.00000:00:09
5-203-248-106.pat.nym.cosmote.net 0.154 0.039 0.00000:00:03
ec2-18-144-66-96.us-west-1.compute.amazonaws.com 0.075 0.000 0.00000:00:00
TOTAL: 9 10.711 2.879 0.01147:55:46

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 72
host81-153-177-82.range81-153.btcentralplus.com 4
host81-135-1-153.range81-135.btcentralplus.com 2
ec2-18-144-66-96.us-west-1.compute.amazonaws.com 1
192.241.210.65 1
TOTAL: 5 80

NNRP client timeouts [Top 20]:

SystemConnPeer
131.93.179.252 8 0
ip72-222-200-117.ph.ph.cox.net 6 0
host81-153-177-82.range81-153.btcentralplus.com 1 0
TOTAL: 3 15 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 22100.0%
TOTAL: 1 22100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 22
TOTAL: 1 22
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