Daily Usenet report for csiph.com

Nov 26 04:15:01 -- Nov 27 04:15:00

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Nov 26 09:39:26 csiph nnrpd[81755]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 26 09:39:26 csiph nnrpd[81755]: 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]
Nov 26 12:00:46 csiph nnrpd[87061]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 26 12:00:46 csiph nnrpd[87061]: 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]
Nov 26 23:22:30 csiph nnrpd[10800]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 26 23:22:30 csiph nnrpd[10800]: 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
innd 16458 44.3%2.2 MB 31.4%
inn 16092 43.3%4.0 MB 58.1%
innfeed 3523 9.5%616.2 KB 8.7%
nnrpd 1043 2.8%119.0 KB 1.7%
nocem 35 0.1%4.1 KB 0.1%
TOTAL: 5 37151 100.0%6.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 243487 56.6%
Negative hits 170243 39.5%
Do not exist 15545 3.6%
Cache misses 1261 0.3%
TOTAL: 4 430536 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.094 0.0%43 0.000 25.442 60.500
article cleanup00:00:00.091 0.0%15260 0.000 0.006 0.065
article logging00:00:00.676 0.0%15699 0.000 0.043 7.075
article parse00:00:01.667 0.0%48342 0.000 0.034 1.295
article write00:00:26.152 0.0%12483 0.206 2.095 65.000
artlog/artcncl00:00:00.000 0.0%43 0.000 0.000 0.000
artlog/artparse00:00:00.015 0.0%355 0.000 0.042 3.000
data move00:00:00.906 0.0%396242 0.000 0.002 0.097
hisgrep/artcncl00:00:00.040 0.0%41 0.000 0.976 8.000
hishave/artcncl00:00:00.008 0.0%43 0.000 0.186 1.000
hishave/artparse00:00:00.000 0.0%349 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:22.529 0.0%431731 0.002 0.052 0.671
history sync00:00:01.256 0.0%354 0.000 3.548 94.333
history write00:00:24.375 0.0%15248 0.146 1.599 29.541
hiswrite/artcncl00:00:00.002 0.0%2 1.000 1.000 1.000
hiswrite/artparse00:00:01.229 0.0%349 0.000 3.521 69.833
idle23:56:46.645 99.7%400561 110.128 215.215 834.153
nntp read00:00:03.120 0.0%404870 0.000 0.008 0.195
overview write00:01:26.557 0.1%12483 0.000 6.934 525.833
perl filter00:00:36.007 0.0%15242 1.068 2.362 10.211
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.201 0.0%25000 0.000 0.008 0.035
TOTAL: 24:00:51.64224:00:12.570100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.039 0.0%14747 0.000 0.003 0.027
article prepare00:00:00.002 0.0%11344 0.000 0.000 0.006
article read00:00:00.568 0.0%1205 0.000 0.471 21.500
backlog stats00:00:00.194 0.0%266362 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.012 0.0%205456 0.000 0.005 0.011
data write00:00:01.239 0.0%197386 0.000 0.006 0.016
idle23:54:17.615100.0%266362 107.812 323.085 1079.424
status file00:00:00.300 0.0%313 0.000 0.958 3.000
TOTAL: 23:54:27.60023:54:20.969100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle54:12:24.247 99.6%28567 46.000 6831.107600137.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:05.935 0.0%311604 0.000 0.019 0.167
readart00:07:28.526 0.2%27963 0.000 16.040 42.000
TOTAL: 54:25:00.74654:19:58.708 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeeds.xmission.com 2 12058 2625 9396 37 21%25:13:05
2news-out.mixmin.net 3 12886 2394 10270 222 18%24:08:06
3csiph-out.news.xs4all.nl 747 14830 2118 11545 1167 14%64:52:22
4csiph-out.feeder.erje.net 1440 60800 1280 59369 151 2%118:42:08
5news-out.aioe.org 1 11165 900 10185 80 8%23:59:56
6newsfeed.fu-berlin.de 12 12666 770 11708 188 6%25:15:03
7csiph-out.news.weretis.net 3 24711 695 23835 181 2%48:14:26
8newsfeed.neva.ru 142 13423 635 12509 279 4%72:31:22
9news-out.neodome.net 1 13488 328 13061 99 2%23:59:54
10news.fcku.it 11 1351 261 1087 3 19%21:21:22
11csiph-out.feed.uzoreto.com 868 20399 257 19466 676 1%71:06:37
12nntp.pasdenom.info 4 8281 109 8169 3 1%20:06:39
13news.swapon.de 8 1080 41 1039 0 3%22:39:09
14csiph-out.news.tnetconsulting.net 1 14542 41 14451 50 0%23:59:58
15news.freedyn.net 1 14407 21 14362 24 0%23:59:57
16news.samoylyk.net 1 11505 6 11498 1 0%23:59:54
17localhost 30 4 4 0 0 100%00:00:00
18news.bbs.nz 2 13850 3 13847 0 0%23:59:45
19xanadu-bbs.net 31 284 0 284 0 0%18:22:33
TOTAL: 19 3308 261730 12488 246081 3161 4%676:32:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net8.7 MB27.6 KB3.0 MB11.7 MB 74%8.3 KB
2newsfeeds.xmission.com8.3 MB0.0 KB2.7 MB11.0 MB 75%4.2 KB
3news-out.mixmin.net5.4 MB0.0 KB572.6 KB5.9 MB 90%2.3 KB
4csiph-out.news.xs4all.nl5.4 MB0.0 KB5.6 MB11.0 MB 48%3.4 KB
5news-out.aioe.org3.2 MB0.0 KB228.4 KB3.5 MB 93%3.6 KB
6csiph-out.news.weretis.net2.1 MB7.7 KB2.6 MB4.6 MB 44%5.4 KB
7newsfeed.fu-berlin.de1.9 MB0.0 KB612.9 KB2.5 MB 75%2.6 KB
8newsfeed.neva.ru1.6 MB0.0 KB561.3 KB2.1 MB 74%2.4 KB
9csiph-out.feed.uzoreto.com1.2 MB0.0 KB13.9 MB15.2 MB 8%16.6 KB
10news-out.neodome.net1.1 MB0.0 KB1.2 MB2.2 MB 47%5.4 KB
11news.fcku.it416.5 KB0.0 KB4.5 KB421.0 KB 98%1.6 KB
12nntp.pasdenom.info228.9 KB0.0 KB3.8 KB232.7 KB 98%2.1 KB
13news.freedyn.net158.5 KB0.0 KB988.4 KB1.1 MB 13%25.5 KB
14csiph-out.news.tnetconsulting.net149.2 KB5.6 KB302.7 KB457.4 KB 32%5.0 KB
15news.swapon.de93.4 KB0.0 KB0.0 KB93.4 KB100%2.3 KB
16news.bbs.nz20.4 KB0.0 KB0.0 KB20.4 KB100%6.8 KB
17news.samoylyk.net17.8 KB0.0 KB58.6 KB76.4 KB 23%10.9 KB
18localhost6.0 KB0.0 KB0.0 KB6.0 KB100%1.5 KB
19xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1939.8 MB40.9 KB32.2 MB72.0 MB 55%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 26 04:15:01 - 04:59:59 141 1.1% 0.05449.1 KB 1.1% 0.17
Nov 26 05:00:00 - 05:59:59 375 3.0% 0.102.3 MB 5.9% 0.66
Nov 26 06:00:00 - 06:59:59 310 2.5% 0.091.2 MB 2.9% 0.33
Nov 26 07:00:00 - 07:59:59 372 3.0% 0.101.3 MB 3.3% 0.38
Nov 26 08:00:00 - 08:59:59 564 4.5% 0.161.6 MB 4.0% 0.45
Nov 26 09:00:00 - 09:59:59 573 4.6% 0.161.8 MB 4.6% 0.52
Nov 26 10:00:00 - 10:59:59 577 4.6% 0.161.5 MB 3.9% 0.44
Nov 26 11:00:00 - 11:59:59 591 4.7% 0.161.6 MB 4.1% 0.46
Nov 26 12:00:00 - 12:59:59 599 4.8% 0.171.6 MB 4.0% 0.45
Nov 26 13:00:00 - 13:59:59 579 4.6% 0.161.7 MB 4.2% 0.48
Nov 26 14:00:00 - 14:59:59 604 4.8% 0.171.7 MB 4.3% 0.49
Nov 26 15:00:00 - 15:59:59 807 6.5% 0.223.2 MB 8.0% 0.91
Nov 26 16:00:00 - 16:59:59 853 6.8% 0.242.6 MB 6.4% 0.73
Nov 26 17:00:00 - 17:59:59 840 6.7% 0.232.8 MB 7.0% 0.79
Nov 26 18:00:00 - 18:59:59 696 5.6% 0.192.2 MB 5.5% 0.62
Nov 26 19:00:00 - 19:59:59 593 4.7% 0.161.6 MB 4.1% 0.47
Nov 26 20:00:00 - 20:59:59 579 4.6% 0.161.8 MB 4.6% 0.52
Nov 26 21:00:00 - 21:59:59 549 4.4% 0.151.7 MB 4.3% 0.49
Nov 26 22:00:00 - 22:59:59 402 3.2% 0.111.3 MB 3.2% 0.36
Nov 26 23:00:00 - 23:59:59 386 3.1% 0.111.4 MB 3.6% 0.41
Nov 27 00:00:00 - 00:59:59 246 2.0% 0.07953.0 KB 2.3% 0.26
Nov 27 01:00:00 - 01:59:59 263 2.1% 0.07774.7 KB 1.9% 0.22
Nov 27 02:00:00 - 02:59:59 172 1.4% 0.05510.9 KB 1.3% 0.14
Nov 27 03:00:00 - 03:59:59 740 5.9% 0.212.0 MB 5.0% 0.57
Nov 27 04:00:00 - 04:15:00 74 0.6% 0.08199.1 KB 0.5% 0.22
TOTAL: 23:59:59 12485 100.0% 0.1439.8 MB 100.0% 0.47
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1186 95 0 0 1 0 0 0 1090
2csiph-out.feed.uzoreto.com 677 22 0 0 1 0 0 0 654
3newsfeed.fu-berlin.de 464 14 0 0 0 0 0 0 450
4news-out.mixmin.net 289 16 0 0 0 0 0 0 273
5newsfeed.neva.ru 282 51 0 0 0 0 0 0 231
6csiph-out.news.weretis.net 181 55 0 8 0 0 0 0 118
7csiph-out.feeder.erje.net 158 45 0 10 0 0 0 0 103
8news-out.neodome.net 102 5 0 0 0 0 0 0 97
9news-out.aioe.org 93 65 0 0 0 0 0 0 28
10newsfeeds.xmission.com 43 3 0 0 0 0 0 0 40
11csiph-out.news.tnetconsulting.net 37 27 0 0 0 0 0 0 10
12news.freedyn.net 24 0 0 0 0 0 0 0 24
13news.swapon.de 21 0 0 0 0 0 0 0 21
14news.fcku.it 3 3 0 0 0 0 0 0 0
15nntp.pasdenom.info 3 0 0 0 0 0 0 0 3
16news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 16 3564 401 0 18 2 0 0 0 3143

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 108
lada.talk 40
scinet.stats 27
alt.politics.usa 15
alt.bbs.synchronet 12
at.jobs 12
alt.windows7.general 11
alt.politics 10
alt.job 10
lada.auto 10
trollnet.cinema 9
mozilla.support.seamonkey 9
alt.religion 8
alt.binaries.pictures.purebeauty 7
mozilla.support.thunderbird 6
free.it.religioni.scientology 5
alt.philosophy 5
alt.survival 5
alt.forsale.seattle 5
it-alt.sport.calcio.juventus 5
TOTAL: 68 401

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

GroupsCount
uk.legal.moderated 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1772
EMP (phn path) 277
EMP (phn nph) 106
Too many newsgroups 80
EMP (phl) 57
0 45
Binary: misplaced binary 4
Too many newsgroups (meow) 2
HTML Multipart 2
Scoring filter 1
HTML post 1
Too many newsgroups (low_xpost) 1
U2 violation - invalid distribution 1
Malformed article 1
TOTAL: 14 2350

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 157
csiph-out.feeder.erje.net 54
csiph-out.news.xs4all.nl 44
newsfeeds.xmission.com 33
csiph-out.news.weretis.net 19
news-out.neodome.net 17
news.freedyn.net 11
csiph-out.news.tnetconsulting.net 6
newsfeed.fu-berlin.de 3
news-out.mixmin.net 3
TOTAL: 11 348
Including strange strings
newsfeed.fu-berlin.de 291
news-out.mixmin.net 67
csiph-out.news.xs4all.nl 23
news.swapon.de 21
news-out.aioe.org 15
csiph-out.feeder.erje.net 7
newsfeeds.xmission.com 6
csiph-out.news.weretis.net 5
newsfeed.neva.ru 2
news-out.neodome.net 1
TOTAL: 11 439
No colon-space in header
csiph-out.news.xs4all.nl 5
csiph-out.feed.uzoreto.com 1
TOTAL: 2 6
TOTAL: 4 838

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 15452 740 11743 1 0 3 4%23:59:54
2fu-berlin.de 11510 523 10987 0 0 0 4%23:59:54
3news.samoylyk.net 12934 510 11962 7 0 4 3%23:59:54
4news.bbs.nz 22803 413 11504 24 0 62 1%23:59:54
5tnet 13085 106 11837 0 0 0 0%23:59:54
6xmission 11205 52 9345 0 0 8 0%23:59:54
7newsfeed.xs4all.nl 10765 52 10219 4 0 8 0%23:59:53
8usenet.pasdenom.info 13059 36 12430 21 0 1477 0%23:59:54
9neva.ru 11061 31 10780 109 0 0 0%23:59:54
10news.freedyn.net 12029 17 11623 60 0 67 0%23:59:54
11news.swapon.de 1182 13 1133 0 0 0 1%23:33:49
12news.mixmin.net 9500 11 9218 0 0 0 0%23:59:53
13neodome.net 12503 9 12088 0 0 0 0%23:59:54
14aioe 9047 7 8479 0 0 0 0%23:59:54
15erje 10635 6 10522 61 0 0 0%23:59:24
16weretis.net 11274 6 10883 1 0 0 0%23:59:54
17news.uzoreto.com 12007 4 11725 17 0 0 0%23:59:47
18news.fcku.it 1034 0 995 0 0 1 0%20:47:55
19eternal-september 0 0 0 0 0 11298 0%23:58:42
TOTAL: 19 201085 2536 177473 305 0 12928 1%452:18:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs7.1 MB3.4 KB7.1 MB0.1 KB/s9.8 KB23:59:54
2fu-berlin.de6.5 MB0.0 KB6.5 MB0.1 KB/s12.6 KB23:59:54
3news.samoylyk.net6.4 MB44.1 KB6.4 MB0.1 KB/s12.7 KB23:59:54
4news.bbs.nz1.1 MB70.4 KB1.1 MB0.0 KB/s2.7 KB23:59:54
5tnet268.6 KB0.0 KB268.6 KB0.0 KB/s2.5 KB23:59:54
6newsfeed.xs4all.nl219.7 KB15.0 KB234.8 KB0.0 KB/s4.2 KB23:59:53
7xmission151.4 KB0.0 KB151.4 KB0.0 KB/s2.9 KB23:59:54
8usenet.pasdenom.info129.9 KB56.8 KB186.8 KB0.0 KB/s3.3 KB23:59:54
9news.swapon.de78.2 KB0.0 KB78.2 KB0.0 KB/s6.0 KB23:33:49
10neva.ru64.4 KB327.6 KB392.0 KB0.0 KB/s2.8 KB23:59:54
11news.freedyn.net48.0 KB984.2 KB1.0 MB0.0 KB/s13.4 KB23:59:54
12news.mixmin.net42.1 KB0.0 KB42.1 KB0.0 KB/s3.8 KB23:59:53
13neodome.net33.7 KB0.0 KB33.7 KB0.0 KB/s3.7 KB23:59:54
14erje24.4 KB273.1 KB297.5 KB0.0 KB/s4.4 KB23:59:24
15aioe17.4 KB0.0 KB17.4 KB0.0 KB/s2.5 KB23:59:54
16weretis.net8.9 KB1.1 KB10.0 KB0.0 KB/s1.4 KB23:59:54
17news.uzoreto.com7.4 KB118.3 KB125.7 KB0.0 KB/s6.0 KB23:59:47
18news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s020:47:55
19eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:42
TOTAL: 1922.1 MB1.8 MB23.9 MB0.0 KB/s8.6 KB452:18:11
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1lfbn-ren-1-681-66.w81-53.abo.wanadoo.fr 8 2788755.6 MB 13 0 008:52:34
2athedsl-175833.home.otenet.gr 2 4188.0 KB 2 0 000:00:24
3a131033.upc-a.chello.nl 53 2050.8 KB 9 0 014:46:49
4071-082-226-242.res.spectrum.com 19 1530.7 KB 15 4 405:43:25
TOTAL: 4 82 2796355.8 MB 39 4 454:24:59

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.w81-53.abo.wanadoo.fr 8 2788755.6 MB 13 0 008:52:34
2*.home.otenet.gr 2 4188.0 KB 2 0 000:00:24
3*.upc-a.chello.nl 53 2050.8 KB 9 0 014:46:49
4*.res.spectrum.com 19 1530.7 KB 15 4 405:43:25
5unresolved 73 00.0 KB 0 0 024:00:51
6*.ph.ph.cox.net 2 00.0 KB 0 0 001:00:09
7*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:01
8*.range5-81.btcentralplus.com 2 00.0 KB 0 0 000:00:43
TOTAL: 8 160 2796355.8 MB 39 4 454:24:59

NNRP auth users [Top 20]:

UserConn
ohlandl 4
TOTAL: 1 4

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 5.009 2.933 0.00024:00:41
a131033.upc-a.chello.nl 3.947 1.841 0.00014:46:49
lfbn-ren-1-681-66.w81-53.abo.wanadoo.fr 3.728 17.272 0.00008:52:34
071-082-226-242.res.spectrum.com 1.545 0.234 0.41005:43:25
ip72-222-200-117.ph.ph.cox.net 0.212 0.030 0.00001:00:09
host5-81-219-132.range5-81.btcentralplus.com 0.121 0.333 0.00000:00:43
athedsl-175833.home.otenet.gr 0.224 0.038 0.00000:00:24
68.183.205.39 0.065 0.016 0.00000:00:10
scanner-06.ch1.censys-scanner.com 0.060 0.020 0.00000:00:01
TOTAL: 9 14.911 22.717 0.41054:24:59

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 72
ip72-222-200-117.ph.ph.cox.net 2
host5-81-219-132.range5-81.btcentralplus.com 2
68.183.205.39 1
scanner-06.ch1.censys-scanner.com 1
TOTAL: 5 78

NNRP unrecognized commands (by host):

SystemConn
scanner-06.ch1.censys-scanner.com 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
071-082-226-242.res.spectrum.com 6 0
ip72-222-200-117.ph.ph.cox.net 2 0
TOTAL: 2 8 0

Newsgroup request counts (by category):

CategoryCountPct
1fr 27887 99.7%
2comp 76 0.3%
TOTAL: 2 27963100.0%

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

NewsgroupCount
1fr.comp.os.mac-os.x 15368
2fr.comp.sys.mac 3936
3fr.comp.sys.mac.materiel 3736
4fr.comp.sys.mac.communication 2861
5fr.rec.photo 1986
6comp.sys.ibm.ps2.hardware 76
TOTAL: 6 27963