Daily Usenet report for csiph.com

Aug 26 04:15:00 -- Aug 27 04:15:00

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Aug 26 08:31:45 csiph nnrpd[7335]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Aug 26 08:31:45 csiph nnrpd[7335]: 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]
Aug 26 08:51:08 csiph nnrpd[8292]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Aug 26 08:51:08 csiph nnrpd[8292]: 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]
Aug 26 18:55:41 csiph nnrpd[38385]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Aug 26 18:55:41 csiph nnrpd[38385]: 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]
Aug 26 22:31:01 csiph nnrpd[49202]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Aug 26 22:31:01 csiph nnrpd[49202]: 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 20857 48.7%5.3 MB 64.9%
innd 18094 42.2%2.2 MB 27.5%
innfeed 3339 7.8%576.7 KB 6.9%
nnrpd 476 1.1%53.2 KB 0.6%
nocem 62 0.1%6.2 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 42829 100.0%8.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 308934 56.1%
Negative hits 192014 34.9%
Cache misses 29092 5.3%
Do not exist 20235 3.7%
TOTAL: 4 550275 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.264 0.0%140 0.000 1.886 19.429
article cleanup00:00:00.121 0.0%19659 0.000 0.006 0.041
article logging00:00:00.272 0.0%20114 0.000 0.014 0.048
article parse00:00:01.254 0.0%69969 0.000 0.018 0.374
article write00:00:07.461 0.0%16148 0.125 0.462 22.286
artlog/artcncl00:00:00.001 0.0%135 0.000 0.007 0.167
artlog/artparse00:00:00.011 0.0%611 0.000 0.018 0.500
data move00:00:00.126 0.0%483089 0.000 0.000 0.005
hisgrep/artcncl00:00:00.012 0.0%140 0.000 0.086 1.000
hishave/artcncl00:00:00.005 0.0%140 0.000 0.036 0.500
hishave/artparse00:00:00.003 0.0%605 0.000 0.005 0.071
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.728 0.0%550421 0.001 0.007 0.050
history sync00:00:01.490 0.0%348 0.000 4.282 54.000
history write00:00:15.094 0.0%19665 0.074 0.768 4.857
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.619 0.0%605 0.000 1.023 21.750
idle23:58:55.743 99.9%494189 71.966 174.702 572.735
nntp read00:00:02.087 0.0%493088 0.001 0.004 0.009
overview write00:00:14.139 0.0%16148 0.116 0.876 9.204
perl filter00:00:33.320 0.0%19659 1.251 1.695 3.730
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.271 0.0%32351 0.000 0.008 0.034
TOTAL: 24:00:50.13324:00:16.021100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.053 0.0%18281 0.000 0.003 0.035
article prepare00:00:00.002 0.0%14076 0.000 0.000 0.005
article read00:00:00.289 0.0%1612 0.000 0.179 8.000
backlog stats00:00:00.160 0.0%336574 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.199 0.0%251741 0.001 0.005 0.009
data write00:00:01.475 0.0%239191 0.003 0.006 0.012
idle23:53:26.316100.0%336574 145.208 255.535 754.102
status file00:00:00.395 0.0%273 0.000 1.447 21.222
TOTAL: 23:53:38.68023:53:29.889100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle17:18:42.206100.0%418 0.000149096.187600124.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.008 0.0%1081 0.000 0.007 0.167
readart00:00:00.320 0.0%35 0.000 9.143 48.000
TOTAL: 17:19:05.65617:18:42.534100.0%----

Control commands to INND:

CommandNumber
L 1
flush 5
flushlogs 2
go 2
logmode 2
mode 138
pause 2
paused 2
reload 2
reserve 2
TOTAL: 10 158

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.weretis.net 5 32671 2878 29548 245 8%46:50:31
2csiph-out.feeder.erje.net 1440 78236 2739 75066 431 3%118:46:18
3feeder.eternal-september.org 4 18782 1878 16825 79 9%26:43:15
4news-out.aioe.org 3 15736 1718 14007 11 10%24:09:58
5csiph-out.news.xs4all.nl 864 18170 1525 15386 1259 8%71:12:37
6news.freedyn.net 3 19448 1231 17236 981 6%24:08:56
7news-out.mixmin.net 1 17228 934 16143 151 5%23:59:53
8newsfeed.neva.ru 152 20811 807 19626 378 3%72:06:15
9newsfeed.fu-berlin.de 20 13267 748 12325 194 5%21:10:03
10csiph-out.feed.uzoreto.com 864 41432 675 40360 397 1%71:16:44
11newsfeeds.xmission.com 2 17466 647 16808 11 3%28:55:12
12news.fcku.it 8 2050 246 1802 2 12%21:45:11
13nntp.pasdenom.info 4 10062 61 9995 6 0%19:55:17
14news.swapon.de 4 1363 17 1343 3 1%24:11:19
15news.bbs.nz 1 14650 8 14642 0 0%23:59:54
16news.samoylyk.net 3 34122 6 34116 0 0%05:53:27
17localhost 37 3 3 0 0 100%00:00:09
18xanadu-bbs.net 26 429 0 429 0 0%21:53:21
TOTAL: 18 3441 355926 16121 335657 4148 4%646:58:20
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net11.7 MB0.0 KB11.5 MB23.2 MB 50%7.5 KB
2csiph-out.news.weretis.net9.1 MB0.0 KB6.0 MB15.1 MB 60%4.9 KB
3feeder.eternal-september.org5.1 MB0.0 KB299.0 KB5.4 MB 94%2.8 KB
4news-out.aioe.org4.3 MB0.0 KB17.0 KB4.3 MB 99%2.6 KB
5csiph-out.news.xs4all.nl3.7 MB0.0 KB8.0 MB11.6 MB 31%4.3 KB
6news.freedyn.net3.2 MB0.0 KB42.1 MB45.3 MB 7%21.0 KB
7news-out.mixmin.net3.0 MB0.0 KB496.2 KB3.5 MB 86%3.3 KB
8newsfeeds.xmission.com2.2 MB0.0 KB282.8 KB2.4 MB 88%3.8 KB
9newsfeed.neva.ru2.0 MB0.0 KB1.1 MB3.1 MB 63%2.7 KB
10csiph-out.feed.uzoreto.com1.8 MB0.0 KB4.5 MB6.3 MB 28%6.0 KB
11newsfeed.fu-berlin.de1.7 MB0.0 KB426.1 KB2.2 MB 80%2.3 KB
12news.fcku.it401.4 KB0.0 KB1.7 KB403.1 KB 99%1.6 KB
13nntp.pasdenom.info136.8 KB0.0 KB12.8 KB149.6 KB 91%2.2 KB
14news.swapon.de38.9 KB0.0 KB1.3 MB1.3 MB 2%68.0 KB
15news.samoylyk.net9.2 KB0.0 KB0.0 KB9.2 KB100%1.5 KB
16localhost8.6 KB0.0 KB0.0 KB8.6 KB100%2.9 KB
17news.bbs.nz8.1 KB0.0 KB0.0 KB8.1 KB100%1.0 KB
18xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1848.3 MB0.0 KB75.9 MB124.2 MB 38%6.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 26 04:15:00 - 04:59:59 211 1.3% 0.08601.9 KB 1.2% 0.22
Aug 26 05:00:00 - 05:59:59 481 3.0% 0.132.0 MB 4.2% 0.57
Aug 26 06:00:00 - 06:59:59 503 3.1% 0.142.0 MB 4.2% 0.58
Aug 26 07:00:00 - 07:59:59 648 4.0% 0.182.2 MB 4.5% 0.62
Aug 26 08:00:00 - 08:59:59 666 4.1% 0.181.7 MB 3.6% 0.49
Aug 26 09:00:00 - 09:59:59 734 4.5% 0.201.6 MB 3.4% 0.47
Aug 26 10:00:00 - 10:59:59 727 4.5% 0.202.0 MB 4.2% 0.57
Aug 26 11:00:00 - 11:59:59 703 4.4% 0.201.8 MB 3.7% 0.51
Aug 26 12:00:00 - 12:59:59 825 5.1% 0.232.0 MB 4.2% 0.58
Aug 26 13:00:00 - 13:59:59 907 5.6% 0.252.6 MB 5.3% 0.73
Aug 26 14:00:00 - 14:59:59 887 5.5% 0.253.0 MB 6.2% 0.85
Aug 26 15:00:00 - 15:59:59 971 6.0% 0.273.4 MB 7.1% 0.98
Aug 26 16:00:00 - 16:59:59 862 5.3% 0.242.5 MB 5.1% 0.70
Aug 26 17:00:00 - 17:59:59 915 5.7% 0.252.4 MB 5.0% 0.68
Aug 26 18:00:00 - 18:59:59 974 6.0% 0.272.9 MB 6.0% 0.82
Aug 26 19:00:00 - 19:59:59 919 5.7% 0.262.5 MB 5.3% 0.72
Aug 26 20:00:00 - 20:59:59 899 5.6% 0.252.4 MB 5.0% 0.69
Aug 26 21:00:00 - 21:59:59 756 4.7% 0.212.0 MB 4.2% 0.58
Aug 26 22:00:00 - 22:59:59 601 3.7% 0.172.0 MB 4.2% 0.57
Aug 26 23:00:00 - 23:59:59 490 3.0% 0.141.4 MB 2.9% 0.40
Aug 27 00:00:00 - 00:59:59 359 2.2% 0.101.1 MB 2.2% 0.31
Aug 27 01:00:00 - 01:59:59 370 2.3% 0.101.2 MB 2.4% 0.33
Aug 27 02:00:00 - 02:59:59 295 1.8% 0.081.1 MB 2.4% 0.33
Aug 27 03:00:00 - 03:59:59 347 2.1% 0.101.2 MB 2.4% 0.33
Aug 27 04:00:00 - 04:15:00 93 0.6% 0.10617.6 KB 1.2% 0.69
TOTAL: 24:00:00 16143 100.0% 0.1948.3 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1302 38 0 0 0 0 0 0 1264
2news.freedyn.net 944 29 0 0 0 0 0 0 915
3newsfeed.fu-berlin.de 610 18 0 0 0 0 0 0 592
4csiph-out.feeder.erje.net 433 74 0 0 0 0 0 0 359
5csiph-out.feed.uzoreto.com 401 36 0 0 0 0 0 0 365
6newsfeed.neva.ru 377 94 0 0 0 0 0 0 283
7csiph-out.news.weretis.net 256 68 0 0 0 0 0 0 188
8news-out.mixmin.net 157 1 0 0 0 0 0 0 156
9feeder.eternal-september.org 59 15 0 0 0 0 0 0 44
10news-out.aioe.org 18 13 0 0 0 0 0 0 5
11newsfeeds.xmission.com 10 0 0 0 0 0 0 0 10
12nntp.pasdenom.info 6 0 0 0 0 0 0 0 6
13news.swapon.de 5 0 0 0 0 0 0 0 5
14news.fcku.it 2 1 0 0 0 0 0 0 1
TOTAL: 14 4580 387 0 0 0 0 0 0 4193

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 52
alt.bbs.synchronet 42
lada.auto 33
it-alt.sport.calcio.juventus 25
alt.computer.workshop 20
mozilla.support.seamonkey 17
oesterreich.tratsch 14
mozilla.support.thunderbird 14
mozilla.dev.platform 12
alt.english.usage 12
mozilla.dev.security.policy 10
alt.binaries.pictures.purebeauty 10
spline.eisfair.dev 8
alt.windows7.general 6
alt.politics.usa 5
alt.binaries.sounds.lossless.1960s 4
alt.music.pink-floyd.publius 4
eagle.support.eng 4
alt.philosophy 4
alt.soupdragons 3
TOTAL: 88 387

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2433
EMP (phn path) 379
EMP (phl) 86
EMP (phn nph) 80
Too many newsgroups 50
Scoring filter (8) 21
User-issued cancel 14
HTML Multipart 12
Binary: misplaced rar 10
Scoring filter (10) 8
Scoring filter (11) 7
Binary Payload 6
Scoring filter (12) 5
User-issued spam cancel 4
Scoring filter (14) 4
Scoring filter (9) 4
Scoring filter (16) 2
Scoring filter (13) 1
Too many newsgroups (meow) 1
HTML Image Tags 1
TOTAL: 20 3128

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com3905252
TOTAL: 139165252

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 45
TOTAL: 1 45
Huge articles
news.freedyn.net 262
csiph-out.feeder.erje.net 206
csiph-out.news.weretis.net 57
csiph-out.news.xs4all.nl 33
csiph-out.feed.uzoreto.com 33
news-out.mixmin.net 5
newsfeeds.xmission.com 3
news.swapon.de 3
newsfeed.fu-berlin.de 2
feeder.eternal-september.org 1
TOTAL: 10 605
Including strange strings
newsfeed.fu-berlin.de 390
csiph-out.news.xs4all.nl 32
csiph-out.news.weretis.net 8
news-out.mixmin.net 6
csiph-out.feed.uzoreto.com 5
news-out.aioe.org 5
csiph-out.feeder.erje.net 3
news.swapon.de 2
news.freedyn.net 2
newsfeed.neva.ru 1
TOTAL: 10 454
TOTAL: 3 1104

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.freedyn.net 15154 597 14235 22 0 0 3%23:59:53
2xanadu-bbs 18961 548 15595 0 0 0 2%23:59:50
3fu-berlin.de 15086 481 14605 0 0 0 3%23:59:42
4news.bbs.nz 30715 222 15398 7 0 2 0%23:59:53
5erje 15599 148 12575 546 0 0 0%23:59:53
6usenet.pasdenom.info 16657 93 15476 514 0 2128 0%23:59:53
7news.uzoreto.com 15387 41 14968 152 0 0 0%23:59:50
8newsfeed.xs4all.nl 15068 31 14090 6 0 57 0%23:59:47
9neva.ru 15022 17 14513 115 0 0 0%23:59:29
10aioe 13723 11 13171 0 0 0 0%23:59:25
11news.mixmin.net 15075 9 14642 1 0 0 0%23:59:53
12xmission 20745 6 15089 2 0 1 0%23:59:53
13eternal-september 14264 6 13758 0 0 0 0%23:59:53
14weretis.net 13737 6 12489 4 0 0 0%23:59:53
15news.swapon.de 1522 3 1482 0 0 0 0%23:40:33
16news.samoylyk.net 0 0 0 0 0 16136 0%23:58:39
17news.fcku.it 1658 0 1647 0 0 0 0%21:33:09
18news.redatomik.org 0 0 0 0 0 15638 0%23:59:53
TOTAL: 18 238373 2219 203733 1369 0 33962 0%429:09:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.freedyn.net6.2 MB30.6 KB6.2 MB0.1 KB/s10.2 KB23:59:53
2xanadu-bbs5.9 MB0.0 KB5.9 MB0.1 KB/s11.0 KB23:59:50
3fu-berlin.de5.7 MB0.0 KB5.7 MB0.1 KB/s12.2 KB23:59:42
4news.bbs.nz593.1 KB17.1 KB610.2 KB0.0 KB/s2.7 KB23:59:53
5erje361.7 KB1.7 MB2.1 MB0.0 KB/s3.1 KB23:59:53
6usenet.pasdenom.info291.6 KB5.8 MB6.1 MB0.1 KB/s10.3 KB23:59:53
7newsfeed.xs4all.nl127.4 KB13.6 KB141.0 KB0.0 KB/s3.8 KB23:59:47
8news.uzoreto.com94.9 KB517.3 KB612.3 KB0.0 KB/s3.2 KB23:59:50
9neva.ru55.1 KB232.5 KB287.6 KB0.0 KB/s2.2 KB23:59:29
10aioe34.0 KB0.0 KB34.0 KB0.0 KB/s3.1 KB23:59:25
11news.mixmin.net23.8 KB1.5 KB25.3 KB0.0 KB/s2.5 KB23:59:53
12weretis.net18.2 KB9.4 KB27.5 KB0.0 KB/s2.8 KB23:59:53
13xmission14.8 KB11.2 KB26.0 KB0.0 KB/s3.2 KB23:59:53
14eternal-september13.3 KB0.0 KB13.3 KB0.0 KB/s2.2 KB23:59:53
15news.swapon.de8.7 KB0.0 KB8.7 KB0.0 KB/s2.9 KB23:40:33
16news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:39
17news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:33:09
18news.redatomik.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 1819.4 MB8.3 MB27.7 MB0.0 KB/s7.9 KB429:09:21
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
171-13-21-253.dhcp.dlth.mn.charter.com 11 1839.3 KB 8 3 303:12:20
2cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net 1 711.3 KB 1 0 000:02:39
3a131033.upc-a.chello.nl 45 613.5 KB 3 0 010:21:13
4208-71-239-109.cust.centrio.cz 3 420.7 KB 3 0 001:32:11
TOTAL: 4 60 3584.8 KB 15 3 317:19:05

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dhcp.dlth.mn.charter.com 11 1839.3 KB 8 3 303:12:20
2*.19-1.cable.virginm.net 1 711.3 KB 1 0 000:02:39
3*.upc-a.chello.nl 45 613.5 KB 3 0 010:21:13
4*.cust.centrio.cz 3 420.7 KB 3 0 001:32:11
5unresolved 6 00.0 KB 0 0 000:00:10
6*.range31-50.btcentralplus.com 4 00.0 KB 0 0 000:10:16
7*.ph.ph.cox.net 2 00.0 KB 0 0 002:00:13
TOTAL: 7 72 3584.8 KB 15 3 317:19:05

NNRP auth users [Top 20]:

UserConn
ctomczyk 3
ohlandl 3
TOTAL: 2 6

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
a131033.upc-a.chello.nl 3.388 0.683 0.00010:21:13
71-13-21-253.dhcp.dlth.mn.charter.com 1.109 0.201 0.00703:12:20
ip72-222-200-117.ph.ph.cox.net 0.483 0.056 0.00002:00:13
208-71-239-109.cust.centrio.cz 0.328 0.054 0.00701:32:11
host31-50-220-123.range31-50.btcentralplus.com 0.270 0.065 0.00000:10:16
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net 0.125 0.017 0.00000:02:39
89.248.168.176 0.066 0.017 0.00000:00:03
5.86.209.93 0.141 0.023 0.00000:00:02
94.165.129.126 0.074 0.008 0.00000:00:01
5.86.118.145 0.057 0.024 0.00000:00:01
5.86.220.65 0.072 0.008 0.00000:00:01
TOTAL: 11 6.113 1.156 0.01417:19:05

Curious NNRP server explorers [Top 20]:

SystemConn
host31-50-220-123.range31-50.btcentralplus.com 4
ip72-222-200-117.ph.ph.cox.net 2
5.86.209.93 2
5.86.220.65 1
5.86.118.145 1
89.248.168.176 1
94.165.129.126 1
TOTAL: 7 12

NNRP client timeouts [Top 20]:

SystemConnPeer
71-13-21-253.dhcp.dlth.mn.charter.com 4 0
ip72-222-200-117.ph.ph.cox.net 4 0
208-71-239-109.cust.centrio.cz 3 0
TOTAL: 3 11 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 35100.0%
TOTAL: 1 35100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 24
2comp.lang.pl1 7
3comp.lang.javascript 4
TOTAL: 3 35