Daily Usenet report for csiph.com

Dec 27 04:15:00 -- Dec 28 04:15:00

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Dec 27 17:29:42 csiph nnrpd[63553]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 27 17:29:42 csiph nnrpd[63553]: 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 27 18:10:16 csiph nnrpd[65632]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 27 18:10:16 csiph nnrpd[65632]: 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 27 19:10:41 csiph nnrpd[68855]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 27 19:10:41 csiph nnrpd[68855]: 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 17360 45.6%4.3 MB 60.5%
innd 15927 41.8%2.1 MB 29.3%
innfeed 3687 9.7%621.5 KB 8.5%
nnrpd 1098 2.9%120.7 KB 1.6%
nocem 38 0.1%4.3 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 38111 100.0%7.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 255265 53.1%
Negative hits 207977 43.3%
Do not exist 16912 3.5%
Cache misses 287 0.1%
TOTAL: 4 480441 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.549 0.0%32 0.000 17.156 35.600
article cleanup00:00:00.092 0.0%16617 0.000 0.006 0.039
article logging00:00:00.333 0.0%16974 0.000 0.020 0.852
article parse00:00:01.132 0.0%58608 0.000 0.019 0.101
article write00:00:35.444 0.0%13558 0.177 2.614 114.982
artlog/artcncl00:00:00.015 0.0%32 0.000 0.469 3.000
artlog/artparse00:00:00.004 0.0%320 0.000 0.013 1.000
data move00:00:00.205 0.0%454886 0.000 0.000 0.002
hisgrep/artcncl00:00:00.031 0.0%30 0.000 1.033 2.700
hishave/artcncl00:00:00.007 0.0%32 0.000 0.219 1.000
hishave/artparse00:00:00.001 0.0%313 0.000 0.003 0.091
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:46.688 0.1%480961 0.001 0.097 0.509
history sync00:00:01.073 0.0%376 0.000 2.854 21.000
history write00:00:32.257 0.0%16622 0.587 1.941 21.108
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
hiswrite/artparse00:00:00.557 0.0%313 0.000 1.780 15.000
idle23:55:47.288 99.6%459122 57.512 187.635 572.104
nntp read00:00:01.850 0.0%464940 0.001 0.004 0.008
overview write00:02:13.673 0.2%13558 0.299 9.859 1011.250
perl filter00:00:31.010 0.0%16615 1.098 1.866 10.276
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.216 0.0%27154 0.000 0.008 0.038
TOTAL: 24:01:04.39824:00:32.425100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%13651 0.000 0.002 0.021
article prepare00:00:00.002 0.0%10500 0.000 0.000 0.017
article read00:00:00.239 0.0%1349 0.000 0.177 12.600
backlog stats00:00:00.160 0.0%284454 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.997 0.0%220172 0.000 0.005 0.010
data write00:00:01.347 0.0%207898 0.001 0.006 0.016
idle23:54:53.551100.0%284454 162.714 302.662 966.453
status file00:00:00.272 0.0%358 0.000 0.760 3.500
TOTAL: 23:55:02.86723:54:56.590100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.017 0.0%6 2.833 2.833 2.833
idle69:56:31.145 99.0%156024 56.500 1613.798600135.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:05.330 0.0%668071 0.000 0.008 0.286
readart00:37:56.682 0.9%153187 0.000 14.862 44.000
TOTAL: 70:40:47.87970:34:33.174 99.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.xs4all.nl 646 15491 2465 11791 1235 15%66:37:02
2newsfeeds.xmission.com 3 12534 2314 10172 48 18%23:16:18
3feeder.eternal-september.org 13 5039 2145 2844 50 42%27:31:43
4news-out.mixmin.net 1 14448 1353 12920 175 9%23:59:51
5news-out.aioe.org 8 13219 1321 11827 71 9%24:07:27
6csiph-out.feeder.erje.net 1440 70148 879 68259 1010 1%118:49:04
7newsfeed.fu-berlin.de 11 12847 801 11823 223 6%23:41:12
8csiph-out.news.weretis.net 3 26003 702 25156 145 2%47:59:26
9newsfeed.neva.ru 143 11749 571 10948 230 4%71:29:06
10news-out.neodome.net 1 14502 402 14090 10 2%23:59:54
11csiph-out.feed.uzoreto.com 864 21268 218 20732 318 1%71:12:05
12nntp.pasdenom.info 1 8847 135 8708 4 1%23:59:55
13news.freedyn.net 1 15610 119 15379 112 0%23:59:57
14news.fcku.it 17 952 73 879 0 7%21:39:26
15news.swapon.de 5 1447 45 1402 0 3%22:39:29
16csiph-out.news.tnetconsulting.net 2 11935 20 11898 17 0%23:59:44
17news.bbs.nz 2 11603 5 11598 0 0%23:59:46
18localhost 28 2 2 0 0 100%00:00:01
19xanadu-bbs.net 39 282 0 282 0 0%19:14:08
TOTAL: 19 3228 267926 13570 250708 3648 5%682:15:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeeds.xmission.com7.1 MB0.0 KB3.1 MB10.2 MB 69%4.4 KB
2csiph-out.feeder.erje.net6.9 MB0.0 KB16.5 MB23.4 MB 29%12.7 KB
3csiph-out.news.xs4all.nl6.5 MB0.0 KB9.2 MB15.7 MB 41%4.4 KB
4feeder.eternal-september.org6.2 MB0.0 KB657.3 KB6.8 MB 90%3.2 KB
5news-out.aioe.org3.7 MB0.0 KB201.2 KB3.9 MB 94%2.8 KB
6news-out.mixmin.net3.5 MB0.0 KB383.6 KB3.9 MB 90%2.6 KB
7csiph-out.news.weretis.net2.1 MB0.0 KB2.0 MB4.0 MB 51%4.9 KB
8newsfeed.fu-berlin.de1.8 MB0.0 KB684.5 KB2.4 MB 72%2.4 KB
9newsfeed.neva.ru1.5 MB0.0 KB617.6 KB2.1 MB 71%2.7 KB
10news-out.neodome.net1.5 MB15.2 KB40.5 KB1.5 MB 96%3.8 KB
11csiph-out.feed.uzoreto.com1.0 MB0.0 KB7.7 MB8.7 MB 11%16.7 KB
12news.freedyn.net399.7 KB15.2 KB2.8 MB3.2 MB 12%14.0 KB
13nntp.pasdenom.info323.5 KB0.0 KB9.7 KB333.2 KB 97%2.4 KB
14news.fcku.it141.3 KB0.0 KB0.0 KB141.3 KB100%1.9 KB
15news.swapon.de116.4 KB0.0 KB0.0 KB116.4 KB100%2.6 KB
16csiph-out.news.tnetconsulting.net79.6 KB0.0 KB54.0 KB133.6 KB 59%3.6 KB
17news.bbs.nz6.7 KB0.0 KB0.0 KB6.7 KB100%1.3 KB
18localhost5.3 KB0.0 KB0.0 KB5.3 KB100%2.7 KB
19xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1942.8 MB30.5 KB43.9 MB86.7 MB 49%5.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 27 04:15:00 - 04:59:59 185 1.4% 0.07609.9 KB 1.4% 0.23
Dec 27 05:00:00 - 05:59:59 255 1.9% 0.07976.9 KB 2.2% 0.27
Dec 27 06:00:00 - 06:59:59 288 2.1% 0.08915.9 KB 2.1% 0.25
Dec 27 07:00:00 - 07:59:59 324 2.4% 0.091.1 MB 2.5% 0.30
Dec 27 08:00:00 - 08:59:59 498 3.7% 0.142.4 MB 5.7% 0.69
Dec 27 09:00:00 - 09:59:59 542 4.0% 0.151.6 MB 3.7% 0.45
Dec 27 10:00:00 - 10:59:59 610 4.5% 0.171.7 MB 3.9% 0.47
Dec 27 11:00:00 - 11:59:59 756 5.6% 0.213.1 MB 7.3% 0.89
Dec 27 12:00:00 - 12:59:59 742 5.5% 0.212.4 MB 5.7% 0.69
Dec 27 13:00:00 - 13:59:59 644 4.7% 0.181.8 MB 4.3% 0.52
Dec 27 14:00:00 - 14:59:59 809 6.0% 0.223.1 MB 7.1% 0.87
Dec 27 15:00:00 - 15:59:59 745 5.5% 0.212.1 MB 4.8% 0.58
Dec 27 16:00:00 - 16:59:59 774 5.7% 0.212.2 MB 5.1% 0.63
Dec 27 17:00:00 - 17:59:59 906 6.7% 0.252.5 MB 5.8% 0.70
Dec 27 18:00:00 - 18:59:59 797 5.9% 0.222.2 MB 5.0% 0.61
Dec 27 19:00:00 - 19:59:59 699 5.2% 0.192.1 MB 4.9% 0.60
Dec 27 20:00:00 - 20:59:59 563 4.2% 0.161.6 MB 3.8% 0.46
Dec 27 21:00:00 - 21:59:59 609 4.5% 0.171.8 MB 4.2% 0.51
Dec 27 22:00:00 - 22:59:59 821 6.1% 0.232.3 MB 5.3% 0.65
Dec 27 23:00:00 - 23:59:59 543 4.0% 0.151.4 MB 3.3% 0.41
Dec 28 00:00:00 - 00:59:59 480 3.5% 0.131.7 MB 4.0% 0.48
Dec 28 01:00:00 - 01:59:59 351 2.6% 0.101.3 MB 3.0% 0.36
Dec 28 02:00:00 - 02:59:59 300 2.2% 0.08992.3 KB 2.3% 0.28
Dec 28 03:00:00 - 03:59:59 238 1.8% 0.07860.1 KB 2.0% 0.24
Dec 28 04:00:00 - 04:15:00 79 0.6% 0.09274.6 KB 0.6% 0.31
TOTAL: 24:00:00 13558 100.0% 0.1642.8 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1248 53 0 0 0 0 0 0 1195
2csiph-out.feeder.erje.net 763 642 0 0 0 0 0 0 121
3newsfeed.fu-berlin.de 494 10 0 0 0 0 0 0 484
4csiph-out.feed.uzoreto.com 320 13 0 0 0 0 0 0 307
5newsfeed.neva.ru 231 37 0 0 0 0 0 0 194
6news-out.mixmin.net 212 9 0 0 0 0 0 0 203
7csiph-out.news.weretis.net 133 72 0 0 0 0 0 0 61
8news.freedyn.net 108 1 0 1 0 0 0 0 106
9feeder.eternal-september.org 83 47 0 0 0 0 0 0 36
10news-out.aioe.org 80 33 0 0 0 0 0 0 47
11newsfeeds.xmission.com 58 7 0 0 0 0 0 0 51
12news.swapon.de 15 0 0 0 0 0 0 0 15
13csiph-out.news.tnetconsulting.net 12 10 0 0 0 0 0 0 2
14news-out.neodome.net 9 2 0 1 0 0 0 0 6
15nntp.pasdenom.info 4 0 0 0 0 0 0 0 4
TOTAL: 15 3770 936 0 2 0 0 0 0 2832

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.vladmodels 595
alt.computer.workshop 116
lada.talk 32
scinet.stats 24
alt.binaries.pictures.purebeauty 24
alt.survival 18
alt.philosophy 13
alt.politics 10
alt.bbs.synchronet 9
alt.slack.goathead 6
mozilla.support.seamonkey 5
mozilla.support.thunderbird 5
oesterreich.tratsch 4
alt.tv.comedy-central.daily-show 4
alt.politics.usa 4
trollnet.cinema 4
spline.eisfair 3
al.christnet.bible 3
alt.binaries.ebook 3
alt.christian.bible 3
TOTAL: 63 936

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1407
EMP (phn path) 265
EMP (phn nph) 205
EMP (phl) 159
0 44
Too many newsgroups 38
Scoring filter 12
Binary: misplaced binary 9
Binary Payload 7
HTML Multipart 7
Too many newsgroups (low_xpost) 1
Too many newsgroups (meow) 1
TOTAL: 12 2155

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 45
TOTAL: 1 45
Huge articles
csiph-out.feed.uzoreto.com 91
csiph-out.news.xs4all.nl 87
csiph-out.feeder.erje.net 42
newsfeeds.xmission.com 40
news.freedyn.net 29
csiph-out.news.weretis.net 17
feeder.eternal-september.org 4
newsfeed.fu-berlin.de 3
news-out.mixmin.net 1
TOTAL: 9 314
Including strange strings
newsfeed.fu-berlin.de 271
news-out.mixmin.net 30
news.swapon.de 15
csiph-out.news.xs4all.nl 13
newsfeeds.xmission.com 10
news-out.aioe.org 10
csiph-out.news.weretis.net 4
csiph-out.feed.uzoreto.com 1
newsfeed.neva.ru 1
feeder.eternal-september.org 1
TOTAL: 11 357
No colon-space in header
csiph-out.news.xs4all.nl 7
TOTAL: 1 7
TOTAL: 4 723

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 16355 972 12584 1 0 0 5%23:59:55
2fu-berlin.de 12514 529 11985 0 0 0 4%23:59:35
3news.bbs.nz 25313 373 12613 24 0 0 1%23:59:55
4newsfeed.xs4all.nl 11482 116 10813 5 0 93 1%23:59:55
5xmission 12240 107 10492 6 0 0 0%23:59:55
6erje 12919 77 12345 53 0 0 0%23:59:55
7tnet 14185 72 12946 2 0 0 0%23:59:52
8usenet.pasdenom.info 13267 14 12832 36 0 0 0%23:59:51
9news.mixmin.net 11739 13 11420 0 0 0 0%23:59:40
10neva.ru 12333 9 12078 159 0 0 0%23:59:55
11news.freedyn.net 12485 8 12168 39 0 0 0%23:59:55
12neodome.net 13436 7 13091 0 0 0 0%23:59:55
13news.uzoreto.com 13099 5 12806 4 0 0 0%23:59:53
14aioe 10358 4 9988 0 0 17 0%23:59:41
15news.swapon.de 1446 2 1439 0 0 0 0%23:32:37
16weretis.net 12364 2 12098 0 0 0 0%23:59:55
17news.samoylyk.net 0 0 0 0 0 13558 0%23:58:41
18eternal-september 0 0 0 0 0 10788 0%23:59:55
19news.fcku.it 816 0 813 0 0 0 0%21:02:32
TOTAL: 19 206351 2310 182511 329 0 24456 1%452:31:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs6.9 MB2.8 KB6.9 MB0.1 KB/s7.3 KB23:59:55
2fu-berlin.de5.8 MB0.0 KB5.8 MB0.1 KB/s11.2 KB23:59:35
3news.bbs.nz856.4 KB97.1 KB953.5 KB0.0 KB/s2.4 KB23:59:55
4newsfeed.xs4all.nl281.8 KB40.2 KB321.9 KB0.0 KB/s2.7 KB23:59:55
5xmission240.5 KB12.8 KB253.4 KB0.0 KB/s2.2 KB23:59:55
6tnet169.0 KB13.7 KB182.7 KB0.0 KB/s2.5 KB23:59:52
7erje132.2 KB171.1 KB303.4 KB0.0 KB/s2.3 KB23:59:55
8news.mixmin.net57.0 KB0.0 KB57.0 KB0.0 KB/s4.4 KB23:59:40
9neodome.net53.7 KB0.0 KB53.7 KB0.0 KB/s7.7 KB23:59:55
10news.freedyn.net48.5 KB669.4 KB717.9 KB0.0 KB/s15.3 KB23:59:55
11usenet.pasdenom.info31.2 KB67.1 KB98.2 KB0.0 KB/s2.0 KB23:59:51
12neva.ru16.2 KB378.2 KB394.4 KB0.0 KB/s2.3 KB23:59:55
13aioe9.3 KB0.0 KB9.3 KB0.0 KB/s2.3 KB23:59:41
14news.uzoreto.com9.0 KB56.1 KB65.1 KB0.0 KB/s7.2 KB23:59:53
15news.swapon.de5.4 KB0.0 KB5.4 KB0.0 KB/s2.7 KB23:32:37
16weretis.net5.4 KB0.0 KB5.4 KB0.0 KB/s2.7 KB23:59:55
17news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:41
18eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:02:32
TOTAL: 1914.6 MB1.5 MB16.0 MB0.0 KB/s6.2 KB452:31:32
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
191.187.33.87 95 48.7 KB 4 2 223:14:18
2a131033.upc-a.chello.nl 65 37.1 KB 2 0 020:36:51
TOTAL: 2 160153093496.3 MB 47 2 270:40:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 97153090496.3 MB 45 2 245:41:48
2*.upc-a.chello.nl 65 37.1 KB 2 0 020:36:51
3*.range31-50.btcentralplus.com 3 00.0 KB 0 0 000:05:39
4*.security.ipip.net 1 00.0 KB 0 0 000:00:00
5*.net.upcbroadband.cz 14 00.0 KB 0 0 004:16:26
TOTAL: 5 180153093496.3 MB 47 2 270:40:46

NNRP auth users [Top 20]:

UserConn
slavotinek 2
TOTAL: 1 2

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 6.077 1.501 0.00623:14:18
212.90.61.180 14.351 30.824 0.00022:27:28
a131033.upc-a.chello.nl 4.107 0.940 0.00020:36:51
ip-78-102-198-192.net.upcbroadband.cz 0.872 0.190 0.00004:16:26
host31-50-220-99.range31-50.btcentralplus.com 0.201 0.038 0.00000:05:39
195.54.160.141 0.121 0.031 0.00000:00:00
scan-141.security.ipip.net 0.060 0.013 0.00000:00:00
TOTAL: 7 25.789 33.537 0.00670:40:46

Curious NNRP server explorers [Top 20]:

SystemConn
ip-78-102-198-192.net.upcbroadband.cz 14
host31-50-220-99.range31-50.btcentralplus.com 3
195.54.160.141 2
scan-141.security.ipip.net 1
TOTAL: 4 20

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
195.54.160.141 2
TOTAL: 2 6

NNRP unrecognized commands (by command):

CommandCount
^C 2
Host: 69.160.37.58:119 1
GET / HTTP/1.1 1
Connection: close 1
User-Agent: HTTP Banner Detection (https... 1
TOTAL: 5 6

NNRP client timeouts [Top 20]:

SystemConnPeer
91.187.33.87 4 0
195.54.160.141 2 2
212.90.61.180 1 1
TOTAL: 3 7 3

Newsgroup request counts (by category):

CategoryCountPct
1linux 67556 44.7%
2de 49140 32.5%
3uk 21128 14.0%
4alt 9102 6.0%
5pl 2665 1.8%
6rec 392 0.3%
7miami 318 0.2%
8nj 248 0.2%
9comp 237 0.2%
10fj 136 0.1%
11it 70 0.0%
12pgsql 68 0.0%
13umontreal 53 0.0%
14no 49 0.0%
15sci 38 0.0%
16soc 16 0.0%
17tw 10 0.0%
18bda 9 0.0%
19microsoft 7 0.0%
20co 6 0.0%
TOTAL: 20 151248100.0%

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

NewsgroupCount
1linux.debian.user 67516
2de.rec.fahrrad 49113
3uk.current-events.terrorism 21088
4alt.smokers.pipes 7474
5pl.soc.prawo.podatki 2665
6alt.healing.reiki 1023
7alt.business.import-export 395
8miami.general 318
9rec.arts.comics.marvel.universe 255
10nj.politics 248
11fj.1st-readme 136
12alt.pets.cats 125
13comp.bbs.misc 90
14comp.os.os2.setup.storage 85
15rec.music.makers.trumpet 78
16it.hobby.satellite-tv 70
17pgsql.general 68
18comp.sys.m6809 55
19umontreal.cerca 53
20alt.sailing 52
21no.fag.medisin.diverse 49
22rec.sport.snowmobiles 43
23linux.debian.devel.italian 40
24sci.med.dentistry 37
25uk.business.accountancy 36
26de.comp.cad 27
27soc.libraries.talk 16
28rec.games.trading-cards.magic.rules 16
29alt.health.fasting 12
30bda.test 9
31alt.comp.programming.theory 9
32comp.sys.ibm.ps2.hardware 7
33microsoft.public.windowsxp.security_admin 7
34tw.bbs.comp.network 7
35co.cos.general 6
36alt.csb.test 5
37uk.culture.nostalgia.1980s 4
38alt.baldurs-gate 3
39tw.bbs.soc.tai-tung 3
40alt.lets.kill.yuri.rutman 2
41alt.music.classical 2
42sci.mech.fluids 1
TOTAL: 42 151248