Daily Usenet report for csiph.com

Feb 28 04:15:00 -- Mar 1 04:15:00

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Feb 28 14:24:06 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[43179]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Feb 28 14:24:06 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[43179]: 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]
Feb 28 20:38:05 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[64310]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Feb 28 20:38:05 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[64310]: 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]
Feb 28 20:38:14 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[64311]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Feb 28 20:38:14 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[64311]: 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 45346 49.7%7.5 MB 52.5%
innd 39943 43.8%5.8 MB 40.7%
innfeed 3729 4.1%697.0 KB 4.7%
nnrpd 2174 2.4%305.2 KB 2.1%
nocem 15 0.0%2.0 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 91208 100.0%14.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 392216 47.5%
Positive hits 385336 46.7%
Do not exist 44769 5.4%
Cache misses 3625 0.4%
TOTAL: 4 825946 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.300 0.0%20 0.000 15.000 31.000
article cleanup00:00:00.272 0.0%44785 0.000 0.006 0.021
article logging00:00:03.002 0.0%45129 0.000 0.067 4.387
article parse00:00:01.283 0.0%115343 0.001 0.011 0.058
article write00:01:30.884 0.1%15776 0.156 5.761 71.702
artlog/artcncl00:00:00.000 0.0%20 0.000 0.000 0.000
artlog/artparse00:00:00.004 0.0%239 0.000 0.017 0.250
data move00:00:00.234 0.0%797810 0.000 0.000 0.001
hisgrep/artcncl00:00:00.023 0.0%20 0.000 1.150 18.000
hishave/artcncl00:00:00.001 0.0%20 0.000 0.050 1.000
hishave/artparse00:00:00.001 0.0%238 0.000 0.004 0.250
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:08.933 0.1%829748 0.005 0.155 1.574
history sync00:00:01.820 0.0%342 0.000 5.322 62.333
history write00:02:25.240 0.2%44784 0.259 3.243 17.585
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.470 0.0%238 0.000 1.975 24.000
idle23:39:55.287 98.4%788188 76.332 108.090 489.373
nntp read00:00:03.367 0.0%803137 0.002 0.004 0.012
overview write00:15:31.789 1.1%15776 0.205 59.064 13026.273
perl filter00:00:42.358 0.0%44783 0.667 0.946 1.848
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.308 0.0%31566 0.000 0.010 0.038
TOTAL: 24:03:31.38324:02:25.576 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.086 0.0%15902 0.000 0.005 1.227
article prepare00:00:00.000 0.0%5288 0.000 0.000 0.000
article read00:00:02.287 0.0%978 0.000 2.338 1777.000
backlog stats00:00:00.220 0.0%305063 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.169 0.0%237678 0.000 0.005 0.228
data write00:00:01.422 0.0%223021 0.000 0.006 0.013
idle23:54:44.316100.0%305063 156.637 282.185 1199.565
status file00:00:00.652 0.0%413 0.000 1.579 41.000
TOTAL: 23:55:00.72123:54:50.152100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle45:38:56.514 99.5%1155 0.000142282.696600274.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.055 0.0%2691 0.000 0.020 4.571
readart00:00:00.202 0.0%5 40.000 40.400 41.000
TOTAL: 45:52:33.46445:38:56.771 99.5%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.neva.ru 144 33819 2657 30968 194 7%72:49:12
2newsfeeds.xmission.com 3 14840 1986 12841 13 13%24:38:11
3feeder.eternal-september.org 40 4673 1698 2840 135 36%34:19:04
4news.freedyn.net 3 31106 1685 28528 893 5%24:09:02
5csiph-out.news.xs4all.nl 3 6473 1545 3812 1116 23%69:11:16
6news-out.aioe.org 2 14606 1221 13346 39 8%23:59:48
7csiph-out.news.weretis.net 9 52348 937 50933 478 1%42:30:43
8news-out.mixmin.net 3 29998 915 28680 403 3%24:08:55
9csiph-out.feeder.erje.net 1440 83443 817 82339 287 0%118:55:53
10news-out.neodome.net 3 28413 681 15276 12456 2%24:59:56
11newsfeed.fu-berlin.de 15 40432 653 27078 12701 1%25:41:44
12csiph-out.feed.uzoreto.com 864 43640 436 42668 536 0%71:19:25
13news.fcku.it 14 1169 190 978 1 16%20:16:28
14nntp.pasdenom.info 5 8044 170 7871 3 2%23:56:15
15news.swapon.de 9 1019 79 939 1 7%20:58:00
16csiph-out.news.tnetconsulting.net 2 12883 61 12817 5 0%23:59:52
17news.bbs.nz 2 12672 2 12669 1 0%23:59:46
18localhost 26 0 0 0 0 0%00:00:00
TOTAL: 18 2587 419578 15733 374583 29262 3%669:53:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.neva.ru10.1 MB4.0 KB580.2 KB10.7 MB 94%3.8 KB
2newsfeeds.xmission.com6.2 MB0.0 KB644.0 KB6.8 MB 90%3.5 KB
3csiph-out.feeder.erje.net5.8 MB0.0 KB3.9 MB9.7 MB 59%9.0 KB
4feeder.eternal-september.org4.6 MB0.0 KB2.5 MB7.1 MB 64%4.0 KB
5csiph-out.news.xs4all.nl4.5 MB0.0 KB5.7 MB10.3 MB 43%3.9 KB
6news.freedyn.net4.2 MB0.0 KB4.1 MB8.3 MB 50%3.3 KB
7news-out.aioe.org3.0 MB4.1 KB102.8 KB3.1 MB 96%2.5 KB
8csiph-out.news.weretis.net2.8 MB0.0 KB2.9 MB5.7 MB 49%4.2 KB
9news-out.neodome.net2.5 MB0.0 KB48.0 MB50.4 MB 4%3.9 KB
10news-out.mixmin.net2.2 MB0.0 KB1.4 MB3.5 MB 60%2.8 KB
11csiph-out.feed.uzoreto.com1.9 MB0.0 KB8.1 MB10.0 MB 18%10.5 KB
12newsfeed.fu-berlin.de1.5 MB0.0 KB32.4 MB33.9 MB 4%2.6 KB
13nntp.pasdenom.info384.9 KB0.0 KB5.5 KB390.4 KB 98%2.3 KB
14news.fcku.it229.7 KB0.0 KB1.3 KB231.0 KB 99%1.2 KB
15csiph-out.news.tnetconsulting.net187.8 KB0.0 KB16.8 KB204.6 KB 91%3.1 KB
16news.swapon.de151.1 KB0.0 KB0.7 KB151.7 KB 99%1.9 KB
17news.bbs.nz2.5 KB0.0 KB2.5 KB5.0 KB 49%1.7 KB
18localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1850.2 MB8.1 KB110.3 MB160.5 MB 31%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 28 04:15:00 - 04:59:59 150 1.0% 0.06480.0 KB 0.9% 0.18
Feb 28 05:00:00 - 05:59:59 467 3.0% 0.131.8 MB 3.6% 0.51
Feb 28 06:00:00 - 06:59:59 322 2.0% 0.091.3 MB 2.6% 0.37
Feb 28 07:00:00 - 07:59:59 484 3.1% 0.132.1 MB 4.3% 0.61
Feb 28 08:00:00 - 08:59:59 511 3.2% 0.142.4 MB 4.8% 0.69
Feb 28 09:00:00 - 09:59:59 559 3.5% 0.161.6 MB 3.2% 0.46
Feb 28 10:00:00 - 10:59:59 579 3.7% 0.161.4 MB 2.8% 0.39
Feb 28 11:00:00 - 11:59:59 681 4.3% 0.191.8 MB 3.7% 0.52
Feb 28 12:00:00 - 12:59:59 676 4.3% 0.192.2 MB 4.4% 0.63
Feb 28 13:00:00 - 13:59:59 762 4.8% 0.212.5 MB 5.0% 0.71
Feb 28 14:00:00 - 14:59:59 701 4.4% 0.191.9 MB 3.7% 0.53
Feb 28 15:00:00 - 15:59:59 694 4.4% 0.191.8 MB 3.6% 0.52
Feb 28 16:00:00 - 16:59:59 834 5.3% 0.232.3 MB 4.6% 0.65
Feb 28 17:00:00 - 17:59:59 805 5.1% 0.222.1 MB 4.2% 0.60
Feb 28 18:00:00 - 18:59:59 711 4.5% 0.201.8 MB 3.6% 0.52
Feb 28 19:00:00 - 19:59:59 684 4.3% 0.192.0 MB 3.9% 0.56
Feb 28 20:00:00 - 20:59:59 709 4.5% 0.202.0 MB 3.9% 0.56
Feb 28 21:00:00 - 21:59:59 693 4.4% 0.191.8 MB 3.6% 0.52
Feb 28 22:00:00 - 22:59:59 498 3.2% 0.141.3 MB 2.7% 0.38
Feb 28 23:00:00 - 23:59:59 556 3.5% 0.151.8 MB 3.5% 0.51
Mar 1 00:00:00 - 00:59:59 1077 6.8% 0.304.1 MB 8.1% 1.16
Mar 1 01:00:00 - 01:59:59 954 6.1% 0.273.6 MB 7.1% 1.02
Mar 1 02:00:00 - 02:59:59 745 4.7% 0.212.7 MB 5.4% 0.77
Mar 1 03:00:00 - 03:59:59 765 4.9% 0.212.9 MB 5.7% 0.81
Mar 1 04:00:00 - 04:15:00 150 1.0% 0.17552.7 KB 1.1% 0.61
TOTAL: 24:00:00 15767 100.0% 0.1850.2 MB 100.0% 0.60
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.fu-berlin.de 13062 21 0 0 0 0 0 013041
2news-out.neodome.net 12449 5 0 0 0 0 0 012444
3csiph-out.news.xs4all.nl 1134 41 0 0 0 0 0 0 1093
4news.freedyn.net 887 9 0 0 0 0 0 0 878
5csiph-out.feed.uzoreto.com 541 19 0 0 0 0 0 0 522
6csiph-out.news.weretis.net 506 45 0 0 0 0 0 0 461
7news-out.mixmin.net 394 11 0 0 0 0 0 0 383
8newsfeed.neva.ru 193 75 0 1 0 0 0 0 117
9csiph-out.feeder.erje.net 163 50 0 0 0 0 0 0 113
10feeder.eternal-september.org 116 35 0 0 0 0 0 0 81
11news-out.aioe.org 43 24 0 1 0 0 0 0 18
12news.swapon.de 38 0 0 0 0 0 0 0 38
13newsfeeds.xmission.com 23 2 0 0 0 0 0 0 21
14csiph-out.news.tnetconsulting.net 5 5 0 0 0 0 0 0 0
15nntp.pasdenom.info 3 0 0 0 0 0 0 0 3
16news.fcku.it 1 1 0 0 0 0 0 0 0
17news.bbs.nz 1 0 0 0 0 0 0 0 1
TOTAL: 17 29559 343 0 2 0 0 0 029214

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 103
lada.talk 85
spline.eisfair.dev 22
alt.binaries.pictures.purebeauty 18
alt.bbs.synchronet 13
alt.binaries.ebook 11
it-alt.sport.calcio.juventus 11
it-alt.comp.software.mozilla 8
scinet.stats 5
alt.politics 5
mozilla.general 4
spline.eisfair 3
cakewalk.audio 3
alt.binaries.android 3
alt.religion 3
0.test 2
alt.survival 2
mozilla.support.seamonkey 2
free.it.religioni.scientology 2
rec.travel.resorts.all 2
TOTAL: 56 343

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 13519
Binary: misplaced binary 12732
EMP (md5) 1899
Too many newsgroups 226
EMP (phl) 161
EMP (phn nph) 63
0 23
HTML Multipart 5
Binary Payload 3
Too many newsgroups (meow) 1
TOTAL: 10 28632

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 45
TOTAL: 1 45
Huge articles
csiph-out.feeder.erje.net 72
csiph-out.feed.uzoreto.com 42
news.freedyn.net 36
csiph-out.news.xs4all.nl 23
newsfeed.fu-berlin.de 23
feeder.eternal-september.org 14
csiph-out.news.weretis.net 14
newsfeeds.xmission.com 8
news-out.mixmin.net 5
news-out.neodome.net 1
TOTAL: 10 238
Including strange strings
newsfeed.fu-berlin.de 245
news.swapon.de 37
csiph-out.news.weretis.net 21
csiph-out.news.xs4all.nl 14
newsfeeds.xmission.com 10
csiph-out.feed.uzoreto.com 5
news-out.aioe.org 4
newsfeed.neva.ru 3
csiph-out.feeder.erje.net 2
feeder.eternal-september.org 1
TOTAL: 11 343
No colon-space in header
csiph-out.news.xs4all.nl 1
TOTAL: 1 1
TOTAL: 4 627

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1fu-berlin.de 14837 499 14338 0 0 0 3%23:59:34
2news.bbs.nz 29418 177 14973 12 0 0 0%23:53:09
3usenet.pasdenom.info 15536 100 14941 23 0 29 0%23:59:52
4tnet 16091 77 15084 1 0 0 0%23:54:08
5neva.ru 12339 65 12050 92 0 0 0%23:50:03
6newsfeed.xs4all.nl 14805 64 13976 1 0 159 0%23:59:51
7xmission 15706 40 13085 4 0 0 0%23:50:03
8erje 15163 29 14652 19 0 0 0%23:52:33
9news.freedyn.net 13916 11 13593 31 0 0 0%23:55:16
10news.mixmin.net 14256 8 13872 13 0 0 0%23:50:03
11aioe 13498 6 13014 0 0 0 0%23:50:03
12neodome.net 15262 4 14829 0 0 0 0%23:53:08
13news.uzoreto.com 15162 4 14893 35 0 0 0%24:05:52
14news.swapon.de 1067 2 1051 0 0 0 0%23:04:49
15eternal-september 0 0 0 0 0 13299 0%23:50:03
16xanadu-bbs 0 0 0 0 0 15679 0%23:50:10
17news.samoylyk.net 0 0 0 0 0 15719 0%23:58:36
18weretis.net 14208 0 14017 3 0 0 0%23:50:36
19news.fcku.it 922 0 921 0 0 0 0%19:14:09
TOTAL: 19 222186 1086 199289 234 0 44885 0%448:41:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1fu-berlin.de4.9 MB0.0 KB4.9 MB0.1 KB/s10.0 KB23:59:34
2news.bbs.nz481.4 KB38.5 KB520.0 KB0.0 KB/s2.8 KB23:53:09
3usenet.pasdenom.info399.8 KB30.5 KB430.4 KB0.0 KB/s3.5 KB23:59:52
4neva.ru239.5 KB268.3 KB507.8 KB0.0 KB/s3.2 KB23:50:03
5tnet178.3 KB1.5 KB179.8 KB0.0 KB/s2.3 KB23:54:08
6newsfeed.xs4all.nl155.1 KB2.6 KB157.7 KB0.0 KB/s2.4 KB23:59:51
7news.freedyn.net103.4 KB487.4 KB590.8 KB0.0 KB/s14.1 KB23:55:16
8xmission98.1 KB8.0 KB106.1 KB0.0 KB/s2.4 KB23:50:03
9erje77.2 KB66.6 KB143.8 KB0.0 KB/s3.0 KB23:52:33
10news.mixmin.net57.4 KB37.6 KB94.9 KB0.0 KB/s4.5 KB23:50:03
11neodome.net22.8 KB0.0 KB22.8 KB0.0 KB/s5.7 KB23:53:08
12aioe16.4 KB0.0 KB16.4 KB0.0 KB/s2.7 KB23:50:03
13news.uzoreto.com11.0 KB179.0 KB190.0 KB0.0 KB/s4.9 KB24:05:52
14news.swapon.de2.5 KB0.0 KB2.5 KB0.0 KB/s1.2 KB23:04:49
15eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:03
16xanadu-bbs0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:10
17news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:36
18weretis.net0.0 KB9.8 KB9.8 KB0.0 KB/s3.3 KB23:50:36
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s019:14:09
TOTAL: 196.7 MB1.1 MB7.8 MB0.0 KB/s6.0 KB448:41:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1a131033.upc-a.chello.nl 69 23.9 KB 2 0 013:00:34
2172.83.100.221 8 23.9 KB 2 0 003:34:40
391.187.33.87 229 11.4 KB 1 0 025:01:25
4212.90.61.180 1 00.0 KB 33 0 000:00:00
TOTAL: 4 307 59.2 KB 38 0 045:52:10

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 239 35.3 KB 36 0 028:36:05
2*.upc-a.chello.nl 69 23.9 KB 2 0 013:00:34
3*.range31-49.btcentralplus.com 3 00.0 KB 0 0 000:03:21
4*.net.upcbroadband.cz 51 00.0 KB 0 0 004:12:08
TOTAL: 4 362 59.2 KB 38 0 045:52:10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 13.882 3.594 0.00025:01:25
a131033.upc-a.chello.nl 4.268 1.108 0.00013:00:34
ip-78-102-198-192.net.upcbroadband.cz 3.176 0.770 0.00004:12:08
172.83.100.221 0.682 0.136 0.00003:34:40
host31-49-229-214.range31-49.btcentralplus.com 0.170 0.067 0.00000:03:21
194.61.53.20 0.047 0.031 0.00000:00:00
TOTAL: 6 22.225 5.706 0.00045:52:10

Curious NNRP server explorers [Top 20]:

SystemConn
ip-78-102-198-192.net.upcbroadband.cz 51
host31-49-229-214.range31-49.btcentralplus.com 3
194.61.53.20 1
TOTAL: 3 55

NNRP client timeouts [Top 20]:

SystemConnPeer
172.83.100.221 6 0
91.187.33.87 2 0
TOTAL: 2 8 1

Newsgroup request counts (by category):

CategoryCountPct
1alt 3359 63.3%
2comp 1408 26.5%
3rec 287 5.4%
4tw 55 1.0%
5uk 47 0.9%
6ne 43 0.8%
7free 32 0.6%
8fr 29 0.5%
9dfw 18 0.3%
10soc 14 0.3%
11hannover 6 0.1%
12microsoft 4 0.1%
13nh 2 0.0%
14de 1 0.0%
15pl 1 0.0%
16opera 1 0.0%
17sci 1 0.0%
TOTAL: 17 5308100.0%

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

NewsgroupCount
1alt.tv.the-shield 1599
2alt.sports.basketball.nba.la-lakers 1488
3comp.lang.perl.announce 1108
4comp.security.pgp.discuss 295
5rec.music.makers.bands 287
6alt.politics.democrats.house 169
7tw.bbs.rec.audiophile 52
8uk.music.guitar 45
9ne.general 43
10alt.fan.states.new-jersey 39
11alt.taiwan.republic 30
12fr.rec.loisirs-creatifs 29
13free.comp 26
14alt.planets.earth.moon 25
15dfw.eats 18
16soc.culture.misc 14
17hannover.fundgrube 6
18comp.sys.ibm.ps2.hardware 5
19alt.pl.regionalne.opole 4
20microsoft.public.de.german.office 3
21tw.bbs.literal.article 3
22alt.politics.ec 2
23free.it.citta.rimini 2
24uk.adverts.games.roleplay 2
25alt.paranet.abduct 2
26nh.housing 2
27free.it.problemi.pensioni 2
28free.uk.scotland.transport-railways 2
29de.admin.news.announce 1
30sci.psychology.theory 1
31microsoft.public.windowsxp.wmi 1
32alt.music.weird-al 1
33pl.sci.psychologia 1
34opera.polish 1
TOTAL: 34 5308