Daily Usenet report for csiph.com

Sep 22 04:15:00 -- Sep 23 04:15:00

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Sep 22 21:42:14 csiph nnrpd[45233]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Sep 22 21:42:14 csiph nnrpd[45233]: 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]
Sep 22 22:04:39 csiph nnrpd[46393]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Sep 22 22:04:39 csiph nnrpd[46393]: 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]
Sep 22 22:23:57 csiph nnrpd[47382]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Sep 22 22:23:57 csiph nnrpd[47382]: 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]
Sep 22 22:44:08 csiph nnrpd[48427]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Sep 22 22:44:08 csiph nnrpd[48427]: 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]
Sep 23 01:52:53 csiph nnrpd[58678]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Sep 23 01:52:53 csiph nnrpd[58678]: 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 19029 49.3%4.9 MB 64.7%
innd 15303 39.6%2.0 MB 26.3%
innfeed 3528 9.1%622.6 KB 8.0%
nnrpd 716 1.9%78.5 KB 1.0%
nocem 33 0.1%4.0 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 38610 100.0%7.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 289581 53.9%
Negative hits 225244 41.9%
Do not exist 18299 3.4%
Cache misses 3974 0.7%
TOTAL: 4 537098 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.335 0.0%38 0.000 8.816 27.500
article cleanup00:00:00.110 0.0%17508 0.000 0.006 0.031
article logging00:00:00.315 0.0%18089 0.000 0.017 0.368
article parse00:00:01.300 0.0%90458 0.000 0.014 0.076
article write00:00:24.491 0.0%15477 0.183 1.582 61.260
artlog/artcncl00:00:00.000 0.0%38 0.000 0.000 0.000
artlog/artparse00:00:00.032 0.0%921 0.000 0.035 3.667
data move00:00:00.225 0.0%544814 0.000 0.000 0.002
hisgrep/artcncl00:00:00.016 0.0%37 0.000 0.432 1.167
hishave/artcncl00:00:00.008 0.0%38 0.000 0.211 0.667
hishave/artparse00:00:00.002 0.0%908 0.000 0.002 0.100
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.844 0.0%538739 0.001 0.018 0.101
history sync00:00:01.037 0.0%373 0.000 2.780 16.333
history write00:00:15.763 0.0%17478 0.254 0.902 15.722
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hiswrite/artparse00:00:00.469 0.0%908 0.000 0.517 3.200
idle23:57:46.459 99.8%546335 62.180 157.900 580.279
nntp read00:00:02.167 0.0%548970 0.001 0.004 0.008
overview write00:01:20.629 0.1%15477 0.141 5.210 499.900
perl filter00:00:24.671 0.0%17464 1.085 1.413 2.778
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.269 0.0%30987 0.000 0.009 0.029
TOTAL: 24:01:02.71424:00:28.142100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.063 0.0%56755 0.000 0.001 0.024
article prepare00:00:00.002 0.0%18732 0.000 0.000 0.010
article read00:00:03.041 0.0%4104 0.000 0.741 7.333
backlog stats00:00:00.194 0.0%336785 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.217 0.0%260545 0.000 0.005 0.010
data write00:00:01.470 0.0%246623 0.000 0.006 0.019
idle23:53:39.256100.0%336785 34.697 255.413 865.330
status file00:00:00.498 0.0%309 0.000 1.612 8.171
TOTAL: 23:53:53.27023:53:45.741100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle30:24:12.394 99.8%494 297.333221563.551600009.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.010 0.0%1360 0.000 0.007 0.167
readart00:00:00.499 0.0%45 0.000 11.089 42.000
TOTAL: 30:27:19.94630:24:12.903 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.xs4all.nl 516 17672 3485 12579 1608 19%68:15:36
2news-out.mixmin.net 3 16126 2421 13555 150 15%24:08:48
3newsfeeds.xmission.com 2 15515 2412 13047 56 15%25:27:23
4feeder.eternal-september.org 4 17192 2287 14862 43 13%25:57:41
5news-out.aioe.org 3 14323 1159 13087 77 8%24:09:31
6newsfeed.fu-berlin.de 11 11598 757 10836 5 6%18:48:10
7csiph-out.news.weretis.net 3 19843 748 19004 91 3%32:21:19
8csiph-out.feeder.erje.net 1439 72520 735 71575 210 1%118:47:11
9newsfeed.neva.ru 152 10647 583 9831 233 5%71:28:08
10news.fcku.it 8 2081 266 1804 11 12%21:21:54
11csiph-out.feed.uzoreto.com 864 22109 171 21649 289 0%71:21:54
12news-out.neodome.net 1 16542 152 16323 67 0%23:59:54
13nntp.pasdenom.info 5 13321 66 13188 67 0%19:53:54
14news.swapon.de 7 1708 46 1662 0 2%23:15:06
15news.freedyn.net 2 17925 22 17871 32 0%23:59:43
16csiph-out.news.tnetconsulting.net 2 23270 18 23248 4 0%34:24:55
17news.bbs.nz 2 14106 3 14103 0 0%23:59:48
18localhost 26 0 0 0 0 0%00:00:04
TOTAL: 18 3050 306498 15331 288224 2943 5%651:40:59
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.xs4all.nl9.5 MB14.7 KB65.3 MB74.7 MB 12%15.0 KB
2news-out.mixmin.net7.6 MB12.3 KB274.9 KB7.9 MB 96%3.1 KB
3newsfeeds.xmission.com7.3 MB0.0 KB3.0 MB10.3 MB 71%4.3 KB
4feeder.eternal-september.org6.4 MB12.3 KB824.4 KB7.2 MB 88%3.2 KB
5news-out.aioe.org4.4 MB12.3 KB193.9 KB4.6 MB 95%3.8 KB
6csiph-out.feeder.erje.net3.7 MB49.4 KB4.1 MB7.8 MB 47%8.5 KB
7csiph-out.news.weretis.net2.5 MB11.0 KB947.0 KB3.4 MB 72%4.2 KB
8newsfeed.fu-berlin.de1.6 MB0.0 KB67.4 KB1.7 MB 96%2.3 KB
9newsfeed.neva.ru1.6 MB33.0 KB615.3 KB2.2 MB 71%2.8 KB
10csiph-out.feed.uzoreto.com693.2 KB20.1 KB17.7 MB18.4 MB 3%41.0 KB
11news-out.neodome.net417.5 KB12.5 KB1.2 MB1.6 MB 25%7.4 KB
12news.fcku.it396.6 KB0.0 KB14.2 KB410.7 KB 96%1.5 KB
13news.freedyn.net225.2 KB11.0 KB1.3 MB1.5 MB 14%28.4 KB
14news.swapon.de164.8 KB0.0 KB0.0 KB164.8 KB100%3.6 KB
15nntp.pasdenom.info136.4 KB9.3 KB93.3 KB239.0 KB 57%1.8 KB
16csiph-out.news.tnetconsulting.net72.2 KB1.8 KB159.0 KB233.0 KB 30%10.6 KB
17news.bbs.nz9.9 KB0.0 KB0.0 KB9.9 KB100%3.3 KB
18localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1846.7 MB199.6 KB95.6 MB142.5 MB 32%8.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 22 04:15:00 - 04:59:59 248 1.6% 0.09861.8 KB 1.8% 0.32
Sep 22 05:00:00 - 05:59:59 392 2.5% 0.111.2 MB 2.6% 0.35
Sep 22 06:00:00 - 06:59:59 568 3.7% 0.161.5 MB 3.2% 0.42
Sep 22 07:00:00 - 07:59:59 792 5.1% 0.222.8 MB 6.0% 0.81
Sep 22 08:00:00 - 08:59:59 903 5.8% 0.253.8 MB 8.1% 1.07
Sep 22 09:00:00 - 09:59:59 877 5.7% 0.243.1 MB 6.7% 0.89
Sep 22 10:00:00 - 10:59:59 703 4.5% 0.202.3 MB 4.9% 0.65
Sep 22 11:00:00 - 11:59:59 669 4.3% 0.191.8 MB 3.7% 0.50
Sep 22 12:00:00 - 12:59:59 764 4.9% 0.212.2 MB 4.8% 0.64
Sep 22 13:00:00 - 13:59:59 863 5.6% 0.242.2 MB 4.7% 0.63
Sep 22 14:00:00 - 14:59:59 850 5.5% 0.242.4 MB 5.1% 0.67
Sep 22 15:00:00 - 15:59:59 765 4.9% 0.212.1 MB 4.5% 0.60
Sep 22 16:00:00 - 16:59:59 894 5.8% 0.252.5 MB 5.4% 0.71
Sep 22 17:00:00 - 17:59:59 945 6.1% 0.262.7 MB 5.8% 0.78
Sep 22 18:00:00 - 18:59:59 822 5.3% 0.232.6 MB 5.6% 0.75
Sep 22 19:00:00 - 19:59:59 782 5.1% 0.222.2 MB 4.6% 0.62
Sep 22 20:00:00 - 20:59:59 714 4.6% 0.202.0 MB 4.3% 0.57
Sep 22 21:00:00 - 21:59:59 658 4.3% 0.181.9 MB 4.0% 0.54
Sep 22 22:00:00 - 22:59:59 528 3.4% 0.151.5 MB 3.2% 0.43
Sep 22 23:00:00 - 23:59:59 488 3.2% 0.141.4 MB 3.0% 0.40
Sep 23 00:00:00 - 00:59:59 370 2.4% 0.101.1 MB 2.3% 0.30
Sep 23 01:00:00 - 01:59:59 292 1.9% 0.08977.4 KB 2.0% 0.27
Sep 23 02:00:00 - 02:59:59 234 1.5% 0.07721.7 KB 1.5% 0.20
Sep 23 03:00:00 - 03:59:59 245 1.6% 0.07830.8 KB 1.7% 0.23
Sep 23 04:00:00 - 04:15:00 95 0.6% 0.11249.1 KB 0.5% 0.28
TOTAL: 24:00:00 15461 100.0% 0.1846.9 MB 100.0% 0.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1647 91 0 4 0 0 0 0 1552
2newsfeed.fu-berlin.de 428 5 0 0 0 0 0 0 423
3csiph-out.feed.uzoreto.com 289 9 0 3 0 0 0 0 277
4newsfeed.neva.ru 224 57 0 6 0 0 0 0 161
5news-out.mixmin.net 199 3 0 3 0 0 0 0 193
6csiph-out.feeder.erje.net 195 59 0 11 0 0 0 0 125
7csiph-out.news.weretis.net 135 38 0 3 0 0 0 0 94
8news-out.aioe.org 119 61 0 3 0 0 0 0 55
9news-out.neodome.net 68 0 0 3 0 0 0 0 65
10nntp.pasdenom.info 67 0 0 1 0 0 0 0 66
11newsfeeds.xmission.com 65 3 0 0 0 0 0 0 62
12feeder.eternal-september.org 41 28 0 3 0 0 0 0 10
13news.freedyn.net 32 0 0 2 0 0 0 0 30
14news.fcku.it 11 11 0 0 0 0 0 0 0
15news.swapon.de 10 0 0 0 0 0 0 0 10
16csiph-out.news.tnetconsulting.net 1 0 0 1 0 0 0 0 0
TOTAL: 16 3531 365 0 43 0 0 0 0 3123

Unwanted newsgroups [Top 20]:

NewsgroupCount
it-alt.sport.calcio.juventus 60
alt.bbs.synchronet 32
lada.auto 24
scinet.stats 23
lada.talk 18
alt.survival 13
alt.binaries.pictures.purebeauty 13
mozilla.support.thunderbird 12
alt.windows7.general 11
alt.math.undergrad 11
alt.philosophy 10
lada.kitchen 9
mozilla.support.seamonkey 8
mozilla.dev.apps.seamonkey 8
mozilla.general 7
cakewalk.audio 7
alt.politics.usa 6
alt.politics 5
alt.computer.workshop 5
alt.tv.comedy-central.daily-show 4
TOTAL: 79 365

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1051
EMP (phn path) 165
EMP (phl) 148
0 106
Too many newsgroups 80
EMP (phn nph) 51
Too many newsgroups (meow) 5
HTML Multipart 4
Binary: misplaced binary 4
Scoring filter 4
HTML post 2
TOTAL: 11 1620

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
csiph-out.feed.uzoreto.com 1
TOTAL: 1 1
Bad Message-ID's offered
csiph-out.feeder.erje.net 65
csiph-out.feed.uzoreto.com 6
csiph-out.news.xs4all.nl 5
TOTAL: 3 76
Huge articles
csiph-out.news.xs4all.nl 580
csiph-out.feed.uzoreto.com 153
csiph-out.feeder.erje.net 78
newsfeeds.xmission.com 43
news.freedyn.net 22
news-out.neodome.net 18
csiph-out.news.weretis.net 6
feeder.eternal-september.org 6
newsfeed.fu-berlin.de 1
TOTAL: 9 907
Including strange strings
newsfeed.fu-berlin.de 419
news-out.mixmin.net 50
csiph-out.news.xs4all.nl 46
news-out.aioe.org 37
newsfeeds.xmission.com 14
news.swapon.de 10
csiph-out.news.weretis.net 3
newsfeed.neva.ru 3
TOTAL: 8 582
No colon-space in header
csiph-out.news.xs4all.nl 9
csiph-out.feed.uzoreto.com 2
csiph-out.feeder.erje.net 1
TOTAL: 3 12
TOTAL: 5 1578

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1usenet.pasdenom.info 68593 1614 19320 574 0 34847 2%23:59:41
2news.bbs.nz 28492 1384 13639 15 0 0 4%23:50:07
3fu-berlin.de 14338 338 14000 0 0 0 2%23:59:54
4tnet 18151 319 14717 0 0 0 1%23:50:08
5neva.ru 14180 143 13901 28 0 0 1%23:59:46
6news.freedyn.net 15294 36 15000 0 0 0 0%23:59:54
7eternal-september 13336 35 12637 71 0 0 0%23:58:45
8aioe 11399 15 11057 0 0 0 0%23:57:58
9xmission 14222 15 12529 3 0 0 0%23:59:36
10newsfeed.xs4all.nl 12211 14 11826 1 0 0 0%23:50:07
11erje 15132 12 14439 3 0 0 0%23:59:54
12neodome.net 15506 9 15206 0 0 0 0%23:50:37
13news.mixmin.net 12571 3 12330 0 0 0 0%23:59:54
14weretis.net 14716 2 14140 0 0 0 0%23:54:21
15news.uzoreto.com 14073 1 13815 12 0 0 0%23:50:07
16news.swapon.de 1850 1 1787 0 0 0 0%23:44:28
17news.samoylyk.net 0 0 0 0 0 15398 0%23:50:08
18xanadu-bbs 0 0 0 0 0 15461 0%23:58:54
19news.fcku.it 1608 0 1608 0 0 0 0%20:36:24
TOTAL: 19 285672 3941 211951 707 0 65706 1%451:10:43
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1usenet.pasdenom.info4.4 MB1.4 MB5.8 MB0.1 KB/s2.7 KB23:59:41
2news.bbs.nz3.9 MB62.0 KB3.9 MB0.0 KB/s2.9 KB23:50:07
3fu-berlin.de2.7 MB0.0 KB2.7 MB0.0 KB/s8.2 KB23:59:54
4tnet868.2 KB0.0 KB868.2 KB0.0 KB/s2.7 KB23:50:08
5news.freedyn.net426.0 KB0.0 KB426.0 KB0.0 KB/s11.8 KB23:59:54
6neva.ru370.6 KB77.1 KB447.6 KB0.0 KB/s2.6 KB23:59:46
7eternal-september123.6 KB256.1 KB379.6 KB0.0 KB/s3.6 KB23:58:45
8aioe48.1 KB0.0 KB48.1 KB0.0 KB/s3.2 KB23:57:58
9news.mixmin.net47.2 KB0.0 KB47.2 KB0.0 KB/s15.7 KB23:59:54
10neodome.net36.3 KB0.0 KB36.3 KB0.0 KB/s4.0 KB23:50:37
11erje33.3 KB27.3 KB60.6 KB0.0 KB/s4.0 KB23:59:54
12xmission30.5 KB4.0 KB34.5 KB0.0 KB/s1.9 KB23:59:36
13newsfeed.xs4all.nl26.7 KB2.1 KB28.8 KB0.0 KB/s1.9 KB23:50:07
14weretis.net15.1 KB0.0 KB15.1 KB0.0 KB/s7.6 KB23:54:21
15news.swapon.de1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:44:28
16news.uzoreto.com1.1 KB42.8 KB44.0 KB0.0 KB/s3.4 KB23:50:07
17news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:08
18xanadu-bbs0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:54
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s020:36:24
TOTAL: 1912.9 MB1.9 MB14.8 MB0.0 KB/s3.3 KB451:10:43
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1096-042-018-108.res.spectrum.com 10 2348.5 KB 7 0 000:38:19
2a131033.upc-a.chello.nl 21 1633.9 KB 4 0 003:24:03
3ip72-222-200-117.ph.ph.cox.net 7 68.0 KB 8 0 004:21:47
TOTAL: 3 38 4590.4 KB 19 0 030:27:19

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 10 2348.5 KB 7 0 000:38:19
2*.upc-a.chello.nl 21 1633.9 KB 4 0 003:24:03
3*.ph.ph.cox.net 7 68.0 KB 8 0 004:21:47
4*.range5-81.btcentralplus.com 5 00.0 KB 0 0 000:33:31
5*.net.upcbroadband.cz 24 00.0 KB 0 0 007:51:42
6unresolved 46 00.0 KB 0 0 013:37:54
TOTAL: 6 113 4590.4 KB 19 0 030:27:19

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 2.962 0.710 0.00013:37:40
ip-89-176-128-12.net.upcbroadband.cz 1.784 0.383 0.00007:51:42
ip72-222-200-117.ph.ph.cox.net 0.796 0.175 0.00004:21:47
a131033.upc-a.chello.nl 1.603 0.277 0.00003:24:03
096-042-018-108.res.spectrum.com 0.955 0.169 0.00000:38:19
host5-81-182-102.range5-81.btcentralplus.com 0.323 0.093 0.00000:33:31
162.243.128.90 0.064 0.016 0.00000:00:09
151.36.169.84 0.180 0.054 0.00000:00:03
TOTAL: 8 8.667 1.877 0.00030:27:19

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 42
ip-89-176-128-12.net.upcbroadband.cz 24
host5-81-182-102.range5-81.btcentralplus.com 5
151.36.169.84 3
162.243.128.90 1
TOTAL: 5 75

NNRP client timeouts [Top 20]:

SystemConnPeer
ip72-222-200-117.ph.ph.cox.net 8 0
096-042-018-108.res.spectrum.com 2 1
ip-89-176-128-12.net.upcbroadband.cz 1 0
TOTAL: 3 11 1

Newsgroup request counts (by category):

CategoryCountPct
1comp 47100.0%
TOTAL: 1 47100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 43
2comp.sys.3b1 4
TOTAL: 2 47