Daily Usenet report for csiph.com

Mar 12 04:15:00 -- Mar 13 04:15:00

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Mar 12 12:29:34 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[23284]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Mar 12 12:29:34 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[23284]: 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 12 12:31:28 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[23474]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Mar 12 12:31:28 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[23474]: 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 12 13:40:06 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[29410]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Mar 12 13:40:06 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[29410]: 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 12 13:43:40 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[29866]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Mar 12 13:43:40 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[29866]: 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 12 18:56:42 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[56749]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Mar 12 18:56:42 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[56749]: 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 12 23:39:14 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[80867]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Mar 12 23:39:14 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[80867]: 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 31252 55.5%7.2 MB 64.1%
innd 19109 33.9%3.0 MB 26.9%
innfeed 3801 6.7%730.3 KB 6.3%
nnrpd 2168 3.8%297.7 KB 2.6%
nocem 18 0.0%2.6 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 56349 100.0%11.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 457981 52.7%
Negative hits 379162 43.6%
Do not exist 29957 3.4%
Cache misses 1854 0.2%
TOTAL: 4 868954 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.524 0.0%25 0.000 20.960 70.000
article cleanup00:00:00.190 0.0%30292 0.000 0.006 0.073
article logging00:00:01.751 0.0%30751 0.000 0.057 3.157
article parse00:00:02.825 0.0%87598 0.000 0.032 0.409
article write00:02:15.410 0.2%21329 0.140 6.349 45.935
artlog/artcncl00:00:00.010 0.0%25 0.000 0.400 1.500
artlog/artparse00:00:00.035 0.0%524 0.000 0.067 1.000
data move00:00:00.205 0.0%742050 0.000 0.000 0.002
hisgrep/artcncl00:00:00.026 0.0%25 0.000 1.040 13.000
hishave/artcncl00:00:00.002 0.0%25 0.000 0.080 0.200
hishave/artparse00:00:00.001 0.0%522 0.000 0.002 0.031
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:31.394 0.1%872233 0.001 0.105 0.611
history sync00:00:01.214 0.0%362 0.000 3.354 19.000
history write00:01:54.040 0.1%29535 0.226 3.861 13.702
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:02.140 0.0%521 0.000 4.107 47.750
idle23:40:46.273 98.2%725113 14.909 117.563 381.638
nntp read00:00:03.112 0.0%747669 0.001 0.004 0.009
overview write00:18:12.207 1.3%21329 0.146 51.208 24980.037
perl filter00:00:37.780 0.0%29533 0.454 1.279 2.489
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.376 0.0%42676 0.000 0.009 0.032
TOTAL: 24:06:42.50224:05:29.515 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.048 0.0%21477 0.000 0.002 0.015
article prepare00:00:00.001 0.0%4432 0.000 0.000 0.042
article read00:00:04.114 0.0%1000 0.000 4.114 587.333
backlog stats00:00:00.220 0.0%393751 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.436 0.0%312888 0.000 0.005 0.011
data write00:00:01.749 0.0%295463 0.000 0.006 0.014
idle23:54:26.369100.0%393751 105.232 218.581 977.357
status file00:00:00.860 0.0%441 0.000 1.950 78.000
TOTAL: 23:54:45.24523:54:34.797100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle36:58:55.816 99.7%1175 0.000113307.077600097.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.052 0.0%2795 0.000 0.019 1.143
readart00:00:00.042 0.0%1 42.000 42.000 42.000
TOTAL: 37:04:47.31136:58:55.910 99.7%----

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
1news-out.mixmin.net 3 21212 4497 16100 615 21%22:51:45
2news-out.aioe.org 4 24161 3524 20573 64 14%24:55:44
3csiph-out.news.xs4all.nl 0 11006 2675 3163 5168 24%75:19:10
4feeder.eternal-september.org 17 6190 2397 3442 351 38%28:34:17
5newsfeeds.xmission.com 4 24058 1715 22326 17 7%23:24:58
6csiph-out.news.weretis.net 11 47719 1364 46007 348 2%48:20:35
7csiph-out.feed.uzoreto.com 864 40683 1106 38786 791 2%71:21:54
8csiph-out.feeder.erje.net 1445 132068 898 130011 1159 0%119:06:26
9newsfeed.fu-berlin.de 22 25520 830 24472 218 3%26:39:17
10newsfeed.neva.ru 147 32290 675 31361 254 2%72:06:36
11news.freedyn.net 3 28578 621 27524 433 2%24:09:03
12news.fcku.it 16 1571 236 1331 4 15%22:56:17
13news-out.neodome.net 3 21329 217 21077 35 1%21:34:37
14nntp.pasdenom.info 2 9746 164 9582 0 1%23:58:37
15csiph-out.news.tnetconsulting.net 4 31130 164 30941 25 0%32:18:31
16news.swapon.de 9 1171 64 1106 1 5%25:19:50
17news.bbs.nz 2 20672 2 20670 0 0%23:59:50
18localhost 26 0 0 0 0 0%00:00:00
TOTAL: 18 2582 479104 21149 448472 9483 4%686:57:27
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.mixmin.net11.9 MB0.0 KB1.1 MB13.0 MB 91%2.6 KB
2news-out.aioe.org11.1 MB9.9 KB117.7 KB11.3 MB 98%3.2 KB
3csiph-out.news.xs4all.nl7.0 MB66.1 KB7.9 MB15.1 MB 46%2.0 KB
4feeder.eternal-september.org6.7 MB10.4 KB9.2 MB15.9 MB 42%5.9 KB
5csiph-out.feeder.erje.net5.4 MB589.4 KB4.1 MB10.1 MB 53%5.0 KB
6newsfeeds.xmission.com5.1 MB0.0 KB797.4 KB5.8 MB 86%3.5 KB
7csiph-out.news.weretis.net3.7 MB28.7 KB2.3 MB6.1 MB 61%3.6 KB
8csiph-out.feed.uzoreto.com3.6 MB19.3 KB14.8 MB18.4 MB 19%10.0 KB
9newsfeed.fu-berlin.de2.0 MB0.0 KB2.0 MB4.0 MB 50%3.9 KB
10newsfeed.neva.ru1.8 MB2.8 KB521.2 KB2.4 MB 78%2.6 KB
11news.freedyn.net1.8 MB15.2 KB3.3 MB5.1 MB 35%5.0 KB
12csiph-out.news.tnetconsulting.net607.6 KB0.0 KB187.0 KB794.6 KB 76%4.2 KB
13news-out.neodome.net464.2 KB0.0 KB771.7 KB1.2 MB 37%4.9 KB
14nntp.pasdenom.info364.4 KB0.0 KB0.0 KB364.4 KB100%2.2 KB
15news.fcku.it361.2 KB0.0 KB5.2 KB366.4 KB 98%1.5 KB
16news.swapon.de136.0 KB0.0 KB48.2 KB184.2 KB 73%2.8 KB
17news.bbs.nz4.1 KB0.0 KB0.0 KB4.1 KB100%2.1 KB
18localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1862.2 MB741.8 KB47.1 MB110.0 MB 56%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 12 04:15:00 - 04:59:59 399 1.9% 0.151.2 MB 1.9% 0.46
Mar 12 05:00:00 - 05:59:59 502 2.4% 0.141.6 MB 2.5% 0.44
Mar 12 06:00:00 - 06:59:59 547 2.6% 0.151.8 MB 2.9% 0.51
Mar 12 07:00:00 - 07:59:59 541 2.5% 0.152.5 MB 4.1% 0.72
Mar 12 08:00:00 - 08:59:59 722 3.4% 0.202.0 MB 3.3% 0.58
Mar 12 09:00:00 - 09:59:59 632 3.0% 0.181.5 MB 2.4% 0.42
Mar 12 10:00:00 - 10:59:59 991 4.7% 0.282.7 MB 4.4% 0.78
Mar 12 11:00:00 - 11:59:59 1241 5.8% 0.343.7 MB 6.0% 1.07
Mar 12 12:00:00 - 12:59:59 1160 5.5% 0.323.5 MB 5.6% 0.99
Mar 12 13:00:00 - 13:59:59 1204 5.7% 0.333.5 MB 5.6% 0.98
Mar 12 14:00:00 - 14:59:59 1351 6.3% 0.384.1 MB 6.6% 1.16
Mar 12 15:00:00 - 15:59:59 1261 5.9% 0.353.9 MB 6.3% 1.12
Mar 12 16:00:00 - 16:59:59 1255 5.9% 0.353.7 MB 5.9% 1.05
Mar 12 17:00:00 - 17:59:59 1241 5.8% 0.343.6 MB 5.8% 1.03
Mar 12 18:00:00 - 18:59:59 1206 5.7% 0.343.4 MB 5.5% 0.98
Mar 12 19:00:00 - 19:59:59 1124 5.3% 0.313.5 MB 5.6% 1.00
Mar 12 20:00:00 - 20:59:59 662 3.1% 0.181.9 MB 3.1% 0.55
Mar 12 21:00:00 - 21:59:59 1064 5.0% 0.302.5 MB 4.0% 0.71
Mar 12 22:00:00 - 22:59:59 587 2.8% 0.161.5 MB 2.4% 0.42
Mar 12 23:00:00 - 23:59:59 537 2.5% 0.151.8 MB 3.0% 0.52
Mar 13 00:00:00 - 00:59:59 376 1.8% 0.101.1 MB 1.7% 0.31
Mar 13 01:00:00 - 01:59:59 438 2.1% 0.121.3 MB 2.1% 0.37
Mar 13 02:00:00 - 02:59:59 896 4.2% 0.252.5 MB 4.0% 0.70
Mar 13 03:00:00 - 03:59:59 1066 5.0% 0.302.6 MB 4.2% 0.74
Mar 13 04:00:00 - 04:15:00 277 1.3% 0.31683.6 KB 1.1% 0.76
TOTAL: 24:00:00 21280 100.0% 0.2562.1 MB 100.0% 0.74
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 5184 58 0 67 0 0 0 0 5059
2csiph-out.feeder.erje.net 1067 69 0 616 1 0 0 0 381
3csiph-out.feed.uzoreto.com 819 51 0 20 1 0 0 0 747
4news-out.mixmin.net 638 192 0 0 0 0 0 0 446
5newsfeed.fu-berlin.de 564 16 0 0 0 0 0 0 548
6csiph-out.news.weretis.net 446 75 0 27 0 0 0 0 344
7news.freedyn.net 433 6 0 15 0 0 0 0 412
8feeder.eternal-september.org 356 25 0 11 0 0 0 0 320
9newsfeed.neva.ru 255 37 0 2 0 0 0 0 216
10news-out.aioe.org 64 48 0 1 0 0 0 0 15
11news-out.neodome.net 44 4 0 0 0 0 0 0 40
12news.swapon.de 36 0 0 0 0 0 0 0 36
13newsfeeds.xmission.com 21 1 0 0 0 0 0 0 20
14csiph-out.news.tnetconsulting.net 15 6 0 0 0 0 0 0 9
15news.fcku.it 5 4 0 0 0 0 0 0 1
TOTAL: 15 9947 592 0 759 2 0 0 0 8594

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 292
alt.finance 25
alt.news.misc 25
alt.comp.lang.raku 21
lada.talk 21
it-alt.sport.calcio.juventus 18
alt.binaries.by-hash.shv1 15
lada.auto 15
alt.job 15
alt.windows7.general 13
alt.bbs.synchronet 10
alt.survival 9
alt.politics.usa 7
mozilla.support.thunderbird 7
spline.fli4l.geschnatter 7
at.jobs 6
trollnet.cinema 5
alt.binaries.pictures.purebeauty 5
alt.philosophy 4
alt.politics 4
TOTAL: 70 592

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

GroupsCount
uk.legal.moderated 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
0 5094
EMP (md5) 1897
Too many newsgroups 158
EMP (phn path) 157
EMP (phl) 120
Binary: misplaced binary 109
EMP (phn nph) 65
Binary Payload 4
HTML Multipart 4
TOTAL: 9 7608

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 202
feeder.eternal-september.org 120
csiph-out.news.xs4all.nl 53
csiph-out.feeder.erje.net 53
news.freedyn.net 36
csiph-out.news.weretis.net 23
news-out.neodome.net 16
newsfeeds.xmission.com 15
csiph-out.news.tnetconsulting.net 3
news-out.mixmin.net 3
TOTAL: 11 525
Including strange strings
newsfeed.fu-berlin.de 336
news.swapon.de 35
csiph-out.feed.uzoreto.com 27
news-out.mixmin.net 20
csiph-out.news.weretis.net 14
csiph-out.news.xs4all.nl 13
csiph-out.feeder.erje.net 4
feeder.eternal-september.org 4
newsfeeds.xmission.com 3
newsfeed.neva.ru 2
TOTAL: 11 459
No colon-space in header
csiph-out.feeder.erje.net 2
TOTAL: 1 2
TOTAL: 4 1031

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1fu-berlin.de 20117 397 19719 0 0 0 1%23:55:12
2newsfeed.xs4all.nl 20375 192 18383 3 0 155 0%23:53:14
3news.bbs.nz 40240 159 20577 22 0 0 0%23:55:20
4xmission 22309 133 18809 5 0 0 0%23:55:12
5usenet.pasdenom.info 21135 41 20601 3 0 5 0%23:58:39
6tnet 22028 27 20735 1 0 0 0%23:55:12
7erje 20222 12 19600 57 0 14 0%23:55:10
8news.freedyn.net 20360 5 20148 27 0 0 0%23:55:12
9aioe 12729 3 12358 0 0 0 0%23:55:12
10news.mixmin.net 15968 1 15740 0 0 0 0%23:55:12
11weretis.net 19622 0 19237 3 0 0 0%23:55:12
12xanadu-bbs 0 0 0 0 0 21136 0%23:50:08
13news.swapon.de 1153 0 1135 0 0 0 0%23:28:10
14news.fcku.it 1268 0 1262 0 0 0 0%22:03:18
15neodome.net 21150 0 20859 0 0 115 0%23:50:37
16eternal-september 0 0 0 0 0 18055 0%23:50:09
17neva.ru 19645 0 19584 5 0 0 0%23:55:15
18news.uzoreto.com 18985 0 18821 13 0 0 0%23:55:15
19news.samoylyk.net 0 0 0 0 0 21136 0%23:50:06
TOTAL: 19 297306 970 267568 139 0 60616 0%451:51:45
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1fu-berlin.de3.9 MB0.0 KB3.9 MB0.0 KB/s10.1 KB23:55:12
2newsfeed.xs4all.nl743.4 KB41.4 KB784.8 KB0.0 KB/s4.0 KB23:53:14
3news.bbs.nz396.8 KB115.1 KB511.9 KB0.0 KB/s2.8 KB23:55:20
4xmission387.9 KB13.0 KB400.9 KB0.0 KB/s2.9 KB23:55:12
5usenet.pasdenom.info181.8 KB9.9 KB191.7 KB0.0 KB/s4.4 KB23:58:39
6news.freedyn.net62.4 KB439.8 KB502.2 KB0.0 KB/s15.7 KB23:55:12
7tnet59.0 KB1.8 KB60.9 KB0.0 KB/s2.2 KB23:55:12
8erje36.8 KB180.5 KB217.3 KB0.0 KB/s3.1 KB23:55:10
9news.mixmin.net36.1 KB0.0 KB36.1 KB0.0 KB/s36.1 KB23:55:12
10aioe5.2 KB0.0 KB5.2 KB0.0 KB/s1.7 KB23:55:12
11weretis.net0.0 KB3.5 KB3.5 KB0.0 KB/s1.2 KB23:55:12
12xanadu-bbs0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:08
13news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:28:10
14news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s022:03:18
15neodome.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:37
16eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:09
17neva.ru0.0 KB44.6 KB44.6 KB0.0 KB/s8.9 KB23:55:15
18news.uzoreto.com0.0 KB68.3 KB68.3 KB0.0 KB/s5.3 KB23:55:15
19news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:06
TOTAL: 195.8 MB917.9 KB6.7 MB0.0 KB/s6.2 KB451:51:45
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.163.24.10.ip.us.as30241.net 5 12.2 KB 1 0 001:00:08
TOTAL: 1 5 12.2 KB 1 0 037:04:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.163.24.10.ip.us.as30241.net 5 12.2 KB 1 0 001:00:08
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:01
3unresolved 292 00.0 KB 0 0 026:47:57
4*.range31-49.btcentralplus.com 5 00.0 KB 0 0 000:43:55
5*.upc-a.chello.nl 53 00.0 KB 0 0 008:32:11
TOTAL: 5 356 12.2 KB 1 0 037:04:14

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 17.359 4.031 0.00025:17:45
a131033.upc-a.chello.nl 3.293 0.638 0.00008:32:11
208.72.53.135 0.229 0.083 0.00001:30:12
192.163.24.10.ip.us.as30241.net 0.447 0.059 0.00001:00:08
host31-49-229-214.range31-49.btcentralplus.com 0.296 0.090 0.00000:43:55
scanner-05.ch1.censys-scanner.com 0.047 0.031 0.00000:00:01
TOTAL: 6 21.671 4.932 0.00037:04:14

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 287
a131033.upc-a.chello.nl 53
host31-49-229-214.range31-49.btcentralplus.com 5
208.72.53.135 5
scanner-05.ch1.censys-scanner.com 1
TOTAL: 5 351

NNRP unrecognized commands (by host):

SystemConn
scanner-05.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
208.72.53.135 3 0
192.163.24.10.ip.us.as30241.net 1 0
TOTAL: 2 4 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 1100.0%
TOTAL: 1 1100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 1
TOTAL: 1 1
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: admin@kev009.com