Daily Usenet report for csiph.com

Jan 6 04:15:01 -- Jan 7 04:15:00

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Jan 6 13:10:40 csiph nnrpd[91481]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 6 13:10:40 csiph nnrpd[91481]: 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 6 17:28:07 csiph nnrpd[5036]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 6 17:28:07 csiph nnrpd[5036]: 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 6 23:33:03 csiph nnrpd[23897]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 6 23:33:03 csiph nnrpd[23897]: 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 20446 51.1%5.2 MB 66.1%
innd 14074 35.2%1.8 MB 23.4%
innfeed 3450 8.6%617.6 KB 7.7%
nnrpd 2033 5.1%229.3 KB 2.8%
nocem 8 0.0%0.9 KB 0.0%
TOTAL: 5 40011 100.0%7.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 304414 49.8%
Negative hits 286991 46.9%
Do not exist 19749 3.2%
Cache misses 342 0.1%
TOTAL: 4 611496 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.521 0.0%49 0.000 10.633 26.700
article cleanup00:00:00.114 0.0%19618 0.000 0.006 0.042
article logging00:00:00.966 0.0%20101 0.000 0.048 2.684
article parse00:00:00.894 0.0%63210 0.000 0.014 0.099
article write00:01:02.156 0.1%16308 0.340 3.811 83.769
artlog/artcncl00:00:00.079 0.0%49 0.000 1.612 6.700
artlog/artparse00:00:00.004 0.0%289 0.000 0.014 0.500
data move00:00:00.226 0.0%577444 0.000 0.000 0.002
hisgrep/artcncl00:00:00.011 0.0%48 0.000 0.229 1.500
hishave/artcncl00:00:00.005 0.0%49 0.000 0.102 1.000
hishave/artparse00:00:00.000 0.0%277 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:25.339 0.0%616079 0.001 0.041 0.378
history sync00:00:01.192 0.0%369 0.000 3.230 23.333
history write00:00:33.343 0.0%19630 0.537 1.699 17.791
hiswrite/artcncl00:00:00.001 0.0%1 1.000 1.000 1.000
hiswrite/artparse00:00:00.361 0.0%277 0.000 1.303 15.000
idle23:54:44.118 99.6%575588 85.771 149.559 779.889
nntp read00:00:02.330 0.0%582128 0.001 0.004 0.011
overview write00:02:55.964 0.2%16308 0.122 10.790 694.200
perl filter00:00:29.180 0.0%19618 1.132 1.487 2.440
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.290 0.0%32624 0.000 0.009 0.042
TOTAL: 24:00:59.35124:00:17.094100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.041 0.0%16321 0.000 0.003 0.028
article prepare00:00:00.001 0.0%14008 0.000 0.000 0.011
article read00:00:00.531 0.0%1449 0.000 0.366 43.000
backlog stats00:00:00.248 0.0%361159 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.296 0.0%283839 0.001 0.005 0.011
data write00:00:01.714 0.0%270272 0.002 0.006 0.015
idle23:54:25.150100.0%361159 121.160 238.303 1146.309
status file00:00:00.267 0.0%276 0.000 0.967 15.000
TOTAL: 23:54:35.97823:54:29.248100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle48:47:24.845 99.6%1082 29.000162333.498360163.200
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.933 0.0%48085 0.000 0.040 0.286
readart00:00:00.290 0.0%23 12.609 12.609 12.609
TOTAL: 48:59:50.06648:47:27.068 99.6%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.xs4all.nl 0 6099 2961 1822 1316 48%75:12:21
2feeder.eternal-september.org 12 4532 2409 2057 66 53%26:13:33
3csiph-out.news.weretis.net 5 36858 1984 34495 379 5%54:07:35
4news-out.mixmin.net 3 17472 1812 15140 520 10%24:08:40
5csiph-out.feeder.erje.net 1440 80537 1521 78633 383 1%118:51:26
6news-out.aioe.org 4 15486 1381 14033 72 8%24:09:41
7newsfeed.fu-berlin.de 22 17177 957 15936 284 5%29:44:21
8newsfeeds.xmission.com 3 14228 882 13335 11 6%21:21:30
9newsfeed.neva.ru 152 11015 824 9892 299 7%72:12:24
10csiph-out.feed.uzoreto.com 864 26943 741 25752 450 2%71:11:27
11news-out.neodome.net 2 17560 379 17152 29 2%23:59:54
12news.fcku.it 12 1739 238 1501 0 13%22:25:15
13nntp.pasdenom.info 2 10701 142 10555 4 1%23:58:48
14news.swapon.de 8 1479 50 1429 0 3%23:30:18
15csiph-out.news.tnetconsulting.net 1 15110 26 15082 2 0%23:59:57
16news.bbs.nz 1 14778 13 14765 0 0%23:59:51
17news.freedyn.net 1 18989 9 18961 19 0%23:59:56
18news.samoylyk.net 1 15905 7 15894 4 0%23:59:52
19localhost 26 0 0 0 0 0%00:00:01
20xanadu-bbs.net 32 383 0 383 0 0%20:32:34
TOTAL: 20 2591 326991 16336 306817 3838 4%727:39:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.xs4all.nl8.5 MB0.0 KB11.9 MB20.4 MB 41%4.9 KB
2csiph-out.feeder.erje.net8.2 MB0.0 KB3.0 MB11.2 MB 73%6.0 KB
3feeder.eternal-september.org6.1 MB0.0 KB569.7 KB6.6 MB 91%2.7 KB
4csiph-out.news.weretis.net5.9 MB0.0 KB2.5 MB8.4 MB 70%3.6 KB
5news-out.mixmin.net4.6 MB0.0 KB2.6 MB7.2 MB 63%3.2 KB
6news-out.aioe.org3.5 MB0.0 KB110.0 KB3.7 MB 97%2.6 KB
7newsfeeds.xmission.com2.7 MB0.0 KB543.8 KB3.2 MB 83%3.7 KB
8csiph-out.feed.uzoreto.com2.7 MB0.0 KB9.2 MB11.8 MB 22%10.2 KB
9newsfeed.neva.ru2.6 MB0.0 KB1.1 MB3.7 MB 69%3.4 KB
10newsfeed.fu-berlin.de2.2 MB0.0 KB2.3 MB4.5 MB 49%3.7 KB
11news-out.neodome.net1.2 MB0.0 KB702.0 KB1.9 MB 63%4.8 KB
12news.fcku.it432.7 KB0.0 KB0.0 KB432.7 KB100%1.8 KB
13nntp.pasdenom.info323.9 KB0.0 KB5.1 KB329.0 KB 98%2.3 KB
14csiph-out.news.tnetconsulting.net124.6 KB0.0 KB212.5 KB337.1 KB 36%12.0 KB
15news.swapon.de95.6 KB0.0 KB0.0 KB95.6 KB100%1.9 KB
16news.freedyn.net52.5 KB0.0 KB1.1 MB1.2 MB 4%43.2 KB
17news.bbs.nz26.2 KB0.0 KB0.0 KB26.2 KB100%2.0 KB
18news.samoylyk.net23.8 KB0.0 KB216.3 KB240.2 KB 9%21.8 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: 2049.2 MB0.0 KB36.1 MB85.3 MB 57%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 6 04:15:01 - 04:59:59 134 0.8% 0.05594.7 KB 1.2% 0.22
Jan 6 05:00:00 - 05:59:59 303 1.9% 0.081.7 MB 3.5% 0.48
Jan 6 06:00:00 - 06:59:59 289 1.8% 0.08989.3 KB 2.0% 0.27
Jan 6 07:00:00 - 07:59:59 419 2.6% 0.121.5 MB 3.0% 0.41
Jan 6 08:00:00 - 08:59:59 540 3.3% 0.151.8 MB 3.6% 0.51
Jan 6 09:00:00 - 09:59:59 693 4.2% 0.192.4 MB 5.0% 0.70
Jan 6 10:00:00 - 10:59:59 673 4.1% 0.192.0 MB 4.0% 0.56
Jan 6 11:00:00 - 11:59:59 735 4.5% 0.202.0 MB 4.1% 0.57
Jan 6 12:00:00 - 12:59:59 760 4.7% 0.212.0 MB 4.0% 0.56
Jan 6 13:00:00 - 13:59:59 789 4.8% 0.222.1 MB 4.3% 0.60
Jan 6 14:00:00 - 14:59:59 964 5.9% 0.272.4 MB 4.8% 0.67
Jan 6 15:00:00 - 15:59:59 949 5.8% 0.262.6 MB 5.2% 0.73
Jan 6 16:00:00 - 16:59:59 1033 6.3% 0.293.6 MB 7.5% 1.04
Jan 6 17:00:00 - 17:59:59 984 6.0% 0.272.7 MB 5.5% 0.77
Jan 6 18:00:00 - 18:59:59 852 5.2% 0.242.6 MB 5.3% 0.73
Jan 6 19:00:00 - 19:59:59 872 5.3% 0.242.7 MB 5.6% 0.78
Jan 6 20:00:00 - 20:59:59 941 5.8% 0.262.8 MB 5.7% 0.79
Jan 6 21:00:00 - 21:59:59 951 5.8% 0.262.7 MB 5.5% 0.77
Jan 6 22:00:00 - 22:59:59 901 5.5% 0.252.5 MB 5.0% 0.70
Jan 6 23:00:00 - 23:59:59 654 4.0% 0.182.1 MB 4.3% 0.59
Jan 7 00:00:00 - 00:59:59 496 3.0% 0.141.3 MB 2.6% 0.36
Jan 7 01:00:00 - 01:59:59 479 2.9% 0.131.4 MB 2.9% 0.41
Jan 7 02:00:00 - 02:59:59 427 2.6% 0.121.2 MB 2.5% 0.35
Jan 7 03:00:00 - 03:59:59 406 2.5% 0.111.2 MB 2.4% 0.34
Jan 7 04:00:00 - 04:15:00 76 0.5% 0.08243.6 KB 0.5% 0.27
TOTAL: 23:59:59 16320 100.0% 0.1948.9 MB 100.0% 0.58
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1312 80 0 0 0 0 0 0 1232
2newsfeed.fu-berlin.de 638 39 0 0 0 0 0 0 599
3news-out.mixmin.net 527 5 0 0 0 0 0 0 522
4csiph-out.feed.uzoreto.com 451 17 0 0 0 0 0 0 434
5csiph-out.news.weretis.net 361 99 0 0 0 0 0 0 262
6newsfeed.neva.ru 301 57 0 0 0 0 0 0 244
7csiph-out.feeder.erje.net 226 62 0 0 2 0 0 0 162
8news-out.aioe.org 72 58 0 0 0 0 0 0 14
9feeder.eternal-september.org 70 28 0 0 0 0 0 0 42
10news-out.neodome.net 31 3 0 0 0 0 0 0 28
11news.freedyn.net 29 3 0 0 0 0 0 0 26
12newsfeeds.xmission.com 25 5 0 0 0 0 0 0 20
13news.swapon.de 24 0 0 0 0 0 0 0 24
14news.samoylyk.net 4 0 0 0 0 0 0 0 4
15nntp.pasdenom.info 4 0 0 0 0 0 0 0 4
16csiph-out.news.tnetconsulting.net 2 0 0 0 0 0 0 0 2
TOTAL: 16 4077 456 0 0 2 0 0 0 3619

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 39
alt.politics 33
it-alt.sport.calcio.juventus 30
alt.bbs.synchronet 29
scinet.general.chatter 29
alt.computer.workshop 28
scinet.stats 25
spline.eisfair.dev 24
mozilla.general 17
alt.tv.comedy-central.daily-show 16
mozilla.support.firefox 15
spline.eisfair 14
at.jobs 11
att.jobs 11
scinet.bbs.mystic 11
mozilla.support.bugzilla 10
alt.job 9
alt.binaries.pictures.purebeauty 8
mozilla.support.seamonkey 8
lada.auto 7
TOTAL: 63 456

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
uk.legal.moderated 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1948
EMP (phn path) 586
EMP (phn nph) 122
Too many newsgroups 120
EMP (phl) 34
0 23
Binary: misplaced binary 8
HTML Multipart 8
Too many newsgroups (meow) 4
Scoring filter 2
TOTAL: 10 2855

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 65
csiph-out.news.xs4all.nl 1
csiph-out.feed.uzoreto.com 1
TOTAL: 3 67
Huge articles
csiph-out.feed.uzoreto.com 66
csiph-out.news.xs4all.nl 58
csiph-out.feeder.erje.net 53
newsfeed.fu-berlin.de 34
csiph-out.news.weretis.net 14
news.freedyn.net 13
news-out.neodome.net 10
feeder.eternal-september.org 6
newsfeeds.xmission.com 5
news.samoylyk.net 4
TOTAL: 12 267
Including strange strings
newsfeed.fu-berlin.de 384
csiph-out.news.xs4all.nl 31
news.swapon.de 24
newsfeeds.xmission.com 14
news-out.mixmin.net 8
csiph-out.feeder.erje.net 7
feeder.eternal-september.org 4
news-out.aioe.org 3
csiph-out.feed.uzoreto.com 3
news-out.neodome.net 3
TOTAL: 12 485
No colon-space in header
csiph-out.news.xs4all.nl 10
csiph-out.feeder.erje.net 1
csiph-out.feed.uzoreto.com 1
TOTAL: 3 12
TOTAL: 4 831

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 19632 1044 15274 1 0 1 5%23:59:55
2news.bbs.nz 30665 583 15199 30 0 0 1%23:57:29
3fu-berlin.de 15153 462 14691 0 0 0 3%23:56:12
4news.samoylyk.net 16694 443 15811 9 0 0 2%23:50:03
5erje 15130 160 14278 49 0 0 1%23:50:03
6xmission 17000 94 14661 6 0 0 0%23:50:03
7tnet 17521 84 15721 1 0 0 0%23:50:03
8newsfeed.xs4all.nl 14044 63 13241 4 0 18 0%23:54:29
9neva.ru 14737 25 14360 257 0 0 0%23:50:03
10usenet.pasdenom.info 16168 23 15645 43 0 19 0%23:59:55
11news.freedyn.net 16233 10 15772 55 0 0 0%23:50:03
12aioe 13226 8 12832 0 0 0 0%23:51:33
13news.mixmin.net 13710 8 13314 0 0 0 0%23:50:03
14news.uzoreto.com 15112 7 14732 26 0 0 0%23:53:46
15neodome.net 16153 5 15732 0 0 0 0%23:50:08
16weretis.net 13898 2 13754 0 0 0 0%23:50:03
17news.fcku.it 1434 0 1434 0 0 0 0%21:58:46
18eternal-september 0 0 0 0 0 13249 0%23:50:03
19news.swapon.de 1484 0 1482 0 0 0 0%23:21:25
TOTAL: 19 267994 3021 237933 481 0 13287 1%451:14:05
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs6.8 MB12.4 KB6.8 MB0.1 KB/s6.7 KB23:59:55
2fu-berlin.de5.4 MB0.0 KB5.4 MB0.1 KB/s11.9 KB23:56:12
3news.samoylyk.net5.3 MB56.2 KB5.4 MB0.1 KB/s12.1 KB23:50:03
4news.bbs.nz1.5 MB163.2 KB1.6 MB0.0 KB/s2.7 KB23:57:29
5erje290.7 KB196.9 KB487.6 KB0.0 KB/s2.3 KB23:50:03
6xmission234.7 KB21.7 KB256.4 KB0.0 KB/s2.6 KB23:50:03
7tnet183.0 KB1.7 KB184.7 KB0.0 KB/s2.2 KB23:50:03
8newsfeed.xs4all.nl138.7 KB17.0 KB155.7 KB0.0 KB/s2.3 KB23:54:29
9usenet.pasdenom.info84.9 KB83.9 KB168.7 KB0.0 KB/s2.6 KB23:59:55
10neva.ru58.2 KB537.5 KB595.8 KB0.0 KB/s2.1 KB23:50:03
11news.freedyn.net23.1 KB955.5 KB978.6 KB0.0 KB/s15.1 KB23:50:03
12aioe14.0 KB0.0 KB14.0 KB0.0 KB/s1.7 KB23:51:33
13news.mixmin.net13.9 KB0.0 KB13.9 KB0.0 KB/s1.7 KB23:50:03
14news.uzoreto.com12.7 KB266.9 KB279.6 KB0.0 KB/s8.5 KB23:53:46
15neodome.net8.5 KB0.0 KB8.5 KB0.0 KB/s1.7 KB23:50:08
16weretis.net4.8 KB0.0 KB4.8 KB0.0 KB/s2.4 KB23:50:03
17news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:58:46
18eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:03
19news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:21:25
TOTAL: 1920.0 MB2.3 MB22.2 MB0.0 KB/s6.5 KB451:14:05
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1aorleans-654-1-55-137.w90-20.abo.wanadoo.fr 2 2341.7 KB 1 0 000:00:27
TOTAL: 1 2 2341.7 KB 1 0 048:59:47

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.w90-20.abo.wanadoo.fr 2 2341.7 KB 1 0 000:00:27
2*.security.ipip.net 1 00.0 KB 0 0 000:00:00
3*.upc-a.chello.nl 68 00.0 KB 0 0 011:15:17
4*.net.upcbroadband.cz 56 00.0 KB 0 0 004:34:45
5unresolved 224 00.0 KB 0 0 032:38:13
6*.range31-50.btcentralplus.com 3 00.0 KB 0 0 000:31:02
TOTAL: 6 354 2341.7 KB 1 0 048:59:47

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 13.491 3.316 0.00032:38:02
a131033.upc-a.chello.nl 4.135 1.022 0.00011:15:17
ip-78-102-198-192.net.upcbroadband.cz 3.497 0.766 0.00004:34:45
host31-50-220-99.range31-50.btcentralplus.com 0.213 0.025 0.00000:31:02
aorleans-654-1-55-137.w90-20.abo.wanadoo.fr 0.203 0.097 0.00000:00:27
192.241.222.214 0.055 0.021 0.00000:00:09
159.203.1.13 0.390 0.147 0.00000:00:00
scan-141.security.ipip.net 0.060 0.017 0.00000:00:00
TOTAL: 8 22.044 5.411 0.00048:59:47

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 216
a131033.upc-a.chello.nl 68
ip-78-102-198-192.net.upcbroadband.cz 56
159.203.1.13 7
host31-50-220-99.range31-50.btcentralplus.com 3
192.241.222.214 1
scan-141.security.ipip.net 1
TOTAL: 7 352

NNRP unrecognized commands (by host):

SystemConn
159.203.1.13 36
scan-141.security.ipip.net 4
TOTAL: 2 40

NNRP unrecognized commands (by command):

CommandCount
Host: 69.160.37.58:119 7
User-Agent: Mozilla/5.0 (Windows NT 10.0... 6
Accept: */* 6
Connection: keep-alive 6
Accept-Encoding: gzip, deflate 6
GET /streaming/clients_live.php HTTP/1.1 1
Connection: close 1
GET / HTTP/1.1 1
GET /stalker_portal/c/version.js HTTP/1.... 1
GET /client_area/ HTTP/1.1 1
GET /stalker_portal/c/ HTTP/1.1 1
User-Agent: HTTP Banner Detection (https... 1
GET /c/version.js HTTP/1.1 1
GET /system_api.php HTTP/1.1 1
TOTAL: 14 40

NNRP client timeouts [Top 20]:

SystemConnPeer
host31-50-220-99.range31-50.btcentralplus.com 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1fr 23100.0%
TOTAL: 1 23100.0%

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

NewsgroupCount
1fr.comp.infosystemes.www.divers 23
TOTAL: 1 23