Daily Usenet report for news.ripco.com

Nov 30 00:01:03 -- Nov 30 23:57:36

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Nov 30 02:41:18 remote5bge0 overchan[21172]: [ID 702911 news.error] input line too long, skipping
Nov 30 06:55:52 remote5bge0 overchan[21172]: [ID 702911 news.error] input line too long, skipping
Nov 30 07:24:45 remote5bge0 overchan[21172]: [ID 702911 news.error] input line too long, skipping
Nov 30 08:06:25 remote5bge0 overchan[21172]: [ID 702911 news.error] input line too long, skipping
Nov 30 08:55:59 remote5bge0 overchan[21172]: [ID 702911 news.error] input line too long, skipping
Nov 30 14:16:58 remote5bge0 overchan[21172]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 25837 34.4%2.8 MB 25.8%
inn 23059 30.7%3.9 MB 35.8%
innd 22504 30.0%3.5 MB 31.6%
innfeed 3628 4.8%766.5 KB 6.8%
controlchan 10 0.0%1.8 KB 0.0%
overchan 6 0.0%1.0 KB 0.0%
TOTAL: 6 75044 100.0%11.0 MB100.0%

History cache:

ReasonCount%Count
Cache misses 205604 53.9%
Do not exist 175818 46.1%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 381422 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%70 0.000 0.000 0.000
article cleanup00:00:00.528 0.0%45822 0.000 0.012 0.048
article logging00:00:00.752 0.0%46228 0.000 0.016 0.165
article parse00:00:01.822 0.0%111404 0.000 0.016 0.037
article write00:00:43.038 0.0%32262 0.446 1.334 28.842
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.284 0.0%399310 0.000 0.001 0.004
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.928 0.0%383780 0.000 0.008 0.580
history sync00:00:00.414 0.0%792 0.000 0.523 8.667
history write00:00:05.806 0.0%45818 0.029 0.127 6.735
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:59:24.450 99.9%433400 229.018 398.626 1190.407
nntp read00:00:02.464 0.0%430526 0.001 0.006 0.015
overview write00:00:00.202 0.0%32262 0.000 0.006 0.043
perl filter00:00:58.020 0.0%45804 1.066 1.267 3.301
python filter00:00:01.094 0.0%45832 0.000 0.024 0.076
site send00:00:01.802 0.0%96710 0.000 0.019 0.042
TOTAL: 48:01:58.36448:01:23.604100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.568 0.0%32250 0.000 0.018 0.060
article prepare00:00:00.010 0.0%22304 0.000 0.000 0.031
article read00:00:00.478 0.0%4390 0.000 0.109 9.500
backlog stats00:00:00.252 0.0%395004 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.812 0.0%258436 0.002 0.011 0.022
data write00:00:03.636 0.0%226700 0.006 0.016 0.039
idle47:52:36.378100.0%395004 256.707 436.341 1060.180
status file00:00:04.202 0.0%342 0.000 12.287 58.000
TOTAL: 47:53:00.24047:52:48.336100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.762 0.0%47316 0.004 0.016 0.300
idle76:31:04.906 99.3%79196 0.333 3478.268282248.222
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:02:35.570 0.1%1592358 0.000 0.098 264.364
readart00:00:35.248 0.0%6368 0.000 5.535 71.000
TOTAL: 77:04:34.81276:34:16.486 99.3%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
usenet@film.rlss.okayama-u.ac.jp002022
TOTAL002022

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 44836 13278 27006 4552 29%94:48:02
2news.snarked.org 66 41680 9940 27284 4456 23%58:24:38
3newsfeed.neva.ru 574 63012 5544 55720 1748 8%280:50:36
4feeder3.feed-ams.uzoreto.com 552 12554 2042 9932 580 16%45:19:34
5newsfeed.fu-berlin.de 2 12520 646 11820 54 5%40:46:48
6news.lightlink.com 2 8426 106 7082 1238 1%37:00:10
7ripco-out.feeder.erje.net 576 35744 92 34668 984 0%47:31:56
8news-in.rahul.net 574 19266 74 19112 80 0%47:18:44
9localhost 172 28 28 0 0 100%00:00:00
10news.cmpublishers.com 54 8712 26 8674 12 0%48:00:04
TOTAL: 10 3720 246778 31776 201298 13704 12%700:00:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com33.5 MB0.0 KB9.6 MB43.0 MB 77%2.5 KB
2news.snarked.org30.5 MB0.0 KB15.5 MB46.0 MB 66%3.3 KB
3newsfeed.neva.ru17.0 MB12.8 KB5.9 MB23.0 MB 74%3.2 KB
4feeder3.feed-ams.uzoreto.com6.6 MB0.0 KB1.7 MB8.3 MB 79%3.3 KB
5newsfeed.fu-berlin.de2.3 MB0.0 KB212.1 KB2.5 MB 91%3.7 KB
6news-in.rahul.net2.3 MB0.0 KB3.8 MB6.1 MB 37%40.2 KB
7news.lightlink.com1.3 MB0.0 KB43.5 MB44.9 MB 2%34.2 KB
8ripco-out.feeder.erje.net205.3 KB0.0 KB9.4 MB9.6 MB 2%9.1 KB
9news.cmpublishers.com64.5 KB0.0 KB17.8 KB82.3 KB 78%2.2 KB
10localhost60.3 KB0.0 KB0.0 KB60.3 KB100%2.2 KB
TOTAL: 1093.9 MB12.8 KB89.6 MB183.5 MB 51%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 30 00:01:03 - 00:59:59 396 2.5% 0.111.2 MB 2.5% 0.35
Nov 30 01:00:00 - 01:59:59 508 3.2% 0.141.5 MB 3.1% 0.42
Nov 30 02:00:00 - 02:59:59 710 4.4% 0.201.9 MB 4.0% 0.54
Nov 30 03:00:00 - 03:59:59 775 4.8% 0.222.0 MB 4.1% 0.56
Nov 30 04:00:00 - 04:59:59 779 4.8% 0.222.2 MB 4.6% 0.62
Nov 30 05:00:00 - 05:59:59 720 4.5% 0.202.1 MB 4.4% 0.60
Nov 30 06:00:00 - 06:59:59 799 5.0% 0.222.3 MB 4.8% 0.65
Nov 30 07:00:00 - 07:59:59 848 5.3% 0.242.9 MB 6.0% 0.81
Nov 30 08:00:00 - 08:59:59 950 5.9% 0.262.8 MB 5.8% 0.79
Nov 30 09:00:00 - 09:59:59 1015 6.3% 0.282.5 MB 5.3% 0.72
Nov 30 10:00:00 - 10:59:59 1024 6.4% 0.282.9 MB 6.1% 0.82
Nov 30 11:00:00 - 11:59:59 979 6.1% 0.272.9 MB 6.2% 0.83
Nov 30 12:00:00 - 12:59:59 828 5.1% 0.232.2 MB 4.5% 0.62
Nov 30 13:00:00 - 13:59:59 781 4.9% 0.222.6 MB 5.5% 0.74
Nov 30 14:00:00 - 14:59:59 746 4.6% 0.212.1 MB 4.4% 0.60
Nov 30 15:00:00 - 15:59:59 752 4.7% 0.212.7 MB 5.7% 0.77
Nov 30 16:00:00 - 16:59:59 619 3.8% 0.171.8 MB 3.7% 0.50
Nov 30 17:00:00 - 17:59:59 586 3.6% 0.161.8 MB 3.7% 0.50
Nov 30 18:00:00 - 18:59:59 539 3.4% 0.151.7 MB 3.6% 0.48
Nov 30 19:00:00 - 19:59:59 416 2.6% 0.121.2 MB 2.5% 0.33
Nov 30 20:00:00 - 20:59:59 294 1.8% 0.08778.3 KB 1.6% 0.22
Nov 30 21:00:00 - 21:59:59 362 2.3% 0.101.2 MB 2.5% 0.33
Nov 30 22:00:00 - 22:59:59 336 2.1% 0.091.4 MB 2.9% 0.39
Nov 30 23:00:00 - 23:57:36 326 2.0% 0.091.2 MB 2.6% 0.37
TOTAL: 23:56:33 16088 100.0% 0.1947.7 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2291 1831 0 0 7 0 0 0 453
2news.snarked.org 2251 68 0 0 8 0 0 0 2175
3newsfeed.neva.ru 905 636 0 2 4 0 0 0 263
4news.lightlink.com 514 5 0 0 0 0 0 0 509
5ripco-out.feeder.erje.net 494 490 0 0 0 0 0 0 4
6feeder3.feed-ams.uzoreto.com 293 186 0 0 2 0 0 0 105
7newsfeed.fu-berlin.de 177 0 0 0 0 0 0 0 177
8news-in.rahul.net 40 2 0 0 0 0 0 0 38
9news.cmpublishers.com 6 1 0 0 0 0 0 0 5
TOTAL: 9 6971 3219 0 2 21 0 0 0 3729

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2113
alt.binaries.ftd 263
free.uk.astrology 65
fido7.su.pol.news 49
perl.cpan.uploads 45
alt.astrology.pro 40
it.comp.os.win.windows10 30
free.willey 29
alt.bestjobsusa.computer.jobs 29
it.tlc.cellulari.android 23
alt.binaries.e-book 23
alt.jobs.jobsearch 20
alt.binaries.nl 18
att.jobs 17
alt.binaries.pictures.scenic 16
mozilla.dev.platform 16
at.jobs 15
alt.my.job.sucks 14
uk.net.news.moderation 14
alt.binaries.sounds.lossless 13
TOTAL: 167 3219

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

GroupsCount
fr.comp.securite 15
pl.praca.oferowana 2
christnet.theology 1
alt.christnet.religion 1
alt.penthouse.sex.masterbation 1
bit.listserv.catholic 1
TOTAL: 6 21

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4476
Too many newsgroups 1400
Binary in non-binary group 946
EMP (phl) 100
Scoring filter (16) 46
Attached HTML file 26
Scoring filter (8) 16
Scoring filter (9) 10
Scoring filter (10) 8
Scoring filter (12) 6
Scoring filter (18) 2
Scoring filter (11) 2
HTML post 2
TOTAL: 13 7040

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
TOTAL: 1 18
Including strange strings
newsfeed.fu-berlin.de 144
newsfeed.neva.ru 35
ripco-out.feed.uzoreto.com 15
news.snarked.org 3
feeder3.feed-ams.uzoreto.com 3
ripco-out.feeder.erje.net 2
TOTAL: 6 202
TOTAL: 2 220

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9714 2370 4556 22 0 0 24%47:40:04
2rahul.net 23906 914 13438 16 0 0 3%47:40:04
3feeder.erje.net 31060 234 29744 162 0 8 0%47:36:48
4news.cmpublishers.com 45268 124 30664 1118 0 14 0%47:41:10
5news.snarked.org 38258 118 21532 6 0 124 0%47:40:04
6news.uzoreto.com 17374 116 16230 216 0 0 0%47:44:02
7fu-berlin.de 29142 54 29088 0 0 0 0%47:44:44
8newsfeed.neva.ru 27080 40 26330 54 0 0 0%47:51:06
9remote6hme0.ripco.com 0 0 0 0 0 10 0%47:40:00
TOTAL: 9 221802 3970 171582 1594 0 156 1%429:18:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com7.1 MB35.3 KB7.2 MB0.0 KB/s3.1 KB47:40:04
2rahul.net3.3 MB33.2 KB3.3 MB0.0 KB/s3.7 KB47:40:04
3feeder.erje.net791.7 KB598.7 KB1.4 MB0.0 KB/s3.5 KB47:36:48
4news.snarked.org416.3 KB17.7 KB434.0 KB0.0 KB/s3.5 KB47:40:04
5news.cmpublishers.com349.8 KB2.9 MB3.2 MB0.0 KB/s2.7 KB47:41:10
6news.uzoreto.com337.4 KB735.3 KB1.0 MB0.0 KB/s3.2 KB47:44:02
7fu-berlin.de179.3 KB0.0 KB179.3 KB0.0 KB/s3.3 KB47:44:44
8newsfeed.neva.ru126.8 KB257.0 KB383.8 KB0.0 KB/s4.1 KB47:51:06
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 912.6 MB4.5 MB17.1 MB0.0 KB/s3.2 KB429:18:02
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
170.125.61.57 26 346810.6 MB 12 0 000:33:25
2172.58.140.153 8 10022.9 MB 6 0 000:03:45
3ftupet.com 286 7902.3 MB 402 26 000:06:51
4shell3 32 254652.7 KB 34 2 001:30:40
5131.45.96.58.static.exetel.com.au 8 3274.4 KB 8 0 000:17:23
6197.211.61.87 2 49.2 KB 2 0 000:20:22
7az1-ss13.a2hosting.com 4 21.5 KB 2 0 000:06:04
TOTAL: 7 366 555216.5 MB 466 28 077:04:26

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 60 447413.5 MB 20 0 071:41:05
2*.com 286 7902.3 MB 402 26 000:06:51
3? 32 254652.7 KB 34 2 001:30:40
4*.45.96.58.static.exetel.com.au 8 3274.4 KB 8 0 000:17:23
5*.a2hosting.com 4 21.5 KB 2 0 000:06:04
6*.w86-207.abo.wanadoo.fr 2 00.0 KB 0 0 000:00:01
7*.fuse.net 2 00.0 KB 0 0 000:20:17
8*.toronto.ca.northamericancoax.com 6 00.0 KB 0 0 000:52:58
9*.range109-155.btcentralplus.com 6 00.0 KB 0 0 000:01:03
10*.19-1.cable.virginm.net 6 00.0 KB 0 0 000:12:10
11*.hawaii.res.rr.com 20 00.0 KB 0 0 001:55:39
12*.nos-oignons.net 10 00.0 KB 0 0 000:00:06
13*.dynamic-ip.hinet.net 4 00.0 KB 0 0 000:00:04
TOTAL: 13 446 555216.5 MB 466 28 077:04:26

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.11.163.217 0.836 0.256 0.00070:43:17
cpe-24-25-255-195.hawaii.res.rr.com 2.802 1.842 0.00001:55:39
shell3 5.982 2.214 0.00001:30:40
ip-58-230-239-173.toronto.ca.northamericancoax.com 0.926 0.336 0.00000:52:58
70.125.61.57 3.968 1.104 0.00000:33:25
197.211.61.87 0.334 0.046 0.00000:20:22
dsl-208-102-99-220.fuse.net 0.206 0.052 0.00000:20:17
131.45.96.58.static.exetel.com.au 2.634 0.614 0.00000:17:23
cpc150131-smal18-2-0-cust414.19-1.cable.virginm.net 1.164 0.338 0.00000:12:10
ftupet.com 45.722 7.378 0.00000:06:51
az1-ss13.a2hosting.com 0.806 0.650 0.00000:06:04
172.58.140.153 1.356 0.542 0.00000:03:45
host109-155-245-73.range109-155.btcentralplus.com 0.690 0.230 0.00000:01:03
marylou.nos-oignons.net 1.208 0.304 0.00000:00:06
185.107.83.75 0.594 0.120 0.00000:00:04
109.236.81.139 0.396 0.082 0.00000:00:03
125-231-87-11.dynamic-ip.hinet.net 0.198 0.038 0.00000:00:02
118-166-143-3.dynamic-ip.hinet.net 0.202 0.042 0.00000:00:02
109.236.81.135 0.198 0.040 0.00000:00:01
85.159.237.41 0.206 0.044 0.00000:00:01
TOTAL: 23 71.292 16.462 0.00077:04:26

Curious NNRP server explorers [Top 20]:

SystemConn
cpe-24-25-255-195.hawaii.res.rr.com 20
marylou.nos-oignons.net 10
66.11.163.217 8
host109-155-245-73.range109-155.btcentralplus.com 6
185.107.83.75 6
cpc150131-smal18-2-0-cust414.19-1.cable.virginm.net 6
ip-58-230-239-173.toronto.ca.northamericancoax.com 6
109.236.81.139 4
125-231-87-11.dynamic-ip.hinet.net 2
195.181.168.211 2
85.159.237.41 2
dsl-208-102-99-220.fuse.net 2
109.236.81.135 2
aclermont-ferrand-652-1-204-137.w86-207.abo.wanadoo.fr 2
118-166-143-3.dynamic-ip.hinet.net 2
TOTAL: 15 80

NNRP unrecognized commands (by host):

SystemConn
shell3 12
125-231-87-11.dynamic-ip.hinet.net 4
118-166-143-3.dynamic-ip.hinet.net 4
TOTAL: 3 20

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 12
Host: cn.aol.com 4
GET http://cn.aol.com HTTP/1.1 4
TOTAL: 3 20

NNRP client timeouts [Top 20]:

SystemConnPeer
66.11.163.217 8 0
125-231-87-11.dynamic-ip.hinet.net 2 2
dsl-208-102-99-220.fuse.net 2 0
197.211.61.87 2 0
shell3 2 0
118-166-143-3.dynamic-ip.hinet.net 2 2
TOTAL: 6 18 4

Newsgroup request counts (by category):

CategoryCountPct
1alt 4514 81.3%
2rec 956 17.2%
3comp 56 1.0%
4chi 8 0.1%
5sci 6 0.1%
6news 6 0.1%
7gnu 2 0.0%
8braunschweig 2 0.0%
9soc 2 0.0%
TOTAL: 9 5552100.0%

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

NewsgroupCount
1alt.comp.os.windows-10 3468
2alt.drugs.dealers.playground.bert-hoff 966
3rec.arts.tv 544
4rec.food.cooking 308
5rec.bicycles.tech 82
6comp.sys.mac.system 32
7alt.drugs.pot 22
8alt.arts.poetry.comments 18
9rec.drugs.cannabis 14
10comp.dcom.telecom 12
11alt.tv.red-dwarf 12
12alt.games.diablo2 10
13alt.stupidity 8
14comp.protocols.dns.bind 8
15sci.electronics.repair 6
16chi.weather 6
17comp.lang.c 4
18alt.2600 4
19rec.radio.swap 4
20alt.vacation.las-vegas 4
21news.software.readers 4
22soc.history.what-if 2
23rec.video.cable-tv 2
24rec.radio.broadcasting 2
25braunschweig.allgemeines 2
26gnu.utils.bug 2
27news.admin.net-abuse.email 2
28alt.tasteless 2
29chi.eats 2
TOTAL: 29 5552