Daily Usenet report for csiph.com

Nov 19 04:15:00 -- Nov 20 04:15:00

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Nov 19 08:11:02 csiph nnrpd[14640]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 19 08:11:02 csiph nnrpd[14640]: 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 19 08:45:52 csiph nnrpd[16020]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 19 08:45:52 csiph nnrpd[16020]: 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 19 10:00:29 csiph nnrpd[18739]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 19 10:00:29 csiph nnrpd[18739]: 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 19 10:36:24 csiph nnrpd[20224]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 19 10:36:24 csiph nnrpd[20224]: 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 19 22:09:11 csiph nnrpd[48128]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 19 22:09:11 csiph nnrpd[48128]: 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 20 03:14:08 csiph nnrpd[60129]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 20 03:14:08 csiph nnrpd[60129]: 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 19187 48.1%4.8 MB 62.9%
innd 16276 40.8%2.1 MB 27.7%
innfeed 3699 9.3%659.9 KB 8.4%
nnrpd 712 1.8%76.6 KB 1.0%
nocem 13 0.0%1.5 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 39888 100.0%7.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 309873 54.2%
Negative hits 239240 41.8%
Do not exist 18568 3.2%
Cache misses 4443 0.8%
TOTAL: 4 572124 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.393 0.0%37 0.000 10.622 36.667
article cleanup00:00:00.104 0.0%18389 0.000 0.006 0.034
article logging00:00:00.545 0.0%18897 0.000 0.029 1.731
article parse00:00:01.199 0.0%55312 0.000 0.022 0.231
article write00:00:32.395 0.0%15202 0.129 2.131 62.040
artlog/artcncl00:00:00.011 0.0%37 0.000 0.297 1.833
artlog/artparse00:00:00.003 0.0%255 0.000 0.012 1.000
data move00:00:00.381 0.0%526376 0.000 0.001 0.032
hisgrep/artcncl00:00:00.053 0.0%37 0.000 1.432 4.333
hishave/artcncl00:00:00.014 0.0%37 0.000 0.378 4.667
hishave/artparse00:00:00.000 0.0%244 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:46.754 0.1%574016 0.002 0.081 0.587
history sync00:00:01.407 0.0%395 0.000 3.562 72.667
history write00:00:59.458 0.1%18390 0.506 3.233 20.627
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.699 0.0%244 0.000 2.865 28.667
idle23:55:45.935 99.6%526886 86.494 163.500200166.000
nntp read00:00:04.211 0.0%535116 0.001 0.008 0.180
overview write00:01:22.842 0.1%15202 0.094 5.449 133.143
perl filter00:00:41.018 0.0%18379 1.148 2.232 15.741
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.224 0.0%30417 0.000 0.007 0.031
TOTAL: 24:01:07.52624:00:17.646 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.039 0.0%18695 0.000 0.002 0.030
article prepare00:00:00.000 0.0%9932 0.000 0.000 0.000
article read00:00:01.361 0.0%1040 0.000 1.309 44.000
backlog stats00:00:00.227 0.0%342268 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.303 0.0%272417 0.000 0.005 0.010
data write00:00:01.618 0.0%258173 0.000 0.006 0.017
idle23:54:46.889100.0%342268 124.023 251.519 4680.163
status file00:00:00.250 0.0%357 0.000 0.700 7.000
TOTAL: 23:54:59.89823:54:51.687100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle31:44:50.856 99.8%448 46.000255113.518600177.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.006 0.0%1177 0.000 0.005 0.143
readart00:00:00.249 0.0%12 0.000 20.750 42.000
TOTAL: 31:48:28.29831:44:51.111 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 3 14031 3494 10435 102 24%24:41:11
2csiph-out.news.xs4all.nl 535 20548 2967 16046 1535 14%69:45:32
3feeder.eternal-september.org 6 17839 2434 15252 153 13%27:06:03
4newsfeeds.xmission.com 4 14671 1869 12745 57 12%25:19:19
5csiph-out.feeder.erje.net 1442 74373 1025 73199 149 1%122:23:13
6newsfeed.fu-berlin.de 21 12774 724 11878 172 5%24:28:25
7newsfeed.neva.ru 150 9898 617 8978 303 6%74:06:36
8csiph-out.news.weretis.net 5 40970 558 40197 215 1%61:00:57
9csiph-out.feed.uzoreto.com 867 27613 528 26537 548 1%73:09:39
10news-out.mixmin.net 2 16042 485 15466 91 3%24:39:29
11news.fcku.it 13 1885 261 1615 9 13%22:24:15
12nntp.pasdenom.info 2 10407 131 10261 15 1%24:34:39
13news.swapon.de 12 1384 60 1323 1 4%23:39:42
14csiph-out.news.tnetconsulting.net 18 26969 59 26881 29 0%41:44:32
15news.freedyn.net 2 17928 32 17829 67 0%24:39:52
16news-out.neodome.net 2 16590 19 16570 1 0%24:35:09
17news.samoylyk.net 2 14700 5 14695 0 0%24:36:28
18news.bbs.nz 3 22510 1 22508 1 0%34:42:40
19xanadu-bbs.net 36 337 0 337 0 0%20:45:33
20localhost 26 0 0 0 0 0%00:00:02
TOTAL: 20 3151 361469 15269 342752 3448 4%768:23:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org8.7 MB0.0 KB336.4 KB9.0 MB 96%2.6 KB
2csiph-out.news.xs4all.nl7.9 MB0.0 KB7.8 MB15.7 MB 50%3.6 KB
3csiph-out.feeder.erje.net7.2 MB26.1 KB2.7 MB9.9 MB 72%8.7 KB
4feeder.eternal-september.org7.1 MB1.9 KB1.3 MB8.4 MB 84%3.3 KB
5newsfeeds.xmission.com5.8 MB0.0 KB3.5 MB9.2 MB 62%4.9 KB
6newsfeed.fu-berlin.de1.7 MB0.0 KB453.3 KB2.2 MB 79%2.5 KB
7csiph-out.feed.uzoreto.com1.7 MB0.0 KB8.5 MB10.3 MB 16%9.8 KB
8csiph-out.news.weretis.net1.6 MB2.0 KB2.0 MB3.6 MB 43%4.8 KB
9newsfeed.neva.ru1.5 MB0.0 KB781.3 KB2.2 MB 66%2.5 KB
10news-out.mixmin.net1.5 MB2.0 KB151.6 KB1.6 MB 90%2.9 KB
11news.fcku.it405.2 KB0.0 KB308.8 KB714.0 KB 56%2.6 KB
12nntp.pasdenom.info287.5 KB1.8 KB19.5 KB308.8 KB 93%2.1 KB
13csiph-out.news.tnetconsulting.net247.9 KB0.0 KB190.9 KB438.8 KB 56%5.0 KB
14news-out.neodome.net169.9 KB0.0 KB3.6 KB173.4 KB 97%8.7 KB
15news.freedyn.net165.5 KB0.0 KB2.8 MB3.0 MB 5%30.8 KB
16news.swapon.de150.3 KB1.7 KB1.7 KB153.8 KB 97%2.5 KB
17news.samoylyk.net14.7 KB0.0 KB0.0 KB14.7 KB100%2.9 KB
18news.bbs.nz2.4 KB1.9 KB1.9 KB6.2 KB 38%3.1 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: 2046.1 MB37.5 KB30.8 MB77.0 MB 59%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 19 04:15:00 - 04:59:59 187 1.2% 0.07569.1 KB 1.2% 0.21
Nov 19 05:00:00 - 05:59:59 291 1.9% 0.081.8 MB 3.8% 0.50
Nov 19 06:00:00 - 06:59:59 259 1.7% 0.07845.1 KB 1.8% 0.23
Nov 19 07:00:00 - 07:59:59 457 3.0% 0.131.3 MB 2.9% 0.38
Nov 19 08:00:00 - 08:59:59 683 4.5% 0.191.9 MB 4.1% 0.54
Nov 19 09:00:00 - 09:59:59 786 5.2% 0.222.6 MB 5.6% 0.73
Nov 19 10:00:00 - 10:59:59 826 5.4% 0.232.4 MB 5.2% 0.68
Nov 19 11:00:00 - 11:59:59 755 5.0% 0.211.9 MB 4.2% 0.55
Nov 19 12:00:00 - 12:59:59 716 4.7% 0.201.9 MB 4.1% 0.53
Nov 19 13:00:00 - 13:59:59 752 4.9% 0.212.1 MB 4.6% 0.59
Nov 19 14:00:00 - 14:59:59 917 6.0% 0.252.6 MB 5.7% 0.74
Nov 19 15:00:00 - 15:59:59 978 6.4% 0.273.7 MB 8.1% 1.06
Nov 19 16:00:00 - 16:59:59 899 5.9% 0.252.7 MB 5.8% 0.76
Nov 19 17:00:00 - 17:59:59 1006 6.6% 0.282.9 MB 6.3% 0.82
Nov 19 18:00:00 - 18:59:59 794 5.2% 0.222.0 MB 4.3% 0.57
Nov 19 19:00:00 - 19:59:59 857 5.6% 0.242.3 MB 5.0% 0.66
Nov 19 20:00:00 - 20:59:59 736 4.8% 0.201.9 MB 4.2% 0.55
Nov 19 21:00:00 - 21:59:59 775 5.1% 0.222.3 MB 5.1% 0.67
Nov 19 22:00:00 - 22:59:59 536 3.5% 0.151.6 MB 3.5% 0.45
Nov 19 23:00:00 - 23:59:59 535 3.5% 0.151.9 MB 4.0% 0.53
Nov 20 00:00:00 - 00:59:59 461 3.0% 0.131.8 MB 4.0% 0.52
Nov 20 01:00:00 - 01:59:59 321 2.1% 0.091.2 MB 2.5% 0.33
Nov 20 02:00:00 - 02:59:59 267 1.8% 0.07717.8 KB 1.5% 0.20
Nov 20 03:00:00 - 03:59:59 322 2.1% 0.09929.7 KB 2.0% 0.26
Nov 20 04:00:00 - 04:15:00 84 0.6% 0.09254.0 KB 0.5% 0.28
TOTAL: 24:00:00 15200 100.0% 0.1845.9 MB 100.0% 0.54
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1561 85 0 0 0 0 0 0 1476
2csiph-out.feed.uzoreto.com 554 41 0 0 0 0 0 0 513
3newsfeed.fu-berlin.de 525 16 0 0 0 0 0 0 509
4newsfeed.neva.ru 304 76 0 0 0 0 0 0 228
5csiph-out.news.weretis.net 215 80 0 1 0 0 0 0 134
6news-out.aioe.org 210 89 0 0 0 0 0 0 121
7feeder.eternal-september.org 157 39 0 1 0 0 0 0 117
8csiph-out.feeder.erje.net 152 46 0 5 0 0 0 0 101
9news-out.mixmin.net 92 0 0 1 0 0 0 0 91
10news.freedyn.net 65 0 0 0 0 0 0 0 65
11newsfeeds.xmission.com 46 6 0 0 0 0 0 0 40
12csiph-out.news.tnetconsulting.net 24 21 0 0 0 0 0 0 3
13news.swapon.de 19 0 0 1 0 0 0 0 18
14nntp.pasdenom.info 15 0 0 1 0 0 0 0 14
15news.fcku.it 10 1 0 0 0 0 0 0 9
16news-out.neodome.net 1 0 0 0 0 0 0 0 1
TOTAL: 16 3950 500 0 10 0 0 0 0 3440

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 123
lada.talk 63
mozilla.support.thunderbird 31
alt.politics 24
scinet.stats 24
mozilla.support.seamonkey 17
alt.bbs.synchronet 12
alt.philosophy 11
spline.eisfair 11
at.jobs 11
att.jobs 10
alt.job 9
tnet.test 9
alt.politics.usa 8
alt.binaries.pictures.purebeauty 8
mozilla.dev.apps.seamonkey 8
mozilla.test 6
alt.religion 5
alt.windows7.general 5
alt.survival 5
TOTAL: 76 500

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2026
EMP (phn path) 353
Too many newsgroups 117
EMP (phl) 87
0 64
EMP (phn nph) 14
Binary: misplaced binary 11
HTML Multipart 2
Scoring filter 2
HTML post 1
TOTAL: 10 2677

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 58
csiph-out.feeder.erje.net 50
newsfeeds.xmission.com 40
news.freedyn.net 31
csiph-out.news.xs4all.nl 31
csiph-out.news.weretis.net 12
feeder.eternal-september.org 12
news.fcku.it 5
newsfeed.fu-berlin.de 4
csiph-out.news.tnetconsulting.net 1
TOTAL: 10 244
Including strange strings
newsfeed.fu-berlin.de 329
news-out.aioe.org 110
csiph-out.news.xs4all.nl 25
news.swapon.de 18
csiph-out.news.weretis.net 7
csiph-out.feed.uzoreto.com 6
feeder.eternal-september.org 5
csiph-out.feeder.erje.net 3
newsfeed.neva.ru 3
news-out.mixmin.net 1
TOTAL: 11 508
No colon-space in header
csiph-out.news.xs4all.nl 10
csiph-out.feeder.erje.net 1
TOTAL: 2 11
TOTAL: 4 808

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 17833 695 14496 8 0 280 3%23:59:53
2fu-berlin.de 14161 487 13674 0 0 224 3%23:59:53
3news.samoylyk.net 15499 483 14704 9 0 234 3%23:59:53
4news.bbs.nz 28356 346 14308 21 0 229 1%23:59:53
5newsfeed.xs4all.nl 12374 41 12030 2 0 161 0%23:59:53
6tnet 16338 35 14644 1 0 303 0%23:59:53
7xmission 15234 17 12745 0 0 314 0%23:59:53
8aioe 10507 14 10112 2 0 0 0%23:56:11
9usenet.pasdenom.info 14930 12 14523 8 0 227 0%23:59:53
10neva.ru 13632 11 13464 95 0 210 0%23:59:53
11erje 14349 11 13636 69 0 51 0%23:59:53
12news.freedyn.net 14483 10 14232 33 0 227 0%23:59:53
13neodome.net 15180 8 14929 0 0 231 0%23:59:53
14news.uzoreto.com 13829 6 13607 48 0 181 0%23:59:53
15news.mixmin.net 14042 6 13835 1 0 200 0%23:59:53
16eternal-september 12292 3 12102 0 0 177 0%23:59:53
17news.swapon.de 1366 0 1363 0 0 16 0%23:33:41
18weretis.net 14503 0 14114 1 0 257 0%23:59:53
19news.fcku.it 1571 0 1570 0 0 0 0%21:08:35
TOTAL: 19 260479 2185 234088 298 0 3522 0%452:36:35
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs6.1 MB24.2 KB6.1 MB0.1 KB/s8.9 KB23:59:53
2news.samoylyk.net5.5 MB18.1 KB5.6 MB0.1 KB/s11.6 KB23:59:53
3fu-berlin.de5.5 MB0.0 KB5.5 MB0.1 KB/s11.6 KB23:59:53
4news.bbs.nz913.2 KB76.5 KB989.7 KB0.0 KB/s2.7 KB23:59:53
5usenet.pasdenom.info132.5 KB25.2 KB157.7 KB0.0 KB/s7.9 KB23:59:53
6news.mixmin.net117.9 KB1.9 KB119.8 KB0.0 KB/s17.1 KB23:59:53
7newsfeed.xs4all.nl109.5 KB68.2 KB177.7 KB0.0 KB/s4.1 KB23:59:53
8news.freedyn.net93.8 KB389.1 KB483.0 KB0.0 KB/s11.2 KB23:59:53
9tnet85.4 KB2.0 KB87.4 KB0.0 KB/s2.4 KB23:59:53
10neva.ru71.6 KB258.9 KB330.5 KB0.0 KB/s3.1 KB23:59:53
11xmission59.9 KB0.0 KB59.9 KB0.0 KB/s3.5 KB23:59:53
12aioe37.9 KB1.3 KB39.2 KB0.0 KB/s2.5 KB23:56:11
13neodome.net35.7 KB0.0 KB35.7 KB0.0 KB/s4.5 KB23:59:53
14erje21.7 KB274.7 KB296.4 KB0.0 KB/s3.7 KB23:59:53
15eternal-september8.5 KB0.0 KB8.5 KB0.0 KB/s2.8 KB23:59:53
16news.uzoreto.com8.5 KB227.7 KB236.2 KB0.0 KB/s4.4 KB23:59:53
17news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:33:41
18weretis.net0.0 KB3.4 KB3.4 KB0.0 KB/s3.4 KB23:59:53
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:08:35
TOTAL: 1918.8 MB1.3 MB20.2 MB0.0 KB/s8.3 KB452:36:35
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ip72-222-200-117.ph.ph.cox.net 10 57.6 KB 5 0 003:49:50
2a131033.upc-a.chello.nl 8 57.6 KB 4 0 001:01:31
3066-188-083-201.res.spectrum.com 4 22.3 KB 2 0 000:57:42
TOTAL: 3 22 1217.5 KB 11 0 031:48:27

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.upc-a.chello.nl 8 57.6 KB 4 0 001:01:31
2*.ph.ph.cox.net 10 57.6 KB 5 0 003:49:50
3*.res.spectrum.com 8 22.3 KB 2 0 002:05:36
4*.range81-153.btcentralplus.com 5 00.0 KB 0 0 001:30:06
5*.net.upcbroadband.cz 16 00.0 KB 0 0 005:39:58
6unresolved 55 00.0 KB 0 0 017:41:23
7*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
TOTAL: 7 104 1217.5 KB 11 0 031:48:27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 3.581 2.049 0.00017:41:12
ip-78-102-198-192.net.upcbroadband.cz 1.035 0.720 0.00005:39:58
ip72-222-200-117.ph.ph.cox.net 0.968 1.165 0.00003:49:50
host81-153-177-33.range81-153.btcentralplus.com 0.336 0.065 0.00001:30:06
024-178-045-162.res.spectrum.com 0.242 0.052 0.00001:07:53
a131033.upc-a.chello.nl 0.699 0.462 0.00001:01:31
066-188-083-201.res.spectrum.com 0.275 0.082 0.00000:57:42
192.241.238.18 0.067 0.008 0.00000:00:09
scanner-06.ch1.censys-scanner.com 0.128 0.024 0.00000:00:00
94.232.42.169 0.071 0.206 0.00000:00:00
TOTAL: 10 7.402 4.833 0.00031:48:27

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 53
ip-78-102-198-192.net.upcbroadband.cz 16
host81-153-177-33.range81-153.btcentralplus.com 5
024-178-045-162.res.spectrum.com 4
scanner-06.ch1.censys-scanner.com 2
192.241.238.18 1
94.232.42.169 1
TOTAL: 7 82

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
^C 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
ip72-222-200-117.ph.ph.cox.net 7 0
ip-78-102-198-192.net.upcbroadband.cz 2 0
066-188-083-201.res.spectrum.com 1 0
94.232.42.169 1 1
024-178-045-162.res.spectrum.com 1 0
91.187.33.87 1 0
host81-153-177-33.range81-153.btcentralplus.com 1 0
TOTAL: 7 14 2

Newsgroup request counts (by category):

CategoryCountPct
1comp 12100.0%
TOTAL: 1 12100.0%

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

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