Daily Usenet report for csiph.com

Jan 7 04:15:00 -- Jan 8 04:15:00

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Jan 7 14:19:26 csiph nnrpd[70113]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 7 14:19:26 csiph nnrpd[70113]: 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]
Jan 7 22:33:42 csiph nnrpd[95833]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 7 22:33:42 csiph nnrpd[95833]: 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 21193 51.6%5.3 MB 66.5%
innd 14152 34.5%1.9 MB 23.1%
innfeed 3658 8.9%635.8 KB 7.7%
nnrpd 2062 5.0%222.5 KB 2.7%
nocem 3 0.0%0.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 41069 100.0%8.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 318204 49.2%
Negative hits 306198 47.4%
Do not exist 20571 3.2%
Cache misses 1506 0.2%
TOTAL: 4 646479 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.305 0.0%60 0.000 21.750 67.000
article cleanup00:00:00.104 0.0%20224 0.000 0.005 0.034
article logging00:00:00.573 0.0%20765 0.000 0.028 0.970
article parse00:00:01.394 0.0%67523 0.000 0.021 0.414
article write00:01:08.327 0.1%16872 0.339 4.050 70.717
artlog/artcncl00:00:00.029 0.0%59 0.000 0.492 2.500
artlog/artparse00:00:00.004 0.0%381 0.000 0.010 0.200
data move00:00:00.201 0.0%603978 0.000 0.000 0.002
hisgrep/artcncl00:00:00.084 0.0%58 0.000 1.448 8.000
hishave/artcncl00:00:00.019 0.0%60 0.000 0.317 1.000
hishave/artparse00:00:00.000 0.0%372 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:26.658 0.0%647867 0.001 0.041 0.560
history sync00:00:01.255 0.0%378 0.000 3.320 23.000
history write00:00:35.350 0.0%20227 0.541 1.748 12.469
hiswrite/artcncl00:00:00.013 0.0%2 0.000 6.500 13.000
hiswrite/artparse00:00:00.802 0.0%372 0.000 2.156 50.667
idle23:54:03.790 99.5%601438 84.237 143.063 477.531
nntp read00:00:02.316 0.0%607510 0.001 0.004 0.007
overview write00:03:29.155 0.2%16872 0.132 12.397 2037.370
perl filter00:00:29.651 0.0%20218 1.071 1.467 2.833
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.282 0.0%33747 0.000 0.008 0.028
TOTAL: 24:01:09.21224:00:21.312 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.031 0.0%16974 0.000 0.002 0.017
article prepare00:00:00.002 0.0%12788 0.000 0.000 0.017
article read00:00:00.320 0.0%1407 0.000 0.227 11.000
backlog stats00:00:00.208 0.0%364080 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.392 0.0%289182 0.001 0.005 0.010
data write00:00:01.710 0.0%275826 0.001 0.006 0.016
idle23:54:31.457100.0%364080 140.951 236.408 756.399
status file00:00:00.620 0.0%352 0.000 1.761 54.000
TOTAL: 23:54:43.48623:54:35.740100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:10.020 0.0%7696 1.119 1.302 1.505
idle59:31:03.153 99.5%9308 146.244 23019.247600097.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.806 0.0%19708 0.000 0.092 8.085
readart00:00:06.611 0.0%332 0.000 19.913 59.000
TOTAL: 59:47:25.37659:31:21.590 99.6%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.xs4all.nl 1 7859 4687 1534 1638 59%69:06:25
2feeder.eternal-september.org 11 4515 2507 1931 77 55%26:42:40
3news-out.aioe.org 2 16290 1834 14404 52 11%24:09:03
4csiph-out.news.weretis.net 3 34613 1349 32878 386 3%46:20:18
5news-out.mixmin.net 2 18428 1126 16957 345 6%23:59:40
6newsfeed.fu-berlin.de 21 15194 900 14174 120 5%24:47:59
7csiph-out.feeder.erje.net 1439 83586 830 82400 356 0%118:47:14
8newsfeed.neva.ru 142 10136 787 9144 205 7%70:59:43
9csiph-out.feed.uzoreto.com 864 27425 742 26342 341 2%71:17:22
10newsfeeds.xmission.com 1 15740 626 15107 7 3%23:14:24
11news-out.neodome.net 2 18916 535 18329 52 2%24:08:58
12news.fcku.it 13 1792 321 1468 3 17%22:14:33
13news.freedyn.net 2 20052 192 19654 206 0%23:59:55
14nntp.pasdenom.info 1 11524 171 11350 3 1%23:59:56
15news.swapon.de 8 1630 55 1575 0 3%22:33:39
16csiph-out.news.tnetconsulting.net 1 16525 27 16496 2 0%23:59:56
17news.samoylyk.net 3 16613 8 16597 8 0%24:03:09
18news.bbs.nz 1 16072 3 16069 0 0%23:59:50
19localhost 26 0 0 0 0 0%00:00:02
20xanadu-bbs.net 36 386 0 386 0 0%20:54:20
TOTAL: 20 2579 337296 16700 316795 3801 4%709:19:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.xs4all.nl12.9 MB0.0 KB12.4 MB25.2 MB 50%4.1 KB
2feeder.eternal-september.org6.4 MB0.0 KB972.6 KB7.3 MB 87%2.9 KB
3csiph-out.feeder.erje.net6.3 MB14.1 KB2.2 MB8.5 MB 73%7.4 KB
4news-out.aioe.org4.3 MB0.0 KB91.3 KB4.4 MB 97%2.4 KB
5csiph-out.news.weretis.net3.9 MB0.0 KB2.5 MB6.4 MB 61%3.8 KB
6news-out.mixmin.net3.0 MB0.0 KB3.0 MB6.0 MB 49%4.2 KB
7csiph-out.feed.uzoreto.com2.4 MB0.0 KB7.5 MB9.8 MB 24%9.3 KB
8newsfeed.fu-berlin.de2.1 MB0.0 KB458.3 KB2.5 MB 82%2.5 KB
9newsfeed.neva.ru2.0 MB0.0 KB830.2 KB2.9 MB 71%2.9 KB
10news-out.neodome.net1.7 MB0.0 KB2.2 MB3.8 MB 43%6.7 KB
11newsfeeds.xmission.com1.6 MB0.0 KB479.3 KB2.1 MB 77%3.4 KB
12news.freedyn.net628.7 KB0.0 KB7.2 MB7.8 MB 7%20.2 KB
13news.fcku.it577.4 KB0.0 KB9.1 KB586.5 KB 98%1.8 KB
14nntp.pasdenom.info363.9 KB0.0 KB6.4 KB370.3 KB 98%2.1 KB
15csiph-out.news.tnetconsulting.net138.0 KB0.0 KB86.9 KB224.9 KB 61%7.8 KB
16news.swapon.de134.0 KB0.0 KB0.0 KB134.0 KB100%2.4 KB
17news.samoylyk.net20.3 KB0.0 KB407.5 KB427.7 KB 4%26.7 KB
18news.bbs.nz3.9 KB0.0 KB0.0 KB3.9 KB100%1.3 KB
19localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
20xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2048.4 MB14.1 KB40.2 MB88.6 MB 54%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 7 04:15:00 - 04:59:59 184 1.1% 0.07541.7 KB 1.1% 0.20
Jan 7 05:00:00 - 05:59:59 379 2.2% 0.112.0 MB 4.2% 0.58
Jan 7 06:00:00 - 06:59:59 352 2.1% 0.101.1 MB 2.2% 0.31
Jan 7 07:00:00 - 07:59:59 442 2.6% 0.121.4 MB 2.9% 0.40
Jan 7 08:00:00 - 08:59:59 612 3.6% 0.171.7 MB 3.5% 0.48
Jan 7 09:00:00 - 09:59:59 823 4.9% 0.232.4 MB 5.0% 0.69
Jan 7 10:00:00 - 10:59:59 793 4.7% 0.222.1 MB 4.3% 0.60
Jan 7 11:00:00 - 11:59:59 749 4.4% 0.211.9 MB 3.9% 0.55
Jan 7 12:00:00 - 12:59:59 854 5.1% 0.242.4 MB 5.0% 0.69
Jan 7 13:00:00 - 13:59:59 946 5.6% 0.262.6 MB 5.4% 0.75
Jan 7 14:00:00 - 14:59:59 960 5.7% 0.272.6 MB 5.4% 0.75
Jan 7 15:00:00 - 15:59:59 1082 6.4% 0.304.0 MB 8.1% 1.13
Jan 7 16:00:00 - 16:59:59 1012 6.0% 0.283.0 MB 6.2% 0.86
Jan 7 17:00:00 - 17:59:59 936 5.5% 0.262.4 MB 4.9% 0.68
Jan 7 18:00:00 - 18:59:59 929 5.5% 0.262.4 MB 4.8% 0.67
Jan 7 19:00:00 - 19:59:59 919 5.4% 0.262.5 MB 5.2% 0.72
Jan 7 20:00:00 - 20:59:59 936 5.5% 0.262.5 MB 5.2% 0.72
Jan 7 21:00:00 - 21:59:59 872 5.2% 0.242.2 MB 4.6% 0.64
Jan 7 22:00:00 - 22:59:59 703 4.2% 0.201.8 MB 3.7% 0.51
Jan 7 23:00:00 - 23:59:59 665 3.9% 0.182.1 MB 4.2% 0.59
Jan 8 00:00:00 - 00:59:59 462 2.7% 0.131.4 MB 2.8% 0.39
Jan 8 01:00:00 - 01:59:59 441 2.6% 0.121.3 MB 2.7% 0.37
Jan 8 02:00:00 - 02:59:59 426 2.5% 0.121.3 MB 2.6% 0.36
Jan 8 03:00:00 - 03:59:59 320 1.9% 0.09918.3 KB 1.8% 0.26
Jan 8 04:00:00 - 04:15:00 68 0.4% 0.08200.7 KB 0.4% 0.22
TOTAL: 24:00:00 16865 100.0% 0.2048.8 MB 100.0% 0.58
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1722 119 0 0 0 0 0 0 1603
2newsfeed.fu-berlin.de 580 24 0 0 0 0 0 0 556
3csiph-out.news.weretis.net 432 80 0 0 0 0 0 0 352
4csiph-out.feed.uzoreto.com 349 31 0 0 0 0 0 0 318
5news-out.mixmin.net 349 7 0 0 0 0 0 0 342
6newsfeed.neva.ru 205 48 0 0 0 0 0 0 157
7news.freedyn.net 200 0 0 0 0 0 0 0 200
8csiph-out.feeder.erje.net 172 43 0 6 0 0 0 0 123
9feeder.eternal-september.org 81 43 0 0 0 0 0 0 38
10news-out.aioe.org 53 46 0 0 0 0 0 0 7
11news-out.neodome.net 50 7 0 0 0 0 0 0 43
12news.swapon.de 30 0 0 0 0 0 0 0 30
13newsfeeds.xmission.com 25 2 0 0 0 0 0 0 23
14news.samoylyk.net 8 0 0 0 0 0 0 0 8
15csiph-out.news.tnetconsulting.net 7 5 0 0 0 0 0 0 2
16nntp.pasdenom.info 3 1 0 0 0 0 0 0 2
17news.fcku.it 3 3 0 0 0 0 0 0 0
TOTAL: 17 4269 459 0 6 0 0 0 0 3804

Unwanted newsgroups [Top 20]:

NewsgroupCount
it-alt.sport.calcio.juventus 66
alt.computer.workshop 65
alt.politics 43
lada.talk 28
scinet.stats 24
alt.tv.comedy-central.daily-show 21
spline.eisfair.dev 21
scinet.general.chatter 17
mozilla.support.bugzilla 13
mozilla.support.seamonkey 12
mozilla.support.firefox 11
oesterreich.tratsch 9
scinet.sysop 8
alt.binaries.ebook 7
alt.politics.usa 7
rocksolid.test.test 7
alt.binaries.pictures.purebeauty 7
alt.binaries.sounds.mp3.pop-crap 5
mozilla.dev.platform 5
alt.bbs.synchronet 5
TOTAL: 68 459

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1845
EMP (phn path) 638
EMP (phn nph) 115
Too many newsgroups 111
EMP (phl) 91
Binary Payload 37
0 23
HTML Multipart 12
Scoring filter 6
Binary: misplaced binary 3
HTML post 2
Too many newsgroups (meow) 1
TOTAL: 12 2884

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 50
news-out.neodome.net 1
csiph-out.feed.uzoreto.com 1
csiph-out.news.xs4all.nl 1
TOTAL: 4 53
Huge articles
news.freedyn.net 108
csiph-out.news.xs4all.nl 72
csiph-out.feed.uzoreto.com 62
news-out.neodome.net 41
csiph-out.feeder.erje.net 38
csiph-out.news.weretis.net 17
feeder.eternal-september.org 10
news.samoylyk.net 8
news-out.mixmin.net 7
newsfeeds.xmission.com 6
TOTAL: 12 375
Including strange strings
newsfeed.fu-berlin.de 436
news.swapon.de 30
csiph-out.news.xs4all.nl 18
newsfeeds.xmission.com 17
csiph-out.news.weretis.net 14
csiph-out.feed.uzoreto.com 9
csiph-out.feeder.erje.net 5
news-out.mixmin.net 5
feeder.eternal-september.org 3
news-out.aioe.org 1
TOTAL: 11 539
No colon-space in header
csiph-out.news.xs4all.nl 8
csiph-out.feeder.erje.net 1
TOTAL: 2 9
TOTAL: 4 976

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 19259 943 15917 3 0 2 4%23:59:55
2news.bbs.nz 31816 484 15844 35 0 0 1%23:50:10
3fu-berlin.de 15607 434 15173 0 0 0 2%23:50:11
4news.samoylyk.net 17233 429 16376 6 0 0 2%23:50:10
5xmission 17796 235 15344 11 0 0 1%23:50:11
6tnet 17881 129 16260 2 0 0 0%23:55:26
7newsfeed.xs4all.nl 12499 55 11765 2 0 133 0%23:54:25
8aioe 13505 17 13116 0 0 0 0%23:50:11
9usenet.pasdenom.info 16681 15 16175 43 0 0 0%23:59:52
10news.freedyn.net 15094 12 14699 22 0 0 0%23:50:10
11erje 15559 9 15225 21 0 0 0%23:50:11
12neva.ru 15410 5 15054 262 0 0 0%23:56:41
13news.mixmin.net 15261 4 14883 0 0 0 0%23:57:54
14news.uzoreto.com 15758 3 15399 10 0 0 0%23:56:55
15neodome.net 16751 2 16317 0 0 0 0%23:53:58
16weretis.net 15061 1 14922 1 0 0 0%23:58:25
17news.swapon.de 1628 1 1624 0 0 0 0%23:31:48
18eternal-september 0 0 0 0 0 13742 0%23:50:11
19news.fcku.it 1377 0 1377 0 0 0 0%22:18:16
TOTAL: 19 274176 2778 245470 418 0 13877 1%452:05:00
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs6.3 MB12.7 KB6.3 MB0.1 KB/s6.8 KB23:59:55
2fu-berlin.de5.1 MB0.0 KB5.1 MB0.1 KB/s11.9 KB23:50:11
3news.samoylyk.net5.0 MB96.5 KB5.1 MB0.1 KB/s11.9 KB23:50:10
4news.bbs.nz1.1 MB129.8 KB1.2 MB0.0 KB/s2.4 KB23:50:10
5xmission536.2 KB38.8 KB575.0 KB0.0 KB/s2.3 KB23:50:11
6tnet263.7 KB6.3 KB270.0 KB0.0 KB/s2.1 KB23:55:26
7newsfeed.xs4all.nl116.3 KB17.7 KB134.0 KB0.0 KB/s2.4 KB23:54:25
8aioe41.5 KB0.0 KB41.5 KB0.0 KB/s2.4 KB23:50:11
9erje37.8 KB110.7 KB148.5 KB0.0 KB/s4.9 KB23:50:11
10usenet.pasdenom.info32.4 KB74.3 KB106.7 KB0.0 KB/s1.8 KB23:59:52
11news.freedyn.net32.1 KB334.2 KB366.3 KB0.0 KB/s10.8 KB23:50:10
12neva.ru13.2 KB578.3 KB591.5 KB0.0 KB/s2.2 KB23:56:41
13news.mixmin.net6.8 KB0.0 KB6.8 KB0.0 KB/s1.7 KB23:57:54
14news.uzoreto.com6.3 KB38.6 KB44.9 KB0.0 KB/s3.5 KB23:56:55
15weretis.net3.7 KB1.1 KB4.8 KB0.0 KB/s2.4 KB23:58:25
16neodome.net3.6 KB0.0 KB3.6 KB0.0 KB/s1.8 KB23:53:58
17news.swapon.de1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:31:48
18eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:11
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s022:18:16
TOTAL: 1918.5 MB1.4 MB19.9 MB0.0 KB/s6.4 KB452:05:00
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
191-165-244-119.subs.proxad.net 5 321362.7 KB 28 0 001:00:20
2aorleans-654-1-55-137.w90-20.abo.wanadoo.fr 1 817.5 KB 1 0 000:00:10
3172.83.100.194 7 25.2 KB 2 0 003:12:01
4a131033.upc-a.chello.nl 28 11.5 KB 1 0 007:51:54
TOTAL: 4 41 332386.9 KB 32 0 059:47:23

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.subs.proxad.net 5 321362.7 KB 28 0 001:00:20
2*.w90-20.abo.wanadoo.fr 1 817.5 KB 1 0 000:00:10
3unresolved 296 25.2 KB 2 0 050:53:47
4*.upc-a.chello.nl 28 11.5 KB 1 0 007:51:54
5*.range31-50.btcentralplus.com 2 00.0 KB 0 0 000:01:09
TOTAL: 5 332 332386.9 KB 32 0 059:47:23

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 18.217 4.245 0.00047:41:45
a131033.upc-a.chello.nl 1.845 0.384 0.00007:51:54
172.83.100.194 0.577 0.242 0.00003:12:01
91-165-244-119.subs.proxad.net 0.782 1.181 0.00001:00:20
host31-50-220-99.range31-50.btcentralplus.com 0.113 0.048 0.00000:01:09
aorleans-654-1-55-137.w90-20.abo.wanadoo.fr 0.103 0.016 0.00000:00:10
TOTAL: 6 21.637 6.116 0.00059:47:23

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 289
host31-50-220-99.range31-50.btcentralplus.com 2
TOTAL: 2 291

NNRP client timeouts [Top 20]:

SystemConnPeer
172.83.100.194 6 0
91-165-244-119.subs.proxad.net 1 0
TOTAL: 2 7 0

Newsgroup request counts (by category):

CategoryCountPct
1alt 28 71.8%
2fr 8 20.5%
3comp 3 7.7%
TOTAL: 3 39100.0%

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

NewsgroupCount
1alt.binaries.cd.image.french 8
2alt.binaries.movies.french 8
3fr.comp.infosystemes 8
4alt.binaries.divx.french.d 7
5comp.sys.ibm.ps2.hardware 3
6alt.binaries.ng4you.french 2
7alt.binaries.cd.image.french.d 1
8alt.binaries.movies.french.xxx.d 1
9alt.binaries.movies.french.xxx 1
TOTAL: 9 39