Daily Usenet report for csiph.com

Mar 7 04:15:00 -- Mar 8 04:15:00

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Mar 7 19:52:44 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[42647]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Mar 7 19:52:44 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[42647]: 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]
Mar 7 19:53:06 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[42649]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Mar 7 19:53:06 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[42649]: 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]
Mar 7 21:26:13 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[47910]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Mar 7 21:26:13 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[47910]: 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]
Mar 7 22:15:59 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[50631]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Mar 7 22:15:59 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[50631]: 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 20559 46.2%4.5 MB 53.7%
innd 18212 40.9%2.9 MB 34.6%
innfeed 3695 8.3%705.1 KB 8.2%
nnrpd 2054 4.6%293.9 KB 3.4%
nocem 16 0.0%2.3 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 44537 100.0%8.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 224657 51.1%
Negative hits 194933 44.3%
Do not exist 19993 4.5%
Cache misses 244 0.1%
TOTAL: 4 439827 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.187 0.0%41 0.000 28.951 207.000
article cleanup00:00:00.101 0.0%19628 0.000 0.005 0.033
article logging00:00:00.918 0.0%20000 0.000 0.046 1.107
article parse00:00:01.978 0.0%62486 0.000 0.032 0.270
article write00:01:22.851 0.1%12321 0.150 6.724 52.500
artlog/artcncl00:00:00.016 0.0%41 0.000 0.390 15.000
artlog/artparse00:00:00.024 0.0%481 0.000 0.050 2.000
data move00:00:00.165 0.0%426931 0.000 0.000 0.002
hisgrep/artcncl00:00:00.185 0.0%39 0.000 4.744 112.000
hishave/artcncl00:00:00.006 0.0%41 0.000 0.146 1.000
hishave/artparse00:00:00.002 0.0%478 0.000 0.004 0.023
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:40.839 0.0%442547 0.002 0.092 0.387
history sync00:00:01.632 0.0%379 0.000 4.306 56.000
history write00:00:54.273 0.1%19631 0.233 2.765 9.955
hiswrite/artcncl00:00:00.029 0.0%2 12.000 14.500 17.000
hiswrite/artparse00:00:01.467 0.0%478 0.000 3.069 20.083
idle23:39:23.462 98.8%420818 90.287 202.376 687.063
nntp read00:00:02.057 0.0%428449 0.001 0.005 0.132
overview write00:13:10.787 0.9%12321 0.188 64.182 29348.368
perl filter00:00:22.783 0.0%19627 0.649 1.161 7.093
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.215 0.0%24658 0.000 0.009 0.033
TOTAL: 23:56:59.66123:56:04.977 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.047 0.0%12467 0.000 0.004 0.163
article prepare00:00:00.001 0.0%3828 0.000 0.000 0.062
article read00:00:02.600 0.0%843 0.000 3.084 229.000
backlog stats00:00:00.164 0.0%237222 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.771 0.0%185339 0.000 0.004 0.012
data write00:00:01.130 0.0%173833 0.000 0.007 0.025
idle24:05:37.421100.0%237222 180.002 365.638 1523.556
status file00:00:00.810 0.0%384 0.000 2.109 307.000
TOTAL: 24:05:52.11824:05:42.944100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle37:27:27.256 99.4%1136 0.000118703.570600138.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.064 0.0%2669 0.000 0.024 5.143
TOTAL: 37:41:32.65237:27:27.320 99.4%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feeder.eternal-september.org 13 3739 1851 1713 175 49%27:33:41
2csiph-out.news.xs4all.nl 0 4194 1667 1747 780 39%72:36:26
3news-out.mixmin.net 1 13381 1536 11569 276 11%23:59:50
4newsfeeds.xmission.com 3 11402 1417 9976 9 12%23:16:49
5news.freedyn.net 2 14445 1366 12426 653 9%23:59:19
6csiph-out.feeder.erje.net 1440 62744 876 61688 180 1%119:08:18
7csiph-out.news.weretis.net 2 24929 790 24020 119 3%47:59:50
8newsfeed.fu-berlin.de 7 17225 646 11637 4942 3%24:22:58
9csiph-out.feed.uzoreto.com 864 20109 628 19076 405 3%71:21:29
10news-out.aioe.org 1 11456 540 10881 35 4%23:59:57
11newsfeed.neva.ru 143 15795 457 15092 246 2%71:25:43
12news-out.neodome.net 2 13910 373 13528 9 2%23:59:53
13news.fcku.it 13 1172 99 1059 14 8%21:21:24
14nntp.pasdenom.info 3 7769 68 7701 0 0%24:49:03
15csiph-out.news.tnetconsulting.net 2 12228 40 12178 10 0%23:59:55
16news.swapon.de 8 1084 36 1048 0 3%23:11:33
17news.bbs.nz 1 12086 6 12080 0 0%23:59:51
18localhost 26 0 0 0 0 0%00:00:00
TOTAL: 18 2531 247668 12396 227419 7853 5%671:05:59
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder.eternal-september.org5.5 MB0.0 KB5.1 MB10.6 MB 51%5.3 KB
2csiph-out.feeder.erje.net5.5 MB0.0 KB3.1 MB8.5 MB 64%8.3 KB
3csiph-out.news.xs4all.nl4.6 MB0.0 KB4.3 MB8.9 MB 51%3.7 KB
4newsfeeds.xmission.com4.1 MB0.0 KB469.5 KB4.6 MB 89%3.3 KB
5news.freedyn.net3.6 MB0.0 KB4.3 MB7.8 MB 45%4.0 KB
6news-out.mixmin.net3.3 MB0.0 KB633.1 KB3.9 MB 84%2.2 KB
7csiph-out.feed.uzoreto.com2.3 MB0.0 KB7.3 MB9.6 MB 24%9.5 KB
8csiph-out.news.weretis.net2.2 MB0.0 KB2.1 MB4.2 MB 50%4.8 KB
9news-out.aioe.org1.8 MB0.0 KB43.1 KB1.9 MB 97%3.3 KB
10newsfeed.fu-berlin.de1.4 MB0.0 KB27.6 MB29.0 MB 4%5.3 KB
11newsfeed.neva.ru1.2 MB0.0 KB539.2 KB1.8 MB 70%2.6 KB
12news-out.neodome.net1.0 MB0.0 KB64.5 KB1.1 MB 94%2.9 KB
13csiph-out.news.tnetconsulting.net178.6 KB0.0 KB23.3 KB201.9 KB 88%4.0 KB
14news.fcku.it149.8 KB0.0 KB16.7 KB166.5 KB 89%1.5 KB
15nntp.pasdenom.info137.2 KB0.0 KB0.0 KB137.2 KB100%2.0 KB
16news.swapon.de92.1 KB0.0 KB0.0 KB92.1 KB100%2.6 KB
17news.bbs.nz10.7 KB0.0 KB0.0 KB10.7 KB100%1.8 KB
18localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1837.0 MB0.0 KB55.4 MB92.5 MB 40%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 7 04:15:00 - 04:59:59 164 1.3% 0.06519.5 KB 1.4% 0.19
Mar 7 05:00:00 - 05:59:59 211 1.7% 0.06635.5 KB 1.7% 0.18
Mar 7 06:00:00 - 06:59:59 374 3.0% 0.101.2 MB 3.3% 0.34
Mar 7 07:00:00 - 07:59:59 427 3.5% 0.121.4 MB 3.8% 0.40
Mar 7 08:00:00 - 08:59:59 506 4.1% 0.142.2 MB 5.9% 0.62
Mar 7 09:00:00 - 09:59:59 590 4.8% 0.161.5 MB 4.2% 0.44
Mar 7 10:00:00 - 10:59:59 634 5.1% 0.181.6 MB 4.4% 0.46
Mar 7 11:00:00 - 11:59:59 592 4.8% 0.161.5 MB 4.1% 0.43
Mar 7 12:00:00 - 12:59:59 614 5.0% 0.171.5 MB 4.2% 0.44
Mar 7 13:00:00 - 13:59:59 528 4.3% 0.151.6 MB 4.4% 0.46
Mar 7 14:00:00 - 14:59:59 740 6.0% 0.212.1 MB 5.6% 0.59
Mar 7 15:00:00 - 15:59:59 763 6.2% 0.212.0 MB 5.3% 0.56
Mar 7 16:00:00 - 16:59:59 738 6.0% 0.201.7 MB 4.7% 0.49
Mar 7 17:00:00 - 17:59:59 837 6.8% 0.233.1 MB 8.3% 0.87
Mar 7 18:00:00 - 18:59:59 745 6.0% 0.212.1 MB 5.8% 0.60
Mar 7 19:00:00 - 19:59:59 659 5.3% 0.182.1 MB 5.8% 0.61
Mar 7 20:00:00 - 20:59:59 650 5.3% 0.181.8 MB 5.0% 0.52
Mar 7 21:00:00 - 21:59:59 526 4.3% 0.151.6 MB 4.2% 0.44
Mar 7 22:00:00 - 22:59:59 414 3.4% 0.121.2 MB 3.4% 0.35
Mar 7 23:00:00 - 23:59:59 453 3.7% 0.131.7 MB 4.7% 0.49
Mar 8 00:00:00 - 00:59:59 373 3.0% 0.101.2 MB 3.4% 0.35
Mar 8 01:00:00 - 01:59:59 229 1.9% 0.06680.0 KB 1.8% 0.19
Mar 8 02:00:00 - 02:59:59 220 1.8% 0.06653.9 KB 1.7% 0.18
Mar 8 03:00:00 - 03:59:59 281 2.3% 0.08879.3 KB 2.3% 0.24
Mar 8 04:00:00 - 04:15:00 69 0.6% 0.08224.5 KB 0.6% 0.25
TOTAL: 24:00:00 12337 100.0% 0.1436.8 MB 100.0% 0.44
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.fu-berlin.de 5276 7 0 0 0 0 0 0 5269
2csiph-out.news.xs4all.nl 810 36 0 0 0 0 0 0 774
3news.freedyn.net 653 11 0 0 0 0 0 0 642
4csiph-out.feed.uzoreto.com 422 33 0 0 0 0 0 0 389
5news-out.mixmin.net 287 22 0 0 0 0 0 0 265
6newsfeed.neva.ru 249 37 0 0 0 0 0 0 212
7feeder.eternal-september.org 176 29 0 0 0 0 0 0 147
8csiph-out.feeder.erje.net 120 42 0 0 0 0 0 0 78
9csiph-out.news.weretis.net 93 37 0 0 0 0 0 0 56
10news-out.aioe.org 35 26 0 0 0 0 0 0 9
11news.swapon.de 16 0 0 0 0 0 0 0 16
12news.fcku.it 14 14 0 0 0 0 0 0 0
13newsfeeds.xmission.com 12 2 0 0 0 0 0 0 10
14csiph-out.news.tnetconsulting.net 9 7 0 0 0 0 0 0 2
15news-out.neodome.net 9 3 0 0 0 0 0 0 6
TOTAL: 15 8181 306 0 0 0 0 0 0 7875

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 81
it-alt.sport.calcio.juventus 54
alt.bbs.synchronet 24
scinet.stats 23
lada.talk 19
alt.music.pink-floyd.publius 11
alt.binaries.by-hash.shv1 10
alt.binaries.pictures.purebeauty 9
oesterreich.tratsch 7
alt.politics 4
alt.politics.usa 4
mozilla.support.firefox 4
alt.windows7.general 4
alt.binaries.pictures.sierra 3
alt.philosophy 3
lada.movies 2
alt.binaries.ebook 2
free.it.religioni.scientology 2
mozilla.support.thunderbird 2
mozilla.test 2
TOTAL: 52 306

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 4815
EMP (md5) 1749
EMP (phl) 177
Too many newsgroups 156
0 46
EMP (phn path) 40
EMP (phn nph) 21
hierarchy violation - crosspost outside sdnet 10
Scoring filter 6
HTML Multipart 1
TOTAL: 10 7021

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
csiph-out.news.xs4all.nl 1
TOTAL: 1 1
Bad Message-ID's offered
csiph-out.feeder.erje.net 55
csiph-out.news.xs4all.nl 1
csiph-out.feed.uzoreto.com 1
TOTAL: 3 57
Huge articles
newsfeed.fu-berlin.de 170
csiph-out.feed.uzoreto.com 82
feeder.eternal-september.org 57
csiph-out.feeder.erje.net 52
news.freedyn.net 46
csiph-out.news.xs4all.nl 40
csiph-out.news.weretis.net 20
newsfeeds.xmission.com 5
news-out.mixmin.net 3
csiph-out.news.tnetconsulting.net 2
TOTAL: 11 478
Including strange strings
newsfeed.fu-berlin.de 291
csiph-out.news.xs4all.nl 24
news.swapon.de 16
csiph-out.feed.uzoreto.com 11
news-out.mixmin.net 10
csiph-out.news.weretis.net 9
newsfeeds.xmission.com 5
newsfeed.neva.ru 3
feeder.eternal-september.org 2
csiph-out.feeder.erje.net 1
TOTAL: 10 372
No colon-space in header
csiph-out.news.xs4all.nl 2
csiph-out.feeder.erje.net 1
TOTAL: 2 3
TOTAL: 5 911

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1fu-berlin.de 11486 464 11022 0 0 0 4%23:50:03
2news.bbs.nz 22953 117 11673 17 0 0 0%23:50:03
3newsfeed.xs4all.nl 11300 81 10575 1 0 75 0%23:59:51
4xmission 12153 66 10181 3 0 0 0%23:50:03
5usenet.pasdenom.info 12048 38 11728 13 0 7 0%23:57:17
6erje 11630 27 11172 16 0 0 0%23:50:03
7tnet 12492 21 11854 3 0 0 0%24:05:06
8news.freedyn.net 10827 10 10610 44 0 43 0%23:54:14
9neodome.net 12015 7 11796 0 0 0 0%23:59:14
10news.uzoreto.com 11341 4 11225 13 0 0 0%23:58:12
11news.mixmin.net 10124 4 9993 0 0 0 0%23:55:10
12weretis.net 11164 2 10899 4 0 0 0%23:50:03
13neva.ru 11248 1 11163 0 0 0 0%23:50:03
14eternal-september 0 0 0 0 0 9908 0%23:50:03
15xanadu-bbs 0 0 0 0 0 12299 0%23:50:08
16news.swapon.de 1133 0 1125 0 0 0 0%23:16:33
17news.fcku.it 973 0 971 0 0 0 0%21:12:22
18news.samoylyk.net 0 0 0 0 0 12326 0%23:58:35
19aioe 10130 0 9895 0 0 0 0%23:56:23
TOTAL: 19 173017 842 155882 114 0 34658 0%450:53:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1fu-berlin.de4.4 MB0.0 KB4.4 MB0.1 KB/s9.7 KB23:50:03
2news.bbs.nz336.1 KB37.8 KB373.9 KB0.0 KB/s2.8 KB23:50:03
3newsfeed.xs4all.nl223.6 KB3.4 KB227.0 KB0.0 KB/s2.8 KB23:59:51
4xmission178.0 KB5.3 KB183.4 KB0.0 KB/s2.7 KB23:50:03
5usenet.pasdenom.info96.2 KB16.0 KB112.2 KB0.0 KB/s2.2 KB23:57:17
6neodome.net78.6 KB0.0 KB78.6 KB0.0 KB/s11.2 KB23:59:14
7erje44.5 KB46.7 KB91.3 KB0.0 KB/s2.1 KB23:50:03
8tnet44.3 KB8.7 KB53.0 KB0.0 KB/s2.2 KB24:05:06
9news.uzoreto.com30.6 KB56.9 KB87.6 KB0.0 KB/s5.2 KB23:58:12
10news.freedyn.net24.0 KB799.6 KB823.6 KB0.0 KB/s15.3 KB23:54:14
11news.mixmin.net7.8 KB0.0 KB7.8 KB0.0 KB/s2.0 KB23:55:10
12weretis.net4.8 KB9.8 KB14.6 KB0.0 KB/s2.4 KB23:50:03
13neva.ru1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:50:03
14eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:03
15xanadu-bbs0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:08
16news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:16:33
17news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:12:22
18news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:35
19aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:23
TOTAL: 195.5 MB984.2 KB6.4 MB0.0 KB/s6.9 KB450:53:26
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1a131033.upc-a.chello.nl 51 00.0 KB 0 0 008:23:38
2host31-49-229-214.range31-49.btcentralplus.com 4 00.0 KB 0 0 000:16:10
3scan-141.security.ipip.net 1 00.0 KB 0 0 000:00:01
4172.83.100.239 2 00.0 KB 0 0 001:00:04
5111.7.96.132 1 00.0 KB 0 0 000:00:05
691.187.33.87 230 00.0 KB 0 0 020:37:30
7192.163.24.10.ip.us.as30241.net 7 00.0 KB 0 0 003:31:46
8188.166.154.116 1 00.0 KB 0 0 000:00:10
9ip-78-102-198-192.net.upcbroadband.cz 45 00.0 KB 0 0 003:41:32
10192.241.228.212 1 00.0 KB 0 0 000:00:09
TOTAL: 10 343 00.0 KB 0 0 037:31:11

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.163.24.10.ip.us.as30241.net 7 00.0 KB 0 0 003:31:46
2unresolved 235 00.0 KB 0 0 021:38:01
3*.upc-a.chello.nl 51 00.0 KB 0 0 008:23:38
4*.range31-49.btcentralplus.com 4 00.0 KB 0 0 000:16:10
5*.security.ipip.net 1 00.0 KB 0 0 000:00:01
6*.net.upcbroadband.cz 45 00.0 KB 0 0 003:41:32
TOTAL: 6 343 00.0 KB 0 0 037:31:11

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 14.005 2.956 0.00020:37:30
a131033.upc-a.chello.nl 3.154 0.621 0.00008:23:38
ip-78-102-198-192.net.upcbroadband.cz 2.793 0.506 0.00003:41:32
192.163.24.10.ip.us.as30241.net 0.513 0.092 0.00003:31:46
172.83.100.239 0.212 0.015 0.00001:00:04
host31-49-229-214.range31-49.btcentralplus.com 0.257 0.052 0.00000:16:10
188.166.154.116 0.065 0.009 0.00000:00:10
192.241.228.212 0.045 0.027 0.00000:00:09
111.7.96.132 0.055 0.024 0.00000:00:05
scan-141.security.ipip.net 0.068 0.007 0.00000:00:01
TOTAL: 10 21.167 4.309 0.00037:31:11

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
Host: 69.160.37.58:119 1
User-Agent: HTTP Banner Detection (https... 1
Connection: close 1
GET / HTTP/1.1 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
192.163.24.10.ip.us.as30241.net 7 0
172.83.100.239 2 0
TOTAL: 2 9 1
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: admin@kev009.com