Daily Usenet report for csiph.com

Nov 18 04:15:00 -- Nov 19 04:15:00

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Nov 18 06:40:04 csiph nnrpd[57823]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 18 06:40:04 csiph nnrpd[57823]: 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 18 18:46:07 csiph nnrpd[85638]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 18 18:46:07 csiph nnrpd[85638]: 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 18 19:51:43 csiph nnrpd[87985]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 18 19:51:43 csiph nnrpd[87985]: 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 19 00:28:48 csiph nnrpd[98365]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 19 00:28:48 csiph nnrpd[98365]: 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 19 01:58:15 csiph nnrpd[1764]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 19 01:58:15 csiph nnrpd[1764]: 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 18921 48.3%4.8 MB 63.1%
innd 15770 40.3%2.1 MB 27.4%
innfeed 3525 9.0%637.3 KB 8.2%
nnrpd 884 2.3%97.5 KB 1.3%
nocem 38 0.1%4.5 KB 0.1%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 39139 100.0%7.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 307169 55.5%
Negative hits 228075 41.2%
Do not exist 18292 3.3%
Cache misses 237 0.0%
TOTAL: 4 553773 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.866 0.0%33 0.000 26.242 88.714
article cleanup00:00:00.121 0.0%18053 0.000 0.007 0.040
article logging00:00:00.445 0.0%18622 0.000 0.024 0.718
article parse00:00:01.319 0.0%55544 0.000 0.024 0.404
article write00:00:36.283 0.0%14995 0.176 2.420 75.769
artlog/artcncl00:00:00.000 0.0%33 0.000 0.000 0.000
artlog/artparse00:00:00.028 0.0%266 0.000 0.105 1.130
data move00:00:01.316 0.0%519709 0.000 0.003 0.077
hisgrep/artcncl00:00:00.036 0.0%33 0.000 1.091 4.667
hishave/artcncl00:00:00.391 0.0%33 0.000 11.848 55.286
hishave/artparse00:00:00.001 0.0%257 0.000 0.004 0.250
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:35.516 0.0%554311 0.003 0.064 0.513
history sync00:00:00.979 0.0%371 0.000 2.639 32.667
history write00:00:47.401 0.1%18056 0.330 2.625 19.479
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.749 0.0%257 0.000 2.914 21.000
idle23:55:49.596 99.6%520856 88.807 165.400 807.282
nntp read00:00:02.219 0.0%528063 0.001 0.004 0.017
overview write00:01:38.673 0.1%14995 0.155 6.580 132.629
perl filter00:00:39.283 0.0%18047 1.041 2.177 12.000
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.243 0.0%30028 0.000 0.008 0.041
TOTAL: 24:01:00.14924:00:15.465 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.035 0.0%15047 0.000 0.002 0.021
article prepare00:00:00.002 0.0%9612 0.000 0.000 0.004
article read00:00:01.171 0.0%1101 0.000 1.064 50.250
backlog stats00:00:00.210 0.0%345160 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.361 0.0%272742 0.001 0.005 0.010
data write00:00:01.665 0.0%260648 0.002 0.006 0.014
idle23:55:01.013100.0%345160 136.119 249.452 863.114
status file00:00:00.389 0.0%275 0.000 1.415 8.333
TOTAL: 23:55:11.98123:55:05.846100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle38:56:30.594 99.9%593 51.000236409.096600238.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.012 0.0%1469 0.000 0.008 0.167
readart00:00:00.246 0.0%25 0.000 9.840 79.000
TOTAL: 38:59:53.21738:56:30.852 99.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 4 14305 3380 10814 111 23%24:09:12
2csiph-out.news.xs4all.nl 512 17646 2701 13384 1561 15%67:58:42
3feeder.eternal-september.org 16 16769 2611 14022 136 15%24:54:59
4newsfeeds.xmission.com 2 15150 2275 12845 30 15%26:11:49
5csiph-out.feeder.erje.net 1441 72883 870 71839 174 1%118:51:24
6newsfeed.fu-berlin.de 11 15126 842 14048 236 5%26:17:03
7newsfeed.neva.ru 148 11937 628 11007 302 5%71:31:01
8news-out.mixmin.net 1 16084 471 15471 142 2%23:59:47
9csiph-out.feed.uzoreto.com 864 23847 374 23066 407 1%71:12:08
10csiph-out.news.weretis.net 3 30817 335 30346 136 1%47:59:44
11news.fcku.it 11 2067 325 1738 4 15%21:42:14
12csiph-out.news.tnetconsulting.net 1 14641 84 14545 12 0%23:59:57
13nntp.pasdenom.info 2 10070 84 9966 20 0%23:58:11
14news.swapon.de 5 1375 50 1325 0 3%23:56:04
15news.freedyn.net 1 17688 19 17618 51 0%23:59:52
16news-out.neodome.net 1 16357 16 16337 4 0%23:59:54
17news.bbs.nz 2 14257 7 14250 0 0%23:59:46
18news.samoylyk.net 2 14601 5 14595 1 0%24:57:18
19localhost 30 4 4 0 0 100%00:00:02
20xanadu-bbs.net 36 361 0 361 0 0%20:22:07
TOTAL: 20 3093 325985 15081 307577 3327 4%714:01:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org8.6 MB0.0 KB328.9 KB8.9 MB 96%2.6 KB
2csiph-out.news.xs4all.nl7.7 MB2.2 KB11.6 MB19.3 MB 39%4.6 KB
3feeder.eternal-september.org7.3 MB2.0 KB724.8 KB8.0 MB 91%3.0 KB
4newsfeeds.xmission.com6.9 MB1.9 KB1.5 MB8.4 MB 82%3.7 KB
5csiph-out.feeder.erje.net5.8 MB0.0 KB2.7 MB8.5 MB 68%8.3 KB
6newsfeed.fu-berlin.de2.0 MB0.0 KB671.4 KB2.6 MB 75%2.5 KB
7newsfeed.neva.ru1.6 MB0.0 KB1.3 MB2.8 MB 54%3.1 KB
8csiph-out.feed.uzoreto.com1.4 MB0.0 KB8.0 MB9.3 MB 14%12.3 KB
9news-out.mixmin.net1.3 MB0.0 KB496.1 KB1.8 MB 72%3.0 KB
10csiph-out.news.weretis.net843.4 KB0.0 KB1.8 MB2.6 MB 31%5.6 KB
11news.fcku.it548.0 KB0.0 KB80.8 KB628.8 KB 87%1.9 KB
12csiph-out.news.tnetconsulting.net368.1 KB0.0 KB20.9 KB389.0 KB 94%4.1 KB
13nntp.pasdenom.info205.7 KB0.0 KB25.2 KB231.0 KB 89%2.2 KB
14news.swapon.de104.7 KB0.0 KB0.0 KB104.7 KB100%2.1 KB
15news-out.neodome.net54.5 KB0.0 KB149.0 KB203.5 KB 26%10.2 KB
16news.freedyn.net46.4 KB2.0 KB848.7 KB897.1 KB 5%12.8 KB
17news.samoylyk.net44.5 KB2.0 KB2.0 KB48.5 KB 91%8.1 KB
18news.bbs.nz9.7 KB0.0 KB0.0 KB9.7 KB100%1.4 KB
19localhost6.5 KB0.0 KB0.0 KB6.5 KB100%1.6 KB
20xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2044.7 MB10.2 KB30.1 MB74.8 MB 59%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 18 04:15:00 - 04:59:59 165 1.1% 0.06522.5 KB 1.1% 0.19
Nov 18 05:00:00 - 05:59:59 363 2.4% 0.102.1 MB 4.7% 0.60
Nov 18 06:00:00 - 06:59:59 362 2.4% 0.101.2 MB 2.6% 0.33
Nov 18 07:00:00 - 07:59:59 459 3.1% 0.131.3 MB 3.0% 0.38
Nov 18 08:00:00 - 08:59:59 588 3.9% 0.161.5 MB 3.3% 0.42
Nov 18 09:00:00 - 09:59:59 774 5.2% 0.212.2 MB 5.1% 0.64
Nov 18 10:00:00 - 10:59:59 681 4.5% 0.191.9 MB 4.2% 0.53
Nov 18 11:00:00 - 11:59:59 768 5.1% 0.211.9 MB 4.2% 0.53
Nov 18 12:00:00 - 12:59:59 645 4.3% 0.181.7 MB 3.7% 0.47
Nov 18 13:00:00 - 13:59:59 811 5.4% 0.231.9 MB 4.4% 0.55
Nov 18 14:00:00 - 14:59:59 879 5.9% 0.242.4 MB 5.3% 0.67
Nov 18 15:00:00 - 15:59:59 946 6.3% 0.263.8 MB 8.5% 1.07
Nov 18 16:00:00 - 16:59:59 950 6.3% 0.263.1 MB 7.0% 0.89
Nov 18 17:00:00 - 17:59:59 896 6.0% 0.252.2 MB 5.0% 0.63
Nov 18 18:00:00 - 18:59:59 800 5.3% 0.222.0 MB 4.4% 0.56
Nov 18 19:00:00 - 19:59:59 917 6.1% 0.252.6 MB 5.9% 0.75
Nov 18 20:00:00 - 20:59:59 741 4.9% 0.212.4 MB 5.4% 0.68
Nov 18 21:00:00 - 21:59:59 648 4.3% 0.181.8 MB 3.9% 0.50
Nov 18 22:00:00 - 22:59:59 572 3.8% 0.161.8 MB 4.0% 0.50
Nov 18 23:00:00 - 23:59:59 571 3.8% 0.161.9 MB 4.3% 0.55
Nov 19 00:00:00 - 00:59:59 460 3.1% 0.131.3 MB 2.8% 0.36
Nov 19 01:00:00 - 01:59:59 363 2.4% 0.101.1 MB 2.5% 0.32
Nov 19 02:00:00 - 02:59:59 326 2.2% 0.091.1 MB 2.4% 0.31
Nov 19 03:00:00 - 03:59:59 238 1.6% 0.07749.6 KB 1.6% 0.21
Nov 19 04:00:00 - 04:15:00 72 0.5% 0.08221.2 KB 0.5% 0.25
TOTAL: 24:00:00 14995 100.0% 0.1744.4 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1589 81 0 1 0 0 0 0 1507
2newsfeed.fu-berlin.de 589 14 0 0 0 0 0 0 575
3csiph-out.feed.uzoreto.com 409 30 0 0 0 0 0 0 379
4newsfeed.neva.ru 307 88 0 0 0 0 0 0 219
5news-out.aioe.org 245 100 0 0 0 0 0 0 145
6csiph-out.feeder.erje.net 175 66 0 0 0 0 0 0 109
7csiph-out.news.weretis.net 153 36 0 0 0 0 0 0 117
8news-out.mixmin.net 138 1 0 0 0 0 0 0 137
9feeder.eternal-september.org 137 36 0 1 0 0 0 0 100
10news.freedyn.net 54 1 0 1 0 0 0 0 52
11newsfeeds.xmission.com 42 10 0 1 0 0 0 0 31
12nntp.pasdenom.info 20 0 0 0 0 0 0 0 20
13news.swapon.de 19 0 0 0 0 0 0 0 19
14csiph-out.news.tnetconsulting.net 6 5 0 0 0 0 0 0 1
15news.fcku.it 4 1 0 0 0 0 0 0 3
16news-out.neodome.net 4 0 0 0 0 0 0 0 4
17news.bbs.nz 1 0 0 1 0 0 0 0 0
18news.samoylyk.net 1 0 0 1 0 0 0 0 0
TOTAL: 18 3893 469 0 6 0 0 0 0 3418

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 132
lada.talk 65
alt.politics 27
scinet.stats 23
mozilla.support.seamonkey 20
mozilla.support.firefox 15
mozilla.support.thunderbird 14
alt.bbs.synchronet 14
spline.eisfair 10
at.jobs 8
att.jobs 8
alt.testing 8
mozilla.dev.apps.seamonkey 7
mozilla.dev.security.policy 7
alt.job 7
alt.binaries.ebook 6
alt.religion 5
alt.binaries.pictures.purebeauty 5
mozilla.accessibility 5
alt.math 4
TOTAL: 70 469

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1786
EMP (phn path) 335
EMP (phl) 273
0 84
Too many newsgroups 78
EMP (phn nph) 9
Scoring filter 6
Binary: misplaced binary 5
Too many newsgroups (meow) 4
HTML Multipart 3
Too many newsgroups (low_xpost) 1
TOTAL: 11 2584

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 55
csiph-out.feed.uzoreto.com 3
csiph-out.news.xs4all.nl 2
TOTAL: 3 60
Huge articles
csiph-out.news.xs4all.nl 78
csiph-out.feed.uzoreto.com 69
csiph-out.feeder.erje.net 47
newsfeeds.xmission.com 28
news.freedyn.net 11
csiph-out.news.weretis.net 10
news-out.mixmin.net 3
feeder.eternal-september.org 3
newsfeed.fu-berlin.de 3
news-out.neodome.net 3
TOTAL: 12 257
Including strange strings
newsfeed.fu-berlin.de 370
news-out.aioe.org 132
csiph-out.news.xs4all.nl 28
news.swapon.de 19
csiph-out.feeder.erje.net 7
newsfeed.neva.ru 4
csiph-out.feed.uzoreto.com 2
csiph-out.news.weretis.net 2
newsfeeds.xmission.com 2
feeder.eternal-september.org 1
TOTAL: 11 568
No colon-space in header
csiph-out.news.xs4all.nl 8
csiph-out.feed.uzoreto.com 1
TOTAL: 2 9
TOTAL: 4 894

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 17996 700 14274 20 0 4 3%23:59:56
2fu-berlin.de 13965 432 13533 0 0 0 3%23:59:56
3news.samoylyk.net 15467 428 14553 7 0 26 2%23:59:56
4news.bbs.nz 28257 397 14113 23 0 1 1%23:59:52
5neva.ru 13636 88 13304 66 0 0 0%23:59:28
6tnet 16115 42 14502 1 0 0 0%23:59:44
7newsfeed.xs4all.nl 12553 33 12136 2 0 19 0%23:59:55
8aioe 10846 22 10411 0 0 1 0%23:59:56
9xmission 14805 15 12193 0 0 0 0%23:59:21
10usenet.pasdenom.info 15205 14 14440 6 0 25 0%23:59:56
11news.freedyn.net 14464 10 14194 19 0 0 0%23:59:56
12news.mixmin.net 14134 10 13782 0 0 0 0%23:59:56
13news.uzoreto.com 14112 8 13818 25 0 0 0%23:58:55
14weretis.net 14460 6 13966 3 0 0 0%23:59:47
15neodome.net 15023 6 14704 0 0 1 0%23:59:38
16eternal-september 12060 4 11751 0 0 0 0%23:59:56
17news.swapon.de 1335 4 1322 0 0 0 0%23:38:57
18erje 14039 1 13823 13 0 0 0%23:59:21
19news.fcku.it 1636 0 1635 0 0 0 0%21:43:06
TOTAL: 19 260108 2220 232454 185 0 77 0%453:17:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs5.3 MB60.6 KB5.3 MB0.1 KB/s7.6 KB23:59:56
2fu-berlin.de4.6 MB0.0 KB4.6 MB0.1 KB/s10.8 KB23:59:56
3news.samoylyk.net4.5 MB31.2 KB4.6 MB0.1 KB/s10.8 KB23:59:56
4news.bbs.nz1023.9 KB83.2 KB1.1 MB0.0 KB/s2.6 KB23:59:52
5neva.ru211.8 KB162.4 KB374.1 KB0.0 KB/s2.4 KB23:59:28
6tnet95.0 KB4.2 KB99.3 KB0.0 KB/s2.3 KB23:59:44
7newsfeed.xs4all.nl87.4 KB16.5 KB103.9 KB0.0 KB/s3.0 KB23:59:55
8usenet.pasdenom.info67.0 KB27.9 KB94.8 KB0.0 KB/s4.7 KB23:59:56
9aioe65.8 KB0.0 KB65.8 KB0.0 KB/s3.0 KB23:59:56
10xmission47.3 KB0.0 KB47.3 KB0.0 KB/s3.2 KB23:59:21
11news.uzoreto.com21.0 KB83.9 KB104.9 KB0.0 KB/s3.2 KB23:58:55
12news.freedyn.net18.2 KB178.9 KB197.1 KB0.0 KB/s6.8 KB23:59:56
13news.mixmin.net18.2 KB0.0 KB18.2 KB0.0 KB/s1.8 KB23:59:56
14neodome.net9.6 KB0.0 KB9.6 KB0.0 KB/s1.6 KB23:59:38
15weretis.net9.3 KB3.4 KB12.7 KB0.0 KB/s1.4 KB23:59:47
16eternal-september6.6 KB0.0 KB6.6 KB0.0 KB/s1.6 KB23:59:56
17news.swapon.de6.6 KB0.0 KB6.6 KB0.0 KB/s1.6 KB23:38:57
18erje1.3 KB50.6 KB51.9 KB0.0 KB/s3.7 KB23:59:21
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:43:06
TOTAL: 1916.0 MB702.8 KB16.7 MB0.0 KB/s7.1 KB453:17:32
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1a131033.upc-a.chello.nl 23 1016.3 KB 6 0 005:58:57
2024-178-045-162.res.spectrum.com 13 914.5 KB 10 4 203:20:55
3ip72-222-200-117.ph.ph.cox.net 18 69.3 KB 7 0 005:54:55
TOTAL: 3 54 2540.1 KB 23 4 238:59:51

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.upc-a.chello.nl 23 1016.3 KB 6 0 005:58:57
2*.res.spectrum.com 13 914.5 KB 10 4 203:20:55
3*.ph.ph.cox.net 18 69.3 KB 7 0 005:54:55
4*.net.upcbroadband.cz 23 00.0 KB 0 0 007:32:23
5unresolved 47 00.0 KB 0 0 015:25:19
6*.range81-153.btcentralplus.com 4 00.0 KB 0 0 000:47:17
7*.internet-census.org 6 00.0 KB 0 0 000:00:02
TOTAL: 7 134 2540.1 KB 23 4 238:59:51

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 3.239 2.683 0.00015:25:19
ip-78-102-198-192.net.upcbroadband.cz 1.487 0.887 0.00007:32:23
a131033.upc-a.chello.nl 1.709 1.513 0.00005:58:57
ip72-222-200-117.ph.ph.cox.net 1.372 1.598 0.00005:54:55
024-178-045-162.res.spectrum.com 1.032 0.795 0.00503:20:55
host81-153-177-33.range81-153.btcentralplus.com 0.282 0.038 0.00000:47:17
sh-ams-nl-gp1-wk101.internet-census.org 0.368 0.079 0.00000:00:02
TOTAL: 7 9.489 7.593 0.00538:59:51

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 47
ip-78-102-198-192.net.upcbroadband.cz 23
sh-ams-nl-gp1-wk101.internet-census.org 6
host81-153-177-33.range81-153.btcentralplus.com 4
TOTAL: 4 80

NNRP unrecognized commands (by host):

SystemConn
sh-ams-nl-gp1-wk101.internet-census.org 10
TOTAL: 1 10

NNRP unrecognized commands (by command):

CommandCount
EHLO sh-ams-nl-gp1-wk101.internet-census... 2
^V^C^A 1
GET / HTTP/1.1 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
Host: 69.160.37.58:119 1
Accept-Encoding: gzip 1
Accept: */* 1
^A 1
SSH-2.0-Go 1
TOTAL: 9 10

NNRP client timeouts [Top 20]:

SystemConnPeer
ip72-222-200-117.ph.ph.cox.net 7 0
024-178-045-162.res.spectrum.com 4 0
sh-ams-nl-gp1-wk101.internet-census.org 1 1
ip-78-102-198-192.net.upcbroadband.cz 1 0
TOTAL: 4 13 1

Newsgroup request counts (by category):

CategoryCountPct
1comp 27100.0%
TOTAL: 1 27100.0%

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

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