Daily Usenet report for news.ripco.com

Sep 22 00:01:02 -- Sep 22 23:57:04

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Sep 22 04:22:01 remote5bge0 overchan[3069]: [ID 702911 news.error] input line too long, skipping
Sep 22 09:15:39 remote5bge0 overchan[3069]: [ID 702911 news.error] input line too long, skipping
Sep 22 10:46:34 remote5bge0 overchan[3069]: [ID 702911 news.error] input line too long, skipping
Sep 22 11:55:19 remote5bge0 overchan[3069]: [ID 702911 news.error] input line too long, skipping
Sep 22 13:26:02 remote5bge0 overchan[3069]: [ID 702911 news.error] input line too long, skipping
Sep 22 17:43:52 remote5bge0 overchan[3069]: [ID 702911 news.error] input line too long, skipping
Sep 22 22:11:52 remote5bge0 overchan[3069]: [ID 702911 news.error] input line too long, skipping
Sep 22 22:14:18 remote5bge0 overchan[3069]: [ID 702911 news.error] input line too long, skipping
Sep 22 22:37:09 remote5bge0 overchan[3069]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 34737 45.3%4.3 MB 37.9%
inn 20197 26.4%3.5 MB 31.0%
innd 17781 23.2%2.7 MB 24.2%
innfeed 3622 4.7%742.2 KB 6.4%
cnfsstat 286 0.4%47.7 KB 0.4%
overchan 9 0.0%1.1 KB 0.0%
controlchan 6 0.0%0.9 KB 0.0%
TOTAL: 7 76638 100.0%11.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 171908 51.0%
Cache misses 164996 49.0%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 336904 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%124 0.000 0.000 0.000
article cleanup00:00:00.422 0.0%40182 0.000 0.011 0.047
article logging00:00:00.524 0.0%40514 0.000 0.013 0.096
article parse00:00:01.572 0.0%96150 0.000 0.016 0.045
article write00:00:39.338 0.0%29292 0.250 1.343 48.982
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.210 0.0%350838 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:05.800 0.0%339438 0.000 0.017 0.811
history sync00:00:00.484 0.0%806 0.000 0.600 6.667
history write00:00:07.110 0.0%40182 0.017 0.177 5.835
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:59:36.792 99.9%384632 252.273 449.200 1280.503
nntp read00:00:02.366 0.0%381708 0.001 0.006 0.019
overview write00:00:00.176 0.0%29292 0.000 0.006 0.039
perl filter00:00:52.280 0.0%40174 1.049 1.301 1.988
python filter00:00:00.972 0.0%40178 0.000 0.024 0.063
site send00:00:01.694 0.0%87778 0.000 0.019 0.114
TOTAL: 48:02:02.94448:01:29.740100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.462 0.0%33994 0.000 0.014 0.062
article prepare00:00:00.000 0.0%9784 0.000 0.000 0.000
article read00:00:00.310 0.0%2076 0.000 0.149 14.600
backlog stats00:00:00.186 0.0%325388 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.048 0.0%220484 0.000 0.009 0.023
data write00:00:02.916 0.0%191736 0.003 0.015 0.035
idle47:34:56.408100.0%325388 223.197 526.437 1567.090
status file00:00:04.658 0.0%346 0.000 13.462 41.000
TOTAL: 47:35:18.01847:35:06.988100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:01.098 0.0%64848 0.000 0.017 0.064
idle45:22:21.086 98.5%106072 18.246 1539.908200080.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:35:14.910 1.3%1795256 0.000 1.178 3853.286
readart00:00:31.726 0.0%7342 0.000 4.321 73.000
TOTAL: 46:02:55.18245:58:08.820 99.8%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
ba-mod@panix.com002002
TOTAL002002

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 44542 13126 26538 4878 29%94:47:12
2news.snarked.org 48 36046 8932 24614 2500 24%54:50:36
3newsfeed.neva.ru 578 41392 5576 34222 1594 13%272:02:54
4newsfeed.fu-berlin.de 2 9952 510 9380 62 5%33:35:14
5news.lightlink.com 2 9352 482 8680 190 5%44:22:30
6news-in.rahul.net 574 17568 164 17312 92 0%47:19:26
7ripco-out.feeder.erje.net 574 32884 102 31318 1464 0%47:17:44
8news.cmpublishers.com 46 9048 62 8982 4 0%43:38:16
9localhost 148 4 4 0 0 100%00:00:00
TOTAL: 9 3120 200788 28958 161046 10784 14%637:53:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com35.6 MB0.0 KB10.9 MB46.5 MB 76%2.6 KB
2news.snarked.org26.2 MB0.0 KB9.2 MB35.3 MB 74%3.2 KB
3newsfeed.neva.ru18.1 MB0.0 KB4.7 MB22.8 MB 79%3.3 KB
4news-in.rahul.net7.8 MB0.0 KB4.1 MB11.9 MB 65%47.5 KB
5news.lightlink.com3.7 MB0.0 KB6.5 MB10.2 MB 36%15.6 KB
6newsfeed.fu-berlin.de3.4 MB0.0 KB2.3 MB5.7 MB 59%10.2 KB
7ripco-out.feeder.erje.net234.1 KB0.0 KB13.5 MB13.7 MB 1%9.0 KB
8news.cmpublishers.com124.6 KB0.0 KB4.5 KB129.1 KB 96%2.0 KB
9localhost7.4 KB0.0 KB0.0 KB7.4 KB100%1.8 KB
TOTAL: 995.0 MB0.0 KB51.3 MB146.3 MB 64%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 22 00:01:02 - 00:59:59 390 2.7% 0.111.4 MB 2.9% 0.41
Sep 22 01:00:00 - 01:59:59 493 3.4% 0.141.8 MB 3.7% 0.51
Sep 22 02:00:00 - 02:59:59 564 3.9% 0.161.7 MB 3.5% 0.47
Sep 22 03:00:00 - 03:59:59 638 4.4% 0.181.9 MB 4.1% 0.55
Sep 22 04:00:00 - 04:59:59 714 4.9% 0.202.3 MB 4.9% 0.67
Sep 22 05:00:00 - 05:59:59 893 6.1% 0.252.7 MB 5.7% 0.78
Sep 22 06:00:00 - 06:59:59 622 4.3% 0.171.9 MB 4.0% 0.54
Sep 22 07:00:00 - 07:59:59 680 4.7% 0.192.1 MB 4.4% 0.59
Sep 22 08:00:00 - 08:59:59 748 5.1% 0.212.5 MB 5.3% 0.72
Sep 22 09:00:00 - 09:59:59 762 5.2% 0.212.2 MB 4.6% 0.63
Sep 22 10:00:00 - 10:59:59 795 5.4% 0.223.2 MB 6.8% 0.92
Sep 22 11:00:00 - 11:59:59 800 5.5% 0.223.1 MB 6.5% 0.88
Sep 22 12:00:00 - 12:59:59 801 5.5% 0.222.3 MB 4.9% 0.67
Sep 22 13:00:00 - 13:59:59 914 6.3% 0.253.1 MB 6.6% 0.89
Sep 22 14:00:00 - 14:59:59 770 5.3% 0.212.5 MB 5.2% 0.71
Sep 22 15:00:00 - 15:59:59 748 5.1% 0.212.6 MB 5.5% 0.74
Sep 22 16:00:00 - 16:59:59 620 4.2% 0.171.9 MB 4.1% 0.55
Sep 22 17:00:00 - 17:59:59 545 3.7% 0.151.5 MB 3.1% 0.42
Sep 22 18:00:00 - 18:59:59 551 3.8% 0.151.5 MB 3.1% 0.43
Sep 22 19:00:00 - 19:59:59 348 2.4% 0.101.0 MB 2.2% 0.29
Sep 22 20:00:00 - 20:59:59 334 2.3% 0.091.2 MB 2.4% 0.33
Sep 22 21:00:00 - 21:59:59 330 2.3% 0.091.2 MB 2.5% 0.34
Sep 22 22:00:00 - 22:59:59 261 1.8% 0.071008.1 KB 2.1% 0.28
Sep 22 23:00:00 - 23:57:04 270 1.9% 0.08985.0 KB 2.0% 0.29
TOTAL: 23:56:02 14591 100.0% 0.1747.8 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
ONECHIAREA979.4 MB687.4 MB 70.2% 0 0.02 680.15
TOTAL: 1-979.4 MB687.4 MB 70.2% 0 0.02-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2448 1860 0 0 3 0 0 0 585
2news.snarked.org 1292 74 0 0 4 0 0 0 1214
3newsfeed.neva.ru 841 544 0 0 3 0 0 0 294
4ripco-out.feeder.erje.net 732 730 0 0 0 0 0 0 2
5newsfeed.fu-berlin.de 144 0 0 0 0 0 0 0 144
6news.lightlink.com 101 0 0 0 0 0 0 0 101
7news-in.rahul.net 46 0 0 0 0 0 0 0 46
8news.cmpublishers.com 2 1 0 0 0 0 0 0 1
TOTAL: 8 5606 3209 0 0 10 0 0 0 2387

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2112
alt.binaries.ftd 409
alt.binaries.pictures.rail 76
it.tlc.cellulari.android 30
free.it.scienza.fisica 30
alt.binaries.e-book 27
alt.bestjobsusa.computer.jobs 26
perl.cpan.uploads 23
alt.binaries.pictures.wallpaper 23
it.comp.os.win.windows10 20
fido7.su.pol.news 20
free.willey 17
alt.my.job.sucks 16
alt.binaries.mma 16
alt.jobs.jobsearch 15
att.jobs 15
alt.binaries.pictures.scenic 13
free.ucp 13
alt.binaries.nl 12
at.jobs 11
TOTAL: 148 3209

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

GroupsCount
pl.praca.oferowana 4
christnet.bible 3
christnet.theology 1
fr.sci.geosciences 1
bit.listserv.catholic 1
TOTAL: 5 10

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2828
Too many newsgroups 1150
Binary in non-binary group 250
EMP (phl) 126
Attached HTML file 32
Scoring filter (8) 32
Scoring filter (14) 10
Scoring filter (16) 6
Scoring filter (18) 4
TOTAL: 9 4438

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
ripco-out.feed.uzoreto.com 4
TOTAL: 1 4
Bad Message-ID's offered
ripco-out.feeder.erje.net 24
TOTAL: 1 24
Including strange strings
newsfeed.fu-berlin.de 102
newsfeed.neva.ru 54
ripco-out.feed.uzoreto.com 9
TOTAL: 3 165
TOTAL: 3 193

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 11004 1044 6524 4 0 0 9%47:49:10
2rahul.net 23984 674 14024 16 0 0 2%47:44:04
3news.snarked.org 30820 60 19822 10 0 38 0%47:40:04
4feeder.erje.net 27176 30 26470 66 0 0 0%47:40:28
5news.uzoreto.com 16266 24 15558 56 0 0 0%47:40:02
6newsfeed.neva.ru 23934 14 23164 270 0 0 0%47:40:04
7fu-berlin.de 26416 14 26402 0 0 0 0%47:40:04
8news.cmpublishers.com 33972 4 28582 160 0 4928 0%47:36:22
9remote6hme0.ripco.com 0 0 0 0 0 10 0%47:40:04
TOTAL: 9 193572 1864 160546 582 0 4976 0%429:10:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com3.3 MB12.4 KB3.3 MB0.0 KB/s3.2 KB47:49:10
2rahul.net2.6 MB125.6 KB2.7 MB0.0 KB/s4.1 KB47:44:04
3news.snarked.org272.0 KB39.2 KB311.2 KB0.0 KB/s4.4 KB47:40:04
4feeder.erje.net92.3 KB254.9 KB347.1 KB0.0 KB/s3.6 KB47:40:28
5fu-berlin.de82.3 KB0.0 KB82.3 KB0.0 KB/s5.9 KB47:40:04
6news.uzoreto.com82.1 KB255.0 KB337.1 KB0.0 KB/s4.2 KB47:40:02
7newsfeed.neva.ru76.1 KB653.8 KB729.8 KB0.0 KB/s2.6 KB47:40:04
8news.cmpublishers.com12.6 KB486.2 KB498.8 KB0.0 KB/s3.0 KB47:36:22
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:04
TOTAL: 96.5 MB1.8 MB8.3 MB0.0 KB/s3.5 KB429:10:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1p5489d596.dip0.t-ipconnect.de 112 12501.4 MB 30 0 007:10:42
2ftupet.com 286 8382.1 MB 408 4 000:06:43
3shell3 6 4541.1 MB 32 0 001:10:43
4p774160-omed01.osaka.ocn.ne.jp 2 2066.7 KB 12 0 000:44:39
575-151-74-61-independence.hfc.comcastbusiness.net 8 43.6 KB 4 0 000:12:50
TOTAL: 5 414 25664.7 MB 486 4 046:02:45

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dip0.t-ipconnect.de 112 12501.4 MB 30 0 007:10:42
2*.com 286 8382.1 MB 408 4 000:06:43
3? 6 4541.1 MB 32 0 001:10:43
4*.osaka.ocn.ne.jp 2 2066.7 KB 12 0 000:44:39
5*.hfc.comcastbusiness.net 8 43.6 KB 4 0 000:12:50
6*.fbx.proxad.net 16 00.0 KB 0 0 028:17:15
7*.adsl.highway.telekom.at 46 00.0 KB 0 0 007:00:09
8*.7-3.cable.virginm.net 4 00.0 KB 0 0 000:43:39
9*.dhcp.embarqhsd.net 4 00.0 KB 0 0 000:01:05
10unresolved 50 00.0 KB 0 0 000:34:46
11*.us-west-1.compute.amazonaws.com 2 00.0 KB 0 0 000:00:00
12*.census.shodan.io 2 00.0 KB 0 0 000:00:07
TOTAL: 12 538 25664.7 MB 486 4 046:02:45

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
vvs78-1-88-173-43-113.fbx.proxad.net 1.680 0.486 0.00028:17:15
p5489d596.dip0.t-ipconnect.de 21.612 10.448 0.00007:10:42
188-23-223-180.adsl.highway.telekom.at 5.402 2.248 0.00007:00:09
shell3 9.882 3.754 0.00001:10:43
p774160-omed01.osaka.ocn.ne.jp 0.660 0.412 0.00000:44:39
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 0.800 0.696 0.00000:43:39
209.107.195.152 3.286 0.808 0.00000:29:52
75-151-74-61-independence.hfc.comcastbusiness.net 1.684 1.274 0.00000:12:50
ftupet.com 45.932 7.320 0.00000:06:43
185.153.179.72 1.670 0.464 0.00000:04:52
or-67-237-111-3.dhcp.embarqhsd.net 0.396 0.080 0.00000:01:05
pirate.census.shodan.io 0.196 0.038 0.00000:00:07
122.228.10.51 0.202 0.042 0.00000:00:01
ec2-13-57-28-33.us-west-1.compute.amazonaws.com 0.202 0.040 0.00000:00:00
TOTAL: 14 93.604 28.110 0.00046:02:45

Curious NNRP server explorers [Top 20]:

SystemConn
188-23-223-180.adsl.highway.telekom.at 46
209.107.195.152 32
185.153.179.72 16
vvs78-1-88-173-43-113.fbx.proxad.net 16
or-67-237-111-3.dhcp.embarqhsd.net 4
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 4
122.228.10.51 2
pirate.census.shodan.io 2
ec2-13-57-28-33.us-west-1.compute.amazonaws.com 2
TOTAL: 9 124

NNRP unrecognized commands (by host):

SystemConn
122.228.10.51 10
shell3 2
TOTAL: 2 12

NNRP unrecognized commands (by command):

CommandCount
Connection: keep-alive 2
GET / HTTP/1.1 2
User-Agent: Mozilla/5.0 (Macintosh; Inte... 2
Host: 66.251.253.167:119 2
XTHREAD DBINIT 2
Accept: */* 2
TOTAL: 6 12

NNRP client timeouts [Top 20]:

SystemConnPeer
188-23-223-180.adsl.highway.telekom.at 50 0
p5489d596.dip0.t-ipconnect.de 26 2
TOTAL: 2 76 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 990 38.6%
2de 708 27.6%
3alt 340 13.3%
4comp 262 10.2%
5misc 154 6.0%
6fido7 52 2.0%
7chi 18 0.7%
8news 16 0.6%
9ba 12 0.5%
10it 6 0.2%
11mozilla 2 0.1%
12grc 2 0.1%
13fr 2 0.1%
14seattle 2 0.1%
TOTAL: 14 2566100.0%

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

NewsgroupCount
1de.comm.software.mozilla.mailnews 708
2rec.food.cooking 450
3rec.arts.tv 422
4alt.2600 298
5misc.phone.mobile.iphone 154
6comp.mail.sendmail 130
7rec.radio.cb 58
8comp.sys.mac.system 58
9fido7.su.hardw.schemes 52
10comp.dcom.telecom 48
11rec.bicycles.tech 44
12alt.games.warcraft 24
13chi.general 14
14news.groups.questions 14
15ba.food 12
16alt.hvac 8
17rec.radio.swap 8
18it.comp.console.playstation 6
19comp.protocols.dns.bind 6
20rec.radio.broadcasting 6
21comp.mobile.ipad 6
22comp.os.minix 4
23comp.mail.pine 4
24alt.autos.ford 4
25chi.weather 4
26mozilla.support.firefox 2
27alt.autos.toyota 2
28alt.sex.erotica 2
29fr.bienvenue 2
30seattle.general 2
31alt.sex.masterbation 2
32rec.heraldry 2
33comp.mail.mime 2
34grc.security.software 2
35comp.mail.mutt 2
36comp.unix.bsd.freebsd.announce 2
37news.software.readers 2
TOTAL: 37 2566