Daily Usenet report for csiph.com

Apr 16 04:15:00 -- Apr 17 04:15:00

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Apr 17 02:41:47 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[19316]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Apr 17 02:41:47 842ffb22-07e1-11e5-a459-00266cf00584 nnrpd[19316]: 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
innd 22436 38.6%3.7 MB 33.9%
inn 18029 31.0%4.6 MB 42.1%
innfeed 15659 26.9%2.4 MB 21.4%
nnrpd 1998 3.4%284.4 KB 2.5%
nocem 2 0.0%0.3 KB 0.0%
TOTAL: 5 58124 100.0%11.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 283330 54.6%
Negative hits 218162 42.0%
Do not exist 17419 3.4%
Cache misses 350 0.1%
TOTAL: 4 519261 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.156 0.0%13 0.000 12.000 28.000
article cleanup00:00:00.132 0.0%17225 0.000 0.008 0.044
article logging00:00:01.393 0.0%17788 0.000 0.078 2.365
article parse00:00:01.997 0.0%51889 0.000 0.038 0.867
article write00:01:47.068 0.1%14783 0.161 7.243 35.592
artlog/artcncl00:00:00.003 0.0%13 0.000 0.231 1.500
artlog/artparse00:00:00.004 0.0%237 0.000 0.017 1.000
data move00:00:00.153 0.0%478344 0.000 0.000 0.003
hisgrep/artcncl00:00:00.015 0.0%13 0.000 1.154 4.500
hishave/artcncl00:00:00.003 0.0%13 0.000 0.231 1.000
hishave/artparse00:00:00.001 0.0%236 0.000 0.004 0.083
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:48.398 0.1%522168 0.002 0.093 0.311
history sync00:00:01.536 0.0%378 0.000 4.063 41.667
history write00:01:19.288 0.1%17226 0.176 4.603 14.174
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:01.554 0.0%236 0.000 6.585 150.000
idle23:33:08.983 98.2%479822 95.649 176.709 551.051
nntp read00:00:02.161 0.0%491688 0.001 0.004 0.008
overview write00:20:28.689 1.4%14783 0.120 83.115 16919.024
perl filter00:00:24.451 0.0%17225 1.085 1.420 2.227
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.269 0.0%29568 0.000 0.009 0.024
TOTAL: 23:58:59.50023:58:06.254 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.038 0.0%16669 0.000 0.002 0.028
article prepare00:00:00.000 0.0%3968 0.000 0.000 0.000
article read00:00:02.030 0.0%875 0.000 2.320 79.143
backlog stats00:00:00.197 0.0%294689 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.983 0.0%225687 0.000 0.004 0.011
data write00:00:01.389 0.0%213112 0.000 0.007 0.024
idle23:53:35.530100.0%294689 155.793 291.886 2674.438
status file00:00:03.574 0.0%5414 0.389 0.660 4.899
TOTAL: 23:53:59.51923:53:43.741100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle33:22:32.320 99.9%1074 0.000111873.669600087.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.030 0.0%2459 0.000 0.012 1.000
readart00:00:00.115 0.0%4 13.000 28.750 48.000
TOTAL: 33:24:23.92833:22:32.465 99.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.xs4all.nl 2352 16646 4685 10085 1876 28%124:28:15
2newsfeeds.xmission.com 3 14352 1966 12380 6 13%26:19:38
3feeder.eternal-september.org 15 6409 1906 4411 92 29%27:19:25
4news-out.mixmin.net 2 15583 1205 14188 190 7%23:57:38
5csiph-out.feeder.erje.net 1444 71946 991 70606 349 1%118:46:57
6newsfeed.fu-berlin.de 14 10683 821 9834 28 7%17:47:20
7csiph-out.news.weretis.net 4 28908 567 28312 29 1%47:56:09
8news-out.aioe.org 2 13762 556 13188 18 4%23:58:38
9newsfeed.neva.ru 141 18693 516 18066 111 2%71:36:48
10csiph-out.news.tnetconsulting.net 2 26100 382 25707 11 1%42:49:01
11news-out.neodome.net 2 16066 319 15727 20 1%23:58:06
12news.freedyn.net 2 16758 288 16379 91 1%23:58:06
13nntp.pasdenom.info 6 18514 286 18227 1 1%47:47:22
14news.fcku.it 13 1416 186 1230 0 13%21:35:44
15csiph-out.feed.uzoreto.com 865 23890 179 23617 94 0%71:08:30
16news.swapon.de 7 1245 35 1210 0 2%23:40:32
17news.bbs.nz 2 14445 7 14438 0 0%24:03:57
18localhost 26 0 0 0 0 0%00:00:00
TOTAL: 18 4902 315416 14895 297605 2916 4%761:12:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.xs4all.nl12.1 MB0.0 KB17.0 MB29.1 MB 41%4.5 KB
2csiph-out.feeder.erje.net7.5 MB0.0 KB2.1 MB9.6 MB 77%7.4 KB
3newsfeeds.xmission.com5.8 MB0.0 KB132.6 KB5.9 MB 97%3.1 KB
4feeder.eternal-september.org5.7 MB0.0 KB2.3 MB8.0 MB 70%4.1 KB
5news-out.mixmin.net2.5 MB0.0 KB771.4 KB3.2 MB 76%2.4 KB
6newsfeed.fu-berlin.de2.0 MB0.0 KB70.9 KB2.1 MB 96%2.5 KB
7news-out.aioe.org1.7 MB0.0 KB40.6 KB1.8 MB 97%3.2 KB
8csiph-out.news.weretis.net1.5 MB0.0 KB1.1 MB2.7 MB 56%4.6 KB
9csiph-out.news.tnetconsulting.net1.3 MB0.0 KB170.0 KB1.4 MB 88%3.7 KB
10newsfeed.neva.ru1.2 MB0.0 KB344.5 KB1.5 MB 78%2.5 KB
11news.freedyn.net858.5 KB0.0 KB698.4 KB1.5 MB 55%4.1 KB
12news-out.neodome.net830.5 KB0.0 KB96.5 KB927.0 KB 89%2.7 KB
13nntp.pasdenom.info595.9 KB0.0 KB0.8 KB596.7 KB 99%2.1 KB
14csiph-out.feed.uzoreto.com569.1 KB0.0 KB2.4 MB2.9 MB 18%11.0 KB
15news.fcku.it318.5 KB0.0 KB0.0 KB318.5 KB100%1.7 KB
16news.swapon.de86.7 KB0.0 KB0.0 KB86.7 KB100%2.5 KB
17news.bbs.nz15.1 KB0.0 KB0.0 KB15.1 KB100%2.2 KB
18localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1844.6 MB0.0 KB27.3 MB71.8 MB 62%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 16 04:15:00 - 04:59:59 366 2.5% 0.142.5 MB 5.7% 0.94
Apr 16 05:00:00 - 05:59:59 361 2.4% 0.101.2 MB 2.7% 0.34
Apr 16 06:00:00 - 06:59:59 441 3.0% 0.121.0 MB 2.4% 0.29
Apr 16 07:00:00 - 07:59:59 580 3.9% 0.161.3 MB 3.0% 0.37
Apr 16 08:00:00 - 08:59:59 801 5.4% 0.222.3 MB 5.3% 0.66
Apr 16 09:00:00 - 09:59:59 744 5.0% 0.211.8 MB 4.2% 0.52
Apr 16 10:00:00 - 10:59:59 698 4.7% 0.191.8 MB 4.2% 0.52
Apr 16 11:00:00 - 11:59:59 689 4.7% 0.191.7 MB 3.9% 0.49
Apr 16 12:00:00 - 12:59:59 729 4.9% 0.202.1 MB 4.7% 0.59
Apr 16 13:00:00 - 13:59:59 786 5.3% 0.221.9 MB 4.3% 0.54
Apr 16 14:00:00 - 14:59:59 809 5.5% 0.222.1 MB 4.9% 0.61
Apr 16 15:00:00 - 15:59:59 776 5.3% 0.222.0 MB 4.5% 0.57
Apr 16 16:00:00 - 16:59:59 874 5.9% 0.243.2 MB 7.3% 0.90
Apr 16 17:00:00 - 17:59:59 925 6.3% 0.262.8 MB 6.3% 0.79
Apr 16 18:00:00 - 18:59:59 857 5.8% 0.242.7 MB 6.2% 0.77
Apr 16 19:00:00 - 19:59:59 703 4.8% 0.202.0 MB 4.5% 0.56
Apr 16 20:00:00 - 20:59:59 648 4.4% 0.182.0 MB 4.5% 0.56
Apr 16 21:00:00 - 21:59:59 675 4.6% 0.192.4 MB 5.6% 0.69
Apr 16 22:00:00 - 22:59:59 600 4.1% 0.171.7 MB 3.8% 0.48
Apr 16 23:00:00 - 23:59:59 390 2.6% 0.111.2 MB 2.7% 0.34
Apr 17 00:00:00 - 00:59:59 386 2.6% 0.111.2 MB 2.7% 0.34
Apr 17 01:00:00 - 01:59:59 318 2.2% 0.091.0 MB 2.3% 0.29
Apr 17 02:00:00 - 02:59:59 282 1.9% 0.08894.4 KB 2.0% 0.25
Apr 17 03:00:00 - 03:59:59 265 1.8% 0.07791.8 KB 1.8% 0.22
Apr 17 04:00:00 - 04:15:00 67 0.5% 0.07211.4 KB 0.5% 0.23
TOTAL: 24:00:00 14770 100.0% 0.1743.8 MB 100.0% 0.52
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 2023 185 0 0 0 0 0 0 1838
2newsfeed.fu-berlin.de 404 15 0 0 0 0 0 0 389
3news-out.mixmin.net 192 19 0 0 0 0 0 0 173
4csiph-out.feeder.erje.net 118 44 0 0 0 0 0 0 74
5newsfeed.neva.ru 117 37 0 0 0 0 0 0 80
6csiph-out.feed.uzoreto.com 100 19 0 0 0 0 0 0 81
7news.freedyn.net 95 0 0 0 0 0 0 0 95
8feeder.eternal-september.org 91 48 0 0 0 0 0 0 43
9csiph-out.news.weretis.net 38 9 0 0 0 0 0 0 29
10news-out.aioe.org 21 13 0 0 0 0 0 0 8
11news.swapon.de 18 0 0 0 0 0 0 0 18
12csiph-out.news.tnetconsulting.net 8 6 0 0 0 0 0 0 2
13newsfeeds.xmission.com 7 2 0 0 0 0 0 0 5
14news-out.neodome.net 7 2 0 0 0 0 0 0 5
15nntp.pasdenom.info 2 0 0 0 0 0 0 0 2
TOTAL: 15 3241 399 0 0 0 0 0 0 2842

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 152
alt.news.misc 46
lada.talk 24
alt.binaries.pictures.purebeauty 16
spline.eisfair 16
trollnet.cinema 10
alt.job 10
alt.politics.usa 9
alt.bbs.synchronet 9
alt.slack.goathead 9
mozilla.support.seamonkey 8
alt.computer.hardware 7
cakewalk.audio 6
alt.finance 6
alt.binaries.books 5
alt.comp.lang.raku 5
at.jobs 4
oesterreich.tratsch 4
it-alt.sport.calcio.juventus 3
lada.movies 2
TOTAL: 60 399

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1697
Too many newsgroups 216
EMP (phl) 69
0 23
EMP (phn path) 12
Binary: misplaced binary 8
Scoring filter 7
Too many newsgroups (low_xpost) 3
Too many newsgroups (meow) 3
HTML Multipart 2
HTML post 1
TOTAL: 11 2041

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 45
TOTAL: 1 45
Huge articles
csiph-out.news.xs4all.nl 123
csiph-out.feeder.erje.net 38
feeder.eternal-september.org 29
csiph-out.feed.uzoreto.com 18
csiph-out.news.weretis.net 13
news.freedyn.net 6
news-out.mixmin.net 6
newsfeeds.xmission.com 2
csiph-out.news.tnetconsulting.net 1
TOTAL: 9 236
Including strange strings
newsfeed.fu-berlin.de 361
csiph-out.news.xs4all.nl 150
news.swapon.de 18
newsfeed.neva.ru 6
csiph-out.news.weretis.net 6
csiph-out.feed.uzoreto.com 5
csiph-out.feeder.erje.net 5
news-out.aioe.org 3
news.freedyn.net 3
news-out.mixmin.net 3
TOTAL: 12 564
No colon-space in header
csiph-out.feed.uzoreto.com 1
TOTAL: 1 1
TOTAL: 4 846

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1fu-berlin.de 13610 453 13157 0 0 0 3%23:59:14
2news.bbs.nz 27288 193 13973 40 0 0 0%23:59:18
3xmission 16048 71 12163 22 0 0 0%23:59:15
4weretis.net 14108 35 13480 8 0 0 0%23:59:16
5tnet 15298 33 14174 6 0 0 0%23:59:15
6newsfeed.xs4all.nl 10304 31 9705 0 0 82 0%23:59:51
7erje 13853 15 13525 20 0 0 0%23:59:15
8news.freedyn.net 14557 4 14375 34 0 0 0%23:59:04
9neva.ru 13349 4 13232 0 0 0 0%23:58:45
10news.uzoreto.com 13680 2 13478 20 0 0 0%23:59:14
11neodome.net 14702 1 14418 0 0 114 0%23:59:51
12news.mixmin.net 12823 1 12686 0 0 0 0%23:59:14
13usenet.pasdenom.info 14118 0 13930 0 0 13 0%23:59:14
14news.swapon.de 1306 0 1295 0 0 0 0%23:49:07
15aioe 12504 0 12256 0 0 18 0%23:59:14
16news.samoylyk.net 0 0 0 0 0 14770 0%23:58:38
17xanadu-bbs 1708 0 0 0 0 16477 0%23:59:37
18eternal-september 0 0 0 0 0 12218 0%23:59:52
19news.fcku.it 1170 0 1169 0 0 0 0%20:55:28
TOTAL: 19 210426 843 187016 150 0 43692 0%452:32:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1fu-berlin.de4.8 MB0.0 KB4.8 MB0.1 KB/s10.9 KB23:59:14
2news.bbs.nz462.7 KB95.0 KB557.7 KB0.0 KB/s2.4 KB23:59:18
3xmission158.4 KB76.8 KB235.2 KB0.0 KB/s2.5 KB23:59:15
4newsfeed.xs4all.nl108.2 KB0.0 KB108.2 KB0.0 KB/s3.5 KB23:59:51
5erje59.5 KB73.3 KB132.9 KB0.0 KB/s3.8 KB23:59:15
6tnet56.4 KB18.0 KB74.4 KB0.0 KB/s1.9 KB23:59:15
7weretis.net55.9 KB33.8 KB89.7 KB0.0 KB/s2.1 KB23:59:16
8neodome.net31.0 KB0.0 KB31.0 KB0.0 KB/s31.0 KB23:59:51
9news.freedyn.net17.8 KB552.2 KB570.1 KB0.0 KB/s15.0 KB23:59:04
10news.uzoreto.com13.6 KB243.3 KB256.9 KB0.0 KB/s11.7 KB23:59:14
11neva.ru5.3 KB0.0 KB5.3 KB0.0 KB/s1.3 KB23:58:45
12news.mixmin.net2.9 KB0.0 KB2.9 KB0.0 KB/s2.9 KB23:59:14
13usenet.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:14
14news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:49:07
15aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:14
16news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:38
17xanadu-bbs0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:37
18eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s020:55:28
TOTAL: 195.8 MB1.1 MB6.8 MB0.0 KB/s7.1 KB452:32:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1a131033.upc-a.chello.nl 25 425.0 KB 3 0 006:37:43
TOTAL: 1 25 425.0 KB 3 0 033:24:07

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.upc-a.chello.nl 25 425.0 KB 3 0 006:37:43
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:01
3*.163.24.10.ip.us.as30241.net 4 00.0 KB 0 0 002:00:24
4unresolved 291 00.0 KB 0 0 024:45:57
TOTAL: 4 321 425.0 KB 3 0 033:24:07

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 17.307 3.770 0.00023:44:36
a131033.upc-a.chello.nl 1.676 0.318 0.00006:37:43
192.163.24.10.ip.us.as30241.net 0.361 0.068 0.00002:00:24
208.72.53.129 0.206 0.023 0.00001:00:12
193.169.255.238 0.116 0.024 0.00000:00:58
192.241.206.176 0.063 0.016 0.00000:00:09
scanner-09.ch1.censys-scanner.com 0.053 0.023 0.00000:00:01
TOTAL: 7 19.782 4.242 0.00033:24:07

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 286
192.163.24.10.ip.us.as30241.net 4
208.72.53.129 2
193.169.255.238 2
scanner-09.ch1.censys-scanner.com 1
192.241.206.176 1
TOTAL: 6 296

NNRP unrecognized commands (by host):

SystemConn
scanner-09.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
192.163.24.10.ip.us.as30241.net 4 0
208.72.53.129 2 0
193.169.255.238 2 2
TOTAL: 3 8 2

Newsgroup request counts (by category):

CategoryCountPct
1comp 4100.0%
TOTAL: 1 4100.0%

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

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