Daily Usenet report for news.ripco.com

Feb 25 00:01:02 -- Feb 25 23:57:44

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Feb 25 13:37:39 remote5bge0 overchan[25364]: [ID 702911 news.error] input line too long, skipping
Feb 25 14:16:15 remote5bge0 overchan[25364]: [ID 702911 news.error] input line too long, skipping
Feb 25 14:35:56 remote5bge0 controlchan[25355]: [ID 702911 news.notice] skipping newgroup free.metaphysics y dale@dalekelly.org (would be created): Empty description
Feb 25 14:35:56 s_local@remote5bge0 controlchan[25355]: [ID 702911 news.notice] skipping newgroup free.metaphysics y dale@dalekelly.org (would be created): Empty description

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 34864 43.1%4.1 MB 34.4%
inn 22285 27.5%3.9 MB 33.1%
innd 20289 25.1%3.2 MB 26.6%
innfeed 3454 4.3%722.5 KB 5.9%
controlchan 6 0.0%0.9 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
TOTAL: 6 80900 100.0%11.9 MB100.0%

History cache:

ReasonCount%Count
Cache misses 185006 50.1%
Do not exist 184588 49.9%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 369594 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%178 0.000 0.000 0.000
article cleanup00:00:00.682 0.0%44172 0.000 0.015 0.042
article logging00:00:01.048 0.0%44648 0.000 0.023 0.203
article parse00:00:01.694 0.0%106798 0.000 0.016 0.035
article write00:00:45.868 0.0%33526 0.415 1.368 67.340
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.442 0.0%377890 0.000 0.001 0.006
hishave/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.534 0.0%371536 0.002 0.007 0.016
history sync00:00:00.350 0.0%804 0.000 0.435 2.667
history write00:00:05.314 0.0%44164 0.011 0.120 3.153
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:56:50.894 99.8%418746 213.078 412.209 894.745
nntp read00:00:03.570 0.0%413082 0.004 0.009 0.016
overview write00:00:00.294 0.0%33526 0.000 0.009 0.041
perl filter00:01:11.096 0.0%44110 1.313 1.612 3.682
python filter00:00:01.914 0.0%44130 0.010 0.043 0.112
site send00:00:02.386 0.0%100514 0.004 0.024 0.056
TOTAL: 48:02:21.72647:59:08.086 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.170 0.0%42894 0.000 0.004 0.051
article prepare00:00:00.004 0.0%17768 0.000 0.000 0.019
article read00:00:00.548 0.0%3878 0.000 0.141 7.100
backlog stats00:00:00.272 0.0%388616 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.718 0.0%257536 0.002 0.011 0.021
data write00:00:03.654 0.0%224290 0.003 0.016 0.040
idle47:52:27.980100.0%388616 145.474 443.492 977.977
status file00:00:05.574 0.0%402 5.000 13.866 44.000
TOTAL: 47:53:00.51647:52:40.920100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:04.840 0.0%311316 0.000 0.016 0.030
idle36:44:30.306 98.8%342078 0.667 386.667121318.400
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:13.720 0.0%1428066 0.000 0.010 0.641
readart00:00:20.852 0.0%3128 0.000 6.666 36.000
TOTAL: 37:11:06.81236:45:09.718 98.8%----

Control commands to INND:

CommandNumber
L 2
flush 2
go 4
logmode 2
mode 6
name 5
pause 2
paused 2
reserve 4
TOTAL: 9 29

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
dale@dalekelly.org200022
TOTAL200022

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 36264 9878 23718 2668 27%94:40:10
2news.snarked.org 50 31110 9704 21070 336 31%56:25:56
3feeder3.feed-ams.uzoreto.com 574 20946 6370 11710 2866 30%47:19:38
4newsfeed.neva.ru 568 50178 5732 41280 3166 11%279:10:08
5newsfeed.fu-berlin.de 2 11958 576 11356 26 4%36:56:34
6news.cmpublishers.com 42 9362 454 8866 42 4%38:11:18
7news.lightlink.com 6 11286 224 10568 494 1%62:45:46
8news-in.rahul.net 574 19748 204 19490 54 1%47:19:02
9ripco-out.feeder.erje.net 574 35604 86 34528 990 0%47:19:54
10localhost 164 20 20 0 0 100%00:00:04
TOTAL: 10 3702 226476 33248 182586 10642 14%710:08:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org28.7 MB0.0 KB1.5 MB30.2 MB 95%3.1 KB
2ripco-out.feed.uzoreto.com24.6 MB0.0 KB6.7 MB31.3 MB 78%2.6 KB
3newsfeed.neva.ru17.8 MB13.5 KB10.5 MB28.3 MB 62%3.3 KB
4feeder3.feed-ams.uzoreto.com16.8 MB0.0 KB5.7 MB22.5 MB 74%2.5 KB
5news.lightlink.com13.8 MB0.0 KB21.4 MB35.2 MB 39%50.2 KB
6news-in.rahul.net4.8 MB0.0 KB1.8 MB6.6 MB 72%26.1 KB
7newsfeed.fu-berlin.de2.8 MB0.0 KB670.3 KB3.4 MB 81%5.9 KB
8news.cmpublishers.com1.2 MB0.0 KB283.0 KB1.5 MB 81%3.1 KB
9ripco-out.feeder.erje.net506.0 KB0.0 KB9.9 MB10.4 MB 4%9.9 KB
10localhost42.7 KB0.0 KB0.0 KB42.7 KB100%2.1 KB
TOTAL: 10111.0 MB13.5 KB58.5 MB169.5 MB 65%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 25 00:01:02 - 00:59:59 377 2.3% 0.111.1 MB 2.0% 0.32
Feb 25 01:00:00 - 01:59:59 560 3.4% 0.161.8 MB 3.3% 0.51
Feb 25 02:00:00 - 02:59:59 603 3.6% 0.171.8 MB 3.4% 0.52
Feb 25 03:00:00 - 03:59:59 683 4.1% 0.191.9 MB 3.5% 0.54
Feb 25 04:00:00 - 04:59:59 798 4.8% 0.222.5 MB 4.7% 0.72
Feb 25 05:00:00 - 05:59:59 734 4.4% 0.202.3 MB 4.3% 0.67
Feb 25 06:00:00 - 06:59:59 719 4.3% 0.202.4 MB 4.4% 0.68
Feb 25 07:00:00 - 07:59:59 871 5.2% 0.242.2 MB 4.1% 0.63
Feb 25 08:00:00 - 08:59:59 896 5.4% 0.253.3 MB 6.1% 0.94
Feb 25 09:00:00 - 09:59:59 889 5.3% 0.252.3 MB 4.2% 0.65
Feb 25 10:00:00 - 10:59:59 1049 6.3% 0.293.8 MB 7.0% 1.08
Feb 25 11:00:00 - 11:59:59 855 5.1% 0.243.2 MB 5.8% 0.90
Feb 25 12:00:00 - 12:59:59 835 5.0% 0.232.5 MB 4.5% 0.70
Feb 25 13:00:00 - 13:59:59 972 5.8% 0.273.6 MB 6.5% 1.01
Feb 25 14:00:00 - 14:59:59 923 5.5% 0.263.1 MB 5.7% 0.88
Feb 25 15:00:00 - 15:59:59 792 4.7% 0.222.6 MB 4.8% 0.75
Feb 25 16:00:00 - 16:59:59 727 4.4% 0.202.0 MB 3.7% 0.57
Feb 25 17:00:00 - 17:59:59 556 3.3% 0.151.5 MB 2.7% 0.42
Feb 25 18:00:00 - 18:59:59 598 3.6% 0.172.3 MB 4.2% 0.64
Feb 25 19:00:00 - 19:59:59 519 3.1% 0.141.6 MB 3.0% 0.46
Feb 25 20:00:00 - 20:59:59 484 2.9% 0.132.6 MB 4.8% 0.74
Feb 25 21:00:00 - 21:59:59 434 2.6% 0.121.2 MB 2.2% 0.34
Feb 25 22:00:00 - 22:59:59 509 3.0% 0.141.5 MB 2.8% 0.44
Feb 25 23:00:00 - 23:57:44 329 2.0% 0.091.1 MB 2.1% 0.34
TOTAL: 23:56:42 16712 100.0% 0.1954.2 MB 100.0% 0.64
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 1655 510 0 3 4 0 0 0 1138
2feeder3.feed-ams.uzoreto.com 1437 1112 0 0 0 0 0 0 325
3ripco-out.feed.uzoreto.com 1345 660 0 0 1 0 0 0 684
4ripco-out.feeder.erje.net 497 483 0 0 0 0 0 0 14
5news.lightlink.com 218 1 0 1 0 0 0 0 216
6newsfeed.fu-berlin.de 206 0 0 0 0 0 0 0 206
7news.snarked.org 168 75 0 0 1 0 0 0 92
8news-in.rahul.net 27 0 0 0 0 0 0 0 27
9news.cmpublishers.com 20 0 0 0 0 0 0 0 20
TOTAL: 9 5573 2841 0 4 6 0 0 0 2722

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1835
alt.binaries.ftd 238
fido7.su.pol.news 47
alt.binaries.nl 41
perl.cpan.uploads 34
it.tlc.cellulari.android 30
alt.astrology.pro 29
free.uk.astrology 27
gmane.linux.alsa.devel 26
de.soc.arbeitslos 24
uk.net.news.moderation 23
it.comp.os.win.windows10 22
fr.usenet.abus.nocem 19
free.it.scienza.fisica 19
alt.bestjobsusa.computer.jobs 17
alt.binaries.e-book 17
alt.binaries.movies.xvid 15
alt.jobs.jobsearch 14
free.willey 13
at.jobs 11
TOTAL: 156 2841

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

GroupsCount
pl.praca.oferowana 4
alt.christnet.religion 1
bit.listserv.catholic 1
TOTAL: 3 6

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3166
Too many newsgroups 1150
Binary in non-binary group 362
Scoring filter (8) 94
EMP (phl) 50
Scoring filter (9) 38
Attached HTML file 16
Scoring filter (10) 16
Scoring filter (13) 10
HTML post 4
Scoring filter (18) 2
Scoring filter (11) 2
Scoring filter (12) 2
MID-Bot 2
TOTAL: 14 4914

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 20
ripco-out.feed.uzoreto.com 4
TOTAL: 2 24
Including strange strings
newsfeed.fu-berlin.de 181
newsfeed.neva.ru 52
feeder3.feed-ams.uzoreto.com 2
ripco-out.feeder.erje.net 1
ripco-out.feed.uzoreto.com 1
TOTAL: 5 237
TOTAL: 2 261

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 11856 2514 4958 10 0 4 21%47:49:46
2rahul.net 28682 828 15996 10 0 0 2%47:42:14
3news.cmpublishers.com 40716 64 31768 678 0 9474 0%47:37:46
4news.uzoreto.com 17074 54 16586 64 0 0 0%47:35:26
5news.snarked.org 38784 42 23444 40 0 54 0%47:45:50
6feeder.erje.net 31846 28 31186 8 0 0 0%47:46:50
7newsfeed.neva.ru 27818 28 27488 28 0 0 0%47:40:42
8fu-berlin.de 30490 28 30460 0 0 0 0%47:40:04
9remote6hme0.ripco.com 16 10 0 6 0 0 62%02:32:28
TOTAL: 9 227282 3596 181886 844 0 9532 1%384:11:06
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com7.3 MB21.0 KB7.4 MB0.0 KB/s3.0 KB47:49:46
2rahul.net4.9 MB40.4 KB5.0 MB0.0 KB/s6.1 KB47:42:14
3news.snarked.org322.5 KB208.5 KB531.0 KB0.0 KB/s6.5 KB47:45:50
4newsfeed.neva.ru225.1 KB63.0 KB288.1 KB0.0 KB/s5.1 KB47:40:42
5news.cmpublishers.com172.2 KB1.8 MB1.9 MB0.0 KB/s2.6 KB47:37:46
6news.uzoreto.com167.9 KB273.9 KB441.8 KB0.0 KB/s3.7 KB47:35:26
7feeder.erje.net98.3 KB19.9 KB118.2 KB0.0 KB/s3.3 KB47:46:50
8fu-berlin.de96.3 KB0.0 KB96.3 KB0.0 KB/s3.4 KB47:40:04
9remote6hme0.ripco.com20.6 KB24.0 KB44.6 KB0.0 KB/s2.8 KB02:32:28
TOTAL: 913.3 MB2.4 MB15.7 MB0.0 KB/s3.6 KB384:11:06
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 12403.4 MB 514 18 000:08:04
2shell3 22 5501.4 MB 58 2 002:54:06
389.39.105.128 10 78224.5 KB 2 0 000:00:25
4az1-ss13.a2hosting.com 4 21.9 KB 2 0 000:06:27
TOTAL: 4 322 18705.1 MB 576 20 037:09:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 12403.4 MB 514 18 000:08:04
2? 22 5501.4 MB 58 2 002:54:07
3unresolved 144 78224.5 KB 2 0 004:30:37
4*.a2hosting.com 4 21.9 KB 2 0 000:06:27
5*.7-3.cable.virginm.net 2 00.0 KB 0 0 000:00:21
6*.access.telenet.be 48 00.0 KB 0 0 008:09:52
7*.sfj.corp.censys.io 2 00.0 KB 0 0 000:00:00
8*.zinnia.simplybits.net 2 00.0 KB 0 0 003:03:04
9*.tbcn.telia.com2824 00.0 KB 0 0 000:14:06
10*.dsl.bell.ca 20 00.0 KB 0 0 001:03:52
11*.tas.foxtel.net.au 4 00.0 KB 0 0 001:13:29
12*.security.ipip.net 2 00.0 KB 0 0 000:00:01
13*.demon.co.uk 6 00.0 KB 0 0 000:00:26
14*.ip.afrihost.joburg 6 00.0 KB 0 0 000:53:32
15*.red-83-56-15.staticip.rima-tde.net 2 00.0 KB 0 0 000:13:38
16*.cm-12-2c.dynamic.ziggo.nl 38 00.0 KB 0 0 014:37:56
17*.census.shodan.io 2 00.0 KB 0 0 000:00:02
TOTAL: 173414 18705.1 MB 576 20 037:09:42

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
54698637.cm-12-2c.dynamic.ziggo.nl 6.848 6.232 0.00014:37:56
d54c176a7.access.telenet.be 6.646 4.404 0.00008:09:52
95.157.1.81 0.350 0.094 0.00003:21:35
canopy1.zinnia.simplybits.net 1.386 1.798 0.00003:03:04
shell3 5.278 2.914 0.00002:54:06
cpe-172-193-130-87.tas.foxtel.net.au 0.552 0.162 0.00001:13:29
nrbaon0431w-lp140-01-70-30-111-64.dsl.bell.ca 2.308 1.076 0.00001:03:52
82.64.52.116 0.800 0.270 0.00000:53:55
165-73-52-18.ip.afrihost.joburg 0.754 0.414 0.00000:53:32
81-233-125-44-no79.tbcn.telia.com 281.558 74.866 0.00000:14:06
114.red-83-56-15.staticip.rima-tde.net 0.244 0.086 0.00000:13:38
ftupet.com 47.554 22.954 0.00000:08:04
109.255.148.241 1.610 0.476 0.00000:07:29
az1-ss13.a2hosting.com 1.224 8.080 0.00000:06:27
199.115.119.241 0.414 0.154 0.00000:03:51
177.40.33.122 0.404 0.116 0.00000:01:46
104.251.79.24 9.604 2.626 0.00000:01:11
gmcirm.demon.co.uk 1.026 0.336 0.00000:00:26
89.39.105.128 1.572 0.330 0.00000:00:25
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 0.210 0.056 0.00000:00:21
TOTAL: 26 371.826 127.838 0.00037:09:42

Curious NNRP server explorers [Top 20]:

SystemConn
81-233-125-44-no79.tbcn.telia.com 2824
104.251.79.24 96
d54c176a7.access.telenet.be 48
54698637.cm-12-2c.dynamic.ziggo.nl 38
nrbaon0431w-lp140-01-70-30-111-64.dsl.bell.ca 20
109.255.148.241 16
82.64.52.116 8
165-73-52-18.ip.afrihost.joburg 6
gmcirm.demon.co.uk 6
177.40.33.122 4
cpe-172-193-130-87.tas.foxtel.net.au 4
199.115.119.241 4
canopy1.zinnia.simplybits.net 2
109.236.87.234 2
ninja.census.shodan.io 2
114.red-83-56-15.staticip.rima-tde.net 2
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 2
scan-141.security.ipip.net 2
104.131.145.15 2
95.157.1.81 2
TOTAL: 21 3092

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 8
shell3 8
TOTAL: 2 16

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 8
Connection: close 2
GET / HTTP/1.1 2
User-Agent: HTTP Banner Detection (https... 2
Host: 66.251.253.167:119 2
TOTAL: 5 16

NNRP client timeouts [Top 20]:

SystemConnPeer
54698637.cm-12-2c.dynamic.ziggo.nl 8 0
82.64.52.116 4 0
shell3 2 0
TOTAL: 3 14 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1502 80.3%
2comp 138 7.4%
3alt 126 6.7%
4misc 76 4.1%
5rocksolid 10 0.5%
6chi 6 0.3%
7sci 6 0.3%
8ba 2 0.1%
9nl 2 0.1%
10news 2 0.1%
TOTAL: 10 1870100.0%

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

NewsgroupCount
1rec.arts.tv 882
2rec.food.cooking 492
3rec.bicycles.tech 110
4alt.os.linux.ubuntu 78
5comp.mobile.android 76
6misc.phone.mobile.iphone 52
7comp.sys.mac.system 34
8alt.comp.os.windows-10 26
9misc.consumers.frugal-living 24
10comp.sys.mac.apps 22
11rocksolid.shared.general 8
12alt.stupidity 8
13alt.games.warcraft 8
14rec.bicycles.misc 6
15sci.electronics.repair 6
16rec.radio.swap 4
17chi.weather 4
18comp.protocols.dns.bind 4
19alt.bittorrent 4
20rec.gardens.edible 4
21nl.test 2
22rec.radio.broadcasting 2
23chi.forsale 2
24alt.hvac 2
25comp.unix.solaris 2
26rocksolid.shared.tor 2
27ba.food 2
28rec.puzzles 2
29news.groups.questions 2
TOTAL: 29 1870