Daily Usenet report for csiph.com

Dec 10 04:15:00 -- Dec 11 04:15:00

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Dec 10 09:17:26 csiph nnrpd[45520]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 10 09:17:26 csiph nnrpd[45520]: 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 10 10:38:32 csiph nnrpd[50058]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 10 10:38:32 csiph nnrpd[50058]: 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 10 10:48:10 csiph nnrpd[50615]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 10 10:48:10 csiph nnrpd[50615]: 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 18629 48.7%4.8 MB 64.3%
innd 15200 39.8%2.0 MB 26.9%
innfeed 3506 9.2%582.2 KB 7.5%
nnrpd 873 2.3%95.4 KB 1.2%
nocem 10 0.0%1.0 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 38219 100.0%7.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 290443 53.7%
Negative hits 231787 42.9%
Do not exist 18173 3.4%
Cache misses 248 0.0%
TOTAL: 4 540651 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.263 0.0%36 0.000 7.306 17.125
article cleanup00:00:00.136 0.0%18025 0.000 0.008 0.057
article logging00:00:00.335 0.0%18454 0.000 0.018 0.634
article parse00:00:00.552 0.0%53336 0.000 0.010 0.041
article write00:00:18.219 0.0%15444 0.150 1.180 29.518
artlog/artcncl00:00:00.002 0.0%36 0.000 0.056 1.000
artlog/artparse00:00:00.001 0.0%143 0.000 0.007 0.167
data move00:00:00.164 0.0%508396 0.000 0.000 0.003
hisgrep/artcncl00:00:00.019 0.0%36 0.000 0.528 1.182
hishave/artcncl00:00:00.002 0.0%36 0.000 0.056 1.000
hishave/artparse00:00:00.000 0.0%141 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.400 0.0%541017 0.002 0.010 0.167
history sync00:00:00.830 0.0%376 0.000 2.207 9.500
history write00:00:17.335 0.0%18027 0.172 0.962 7.125
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.082 0.0%141 0.000 0.582 4.000
idle23:58:24.604 99.8%514364 100.004 167.789 594.402
nntp read00:00:02.026 0.0%515797 0.000 0.004 0.009
overview write00:00:47.512 0.1%15444 0.157 3.076 227.818
perl filter00:00:27.275 0.0%18025 1.146 1.513 4.081
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.239 0.0%30897 0.000 0.008 0.032
TOTAL: 24:00:57.73724:00:24.996100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.050 0.0%15490 0.000 0.003 0.048
article prepare00:00:00.001 0.0%14808 0.000 0.000 0.009
article read00:00:00.277 0.0%1973 0.000 0.140 8.800
backlog stats00:00:00.214 0.0%328231 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.173 0.0%254415 0.000 0.005 0.012
data write00:00:01.545 0.0%241222 0.002 0.006 0.016
idle23:53:53.240100.0%328231 148.678 262.112 813.149
status file00:00:00.499 0.0%295 0.000 1.692 11.200
TOTAL: 23:54:03.21223:53:56.999100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle46:45:18.625 99.8%506 148.500332645.504600136.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.006 0.0%1212 0.000 0.005 0.167
readart00:00:00.165 0.0%8 0.000 20.625 41.000
TOTAL: 46:50:04.59746:45:18.796 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.aioe.org 4 14640 3363 11177 100 22%24:09:26
2newsfeeds.xmission.com 3 14605 2806 11758 41 19%24:13:49
3feeder.eternal-september.org 13 5942 2337 3510 95 39%27:37:53
4csiph-out.news.xs4all.nl 532 17334 2178 14009 1147 12%68:03:38
5csiph-out.feeder.erje.net 1436 75722 924 74520 278 1%119:35:32
6news-out.mixmin.net 1 16269 791 15339 139 4%23:59:42
7newsfeed.fu-berlin.de 12 13505 738 12569 198 5%22:12:51
8csiph-out.news.weretis.net 4 31634 693 30837 104 2%47:59:41
9newsfeed.neva.ru 149 12104 586 11326 192 4%72:03:19
10csiph-out.feed.uzoreto.com 864 23768 383 22987 398 1%71:13:06
11news.fcku.it 11 1832 274 1550 8 14%22:03:03
12news-out.neodome.net 3 16576 239 16326 11 1%23:59:42
13news.freedyn.net 1 17532 52 17427 53 0%23:59:56
14news.swapon.de 6 1378 51 1327 0 3%23:38:12
15csiph-out.news.tnetconsulting.net 1 15177 42 15125 10 0%23:59:57
16news.samoylyk.net 1 14903 3 14900 0 0%23:59:52
17news.bbs.nz 2 14798 3 14795 0 0%23:59:39
18xanadu-bbs.net 28 410 1 409 0 0%21:27:39
19localhost 26 0 0 0 0 0%00:00:02
TOTAL: 19 3097 308129 15464 289891 2774 5%688:16:59
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeeds.xmission.com10.1 MB0.0 KB2.4 MB12.5 MB 80%4.5 KB
2news-out.aioe.org8.7 MB0.0 KB278.0 KB8.9 MB 96%2.6 KB
3csiph-out.feeder.erje.net6.5 MB0.0 KB2.5 MB9.0 MB 72%7.7 KB
4csiph-out.news.xs4all.nl6.5 MB0.0 KB4.7 MB11.2 MB 57%3.4 KB
5feeder.eternal-september.org6.2 MB0.0 KB333.4 KB6.5 MB 95%2.7 KB
6news-out.mixmin.net2.4 MB0.0 KB261.2 KB2.7 MB 90%2.9 KB
7csiph-out.news.weretis.net2.3 MB0.8 KB1.3 MB3.6 MB 64%4.6 KB
8csiph-out.feed.uzoreto.com1.8 MB0.0 KB4.8 MB6.6 MB 27%8.6 KB
9newsfeed.fu-berlin.de1.7 MB0.0 KB438.8 KB2.1 MB 79%2.3 KB
10newsfeed.neva.ru1.5 MB0.0 KB573.1 KB2.1 MB 73%2.7 KB
11news-out.neodome.net799.3 KB0.0 KB69.4 KB868.7 KB 92%3.5 KB
12news.fcku.it399.7 KB0.0 KB11.6 KB411.2 KB 97%1.5 KB
13news.freedyn.net270.8 KB0.0 KB897.5 KB1.1 MB 23%11.1 KB
14csiph-out.news.tnetconsulting.net151.0 KB0.0 KB91.9 KB243.0 KB 62%4.7 KB
15news.swapon.de117.8 KB0.0 KB0.0 KB117.8 KB100%2.3 KB
16news.samoylyk.net8.9 KB0.0 KB0.0 KB8.9 KB100%3.0 KB
17news.bbs.nz8.5 KB0.0 KB0.0 KB8.5 KB100%2.8 KB
18xanadu-bbs.net2.0 KB0.0 KB0.0 KB2.0 KB100%2.0 KB
19localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1949.4 MB0.8 KB18.5 MB67.9 MB 72%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 10 04:15:00 - 04:59:59 180 1.2% 0.07686.5 KB 1.4% 0.25
Dec 10 05:00:00 - 05:59:59 387 2.5% 0.112.6 MB 5.3% 0.75
Dec 10 06:00:00 - 06:59:59 307 2.0% 0.091.2 MB 2.4% 0.34
Dec 10 07:00:00 - 07:59:59 462 3.0% 0.131.4 MB 2.8% 0.39
Dec 10 08:00:00 - 08:59:59 718 4.6% 0.201.9 MB 3.9% 0.54
Dec 10 09:00:00 - 09:59:59 727 4.7% 0.202.2 MB 4.5% 0.63
Dec 10 10:00:00 - 10:59:59 747 4.8% 0.212.1 MB 4.3% 0.61
Dec 10 11:00:00 - 11:59:59 756 4.9% 0.212.1 MB 4.2% 0.59
Dec 10 12:00:00 - 12:59:59 705 4.6% 0.202.0 MB 4.0% 0.56
Dec 10 13:00:00 - 13:59:59 852 5.5% 0.242.4 MB 4.8% 0.68
Dec 10 14:00:00 - 14:59:59 804 5.2% 0.222.2 MB 4.5% 0.63
Dec 10 15:00:00 - 15:59:59 945 6.1% 0.263.8 MB 7.8% 1.09
Dec 10 16:00:00 - 16:59:59 898 5.8% 0.252.7 MB 5.5% 0.78
Dec 10 17:00:00 - 17:59:59 903 5.8% 0.252.9 MB 5.9% 0.83
Dec 10 18:00:00 - 18:59:59 867 5.6% 0.242.6 MB 5.2% 0.74
Dec 10 19:00:00 - 19:59:59 888 5.8% 0.252.7 MB 5.4% 0.76
Dec 10 20:00:00 - 20:59:59 722 4.7% 0.202.1 MB 4.3% 0.60
Dec 10 21:00:00 - 21:59:59 736 4.8% 0.202.2 MB 4.5% 0.63
Dec 10 22:00:00 - 22:59:59 713 4.6% 0.202.2 MB 4.4% 0.62
Dec 10 23:00:00 - 23:59:59 610 4.0% 0.171.9 MB 3.8% 0.54
Dec 11 00:00:00 - 00:59:59 461 3.0% 0.131.6 MB 3.3% 0.46
Dec 11 01:00:00 - 01:59:59 328 2.1% 0.091.1 MB 2.3% 0.32
Dec 11 02:00:00 - 02:59:59 357 2.3% 0.101.5 MB 3.0% 0.43
Dec 11 03:00:00 - 03:59:59 298 1.9% 0.081.0 MB 2.1% 0.30
Dec 11 04:00:00 - 04:15:00 71 0.5% 0.08245.4 KB 0.5% 0.27
TOTAL: 24:00:00 15442 100.0% 0.1849.5 MB 100.0% 0.59
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1156 81 0 0 0 0 0 0 1075
2newsfeed.fu-berlin.de 490 13 0 0 0 0 0 0 477
3csiph-out.feed.uzoreto.com 398 28 0 0 0 0 0 0 370
4news-out.aioe.org 205 96 0 0 0 0 0 0 109
5newsfeed.neva.ru 194 58 0 0 0 0 0 0 136
6csiph-out.news.weretis.net 174 75 0 0 0 0 0 0 99
7csiph-out.feeder.erje.net 149 36 0 0 0 0 0 0 113
8news-out.mixmin.net 140 1 0 0 0 0 0 0 139
9feeder.eternal-september.org 99 59 0 0 0 0 0 0 40
10news.freedyn.net 55 1 0 0 0 0 0 0 54
11newsfeeds.xmission.com 46 8 0 0 0 0 0 0 38
12news.swapon.de 16 0 0 0 0 0 0 0 16
13csiph-out.news.tnetconsulting.net 13 13 0 0 0 0 0 0 0
14news.fcku.it 8 8 0 0 0 0 0 0 0
15news-out.neodome.net 8 1 0 0 0 0 0 0 7
TOTAL: 15 3151 478 0 0 0 0 0 0 2673

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 135
scinet.stats 32
it-alt.sport.calcio.juventus 32
lada.auto 26
lada.talk 22
alt.politics 17
trollnet.cinema 16
alt.binaries.pictures.purebeauty 16
spline.eisfair 14
free.it.religioni.scientology 12
alt.politics.usa 12
mozilla.support.thunderbird 11
alt.windows7.general 10
at.jobs 9
mozilla.support.firefox 8
mozilla.dev.apps.seamonkey 8
aus.jobs 7
it-alt.comp.software.mozilla 6
att.jobs 6
alt.philosophy 4
TOTAL: 68 478

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1425
EMP (phn path) 310
EMP (phl) 169
Too many newsgroups 100
0 33
EMP (phn nph) 29
Scoring filter 26
HTML Multipart 4
Binary: misplaced binary 2
Too many newsgroups (low_xpost) 1
HTML post 1
TOTAL: 11 2100

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 50
csiph-out.feed.uzoreto.com 2
csiph-out.news.xs4all.nl 1
TOTAL: 3 53
Huge articles
csiph-out.feeder.erje.net 44
newsfeeds.xmission.com 31
csiph-out.feed.uzoreto.com 26
csiph-out.news.xs4all.nl 17
csiph-out.news.weretis.net 11
news.freedyn.net 8
newsfeed.fu-berlin.de 2
news-out.neodome.net 1
feeder.eternal-september.org 1
TOTAL: 9 141
Including strange strings
newsfeed.fu-berlin.de 281
news-out.aioe.org 101
news.swapon.de 16
csiph-out.news.xs4all.nl 10
csiph-out.news.weretis.net 9
newsfeeds.xmission.com 5
feeder.eternal-september.org 3
news.freedyn.net 2
csiph-out.feeder.erje.net 2
newsfeed.neva.ru 1
TOTAL: 10 430
No colon-space in header
csiph-out.feeder.erje.net 2
TOTAL: 1 2
TOTAL: 4 626

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 18959 1507 13891 2 0 0 7%23:50:05
2fu-berlin.de 14440 530 13910 0 0 0 3%23:51:00
3news.samoylyk.net 15800 521 14870 10 0 0 3%23:50:05
4news.bbs.nz 29095 398 14426 26 0 0 1%23:57:09
5xmission 13956 136 11904 6 0 0 0%23:50:05
6newsfeed.xs4all.nl 14044 105 13008 0 0 27 0%23:54:27
7neva.ru 13964 90 13706 38 0 0 0%23:54:24
8tnet 16889 89 14734 4 0 0 0%23:50:05
9erje 14336 7 14046 125 0 42 0%23:52:20
10neodome.net 15449 6 15033 0 0 0 0%23:50:14
11aioe 10865 3 10442 0 0 0 0%23:50:25
12news.mixmin.net 14002 3 13730 0 0 0 0%23:50:05
13news.uzoreto.com 14826 3 14524 26 0 0 0%23:51:48
14news.freedyn.net 14999 3 14696 60 0 0 0%23:58:21
15news.swapon.de 1382 1 1371 0 0 0 0%23:35:06
16news.fcku.it 1501 0 1496 0 0 0 0%21:16:57
17usenet.pasdenom.info 0 0 0 0 0 14864 0%23:58:43
18weretis.net 14412 0 13959 0 0 0 0%23:56:41
19eternal-september 0 0 0 0 0 12453 0%23:50:05
TOTAL: 19 238919 3402 209746 297 0 27386 1%450:48:05
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs8.1 MB6.2 KB8.1 MB0.1 KB/s5.5 KB23:50:05
2fu-berlin.de5.3 MB0.0 KB5.3 MB0.1 KB/s10.3 KB23:51:00
3news.samoylyk.net5.3 MB25.7 KB5.3 MB0.1 KB/s10.3 KB23:50:05
4news.bbs.nz1.0 MB142.1 KB1.2 MB0.0 KB/s2.8 KB23:57:09
5newsfeed.xs4all.nl364.5 KB0.0 KB364.5 KB0.0 KB/s3.5 KB23:54:27
6xmission286.0 KB24.1 KB310.1 KB0.0 KB/s2.2 KB23:50:05
7neva.ru226.2 KB83.0 KB309.2 KB0.0 KB/s2.4 KB23:54:24
8tnet201.0 KB9.5 KB210.4 KB0.0 KB/s2.3 KB23:50:05
9neodome.net29.7 KB0.0 KB29.7 KB0.0 KB/s5.0 KB23:50:14
10erje17.5 KB372.5 KB390.1 KB0.0 KB/s3.0 KB23:52:20
11news.freedyn.net12.5 KB837.0 KB849.5 KB0.0 KB/s13.5 KB23:58:21
12aioe10.8 KB0.0 KB10.8 KB0.0 KB/s3.6 KB23:50:25
13news.uzoreto.com9.7 KB118.6 KB128.3 KB0.0 KB/s4.4 KB23:51:48
14news.mixmin.net7.3 KB0.0 KB7.3 KB0.0 KB/s2.4 KB23:50:05
15news.swapon.de1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:35:06
16news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:16:57
17usenet.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:43
18weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:41
19eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:05
TOTAL: 1920.8 MB1.6 MB22.4 MB0.0 KB/s6.2 KB450:48:05
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ip72-222-200-117.ph.ph.cox.net 3 43.9 KB 4 0 001:32:12
2a131033.upc-a.chello.nl 63 22.3 KB 2 0 020:43:26
391.187.33.87 74 22.3 KB 2 0 024:32:15
TOTAL: 3 140 88.6 KB 8 0 046:50:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ph.ph.cox.net 3 43.9 KB 4 0 001:32:12
2unresolved 76 22.3 KB 2 0 024:32:28
3*.upc-a.chello.nl 63 22.3 KB 2 0 020:43:26
4*.range86-130.btcentralplus.com 3 00.0 KB 0 0 000:01:55
TOTAL: 4 145 88.6 KB 8 0 046:50:03

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 4.750 1.124 0.00024:32:15
a131033.upc-a.chello.nl 3.986 0.903 0.00020:43:26
ip72-222-200-117.ph.ph.cox.net 0.308 0.055 0.00001:32:12
host86-130-133-6.range86-130.btcentralplus.com 0.172 0.065 0.00000:01:55
192.241.238.220 0.061 0.015 0.00000:00:09
183.136.225.45 0.058 0.017 0.00000:00:03
TOTAL: 6 9.335 2.179 0.00046:50:03

Curious NNRP server explorers [Top 20]:

SystemConn
host86-130-133-6.range86-130.btcentralplus.com 3
192.241.238.220 1
183.136.225.45 1
TOTAL: 3 5

NNRP unrecognized commands (by host):

SystemConn
183.136.225.45 5
TOTAL: 1 5

NNRP unrecognized commands (by command):

CommandCount
Connection: keep-alive 1
Host: 69.160.37.58:119 1
GET / HTTP/1.1 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
Accept: */* 1
TOTAL: 5 5

NNRP client timeouts [Top 20]:

SystemConnPeer
ip72-222-200-117.ph.ph.cox.net 3 0
91.187.33.87 2 0
TOTAL: 2 5 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 8100.0%
TOTAL: 1 8100.0%

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

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