Daily Usenet report for csiph.com

Aug 12 04:15:00 -- Aug 13 04:15:00

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Aug 12 22:31:53 csiph nnrpd[40144]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Aug 12 22:31:53 csiph nnrpd[40144]: 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 18702 47.0%4.8 MB 62.4%
innd 16735 42.1%2.2 MB 28.6%
innfeed 3535 8.9%626.6 KB 7.9%
nnrpd 790 2.0%85.1 KB 1.1%
nocem 21 0.1%2.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 39784 100.0%7.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 319196 57.9%
Negative hits 213818 38.8%
Do not exist 18095 3.3%
Cache misses 467 0.1%
TOTAL: 4 551576 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.503 0.0%46 0.000 10.935 131.500
article cleanup00:00:00.101 0.0%17960 0.000 0.006 0.031
article logging00:00:00.284 0.0%18411 0.000 0.015 0.101
article parse00:00:00.683 0.0%53039 0.000 0.013 0.098
article write00:00:26.447 0.0%15219 0.168 1.738 37.377
artlog/artcncl00:00:00.000 0.0%46 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%240 0.000 0.000 0.000
data move00:00:00.196 0.0%511334 0.000 0.000 0.004
hisgrep/artcncl00:00:00.054 0.0%46 0.000 1.174 19.500
hishave/artcncl00:00:00.008 0.0%46 0.000 0.174 1.000
hishave/artparse00:00:00.001 0.0%221 0.000 0.005 0.167
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:14.047 0.0%553724 0.001 0.025 0.246
history sync00:00:00.765 0.0%328 0.000 2.332 23.000
history write00:00:19.385 0.0%17948 0.209 1.080 5.176
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.192 0.0%221 0.000 0.869 9.000
idle23:56:54.107 99.7%516369 93.537 166.962 484.436
nntp read00:00:01.989 0.0%518906 0.002 0.004 0.008
overview write00:01:37.662 0.1%15219 0.175 6.417 670.470
perl filter00:00:24.998 0.0%17879 1.099 1.398 2.105
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.266 0.0%30459 0.000 0.009 0.026
TOTAL: 24:00:38.44724:00:01.688100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.037 0.0%15616 0.000 0.002 0.030
article prepare00:00:00.000 0.0%12760 0.000 0.000 0.000
article read00:00:00.309 0.0%1643 0.000 0.188 12.000
backlog stats00:00:00.214 0.0%353657 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.357 0.0%279118 0.001 0.005 0.015
data write00:00:01.585 0.0%266724 0.002 0.006 0.013
idle23:55:14.511100.0%353657 143.481 243.497 629.751
status file00:00:00.194 0.0%280 0.000 0.693 5.000
TOTAL: 23:55:26.54923:55:18.207100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle34:16:15.295 99.8%522 63.000236351.140600114.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.010 0.0%1267 0.000 0.008 0.167
readart00:00:00.169 0.0%54 0.000 3.130 42.000
TOTAL: 34:21:05.43134:16:15.474 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeeds.xmission.com 2 14807 3759 10993 55 25%23:54:03
2news-out.mixmin.net 4 15960 2472 13217 271 15%24:11:47
3feeder.eternal-september.org 2 16329 2351 13856 122 14%23:08:48
4news-out.aioe.org 3 15021 1377 13525 119 9%24:08:41
5newsfeed.neva.ru 151 17356 1192 15723 441 6%71:45:45
6csiph-out.feeder.erje.net 1440 75904 962 74462 480 1%118:42:27
7csiph-out.news.weretis.net 6 39263 820 38273 170 2%57:56:01
8newsfeed.fu-berlin.de 12 15942 815 14804 323 5%27:12:37
9csiph-out.news.xs4all.nl 861 16609 593 15519 497 3%71:28:09
10news.fcku.it 12 1429 227 1201 1 15%21:41:30
11csiph-out.feed.uzoreto.com 863 23739 197 23069 473 0%71:20:41
12news-out.neodome.net 2 16189 174 15910 105 1%23:59:54
13nntp.pasdenom.info 2 10374 89 10261 24 0%23:58:44
14news.swapon.de 5 1344 35 1309 0 2%23:49:32
15news.freedyn.net 3 11296 25 11193 78 0%13:16:29
16csiph-out.news.tnetconsulting.net 2 14807 18 14773 16 0%23:59:56
17news.samoylyk.net 3 15072 13 15058 1 0%24:53:02
18news.bbs.nz 2 14223 4 14219 0 0%23:59:49
19xanadu-bbs.net 27 411 0 411 0 0%21:56:48
20localhost 26 0 0 0 0 0%00:00:03
TOTAL: 20 3428 336075 15123 317776 3176 4%715:24:46
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeeds.xmission.com10.5 MB0.0 KB4.0 MB14.5 MB 72%3.9 KB
2feeder.eternal-september.org6.5 MB3.4 KB1.2 MB7.7 MB 83%3.2 KB
3news-out.mixmin.net5.1 MB15.8 KB758.5 KB5.8 MB 87%2.2 KB
4news-out.aioe.org4.6 MB15.8 KB273.9 KB4.9 MB 94%3.4 KB
5csiph-out.feeder.erje.net4.3 MB13.7 KB3.9 MB8.2 MB 52%5.8 KB
6newsfeed.neva.ru3.5 MB58.4 KB1.3 MB4.8 MB 72%3.0 KB
7csiph-out.news.weretis.net2.4 MB49.6 KB1.6 MB4.0 MB 59%4.1 KB
8newsfeed.fu-berlin.de2.0 MB0.0 KB1.1 MB3.1 MB 64%2.7 KB
9csiph-out.news.xs4all.nl1.7 MB0.0 KB4.9 MB6.6 MB 26%6.2 KB
10csiph-out.feed.uzoreto.com804.3 KB3.4 KB11.0 MB11.8 MB 6%18.0 KB
11news-out.neodome.net542.5 KB11.3 KB170.6 KB724.5 KB 74%2.6 KB
12news.fcku.it352.6 KB0.0 KB96.5 KB449.1 KB 78%2.0 KB
13nntp.pasdenom.info249.7 KB0.0 KB43.5 KB293.2 KB 85%2.6 KB
14news.freedyn.net90.8 KB12.4 KB751.1 KB854.3 KB 10%8.3 KB
15news.swapon.de86.2 KB0.0 KB0.0 KB86.2 KB100%2.5 KB
16csiph-out.news.tnetconsulting.net51.5 KB7.8 KB195.5 KB254.8 KB 20%7.5 KB
17news.samoylyk.net38.8 KB3.4 KB3.4 KB45.6 KB 84%3.3 KB
18news.bbs.nz9.1 KB0.0 KB0.0 KB9.1 KB100%2.3 KB
19xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
20localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2042.7 MB195.0 KB31.2 MB74.1 MB 57%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 12 04:15:00 - 04:59:59 279 1.8% 0.10797.8 KB 1.8% 0.30
Aug 12 05:00:00 - 05:59:59 368 2.4% 0.101.0 MB 2.4% 0.30
Aug 12 06:00:00 - 06:59:59 451 3.0% 0.131.3 MB 2.9% 0.36
Aug 12 07:00:00 - 07:59:59 575 3.8% 0.161.7 MB 4.0% 0.50
Aug 12 08:00:00 - 08:59:59 667 4.4% 0.191.9 MB 4.5% 0.55
Aug 12 09:00:00 - 09:59:59 665 4.4% 0.181.9 MB 4.4% 0.54
Aug 12 10:00:00 - 10:59:59 655 4.3% 0.181.9 MB 4.3% 0.53
Aug 12 11:00:00 - 11:59:59 663 4.4% 0.181.7 MB 4.0% 0.49
Aug 12 12:00:00 - 12:59:59 745 4.9% 0.212.0 MB 4.7% 0.57
Aug 12 13:00:00 - 13:59:59 822 5.4% 0.232.1 MB 4.8% 0.59
Aug 12 14:00:00 - 14:59:59 911 6.0% 0.252.5 MB 5.7% 0.71
Aug 12 15:00:00 - 15:59:59 894 5.9% 0.252.4 MB 5.5% 0.68
Aug 12 16:00:00 - 16:59:59 832 5.5% 0.232.3 MB 5.4% 0.66
Aug 12 17:00:00 - 17:59:59 815 5.4% 0.232.2 MB 5.2% 0.64
Aug 12 18:00:00 - 18:59:59 812 5.3% 0.232.4 MB 5.5% 0.68
Aug 12 19:00:00 - 19:59:59 815 5.4% 0.232.1 MB 4.8% 0.59
Aug 12 20:00:00 - 20:59:59 738 4.8% 0.202.2 MB 5.0% 0.62
Aug 12 21:00:00 - 21:59:59 730 4.8% 0.202.0 MB 4.5% 0.56
Aug 12 22:00:00 - 22:59:59 625 4.1% 0.171.9 MB 4.5% 0.55
Aug 12 23:00:00 - 23:59:59 491 3.2% 0.141.5 MB 3.4% 0.42
Aug 13 00:00:00 - 00:59:59 448 2.9% 0.121.3 MB 3.1% 0.38
Aug 13 01:00:00 - 01:59:59 423 2.8% 0.121.4 MB 3.2% 0.40
Aug 13 02:00:00 - 02:59:59 410 2.7% 0.111.4 MB 3.4% 0.41
Aug 13 03:00:00 - 03:59:59 289 1.9% 0.08855.5 KB 1.9% 0.24
Aug 13 04:00:00 - 04:15:00 105 0.7% 0.12383.7 KB 0.9% 0.43
TOTAL: 24:00:00 15228 100.0% 0.1843.2 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.fu-berlin.de 608 48 0 0 0 0 0 0 560
2csiph-out.news.xs4all.nl 499 19 0 0 0 0 0 0 480
3csiph-out.feed.uzoreto.com 474 18 0 1 0 0 0 0 455
4newsfeed.neva.ru 443 85 0 10 0 0 0 0 348
5news-out.mixmin.net 354 7 0 2 0 0 0 0 345
6csiph-out.feeder.erje.net 290 60 0 4 0 0 0 0 226
7csiph-out.news.weretis.net 194 43 0 6 0 0 0 0 145
8news-out.aioe.org 141 101 0 2 0 0 0 0 38
9feeder.eternal-september.org 125 24 0 2 0 0 0 0 99
10news-out.neodome.net 108 2 0 2 0 0 0 0 104
11news.freedyn.net 79 1 0 1 0 50 0 0 27
12newsfeeds.xmission.com 62 3 0 0 0 0 0 0 59
13nntp.pasdenom.info 23 0 0 0 0 0 0 0 23
14csiph-out.news.tnetconsulting.net 22 20 0 0 0 0 0 0 2
15news.swapon.de 4 0 0 0 0 0 0 0 4
16news.fcku.it 2 1 0 0 0 0 0 0 1
17news.samoylyk.net 1 0 0 1 0 0 0 0 0
TOTAL: 17 3429 432 0 31 0 50 0 0 2916

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 83
alt.computer.workshop 48
alt.bbs.synchronet 34
it-alt.sport.calcio.juventus 30
alt.politics.usa 19
trollnet.cinema 17
mozilla.general 16
scinet.stats 16
spline.fli4l.dev 11
mozilla.support.seamonkey 10
alt.hack.nl 8
spline.eisfair 7
alt.paranormal.spells 7
oesterreich.tratsch 6
alt.english.usage 6
alt.survival 6
mozilla.dev.l10n 6
alt.politics 6
mozilla.support.thunderbird 6
alt.philosophy 5
TOTAL: 74 432

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1350
EMP (phn path) 388
EMP (phl) 200
EMP (phn nph) 94
0 89
Too many newsgroups 60
HTML Multipart 25
Scoring filter 6
Too many newsgroups (meow) 4
Binary Payload 4
Binary: misplaced binary 4
Too many newsgroups (low_xpost) 1
TOTAL: 12 2225

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 60
csiph-out.news.xs4all.nl 3
csiph-out.feed.uzoreto.com 3
TOTAL: 3 66
Huge articles
csiph-out.feeder.erje.net 66
csiph-out.feed.uzoreto.com 55
newsfeeds.xmission.com 52
csiph-out.news.weretis.net 12
csiph-out.news.xs4all.nl 10
feeder.eternal-september.org 9
news.freedyn.net 6
news-out.mixmin.net 5
newsfeed.fu-berlin.de 3
csiph-out.news.tnetconsulting.net 2
TOTAL: 11 221
Including strange strings
newsfeed.fu-berlin.de 322
news-out.mixmin.net 85
news-out.aioe.org 19
csiph-out.news.weretis.net 10
news.swapon.de 4
csiph-out.news.xs4all.nl 4
newsfeeds.xmission.com 4
csiph-out.feeder.erje.net 1
csiph-out.feed.uzoreto.com 1
newsfeed.neva.ru 1
TOTAL: 10 451
No colon-space in header
csiph-out.news.xs4all.nl 14
csiph-out.feed.uzoreto.com 4
csiph-out.feeder.erje.net 1
TOTAL: 3 19
TOTAL: 4 757

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 18809 1237 13968 23 0 61 6%23:59:54
2news.bbs.nz 29013 404 14472 51 0 0 1%23:59:53
3fu-berlin.de 14344 283 14061 0 0 0 1%23:59:52
4news.samoylyk.net 15727 279 14931 4 0 116 1%23:59:53
5tnet 17003 182 14746 2 0 0 1%23:59:54
6newsfeed.xs4all.nl 14910 121 14413 11 0 152 0%23:59:53
7news.freedyn.net 15450 60 15093 0 0 21 0%23:59:53
8neva.ru 13678 54 13355 109 0 66 0%23:59:53
9xmission 13027 28 11092 3 0 0 0%23:59:43
10news.uzoreto.com 14814 14 14523 128 0 0 0%23:59:53
11usenet.pasdenom.info 15446 11 14825 8 0 6 0%23:59:53
12erje 14215 6 14000 148 0 0 0%23:59:31
13eternal-september 13108 5 12346 6 0 0 0%23:59:53
14aioe 11502 2 11074 0 0 0 0%23:59:53
15news.swapon.de 1378 1 1365 0 0 0 0%23:54:32
16neodome.net 15480 1 15047 0 0 0 0%23:59:53
17news.mixmin.net 12561 1 12233 0 0 0 0%23:59:46
18weretis.net 14184 0 13979 0 0 0 0%23:59:54
19news.fcku.it 1035 0 1032 0 0 0 0%21:26:25
TOTAL: 19 265684 2689 236555 493 0 422 1%453:18:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs4.8 MB114.9 KB5.0 MB0.1 KB/s4.0 KB23:59:54
2fu-berlin.de2.4 MB0.0 KB2.4 MB0.0 KB/s8.5 KB23:59:52
3news.samoylyk.net2.4 MB3.9 KB2.4 MB0.0 KB/s8.5 KB23:59:53
4news.bbs.nz1.0 MB133.5 KB1.1 MB0.0 KB/s2.6 KB23:59:53
5news.freedyn.net498.9 KB0.0 KB498.9 KB0.0 KB/s8.3 KB23:59:53
6tnet465.2 KB5.3 KB470.4 KB0.0 KB/s2.6 KB23:59:54
7newsfeed.xs4all.nl304.0 KB62.3 KB366.3 KB0.0 KB/s2.8 KB23:59:53
8neva.ru127.4 KB236.5 KB363.9 KB0.0 KB/s2.2 KB23:59:53
9xmission91.8 KB6.1 KB97.9 KB0.0 KB/s3.2 KB23:59:43
10news.mixmin.net36.4 KB0.0 KB36.4 KB0.0 KB/s36.4 KB23:59:46
11news.uzoreto.com34.3 KB286.2 KB320.5 KB0.0 KB/s2.3 KB23:59:53
12usenet.pasdenom.info33.7 KB17.6 KB51.3 KB0.0 KB/s2.7 KB23:59:53
13eternal-september22.1 KB31.8 KB53.8 KB0.0 KB/s4.9 KB23:59:53
14erje17.2 KB440.1 KB457.4 KB0.0 KB/s3.0 KB23:59:31
15aioe4.4 KB0.0 KB4.4 KB0.0 KB/s2.2 KB23:59:53
16neodome.net2.6 KB0.0 KB2.6 KB0.0 KB/s2.6 KB23:59:53
17news.swapon.de1.8 KB0.0 KB1.8 KB0.0 KB/s1.8 KB23:54:32
18weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:26:25
TOTAL: 1912.2 MB1.3 MB13.5 MB0.0 KB/s4.3 KB453:18:21
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ppp-94-68-97-189.home.otenet.gr 1 2756.2 KB 1 0 000:00:21
2a131033.upc-a.chello.nl 12 1835.2 KB 2 0 001:57:47
3047-035-184-231.res.spectrum.com 22 921.9 KB 2 0 006:14:03
TOTAL: 3 35 54113.3 KB 5 0 034:21:04

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.home.otenet.gr 2 2756.2 KB 1 0 000:00:24
2*.upc-a.chello.nl 12 1835.2 KB 2 0 001:57:47
3*.res.spectrum.com 22 921.9 KB 2 0 006:14:03
4*.ph.ph.cox.net 4 00.0 KB 0 0 002:00:18
5unresolved 76 00.0 KB 0 0 024:08:28
6*.static.otenet.gr 2 00.0 KB 0 0 000:00:02
TOTAL: 6 118 54113.3 KB 5 0 034:21:04

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 4.651 1.213 0.00024:08:25
047-035-184-231.res.spectrum.com 1.457 0.363 0.00006:14:03
ip72-222-200-117.ph.ph.cox.net 0.452 0.048 0.00002:00:18
a131033.upc-a.chello.nl 0.877 0.164 0.00001:57:47
ppp-94-68-97-189.home.otenet.gr 0.106 0.016 0.00000:00:21
o04n9v.static.otenet.gr 0.139 0.016 0.00000:00:02
athedsl-152558.home.otenet.gr 0.056 0.024 0.00000:00:02
185.100.87.246 0.134 0.024 0.00000:00:02
192.35.168.220 0.137 0.024 0.00000:00:01
TOTAL: 9 8.009 1.892 0.00034:21:04

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 72
ip72-222-200-117.ph.ph.cox.net 4
185.100.87.246 2
o04n9v.static.otenet.gr 2
192.35.168.220 2
athedsl-152558.home.otenet.gr 1
TOTAL: 6 83

NNRP unrecognized commands (by host):

SystemConn
192.35.168.220 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
047-035-184-231.res.spectrum.com 9 1
ip72-222-200-117.ph.ph.cox.net 4 0
91.187.33.87 1 0
TOTAL: 3 14 2

Newsgroup request counts (by category):

CategoryCountPct
1comp 54100.0%
TOTAL: 1 54100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 54
TOTAL: 1 54