Daily Usenet report for csiph.com

Jan 22 04:15:00 -- Jan 23 04:15:00

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Jan 22 08:21:31 csiph nnrpd[27306]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 22 08:21:31 csiph nnrpd[27306]: 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 22 09:28:29 csiph nnrpd[30882]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 22 09:28:29 csiph nnrpd[30882]: 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 22 14:06:30 csiph nnrpd[45654]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 22 14:06:30 csiph nnrpd[45654]: 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 22 14:29:31 csiph nnrpd[46766]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 22 14:29:31 csiph nnrpd[46766]: 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 22 21:36:57 csiph nnrpd[69621]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 22 21:36:57 csiph nnrpd[69621]: 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 19868 49.6%5.0 MB 64.6%
innd 14137 35.3%1.9 MB 24.2%
innfeed 3603 9.0%626.3 KB 7.9%
nnrpd 2440 6.1%256.1 KB 3.2%
nocem 37 0.1%4.2 KB 0.1%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 40087 100.0%7.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 302940 52.0%
Negative hits 260355 44.7%
Do not exist 19271 3.3%
Cache misses 300 0.1%
TOTAL: 4 582866 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.342 0.0%23 0.000 14.870 29.000
article cleanup00:00:00.119 0.0%19169 0.000 0.006 0.033
article logging00:00:00.530 0.0%19636 0.000 0.027 0.477
article parse00:00:00.973 0.0%61879 0.000 0.016 0.942
article write00:01:03.620 0.1%15658 0.244 4.063 87.895
artlog/artcncl00:00:00.000 0.0%23 0.000 0.000 0.000
artlog/artparse00:00:00.003 0.0%199 0.000 0.015 1.000
data move00:00:00.208 0.0%548687 0.000 0.000 0.003
hisgrep/artcncl00:00:00.008 0.0%22 0.000 0.364 1.000
hishave/artcncl00:00:00.011 0.0%23 0.000 0.478 11.000
hishave/artparse00:00:00.002 0.0%194 0.000 0.010 0.100
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:40.370 0.0%585775 0.002 0.069 0.623
history sync00:00:01.474 0.0%385 0.000 3.829 27.000
history write00:00:44.307 0.1%19165 0.533 2.312 12.434
hiswrite/artcncl00:00:00.001 0.0%1 1.000 1.000 1.000
hiswrite/artparse00:00:00.445 0.0%194 0.000 2.294 161.000
idle23:54:26.281 99.5%544483 72.701 158.070 508.654
nntp read00:00:02.140 0.0%553176 0.001 0.004 0.007
overview write00:02:55.373 0.2%15658 0.105 11.200 515.389
perl filter00:00:28.890 0.0%19160 1.028 1.508 3.745
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.286 0.0%31351 0.000 0.009 0.032
TOTAL: 24:01:05.86424:00:25.383100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.032 0.0%15707 0.000 0.002 0.025
article prepare00:00:00.003 0.0%11672 0.000 0.000 0.016
article read00:00:00.337 0.0%1271 0.000 0.265 59.000
backlog stats00:00:00.184 0.0%345944 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.194 0.0%271150 0.000 0.004 0.013
data write00:00:01.605 0.0%258517 0.001 0.006 0.016
idle23:54:44.136100.0%345944 122.994 248.838 810.886
status file00:00:00.706 0.0%297 0.000 2.377 19.000
TOTAL: 23:54:54.52423:54:48.197100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle56:10:57.917 99.5%1279 140.667158137.543600075.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.921 0.0%2971 0.000 0.647 18.019
readart00:00:00.144 0.0%17 6.312 8.471 43.000
TOTAL: 56:27:23.75856:10:59.982 99.5%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.xs4all.nl 0 7832 3664 2607 1561 46%73:52:02
2feeder.eternal-september.org 12 5700 2422 3199 79 42%26:55:30
3newsfeeds.xmission.com 3 14439 2038 12391 10 14%23:21:31
4news-out.aioe.org 6 14915 1460 13401 54 9%24:12:37
5csiph-out.feeder.erje.net 1440 78634 1177 77159 298 1%118:36:05
6newsfeed.fu-berlin.de 17 18081 978 16912 191 5%31:53:02
7news-out.mixmin.net 2 17136 964 15871 301 5%23:59:36
8csiph-out.news.weretis.net 2 35980 830 34891 259 2%53:19:17
9newsfeed.neva.ru 147 13525 657 12600 268 4%71:29:22
10news-out.neodome.net 2 17181 389 16605 187 2%23:59:48
11csiph-out.feed.uzoreto.com 864 26043 363 25473 207 1%71:11:41
12news.fcku.it 13 1845 312 1511 22 16%21:16:07
13news.freedyn.net 2 18483 191 18192 100 1%23:59:20
14nntp.pasdenom.info 2 10555 183 10364 8 1%23:59:07
15news.swapon.de 14 1321 55 1266 0 4%22:42:55
16csiph-out.news.tnetconsulting.net 1 3517 11 3494 12 0%07:28:03
17news.samoylyk.net 2 15075 4 15066 5 0%23:59:49
18news.bbs.nz 2 15024 4 15020 0 0%23:59:52
19xanadu-bbs.net 30 442 1 441 0 0%20:15:02
20localhost 26 0 0 0 0 0%00:00:02
TOTAL: 20 2587 315728 15703 296463 3562 4%710:30:48
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.xs4all.nl11.5 MB0.0 KB9.4 MB20.9 MB 55%4.1 KB
2csiph-out.feeder.erje.net7.2 MB9.3 KB3.1 MB10.4 MB 69%7.2 KB
3feeder.eternal-september.org6.2 MB0.0 KB205.8 KB6.4 MB 96%2.6 KB
4newsfeeds.xmission.com6.1 MB0.0 KB348.4 KB6.4 MB 94%3.2 KB
5news-out.aioe.org3.5 MB0.0 KB97.8 KB3.6 MB 97%2.4 KB
6csiph-out.news.weretis.net2.5 MB0.0 KB1.2 MB3.7 MB 67%3.5 KB
7newsfeed.fu-berlin.de2.5 MB0.0 KB484.9 KB3.0 MB 84%2.6 KB
8news-out.mixmin.net2.4 MB0.0 KB869.5 KB3.2 MB 73%2.6 KB
9csiph-out.feed.uzoreto.com1.7 MB0.0 KB4.6 MB6.3 MB 27%11.3 KB
10newsfeed.neva.ru1.7 MB1.7 KB870.9 KB2.5 MB 66%2.8 KB
11news-out.neodome.net1.1 MB1.7 KB1.6 MB2.7 MB 40%4.9 KB
12news.freedyn.net1.0 MB0.0 KB1.5 MB2.6 MB 39%9.0 KB
13news.fcku.it510.4 KB0.0 KB30.7 KB541.1 KB 94%1.6 KB
14nntp.pasdenom.info402.1 KB0.0 KB11.9 KB413.9 KB 97%2.2 KB
15news.swapon.de128.0 KB0.0 KB0.0 KB128.0 KB100%2.3 KB
16news.samoylyk.net40.7 KB1.7 KB228.6 KB271.1 KB 15%30.1 KB
17csiph-out.news.tnetconsulting.net28.1 KB0.0 KB171.4 KB199.4 KB 14%8.7 KB
18news.bbs.nz6.2 KB0.0 KB0.0 KB6.2 KB100%1.5 KB
19xanadu-bbs.net2.2 KB0.0 KB0.0 KB2.2 KB100%2.2 KB
20localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2048.6 MB14.4 KB24.8 MB73.4 MB 66%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 22 04:15:00 - 04:59:59 305 1.9% 0.11972.4 KB 1.9% 0.36
Jan 22 05:00:00 - 05:59:59 342 2.2% 0.102.1 MB 4.3% 0.59
Jan 22 06:00:00 - 06:59:59 308 2.0% 0.091.0 MB 2.0% 0.29
Jan 22 07:00:00 - 07:59:59 472 3.0% 0.131.3 MB 2.7% 0.38
Jan 22 08:00:00 - 08:59:59 563 3.6% 0.161.7 MB 3.5% 0.49
Jan 22 09:00:00 - 09:59:59 830 5.3% 0.232.3 MB 4.7% 0.65
Jan 22 10:00:00 - 10:59:59 758 4.8% 0.212.2 MB 4.5% 0.63
Jan 22 11:00:00 - 11:59:59 745 4.8% 0.212.2 MB 4.5% 0.62
Jan 22 12:00:00 - 12:59:59 814 5.2% 0.232.6 MB 5.2% 0.73
Jan 22 13:00:00 - 13:59:59 843 5.4% 0.232.8 MB 5.6% 0.78
Jan 22 14:00:00 - 14:59:59 848 5.4% 0.242.4 MB 5.0% 0.69
Jan 22 15:00:00 - 15:59:59 850 5.4% 0.242.4 MB 4.8% 0.67
Jan 22 16:00:00 - 16:59:59 907 5.8% 0.252.4 MB 4.9% 0.68
Jan 22 17:00:00 - 17:59:59 1065 6.8% 0.304.3 MB 8.7% 1.22
Jan 22 18:00:00 - 18:59:59 849 5.4% 0.242.5 MB 5.2% 0.72
Jan 22 19:00:00 - 19:59:59 853 5.4% 0.242.5 MB 5.2% 0.72
Jan 22 20:00:00 - 20:59:59 698 4.5% 0.192.0 MB 4.1% 0.57
Jan 22 21:00:00 - 21:59:59 671 4.3% 0.191.9 MB 3.8% 0.53
Jan 22 22:00:00 - 22:59:59 722 4.6% 0.202.2 MB 4.5% 0.63
Jan 22 23:00:00 - 23:59:59 596 3.8% 0.172.0 MB 4.1% 0.57
Jan 23 00:00:00 - 00:59:59 469 3.0% 0.131.4 MB 2.8% 0.39
Jan 23 01:00:00 - 01:59:59 410 2.6% 0.111.3 MB 2.6% 0.37
Jan 23 02:00:00 - 02:59:59 330 2.1% 0.091.0 MB 2.1% 0.29
Jan 23 03:00:00 - 03:59:59 339 2.2% 0.091.4 MB 2.8% 0.40
Jan 23 04:00:00 - 04:15:00 75 0.5% 0.08269.1 KB 0.5% 0.30
TOTAL: 24:00:00 15662 100.0% 0.1849.1 MB 100.0% 0.58
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1634 68 0 0 0 0 0 0 1566
2newsfeed.fu-berlin.de 503 36 0 0 0 0 0 0 467
3csiph-out.news.weretis.net 414 101 0 0 0 0 0 0 313
4news-out.mixmin.net 319 10 0 0 0 0 0 0 309
5newsfeed.neva.ru 274 50 0 1 0 0 0 0 223
6csiph-out.feeder.erje.net 225 83 0 5 0 0 0 0 137
7csiph-out.feed.uzoreto.com 208 16 0 0 0 0 0 0 192
8news-out.neodome.net 180 2 0 1 0 0 0 0 177
9news.freedyn.net 100 0 0 0 0 0 0 0 100
10csiph-out.news.tnetconsulting.net 88 8 0 1 0 0 0 0 79
11feeder.eternal-september.org 84 40 0 0 0 0 0 0 44
12news-out.aioe.org 53 38 0 0 0 0 0 0 15
13newsfeeds.xmission.com 35 2 0 0 0 0 0 0 33
14news.swapon.de 31 0 0 0 0 0 0 0 31
15news.fcku.it 22 22 0 0 0 0 0 0 0
16nntp.pasdenom.info 8 0 0 0 0 0 0 0 8
17news.samoylyk.net 5 0 0 1 0 0 0 0 4
TOTAL: 17 4183 476 0 9 0 0 0 0 3698

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 76
lada.talk 37
it-alt.sport.calcio.juventus 35
spline.eisfair.dev 24
scinet.stats 24
mozilla.support.thunderbird 20
alt.binaries.pictures.purebeauty 20
alt.survival 18
alt.bbs.synchronet 17
alt.politics 16
scinet.sysop 16
mozilla.dev.apps.seamonkey 15
mozilla.support.seamonkey 13
alt.job 10
mozilla.general 10
mozilla.support.firefox 9
mozilla.dev.security.policy 7
alt.math.undergrad 7
alt.politics.usa 6
alt.tv.comedy-central.daily-show 6
TOTAL: 74 476

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2072
EMP (phn path) 500
EMP (phn nph) 134
EMP (phl) 128
Too many newsgroups 75
0 60
Binary: misplaced binary 23
Scoring filter 19
HTML Multipart 13
Too many newsgroups (meow) 4
Too many test groups in crosspost 3
Poison newsgroup 1
TOTAL: 12 3032

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 51
csiph-out.news.tnetconsulting.net 36
news-out.neodome.net 27
csiph-out.feed.uzoreto.com 23
csiph-out.news.xs4all.nl 20
news.freedyn.net 19
newsfeeds.xmission.com 6
csiph-out.news.weretis.net 5
news.samoylyk.net 4
news-out.mixmin.net 2
TOTAL: 11 194
Including strange strings
newsfeed.fu-berlin.de 347
news.swapon.de 31
newsfeeds.xmission.com 25
csiph-out.news.weretis.net 18
news-out.mixmin.net 13
csiph-out.news.xs4all.nl 12
csiph-out.feeder.erje.net 9
newsfeed.neva.ru 5
feeder.eternal-september.org 4
news-out.aioe.org 2
TOTAL: 11 467
No colon-space in header
csiph-out.feed.uzoreto.com 2
csiph-out.news.xs4all.nl 2
csiph-out.feeder.erje.net 1
TOTAL: 3 5
TOTAL: 4 711

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 17896 846 14814 1 0 0 4%23:59:56
2fu-berlin.de 14587 527 14060 0 0 0 3%23:59:40
3news.samoylyk.net 16292 523 15133 2 0 30 3%23:59:56
4news.bbs.nz 29246 249 14840 27 0 0 0%23:59:52
5neva.ru 14221 131 13778 178 0 0 0%23:59:56
6xmission 16365 77 12830 5 0 0 0%23:59:56
7newsfeed.xs4all.nl 12534 72 11803 2 0 22 0%23:59:55
8tnet 16139 55 15068 0 0 0 0%23:59:56
9news.freedyn.net 14392 37 13863 27 0 0 0%23:59:56
10usenet.pasdenom.info 15524 18 14849 77 0 7 0%23:59:56
11neodome.net 15766 7 15159 0 0 0 0%23:59:55
12news.uzoreto.com 15205 7 14737 34 0 0 0%23:59:53
13news.mixmin.net 14283 4 13762 0 0 0 0%23:59:43
14aioe 13370 1 12720 0 0 0 0%23:59:46
15news.swapon.de 1309 1 1297 0 0 0 0%23:02:16
16news.fcku.it 1249 0 1247 0 0 0 0%20:32:54
17erje 14510 0 14242 10 0 10 0%23:59:56
18weretis.net 14327 0 14057 1 0 0 0%23:59:53
19eternal-september 0 0 0 0 0 12590 0%23:59:56
TOTAL: 19 257215 2555 228259 364 0 12659 0%451:33:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs6.1 MB12.3 KB6.1 MB0.1 KB/s7.4 KB23:59:56
2fu-berlin.de5.4 MB0.0 KB5.4 MB0.1 KB/s10.5 KB23:59:40
3news.samoylyk.net5.4 MB28.8 KB5.4 MB0.1 KB/s10.5 KB23:59:56
4news.bbs.nz603.3 KB94.8 KB698.1 KB0.0 KB/s2.5 KB23:59:52
5neva.ru258.1 KB428.7 KB686.8 KB0.0 KB/s2.2 KB23:59:56
6xmission187.2 KB14.5 KB201.7 KB0.0 KB/s2.5 KB23:59:56
7newsfeed.xs4all.nl178.2 KB9.0 KB187.2 KB0.0 KB/s2.5 KB23:59:55
8tnet100.9 KB0.0 KB100.9 KB0.0 KB/s1.8 KB23:59:56
9news.freedyn.net67.3 KB343.8 KB411.1 KB0.0 KB/s6.4 KB23:59:56
10neodome.net46.4 KB0.0 KB46.4 KB0.0 KB/s6.6 KB23:59:55
11usenet.pasdenom.info32.5 KB121.9 KB154.4 KB0.0 KB/s1.6 KB23:59:56
12news.uzoreto.com8.6 KB101.6 KB110.2 KB0.0 KB/s2.7 KB23:59:53
13news.mixmin.net4.3 KB0.0 KB4.3 KB0.0 KB/s1.1 KB23:59:43
14aioe3.4 KB0.0 KB3.4 KB0.0 KB/s3.4 KB23:59:46
15news.swapon.de1.8 KB0.0 KB1.8 KB0.0 KB/s1.8 KB23:02:16
16news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s020:32:54
17erje0.0 KB30.3 KB30.3 KB0.0 KB/s3.0 KB23:59:56
18weretis.net0.0 KB5.3 KB5.3 KB0.0 KB/s5.3 KB23:59:53
19eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 1918.3 MB1.2 MB19.5 MB0.0 KB/s6.8 KB451:33:11
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1p578e8829.dip0.t-ipconnect.de 1 1629.3 KB 19 0 000:03:34
291.187.33.87 292 11.7 KB 1 0 040:49:04
3212.90.61.180 1 00.0 KB 15 0 000:00:00
TOTAL: 3 294 1731.0 KB 35 0 056:27:21

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dip0.t-ipconnect.de 1 1629.3 KB 19 0 000:03:34
2unresolved 300 11.7 KB 16 0 043:50:07
3*.upc-a.chello.nl 75 00.0 KB 0 0 012:30:49
4*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:01
5*.range86-138.btcentralplus.com 4 00.0 KB 0 0 000:02:48
TOTAL: 5 381 1731.0 KB 35 0 056:27:21

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 18.214 4.425 0.00040:49:04
a131033.upc-a.chello.nl 4.711 1.008 0.00012:30:49
172.83.96.97 0.360 0.040 0.00002:00:18
208.72.53.133 0.204 0.041 0.00001:00:43
p578e8829.dip0.t-ipconnect.de 0.119 0.135 0.00000:03:34
host86-138-214-35.range86-138.btcentralplus.com 0.270 0.046 0.00000:02:48
scanner-04.ch1.censys-scanner.com 0.079 0.000 0.00000:00:01
151.36.10.141 0.063 0.014 0.00000:00:01
TOTAL: 8 24.020 5.709 0.00056:27:21

Curious NNRP server explorers [Top 20]:

SystemConn
a131033.upc-a.chello.nl 75
172.83.96.97 4
host86-138-214-35.range86-138.btcentralplus.com 4
208.72.53.133 2
151.36.10.141 1
scanner-04.ch1.censys-scanner.com 1
TOTAL: 6 87

NNRP unrecognized commands (by host):

SystemConn
scanner-04.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 4 0
208.72.53.133 2 0
TOTAL: 2 6 0

Newsgroup request counts (by category):

CategoryCountPct
1alt 315 92.1%
2comp 20 5.8%
3aioe 6 1.8%
4ab 1 0.3%
TOTAL: 4 342100.0%

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

NewsgroupCount
1alt.atheism 123
2alt.arts.poetry.comments 79
3alt.anonymous.messages 35
4comp.sys.ibm.ps2.hardware 20
5alt.assassination.jfk 18
6alt.appalachian 14
7alt.buddha.short.fat.guy 12
8alt.bible 11
9alt.bible.prophecy 10
10aioe.news.assistenza 6
11alt.baldspot 5
12alt.aeffle.und.pferdle 4
13alt.alt.test 2
14alt.books.tom-holt 1
15ab.politics 1
16alt.autos.subaru 1
TOTAL: 16 342
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