Daily Usenet report for csiph.com

Jan 16 04:15:00 -- Jan 17 04:15:00

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Jan 16 09:38:35 csiph nnrpd[81803]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 16 09:38:35 csiph nnrpd[81803]: 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]
Jan 16 09:55:35 csiph nnrpd[82715]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 16 09:55:35 csiph nnrpd[82715]: 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]
Jan 16 14:44:29 csiph nnrpd[98301]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 16 14:44:29 csiph nnrpd[98301]: 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]
Jan 16 15:54:51 csiph nnrpd[2167]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 16 15:54:51 csiph nnrpd[2167]: 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 19484 47.8%4.6 MB 61.8%
innd 15423 37.9%2.0 MB 26.8%
innfeed 3714 9.1%647.7 KB 8.5%
nnrpd 2092 5.1%221.2 KB 2.9%
nocem 13 0.0%1.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 40727 100.0%7.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 268681 51.5%
Negative hits 231630 44.4%
Do not exist 21285 4.1%
Cache misses 256 0.0%
TOTAL: 4 521852 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.132 0.0%19 0.000 6.947 22.200
article cleanup00:00:00.107 0.0%18880 0.000 0.006 0.045
article logging00:00:00.313 0.0%19311 0.000 0.016 0.635
article parse00:00:00.679 0.0%59987 0.000 0.011 0.107
article write00:00:17.659 0.0%14065 0.143 1.256 57.424
artlog/artcncl00:00:00.002 0.0%19 0.000 0.105 1.000
artlog/artparse00:00:00.001 0.0%178 0.000 0.006 0.333
data move00:00:00.171 0.0%496593 0.000 0.000 0.002
hisgrep/artcncl00:00:00.004 0.0%19 0.000 0.211 1.000
hishave/artcncl00:00:00.000 0.0%19 0.000 0.000 0.000
hishave/artparse00:00:00.001 0.0%173 0.000 0.006 0.083
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:12.497 0.0%522955 0.001 0.024 0.597
history sync00:00:01.769 0.0%368 0.000 4.807 191.667
history write00:00:19.837 0.0%18885 0.022 1.050 12.333
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.174 0.0%173 0.000 1.006 21.000
idle23:57:34.819 99.8%498628 89.022 172.984 712.032
nntp read00:00:02.008 0.0%500666 0.002 0.004 0.010
overview write00:01:26.476 0.1%14065 0.062 6.148 679.117
perl filter00:00:26.489 0.0%18880 0.465 1.403 6.440
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.232 0.0%28143 0.000 0.008 0.033
TOTAL: 24:00:57.67824:00:23.370100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.029 0.0%14118 0.000 0.002 0.038
article prepare00:00:00.001 0.0%14160 0.000 0.000 0.005
article read00:00:00.286 0.0%1491 0.000 0.192 18.333
backlog stats00:00:00.187 0.0%306676 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.052 0.0%238935 0.000 0.004 0.011
data write00:00:01.435 0.0%227361 0.000 0.006 0.015
idle23:55:34.850100.0%306676 157.545 280.866 893.696
status file00:00:00.265 0.0%362 0.000 0.732 2.667
TOTAL: 23:55:44.94123:55:38.105100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle57:22:12.390 99.5%1136 151.000181806.681450100.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.024 0.0%2650 0.000 0.009 0.333
readart00:00:00.084 0.0%6 8.400 14.000 42.000
TOTAL: 57:38:08.79357:22:12.498 99.5%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 134
pause 3
paused 2
reload 2
reserve 2
TOTAL: 10 155

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.xs4all.nl 0 7927 4022 2094 1811 50%70:36:00
2feeder.eternal-september.org 14 4770 2061 2584 125 43%26:49:27
3newsfeeds.xmission.com 2 12528 1923 10591 14 15%22:38:07
4news-out.mixmin.net 2 15432 1653 13468 311 10%23:59:47
5csiph-out.feeder.erje.net 1440 75632 1023 70543 4066 1%118:47:05
6csiph-out.news.weretis.net 3 29678 875 28614 189 2%47:59:48
7newsfeed.fu-berlin.de 12 14865 769 13804 292 5%27:07:40
8newsfeed.neva.ru 143 12215 565 11380 270 4%71:24:01
9csiph-out.feed.uzoreto.com 864 23003 330 22409 264 1%71:11:59
10news-out.aioe.org 1 13479 278 13168 33 2%23:59:57
11news-out.neodome.net 1 15745 195 15543 7 1%23:59:54
12nntp.pasdenom.info 3 8671 105 8562 4 1%24:52:24
13news.fcku.it 20 896 96 800 0 10%21:18:43
14news.swapon.de 9 1351 43 1307 1 3%23:38:31
15csiph-out.news.tnetconsulting.net 1 11825 40 11777 8 0%20:02:23
16news.freedyn.net 1 16637 7 16608 22 0%23:59:57
17news.bbs.nz 2 14466 3 14463 0 0%23:59:49
18news.samoylyk.net 1 13257 2 13255 0 0%23:59:54
19xanadu-bbs.net 32 342 1 341 0 0%20:32:16
20localhost 26 0 0 0 0 0%00:00:02
TOTAL: 20 2577 292719 13991 271311 7417 4%710:57:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.xs4all.nl10.5 MB0.0 KB9.2 MB19.8 MB 53%3.5 KB
2csiph-out.feeder.erje.net9.8 MB0.0 KB4.0 MB13.8 MB 70%2.8 KB
3feeder.eternal-september.org5.8 MB0.0 KB2.4 MB8.2 MB 70%3.8 KB
4newsfeeds.xmission.com5.7 MB0.0 KB376.2 KB6.1 MB 93%3.2 KB
5news-out.mixmin.net3.9 MB0.0 KB612.5 KB4.5 MB 86%2.4 KB
6csiph-out.news.weretis.net2.5 MB0.0 KB1.8 MB4.3 MB 57%4.1 KB
7newsfeed.fu-berlin.de1.9 MB0.0 KB1.8 MB3.7 MB 51%3.5 KB
8newsfeed.neva.ru1.5 MB0.0 KB678.7 KB2.2 MB 69%2.6 KB
9news-out.aioe.org1.2 MB0.0 KB69.6 KB1.3 MB 94%4.2 KB
10csiph-out.feed.uzoreto.com1.2 MB0.0 KB6.1 MB7.3 MB 16%12.6 KB
11news-out.neodome.net556.6 KB0.0 KB49.3 KB606.0 KB 91%3.0 KB
12nntp.pasdenom.info235.8 KB0.0 KB10.9 KB246.7 KB 95%2.3 KB
13csiph-out.news.tnetconsulting.net163.1 KB0.0 KB224.3 KB387.4 KB 42%8.1 KB
14news.fcku.it137.7 KB0.0 KB0.0 KB137.7 KB100%1.4 KB
15news.swapon.de101.4 KB0.0 KB80.3 KB181.7 KB 55%4.1 KB
16news.freedyn.net34.3 KB0.0 KB1.4 MB1.4 MB 2%50.8 KB
17news.samoylyk.net8.2 KB0.0 KB0.0 KB8.2 KB100%4.1 KB
18news.bbs.nz4.6 KB0.0 KB0.0 KB4.6 KB100%1.5 KB
19xanadu-bbs.net3.3 KB0.0 KB0.0 KB3.3 KB100%3.3 KB
20localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2045.2 MB0.0 KB28.8 MB74.0 MB 61%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 16 04:15:00 - 04:59:59 206 1.5% 0.08577.7 KB 1.2% 0.21
Jan 16 05:00:00 - 05:59:59 312 2.2% 0.091.0 MB 2.2% 0.29
Jan 16 06:00:00 - 06:59:59 249 1.8% 0.07689.9 KB 1.5% 0.19
Jan 16 07:00:00 - 07:59:59 380 2.7% 0.111.7 MB 3.7% 0.48
Jan 16 08:00:00 - 08:59:59 464 3.3% 0.131.5 MB 3.3% 0.42
Jan 16 09:00:00 - 09:59:59 604 4.3% 0.171.7 MB 3.7% 0.47
Jan 16 10:00:00 - 10:59:59 707 5.0% 0.202.1 MB 4.6% 0.59
Jan 16 11:00:00 - 11:59:59 700 5.0% 0.192.2 MB 4.9% 0.63
Jan 16 12:00:00 - 12:59:59 703 5.0% 0.201.9 MB 4.3% 0.55
Jan 16 13:00:00 - 13:59:59 880 6.3% 0.242.3 MB 5.0% 0.64
Jan 16 14:00:00 - 14:59:59 751 5.3% 0.213.0 MB 6.6% 0.85
Jan 16 15:00:00 - 15:59:59 760 5.4% 0.212.4 MB 5.2% 0.68
Jan 16 16:00:00 - 16:59:59 895 6.4% 0.254.0 MB 8.9% 1.15
Jan 16 17:00:00 - 17:59:59 905 6.4% 0.253.3 MB 7.3% 0.94
Jan 16 18:00:00 - 18:59:59 803 5.7% 0.222.7 MB 6.0% 0.78
Jan 16 19:00:00 - 19:59:59 784 5.6% 0.222.1 MB 4.7% 0.60
Jan 16 20:00:00 - 20:59:59 711 5.1% 0.202.1 MB 4.6% 0.59
Jan 16 21:00:00 - 21:59:59 633 4.5% 0.181.9 MB 4.1% 0.53
Jan 16 22:00:00 - 22:59:59 621 4.4% 0.171.9 MB 4.2% 0.55
Jan 16 23:00:00 - 23:59:59 534 3.8% 0.151.7 MB 3.8% 0.49
Jan 17 00:00:00 - 00:59:59 454 3.2% 0.131.4 MB 3.0% 0.39
Jan 17 01:00:00 - 01:59:59 379 2.7% 0.111.3 MB 2.9% 0.38
Jan 17 02:00:00 - 02:59:59 283 2.0% 0.08871.6 KB 1.9% 0.24
Jan 17 03:00:00 - 03:59:59 286 2.0% 0.081012.8 KB 2.2% 0.28
Jan 17 04:00:00 - 04:15:00 41 0.3% 0.05128.7 KB 0.3% 0.14
TOTAL: 24:00:00 14045 100.0% 0.1645.3 MB 100.0% 0.54
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1807 88 0 0 0 0 0 0 1719
2csiph-out.feeder.erje.net 1652 80 0 0 2 0 0 0 1570
3newsfeed.fu-berlin.de 625 33 0 0 0 0 0 0 592
4news-out.mixmin.net 315 9 0 0 0 0 0 0 306
5newsfeed.neva.ru 276 29 0 0 0 0 0 0 247
6csiph-out.feed.uzoreto.com 263 16 0 0 0 0 0 0 247
7csiph-out.news.weretis.net 238 77 0 0 0 0 0 0 161
8feeder.eternal-september.org 122 85 0 0 0 0 0 0 37
9news-out.aioe.org 34 26 0 0 0 0 0 0 8
10newsfeeds.xmission.com 30 8 0 0 0 0 0 0 22
11news.freedyn.net 22 0 0 0 0 0 0 0 22
12news.swapon.de 22 0 0 0 0 0 0 0 22
13news-out.neodome.net 8 2 0 0 0 0 0 0 6
14nntp.pasdenom.info 4 0 0 0 0 0 0 0 4
15csiph-out.news.tnetconsulting.net 2 1 0 0 0 0 0 0 1
TOTAL: 15 5420 454 0 0 2 0 0 0 4964

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 134
alt.binaries.pictures.purebeauty 36
scinet.stats 24
alt.survival 20
lada.talk 20
alt.politics 17
mozilla.general 15
alt.bbs.synchronet 15
spline.fli4l.geschnatter 13
alt.job 7
at.jobs 7
spline.eisfair 7
mozilla.support.seamonkey 6
trollnet.cinema 6
alt.binaries.mp3.abooks 5
mozilla.support.thunderbird 5
scinet.bbs.software 5
spline.eisfair.dev 5
alt.philosophy 5
alt.politics.usa 5
TOTAL: 79 454

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

GroupsCount
alt.binaries.sounds.mp3.jazz.vocals 1
uk.legal.moderated 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2089
Binary Payload 1467
EMP (phn path) 353
EMP (phn nph) 220
EMP (phl) 86
Too many newsgroups 68
Binary: misplaced binary 36
0 23
HTML Multipart 12
Too many newsgroups (meow) 1
HTML post 1
Scoring filter 1
TOTAL: 12 4357

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 45
TOTAL: 1 45
Huge articles
csiph-out.feeder.erje.net 50
csiph-out.feed.uzoreto.com 37
csiph-out.news.xs4all.nl 28
newsfeed.fu-berlin.de 14
news.freedyn.net 14
csiph-out.news.weretis.net 11
feeder.eternal-september.org 9
newsfeeds.xmission.com 6
news-out.mixmin.net 2
csiph-out.news.tnetconsulting.net 1
TOTAL: 11 173
Including strange strings
newsfeed.fu-berlin.de 336
csiph-out.news.xs4all.nl 25
news.swapon.de 21
csiph-out.news.weretis.net 15
newsfeeds.xmission.com 15
newsfeed.neva.ru 5
csiph-out.feeder.erje.net 4
news-out.mixmin.net 4
feeder.eternal-september.org 3
news-out.aioe.org 1
TOTAL: 10 429
No colon-space in header
csiph-out.news.xs4all.nl 3
csiph-out.feed.uzoreto.com 1
csiph-out.feeder.erje.net 1
TOTAL: 3 5
TOTAL: 4 652

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 16886 1160 12881 2 0 1 6%23:59:55
2fu-berlin.de 13126 780 12346 0 0 0 5%23:59:55
3news.samoylyk.net 14374 772 13261 9 0 0 5%23:59:55
4news.bbs.nz 25921 250 12981 32 0 1 0%23:59:55
5xmission 13842 95 11017 4 0 0 0%23:59:45
6tnet 14262 59 13206 1 0 0 0%23:59:50
7neva.ru 12523 36 12334 61 0 0 0%23:59:52
8newsfeed.xs4all.nl 10282 35 9813 1 0 72 0%23:59:54
9usenet.pasdenom.info 13467 10 13100 47 0 9 0%23:59:55
10news.freedyn.net 12524 6 12196 55 0 0 0%23:59:55
11aioe 11320 5 10974 1 0 1 0%23:59:45
12neodome.net 14044 4 13695 0 0 0 0%23:59:34
13erje 12735 4 12606 66 0 0 0%23:59:50
14news.uzoreto.com 13074 3 12871 35 0 0 0%23:59:54
15news.swapon.de 1350 3 1337 0 0 0 0%23:25:53
16news.mixmin.net 11602 3 11349 0 0 0 0%23:59:36
17eternal-september 0 0 0 0 0 11144 0%23:59:55
18weretis.net 12481 0 12251 1 0 0 0%23:59:45
19news.fcku.it 764 0 763 0 0 0 0%20:28:16
TOTAL: 19 224577 3225 198981 315 0 11228 1%451:51:19
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs10.0 MB4.4 KB10.0 MB0.1 KB/s8.8 KB23:59:55
2fu-berlin.de9.1 MB0.0 KB9.1 MB0.1 KB/s11.9 KB23:59:55
3news.samoylyk.net9.0 MB99.3 KB9.1 MB0.1 KB/s11.9 KB23:59:55
4news.bbs.nz600.4 KB136.9 KB737.3 KB0.0 KB/s2.6 KB23:59:55
5xmission228.1 KB7.4 KB235.5 KB0.0 KB/s2.4 KB23:59:45
6tnet109.5 KB1.2 KB110.6 KB0.0 KB/s1.8 KB23:59:50
7newsfeed.xs4all.nl87.9 KB4.7 KB92.6 KB0.0 KB/s2.6 KB23:59:54
8neva.ru53.9 KB146.6 KB200.5 KB0.0 KB/s2.1 KB23:59:52
9usenet.pasdenom.info13.8 KB79.9 KB93.7 KB0.0 KB/s1.6 KB23:59:55
10neodome.net10.6 KB0.0 KB10.6 KB0.0 KB/s2.7 KB23:59:34
11news.freedyn.net10.0 KB866.8 KB876.9 KB0.0 KB/s14.4 KB23:59:55
12aioe8.5 KB0.7 KB9.2 KB0.0 KB/s1.5 KB23:59:45
13erje6.4 KB171.5 KB177.8 KB0.0 KB/s2.5 KB23:59:50
14news.swapon.de6.0 KB0.0 KB6.0 KB0.0 KB/s2.0 KB23:25:53
15news.uzoreto.com3.1 KB91.4 KB94.6 KB0.0 KB/s2.5 KB23:59:54
16news.mixmin.net2.7 KB0.0 KB2.7 KB0.0 KB/s0.9 KB23:59:36
17eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
18weretis.net0.0 KB7.0 KB7.0 KB0.0 KB/s7.0 KB23:59:45
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s020:28:16
TOTAL: 1929.1 MB1.6 MB30.7 MB0.0 KB/s8.9 KB451:51:19
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1a131033.upc-a.chello.nl 43 614.2 KB 2 0 006:56:59
TOTAL: 1 43 614.2 KB 2 0 057:38:06

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.upc-a.chello.nl 43 614.2 KB 2 0 006:56:59
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:01
3unresolved 293 00.0 KB 0 0 050:29:27
4*.range86-138.btcentralplus.com 3 00.0 KB 0 0 000:11:38
TOTAL: 4 340 614.2 KB 2 0 057:38:06

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 17.866 4.441 0.00047:59:03
a131033.upc-a.chello.nl 2.763 0.634 0.00006:56:59
172.83.96.97 0.310 0.055 0.00001:30:10
172.83.100.240 0.218 0.031 0.00001:00:12
host86-138-214-35.range86-138.btcentralplus.com 0.196 0.037 0.00000:11:38
scanner-08.ch1.censys-scanner.com 0.072 0.007 0.00000:00:01
TOTAL: 6 21.425 5.205 0.00057:38:06

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 288
host86-138-214-35.range86-138.btcentralplus.com 3
172.83.96.97 3
172.83.100.240 2
scanner-08.ch1.censys-scanner.com 1
TOTAL: 5 297

NNRP unrecognized commands (by host):

SystemConn
scanner-08.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
172.83.96.97 3 0
172.83.100.240 2 0
TOTAL: 2 5 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 6100.0%
TOTAL: 1 6100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 6
TOTAL: 1 6
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: admin@kev009.com