Daily Usenet report for news.ripco.com

Oct 15 00:01:02 -- Oct 15 23:58:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Oct 15 07:43:03 remote5bge0 overchan[28821]: [ID 702911 news.error] input line too long, skipping
Oct 15 11:32:00 remote5bge0 overchan[28821]: [ID 702911 news.error] input line too long, skipping
Oct 15 11:42:41 remote5bge0 overchan[28821]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 26951 36.2%4.3 MB 39.6%
innd 26547 35.6%4.1 MB 36.9%
nnrpd 17452 23.4%1.8 MB 16.5%
innfeed 3586 4.8%783.8 KB 7.0%
controlchan 8 0.0%1.8 KB 0.0%
overchan 3 0.0%0.5 KB 0.0%
TOTAL: 6 74547 100.0%11.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 218746 57.0%
Cache misses 164846 43.0%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 383592 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%206 0.000 0.000 0.000
article cleanup00:00:00.482 0.0%53372 0.000 0.009 0.027
article logging00:00:00.778 0.0%53700 0.000 0.014 0.172
article parse00:00:02.002 0.0%130452 0.005 0.015 0.034
article write00:00:43.612 0.0%29878 0.264 1.460 26.658
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.318 0.0%400272 0.000 0.001 0.005
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:03.158 0.0%384238 0.003 0.008 0.017
history sync00:00:00.230 0.0%768 0.000 0.299 2.500
history write00:00:05.010 0.0%53370 0.024 0.094 0.582
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:39:17.766 99.9%449188 225.338 381.929 804.619
nntp read00:00:02.532 0.0%448422 0.001 0.006 0.014
overview write00:00:00.198 0.0%29878 0.000 0.007 0.034
perl filter00:01:06.164 0.0%53368 1.040 1.240 1.679
python filter00:00:01.264 0.0%53374 0.000 0.024 0.059
site send00:00:02.068 0.0%89604 0.000 0.023 0.071
TOTAL: 47:41:58.81647:41:25.582100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.132 0.0%29890 0.000 0.004 0.037
article prepare00:00:00.006 0.0%17808 0.000 0.000 0.014
article read00:00:00.466 0.0%3606 0.000 0.129 5.000
backlog stats00:00:00.162 0.0%357784 0.000 0.000 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.458 0.0%236912 0.000 0.006 0.019
data write00:00:03.328 0.0%207586 0.000 0.016 0.034
idle47:35:06.742100.0%357784 272.921 478.799 1464.890
status file00:00:02.582 0.0%322 0.000 8.019 44.000
TOTAL: 47:35:23.25647:35:14.876100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:41:06.204 99.3%18222 15.250 728.032 23594.480
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.484 0.1%903080 0.000 0.009 1.000
readart00:00:20.250 0.2%2392 0.000 8.466 36.000
TOTAL: 03:42:36.79003:41:34.938 99.5%----

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
group-admin@isc.org002002
TOTAL002002

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 36424 9446 21062 5916 25%94:40:34
2news.snarked.org 56 28324 8650 19288 386 30%56:18:36
3newsfeed.neva.ru 558 59440 5456 39140 14844 9%282:28:08
4feeder3.feed-ams.uzoreto.com 572 15384 5186 9282 916 33%47:19:14
5newsfeed.fu-berlin.de 4 18206 574 17614 18 3%58:15:42
6news.cmpublishers.com 50 8174 368 7788 18 4%47:59:54
7news-in.rahul.net 574 16904 204 16670 30 1%47:21:14
8news.lightlink.com 2 1724 72 1638 14 4%12:02:02
9ripco-out.feeder.erje.net 574 31466 50 30334 1082 0%47:17:48
10localhost 152 6 6 0 0 100%00:00:00
TOTAL: 10 3690 216052 30012 162816 23224 13%693:43:12
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com25.7 MB0.0 KB14.7 MB40.4 MB 63%2.7 KB
2news.snarked.org23.7 MB4.8 KB1.6 MB25.3 MB 93%2.9 KB
3newsfeed.neva.ru15.5 MB0.0 KB60.7 MB76.1 MB 20%3.8 KB
4feeder3.feed-ams.uzoreto.com12.3 MB0.0 KB3.0 MB15.3 MB 80%2.6 KB
5news-in.rahul.net8.5 MB0.0 KB1.2 MB9.7 MB 87%42.3 KB
6newsfeed.fu-berlin.de6.1 MB0.0 KB373.4 KB6.4 MB 94%11.1 KB
7news.cmpublishers.com1.2 MB0.0 KB53.3 KB1.2 MB 95%3.3 KB
8news.lightlink.com904.2 KB0.0 KB422.7 KB1.3 MB 68%15.4 KB
9ripco-out.feeder.erje.net240.1 KB0.0 KB10.4 MB10.6 MB 2%9.6 KB
10localhost11.5 KB0.0 KB0.0 KB11.5 KB100%1.9 KB
TOTAL: 1094.0 MB4.8 KB92.4 MB186.4 MB 50%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 15 00:01:02 - 00:59:59 410 2.7% 0.121.7 MB 3.6% 0.49
Oct 15 01:00:00 - 01:59:59 471 3.1% 0.131.7 MB 3.6% 0.48
Oct 15 02:00:00 - 02:59:59 566 3.8% 0.161.5 MB 3.3% 0.44
Oct 15 03:00:00 - 03:59:59 614 4.1% 0.171.8 MB 3.7% 0.50
Oct 15 04:00:00 - 04:59:59 699 4.7% 0.192.2 MB 4.7% 0.62
Oct 15 05:00:00 - 05:59:59 675 4.5% 0.192.1 MB 4.5% 0.60
Oct 15 06:00:00 - 06:59:59 684 4.6% 0.192.1 MB 4.4% 0.59
Oct 15 07:00:00 - 07:59:59 725 4.8% 0.201.8 MB 3.8% 0.51
Oct 15 08:00:00 - 08:59:59 810 5.4% 0.232.6 MB 5.5% 0.74
Oct 15 09:00:00 - 09:59:59 769 5.1% 0.212.1 MB 4.5% 0.60
Oct 15 10:00:00 - 10:59:59 802 5.4% 0.222.8 MB 5.9% 0.78
Oct 15 11:00:00 - 11:59:59 972 6.5% 0.272.7 MB 5.6% 0.75
Oct 15 12:00:00 - 12:59:59 853 5.7% 0.242.4 MB 5.0% 0.67
Oct 15 13:00:00 - 13:59:59 831 5.6% 0.232.3 MB 5.0% 0.66
Oct 15 14:00:00 - 14:59:59 804 5.4% 0.222.2 MB 4.7% 0.63
Oct 15 15:00:00 - 15:59:59 741 5.0% 0.211.9 MB 4.1% 0.54
Oct 15 16:00:00 - 16:59:59 595 4.0% 0.171.7 MB 3.7% 0.49
Oct 15 17:00:00 - 17:59:59 684 4.6% 0.191.9 MB 4.1% 0.54
Oct 15 18:00:00 - 18:59:59 494 3.3% 0.142.0 MB 4.2% 0.56
Oct 15 19:00:00 - 19:59:59 423 2.8% 0.121.1 MB 2.4% 0.32
Oct 15 20:00:00 - 20:59:59 365 2.4% 0.102.5 MB 5.2% 0.70
Oct 15 21:00:00 - 21:59:59 356 2.4% 0.101.5 MB 3.2% 0.43
Oct 15 22:00:00 - 22:59:59 332 2.2% 0.091.6 MB 3.3% 0.44
Oct 15 23:00:00 - 23:58:01 292 2.0% 0.081.0 MB 2.1% 0.30
TOTAL: 23:56:59 14967 100.0% 0.1747.0 MB 100.0% 0.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 7572 3628 0 0 1 0 0 0 3943
2ripco-out.feed.uzoreto.com 2968 1824 0 0 4 0 0 0 1140
3ripco-out.feeder.erje.net 550 549 0 0 0 0 0 0 1
4feeder3.feed-ams.uzoreto.com 459 119 0 0 0 0 0 0 340
5news.snarked.org 190 59 0 2 0 0 0 0 129
6newsfeed.fu-berlin.de 119 0 0 0 0 0 0 0 119
7news.lightlink.com 99 3 0 0 0 0 0 0 96
8news-in.rahul.net 15 3 0 0 0 0 0 0 12
9news.cmpublishers.com 12 2 0 0 0 0 0 0 10
TOTAL: 9 11984 6187 0 2 5 0 0 0 5790

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.boneless 3228
free.usenet 2044
alt.binaries.ftd 277
fido7.su.pol.news 47
it.comp.os.win.windows10 42
alt.binaries.nl 39
scot.general 25
perl.cpan.uploads 24
it.tlc.cellulari.android 18
alt.binaries.nospam.female.bodyhair.pubes 18
free.it.scienza.fisica 17
free.willey 15
alt.tv.oreilly-factor 15
alt.binaries.pictures.purebeauty 15
alt.binaries.3d.poser 15
alt.binaries.e-book 15
alt.binaries.pictures.scenic 14
alt.binaries.test.yenc 13
alt.binaries.ebooks 12
alt.binaries.nospam.female.bodyhair 10
TOTAL: 140 6187

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

GroupsCount
christnet.bible 3
bit.listserv.catholic 2
TOTAL: 2 5

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 6808
EMP (md5) 3146
Too many newsgroups 992
EMP (phl) 142
Scoring filter (8) 64
Scoring filter (9) 52
Scoring filter (10) 16
Scoring filter (11) 12
Scoring filter (18) 6
HTML post 4
Scoring filter (13) 2
Scoring filter (12) 2
Scoring filter (15) 2
Scoring filter (14) 2
TOTAL: 14 11250

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 110
newsfeed.neva.ru 43
ripco-out.feed.uzoreto.com 9
ripco-out.feeder.erje.net 1
feeder3.feed-ams.uzoreto.com 1
TOTAL: 5 164
No colon-space in header
feeder3.feed-ams.uzoreto.com 1
TOTAL: 1 1
TOTAL: 3 183

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10716 1804 4994 10 0 0 16%47:40:06
2rahul.net 24238 978 13136 38 0 10 4%47:36:52
3news.cmpublishers.com 38082 134 27976 1078 0 28 0%47:40:06
4news.uzoreto.com 15240 64 14728 92 0 0 0%47:40:06
5news.snarked.org 34958 48 21082 16 0 38 0%47:40:06
6feeder.erje.net 28330 28 27864 104 0 2 0%47:36:48
7fu-berlin.de 27492 20 27472 0 0 0 0%47:40:06
8newsfeed.neva.ru 25048 12 24324 26 0 0 0%47:40:06
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:00
TOTAL: 9 204104 3088 161576 1364 0 84 1%428:54:16
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com4.9 MB66.2 KB5.0 MB0.0 KB/s2.8 KB47:40:06
2rahul.net4.4 MB342.7 KB4.7 MB0.0 KB/s4.8 KB47:36:52
3news.cmpublishers.com369.4 KB2.6 MB2.9 MB0.0 KB/s2.5 KB47:40:06
4news.uzoreto.com232.1 KB356.6 KB588.7 KB0.0 KB/s3.8 KB47:40:06
5news.snarked.org178.6 KB82.4 KB261.0 KB0.0 KB/s4.1 KB47:40:06
6feeder.erje.net94.4 KB333.7 KB428.1 KB0.0 KB/s3.2 KB47:36:48
7fu-berlin.de89.0 KB0.0 KB89.0 KB0.0 KB/s4.5 KB47:40:06
8newsfeed.neva.ru32.1 KB65.3 KB97.4 KB0.0 KB/s2.6 KB47:40:06
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 910.3 MB3.8 MB14.1 MB0.0 KB/s3.2 KB428:54:16
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9162.9 MB 404 4 000:07:40
2shell3 14 5561.7 MB 70 2 003:34:38
TOTAL: 2 300 14724.6 MB 474 6 003:42:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9162.9 MB 404 4 000:07:40
2? 14 5561.7 MB 70 2 003:34:38
TOTAL: 2 300 14724.6 MB 474 6 003:42:18

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 4.766 2.480 0.00003:34:38
ftupet.com 45.172 7.372 0.00000:07:40
80.82.65.74 3.240 0.640 0.00000:00:07
082.181.76.219.static.netvigator.com 0.200 0.042 0.00000:00:01
86.100.36.49 0.200 0.038 0.00000:00:00
219.95.55.64 0.200 0.042 0.00000:00:00
ppp121-44-200-194.bras1.syd2.internode.on.net 0.200 0.038 0.00000:00:00
96-92-127-254-static.hfc.comcastbusiness.net 0.200 0.038 0.00000:00:00
worker-18.sfj.corp.censys.io 0.200 0.044 0.00000:00:00
159.203.201.148 0.200 0.040 0.00000:00:00
TOTAL: 10 54.578 10.774 0.00003:42:30

NNRP no permission clients:

SystemConn
80.82.65.74 32
219.95.55.64 2
96-92-127-254-static.hfc.comcastbusiness.net 2
86.100.36.49 2
ppp121-44-200-194.bras1.syd2.internode.on.net 2
159.203.201.148 2
082.181.76.219.static.netvigator.com 2
worker-18.sfj.corp.censys.io 2
TOTAL: 8 46

NNRP unrecognized commands (by host):

SystemConn
shell3 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 4
TOTAL: 1 4

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1078 73.2%
2alt 126 8.6%
3misc 108 7.3%
4sci 76 5.2%
5comp 74 5.0%
6chi 4 0.3%
7news 4 0.3%
8ba 2 0.1%
TOTAL: 8 1472100.0%

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

NewsgroupCount
1rec.arts.tv 696
2rec.food.cooking 238
3rec.bicycles.tech 112
4misc.phone.mobile.iphone 90
5sci.electronics.repair 50
6alt.comp.os.windows-10 48
7comp.mobile.android 32
8alt.online-service.comcast 28
9comp.sys.mac.system 28
10sci.crypt 26
11alt.free.newsservers 20
12alt.stupidity 16
13rec.outdoors.rv-travel 16
14misc.consumers.frugal-living 16
15comp.sys.mac.apps 8
16alt.internet.wireless 8
17rec.radio.broadcasting 6
18comp.mobile.ipad 4
19rec.radio.swap 4
20chi.weather 4
21rec.gardens.edible 4
22alt.autos.ford 2
23rec.audio.high-end 2
24misc.transport.rail.americas 2
25alt.video.dvd.authoring 2
26news.admin.hierarchies 2
27comp.mail.sendmail 2
28alt.security.alarms 2
29news.announce.newgroups 2
30ba.food 2
TOTAL: 30 1472