Daily Usenet report for news.ripco.com

Oct 10 00:01:02 -- Oct 10 23:57:47

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Oct 10 01:35:39 remote5bge0 overchan[13092]: [ID 702911 news.error] input line too long, skipping
Oct 10 08:14:01 remote5bge0 overchan[13092]: [ID 702911 news.error] input line too long, skipping
Oct 10 11:14:19 remote5bge0 overchan[13092]: [ID 702911 news.error] input line too long, skipping
Oct 10 11:35:23 remote5bge0 overchan[13092]: [ID 702911 news.error] input line too long, skipping
Oct 10 11:40:28 remote5bge0 overchan[13092]: [ID 702911 news.error] input line too long, skipping
Oct 10 12:30:20 remote5bge0 overchan[13092]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 19841 32.6%3.1 MB 33.9%
inn 19738 32.5%3.5 MB 38.0%
nnrpd 17504 28.8%1.8 MB 20.0%
innfeed 3706 6.1%753.4 KB 8.1%
overchan 6 0.0%0.9 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 60797 100.0%9.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 165662 50.5%
Cache misses 162336 49.5%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 327998 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%106 0.000 0.000 0.000
article cleanup00:00:00.320 0.0%39268 0.000 0.008 0.043
article logging00:00:00.526 0.0%39606 0.000 0.013 0.059
article parse00:00:01.482 0.0%93226 0.000 0.016 0.041
article write00:00:45.256 0.0%29648 0.415 1.526 74.922
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.200 0.0%334226 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.530 0.0%329690 0.000 0.008 0.019
history sync00:00:00.268 0.0%766 0.000 0.350 10.667
history write00:00:02.870 0.0%39270 0.000 0.073 1.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:59:27.634 99.9%370778 242.027 465.960 1412.200
nntp read00:00:02.044 0.0%368876 0.000 0.006 0.014
overview write00:00:00.180 0.0%29648 0.000 0.006 0.059
perl filter00:00:52.614 0.0%39266 0.991 1.340 2.568
python filter00:00:00.912 0.0%39270 0.000 0.023 0.075
site send00:00:01.646 0.0%88930 0.000 0.019 0.091
TOTAL: 48:01:48.66248:01:18.482100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.362 0.0%38336 0.000 0.009 0.043
article prepare00:00:00.004 0.0%11248 0.000 0.000 0.013
article read00:00:00.338 0.0%2364 0.000 0.143 10.571
backlog stats00:00:00.206 0.0%338984 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.600 0.0%223354 0.000 0.012 0.021
data write00:00:03.084 0.0%194656 0.004 0.016 0.031
idle47:34:05.734100.0%338984 185.184 505.174 1396.346
status file00:00:02.650 0.0%364 0.000 7.280 47.000
TOTAL: 47:34:25.26047:34:14.978100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:31:29.574 99.4%18746 18.524 868.963 47381.765
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:07.860 0.0%818346 0.000 0.010 0.046
readart00:00:24.708 0.2%2884 0.100 8.567 72.000
TOTAL: 04:33:10.10804:32:02.142 99.6%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 37826 10462 22268 5096 27%94:38:42
2news.snarked.org 52 29286 7860 20950 476 26%56:20:40
3newsfeed.neva.ru 632 44408 5668 36876 1864 12%277:05:46
4feeder3.feed-ams.uzoreto.com 574 12332 4450 6984 898 36%47:19:04
5newsfeed.fu-berlin.de 2 14318 492 13802 24 3%45:11:58
6news-in.rahul.net 574 15956 272 15630 54 1%47:19:16
7news.cmpublishers.com 44 8190 220 7938 32 2%39:49:04
8news.lightlink.com 2 10978 144 10332 502 1%57:44:10
9ripco-out.feeder.erje.net 574 30872 30 30112 730 0%47:17:54
10localhost 150 4 4 0 0 100%00:00:00
TOTAL: 10 3752 204170 29602 164892 9676 14%712:46:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com26.8 MB0.0 KB11.4 MB38.2 MB 70%2.5 KB
2news.snarked.org21.6 MB0.0 KB1.9 MB23.5 MB 91%2.9 KB
3newsfeed.neva.ru16.6 MB0.0 KB5.5 MB22.1 MB 74%3.0 KB
4feeder3.feed-ams.uzoreto.com11.8 MB0.0 KB2.9 MB14.6 MB 80%2.8 KB
5news-in.rahul.net9.9 MB0.0 KB2.2 MB12.1 MB 82%37.9 KB
6newsfeed.fu-berlin.de3.3 MB0.0 KB370.7 KB3.7 MB 90%7.3 KB
7news.lightlink.com1.2 MB0.0 KB19.1 MB20.3 MB 5%32.2 KB
8news.cmpublishers.com599.6 KB0.0 KB68.6 KB668.2 KB 89%2.7 KB
9ripco-out.feeder.erje.net134.1 KB0.0 KB6.0 MB6.1 MB 2%8.3 KB
10localhost11.8 KB0.0 KB0.0 KB11.8 KB100%2.9 KB
TOTAL: 1091.9 MB0.0 KB49.4 MB141.4 MB 65%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 10 00:01:02 - 00:59:59 288 1.9% 0.08732.6 KB 1.6% 0.21
Oct 10 01:00:00 - 01:59:59 435 2.9% 0.121.4 MB 3.1% 0.40
Oct 10 02:00:00 - 02:59:59 566 3.8% 0.161.4 MB 3.1% 0.40
Oct 10 03:00:00 - 03:59:59 665 4.5% 0.181.8 MB 4.0% 0.51
Oct 10 04:00:00 - 04:59:59 742 5.0% 0.212.4 MB 5.2% 0.67
Oct 10 05:00:00 - 05:59:59 833 5.6% 0.232.3 MB 5.1% 0.65
Oct 10 06:00:00 - 06:59:59 661 4.5% 0.182.2 MB 4.8% 0.62
Oct 10 07:00:00 - 07:59:59 866 5.9% 0.242.2 MB 4.8% 0.62
Oct 10 08:00:00 - 08:59:59 863 5.8% 0.242.8 MB 6.1% 0.79
Oct 10 09:00:00 - 09:59:59 865 5.9% 0.242.8 MB 6.1% 0.78
Oct 10 10:00:00 - 10:59:59 795 5.4% 0.222.5 MB 5.6% 0.72
Oct 10 11:00:00 - 11:59:59 808 5.5% 0.222.5 MB 5.6% 0.72
Oct 10 12:00:00 - 12:59:59 783 5.3% 0.222.1 MB 4.5% 0.58
Oct 10 13:00:00 - 13:59:59 740 5.0% 0.212.6 MB 5.8% 0.74
Oct 10 14:00:00 - 14:59:59 792 5.4% 0.222.1 MB 4.7% 0.60
Oct 10 15:00:00 - 15:59:59 713 4.8% 0.202.7 MB 6.0% 0.77
Oct 10 16:00:00 - 16:59:59 650 4.4% 0.182.6 MB 5.8% 0.75
Oct 10 17:00:00 - 17:59:59 655 4.4% 0.181.8 MB 4.1% 0.52
Oct 10 18:00:00 - 18:59:59 403 2.7% 0.111.2 MB 2.6% 0.34
Oct 10 19:00:00 - 19:59:59 360 2.4% 0.10911.8 KB 2.0% 0.25
Oct 10 20:00:00 - 20:59:59 287 1.9% 0.081.1 MB 2.4% 0.31
Oct 10 21:00:00 - 21:59:59 404 2.7% 0.111.2 MB 2.6% 0.34
Oct 10 22:00:00 - 22:59:59 336 2.3% 0.091.2 MB 2.6% 0.33
Oct 10 23:00:00 - 23:57:47 269 1.8% 0.08803.6 KB 1.7% 0.23
TOTAL: 23:56:45 14779 100.0% 0.1745.2 MB 100.0% 0.54
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2557 1671 0 0 6 0 0 0 880
2newsfeed.neva.ru 972 362 0 0 5 0 0 0 605
3feeder3.feed-ams.uzoreto.com 452 158 0 0 1 0 0 0 293
4ripco-out.feeder.erje.net 365 365 0 0 0 0 0 0 0
5news.snarked.org 238 76 0 0 1 0 0 0 161
6news.lightlink.com 197 3 0 0 0 0 0 0 194
7newsfeed.fu-berlin.de 132 0 0 0 0 0 0 0 132
8news-in.rahul.net 27 1 0 0 0 0 0 0 26
9news.cmpublishers.com 19 2 0 0 0 0 0 0 17
TOTAL: 9 4959 2638 0 0 13 0 0 0 2308

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1888
alt.binaries.ftd 166
fido7.su.pol.news 48
free.willey 42
it.tlc.cellulari.android 32
perl.cpan.uploads 27
scot.general 23
it.comp.os.win.windows10 20
uk.net.news.moderation 19
alt.bestjobsusa.computer.jobs 19
alt.binaries.e-book 18
free.it.scienza.fisica 15
alt.alan.c.sanderson.looks.like.a.dork 14
alt.binaries.nospam.female.bodyhair.pubes 12
alt.binaries.pictures.scenic 11
alt.binaries.test.yenc 10
alt.binaries.pictures.purebeauty 10
alt.binaries.pictures.rail 10
fr.usenet.abus.nocem 9
alt.binaries.sounds.karaoke 8
TOTAL: 125 2638

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

GroupsCount
pl.praca.oferowana 7
christnet.bible 3
alt.penthouse.sex.masterbation 1
alt.christnet.christnews 1
bit.listserv.catholic 1
TOTAL: 5 13

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2910
Too many newsgroups 936
Binary in non-binary group 192
EMP (phl) 84
Scoring filter (8) 62
Scoring filter (9) 50
EMP (fsl) 18
Scoring filter (11) 8
HTML post 6
Scoring filter (18) 4
Scoring filter (16) 2
Scoring filter (10) 2
TOTAL: 12 4274

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 116
newsfeed.neva.ru 42
ripco-out.feed.uzoreto.com 9
feeder3.feed-ams.uzoreto.com 2
TOTAL: 4 169
TOTAL: 2 187

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 11192 1096 5510 6 0 0 9%47:46:54
2rahul.net 21600 870 12396 10 0 0 4%47:52:18
3news.cmpublishers.com 36764 86 28582 436 0 8728 0%47:51:30
4news.snarked.org 35440 58 21360 4 0 156 0%47:34:22
5news.uzoreto.com 14376 30 14160 106 0 0 0%47:40:00
6feeder.erje.net 28300 28 27972 42 0 0 0%47:43:06
7fu-berlin.de 27232 20 27212 0 0 0 0%47:46:38
8newsfeed.neva.ru 24590 6 23772 20 0 0 0%47:44:08
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:00
TOTAL: 9 199494 2194 160964 624 0 8890 1%429:38:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net2.9 MB23.5 KB2.9 MB0.0 KB/s3.4 KB47:52:18
2news.lightlink.com2.8 MB179.8 KB3.0 MB0.0 KB/s2.8 KB47:46:54
3news.snarked.org245.4 KB8.8 KB254.2 KB0.0 KB/s4.1 KB47:34:22
4news.cmpublishers.com243.6 KB1.2 MB1.4 MB0.0 KB/s2.8 KB47:51:30
5news.uzoreto.com138.4 KB385.4 KB523.8 KB0.0 KB/s3.9 KB47:40:00
6feeder.erje.net117.6 KB132.4 KB250.0 KB0.0 KB/s3.6 KB47:43:06
7fu-berlin.de102.0 KB0.0 KB102.0 KB0.0 KB/s5.1 KB47:46:38
8newsfeed.neva.ru47.9 KB70.6 KB118.5 KB0.0 KB/s4.6 KB47:44:08
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 96.6 MB2.0 MB8.6 MB0.0 KB/s3.1 KB429:38:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10503.3 MB 464 2 000:08:03
2shell3 24 7821.9 MB 50 2 004:24:45
TOTAL: 2 310 18325.2 MB 514 4 004:33:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10503.3 MB 464 2 000:08:03
2? 24 7821.9 MB 50 2 004:24:45
TOTAL: 2 310 18325.2 MB 514 4 004:32:48

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 5.462 2.440 0.00004:24:45
ftupet.com 47.328 7.402 0.00000:08:03
d54c176a7.access.telenet.be 4.832 1.012 0.00000:00:12
ppp121-44-200-194.bras1.syd2.internode.on.net 0.200 0.046 0.00000:00:01
96-92-127-254-static.hfc.comcastbusiness.net 0.200 0.038 0.00000:00:00
TOTAL: 5 58.022 10.938 0.00004:33:03

NNRP no permission clients:

SystemConn
d54c176a7.access.telenet.be 48
ppp121-44-200-194.bras1.syd2.internode.on.net 2
96-92-127-254-static.hfc.comcastbusiness.net 2
TOTAL: 3 52

NNRP unrecognized commands (by host):

SystemConn
shell3 12
TOTAL: 1 12

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 12
TOTAL: 1 12

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 4 0
TOTAL: 1 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1324 72.3%
2alt 254 13.9%
3comp 134 7.3%
4misc 60 3.3%
5sci 54 2.9%
6chi 6 0.3%
TOTAL: 6 1832100.0%

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

NewsgroupCount
1rec.arts.tv 930
2rec.food.cooking 310
3alt.comp.os.windows-10 234
4sci.electronics.repair 54
5rec.bicycles.tech 54
6comp.sys.mac.system 50
7comp.mobile.ipad 40
8misc.phone.mobile.iphone 30
9misc.consumers.frugal-living 30
10comp.mobile.android 18
11comp.protocols.dns.bind 14
12rec.bicycles.misc 12
13alt.stupidity 12
14rec.gardens.edible 12
15comp.sys.raspberry-pi 6
16rec.radio.swap 4
17comp.security.ssh 4
18chi.weather 4
19alt.free.newsservers 4
20rec.radio.broadcasting 2
21alt.apache.configuration 2
22alt.security.alarms 2
23chi.general 2
24comp.internet.services.video.youtube 2
TOTAL: 24 1832