Daily Usenet report for news.ripco.com

Oct 14 00:01:02 -- Oct 14 23:57:53

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Oct 14 00:06:43 remote5bge0 overchan[26207]: [ID 702911 news.error] input line too long, skipping
Oct 14 00:45:51 remote5bge0 overchan[26207]: [ID 702911 news.error] input line too long, skipping
Oct 14 05:54:10 remote5bge0 overchan[26207]: [ID 702911 news.error] input line too long, skipping
Oct 14 08:14:40 remote5bge0 overchan[26207]: [ID 702911 news.error] input line too long, skipping
Oct 14 08:20:43 remote5bge0 overchan[26207]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 26215 36.4%4.3 MB 40.3%
innd 24847 34.5%3.8 MB 35.7%
nnrpd 17334 24.1%1.8 MB 16.9%
innfeed 3592 5.0%770.9 KB 7.1%
overchan 5 0.0%0.7 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 71995 100.0%10.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 203746 52.5%
Cache misses 184406 47.5%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 388152 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%120 0.000 0.000 0.000
article cleanup00:00:00.514 0.0%52070 0.000 0.010 0.043
article logging00:00:00.706 0.0%52352 0.000 0.013 0.038
article parse00:00:01.934 0.0%125060 0.000 0.015 0.040
article write00:00:49.974 0.0%31290 0.306 1.597 71.217
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.282 0.0%401334 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:03.002 0.0%389190 0.002 0.008 0.015
history sync00:00:00.280 0.0%760 0.000 0.368 7.500
history write00:00:03.830 0.0%52070 0.014 0.074 0.843
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:39:12.192 99.9%449692 217.132 381.488 1063.436
nntp read00:00:02.520 0.0%448226 0.001 0.006 0.011
overview write00:00:00.186 0.0%31290 0.000 0.006 0.032
perl filter00:01:03.570 0.0%52066 0.994 1.221 1.983
python filter00:00:01.210 0.0%52074 0.000 0.023 0.065
site send00:00:01.696 0.0%93806 0.000 0.018 0.065
TOTAL: 47:41:54.63047:41:21.896100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.120 0.0%31302 0.000 0.004 0.032
article prepare00:00:00.006 0.0%18064 0.000 0.000 0.250
article read00:00:00.464 0.0%3812 0.000 0.122 8.875
backlog stats00:00:00.210 0.0%389574 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.836 0.0%252224 0.002 0.007 0.019
data write00:00:03.404 0.0%221548 0.003 0.015 0.027
idle47:33:47.158100.0%389574 258.033 439.524 1179.586
status file00:00:01.650 0.0%328 0.000 5.030 45.500
TOTAL: 47:34:05.59247:33:54.848100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:15:56.176 99.2%18328 19.200 641.433 54470.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.274 0.0%473936 0.000 0.009 0.040
readart00:00:20.726 0.2%2550 0.000 8.128 37.500
TOTAL: 03:17:27.25803:16:21.176 99.4%----

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 38300 12960 21390 3950 33%94:38:42
2news.snarked.org 48 30018 8068 21582 368 26%49:14:16
3newsfeed.neva.ru 580 68932 5222 51654 12056 7%287:03:12
4feeder3.feed-ams.uzoreto.com 574 16630 3634 9918 3078 21%47:20:26
5newsfeed.fu-berlin.de 2 15436 494 14908 34 3%47:25:58
6news.lightlink.com 2 8188 338 7740 110 4%48:06:22
7news-in.rahul.net 574 16940 226 16684 30 1%47:20:18
8news.cmpublishers.com 52 9202 204 8968 30 2%47:59:28
9ripco-out.feeder.erje.net 574 33570 96 32240 1234 0%47:17:10
10localhost 154 8 8 0 0 100%00:00:00
TOTAL: 10 3708 237224 31250 185084 20890 13%716:25:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com32.8 MB3.0 KB10.5 MB43.3 MB 75%2.6 KB
2news.snarked.org23.6 MB0.0 KB1.5 MB25.2 MB 93%3.1 KB
3newsfeed.neva.ru15.1 MB0.0 KB49.6 MB64.6 MB 23%3.8 KB
4feeder3.feed-ams.uzoreto.com9.6 MB0.0 KB7.4 MB17.0 MB 56%2.6 KB
5news-in.rahul.net8.7 MB0.0 KB784.7 KB9.4 MB 91%37.7 KB
6newsfeed.fu-berlin.de2.6 MB0.0 KB449.1 KB3.0 MB 85%5.8 KB
7news.lightlink.com1.8 MB0.0 KB6.2 MB8.0 MB 22%18.2 KB
8news.cmpublishers.com611.4 KB0.0 KB45.5 KB657.0 KB 93%2.8 KB
9ripco-out.feeder.erje.net268.1 KB0.0 KB14.2 MB14.4 MB 1%11.1 KB
10localhost13.8 KB0.0 KB0.0 KB13.8 KB100%1.7 KB
TOTAL: 1095.0 MB3.0 KB90.6 MB185.6 MB 51%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 14 00:01:02 - 00:59:59 430 2.7% 0.121.2 MB 2.5% 0.35
Oct 14 01:00:00 - 01:59:59 431 2.7% 0.121.2 MB 2.5% 0.34
Oct 14 02:00:00 - 02:59:59 585 3.7% 0.161.6 MB 3.3% 0.46
Oct 14 03:00:00 - 03:59:59 607 3.9% 0.171.6 MB 3.3% 0.45
Oct 14 04:00:00 - 04:59:59 697 4.4% 0.192.4 MB 5.1% 0.70
Oct 14 05:00:00 - 05:59:59 771 4.9% 0.212.4 MB 5.0% 0.68
Oct 14 06:00:00 - 06:59:59 685 4.4% 0.191.9 MB 4.1% 0.55
Oct 14 07:00:00 - 07:59:59 690 4.4% 0.191.7 MB 3.5% 0.48
Oct 14 08:00:00 - 08:59:59 783 5.0% 0.222.3 MB 4.8% 0.66
Oct 14 09:00:00 - 09:59:59 806 5.1% 0.222.1 MB 4.5% 0.61
Oct 14 10:00:00 - 10:59:59 942 6.0% 0.262.8 MB 5.9% 0.80
Oct 14 11:00:00 - 11:59:59 968 6.2% 0.272.7 MB 5.7% 0.77
Oct 14 12:00:00 - 12:59:59 935 6.0% 0.262.6 MB 5.4% 0.74
Oct 14 13:00:00 - 13:59:59 843 5.4% 0.232.8 MB 5.9% 0.81
Oct 14 14:00:00 - 14:59:59 898 5.7% 0.252.5 MB 5.2% 0.71
Oct 14 15:00:00 - 15:59:59 796 5.1% 0.223.0 MB 6.3% 0.86
Oct 14 16:00:00 - 16:59:59 725 4.6% 0.202.0 MB 4.1% 0.56
Oct 14 17:00:00 - 17:59:59 621 4.0% 0.172.4 MB 5.0% 0.68
Oct 14 18:00:00 - 18:59:59 476 3.0% 0.131.7 MB 3.6% 0.50
Oct 14 19:00:00 - 19:59:59 467 3.0% 0.131.6 MB 3.4% 0.47
Oct 14 20:00:00 - 20:59:59 367 2.3% 0.101.3 MB 2.7% 0.37
Oct 14 21:00:00 - 21:59:59 353 2.3% 0.101.3 MB 2.7% 0.36
Oct 14 22:00:00 - 22:59:59 352 2.2% 0.101.2 MB 2.5% 0.34
Oct 14 23:00:00 - 23:57:53 445 2.8% 0.131.4 MB 2.9% 0.40
TOTAL: 23:56:51 15673 100.0% 0.1847.9 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 6025 2906 0 0 3 0 0 0 3116
2ripco-out.feed.uzoreto.com 1978 914 0 1 2 0 0 0 1061
3feeder3.feed-ams.uzoreto.com 1539 1134 0 0 1 0 0 0 404
4ripco-out.feeder.erje.net 617 615 0 0 0 0 0 0 2
5news.snarked.org 180 79 0 0 1 0 0 0 100
6newsfeed.fu-berlin.de 119 0 0 0 0 0 0 0 119
7news.lightlink.com 55 0 0 0 0 0 0 0 55
8news-in.rahul.net 15 1 0 0 0 0 0 0 14
9news.cmpublishers.com 14 3 0 0 0 0 0 0 11
TOTAL: 9 10542 5652 0 1 7 0 0 0 4882

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.boneless 2531
free.usenet 2069
alt.binaries.ftd 362
free.willey 74
fido7.su.pol.news 48
scot.general 46
alt.binaries.nl 40
it.tlc.cellulari.android 38
perl.cpan.uploads 29
it.comp.os.win.windows10 28
alt.binaries.e-book 20
linux.debian.maint.python 15
free.it.scienza.fisica 14
alt.binaries.pictures.scenic 11
alt.bestjobsusa.computer.jobs 11
mozilla.dev.platform 11
alt.binaries.test.yenc 11
alt.binaries.nospam.breasts.natural 10
alt.binaries.mac.applications 10
alt.binaries.pictures.purebeauty 9
TOTAL: 142 5652

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

GroupsCount
pl.praca.oferowana 3
christnet.theology 1
alt.christnet.religion 1
alt.penthouse.sex.masterbation 1
bit.listserv.catholic 1
TOTAL: 5 7

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 5222
EMP (md5) 2574
Too many newsgroups 1378
EMP (phl) 168
Scoring filter (8) 58
Scoring filter (9) 40
Scoring filter (10) 20
Scoring filter (18) 4
Scoring filter (11) 4
Scoring filter (12) 4
Scoring filter (16) 2
U2 violation - invalid distribution 2
Scoring filter (14) 2
TOTAL: 13 9478

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
feeder3.feed-ams.uzoreto.com 1
TOTAL: 1 1
Bad Message-ID's offered
ripco-out.feeder.erje.net 20
ripco-out.feed.uzoreto.com 2
TOTAL: 2 22
Including strange strings
newsfeed.fu-berlin.de 104
newsfeed.neva.ru 32
ripco-out.feed.uzoreto.com 5
TOTAL: 3 141
No colon-space in header
ripco-out.feed.uzoreto.com 1
TOTAL: 1 1
TOTAL: 4 165

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 11182 1600 5346 12 0 0 14%47:43:10
2rahul.net 25568 850 13690 28 0 0 3%47:40:00
3news.cmpublishers.com 42740 136 29342 1454 0 10 0%47:49:48
4newsfeed.neva.ru 29198 56 25902 18 0 108 0%47:34:04
5news.uzoreto.com 14850 50 14268 74 0 0 0%47:40:00
6feeder.erje.net 28272 48 27760 118 0 0 0%47:40:00
7news.snarked.org 37630 44 22722 8 0 18 0%47:40:00
8fu-berlin.de 28766 24 28742 0 0 0 0%47:40:00
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:00
TOTAL: 9 218206 2808 167772 1712 0 142 1%429:07:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com4.5 MB145.7 KB4.6 MB0.0 KB/s3.0 KB47:43:10
2rahul.net3.9 MB119.6 KB4.1 MB0.0 KB/s4.7 KB47:40:00
3news.cmpublishers.com456.5 KB4.1 MB4.6 MB0.0 KB/s2.9 KB47:49:48
4newsfeed.neva.ru312.3 KB36.0 KB348.4 KB0.0 KB/s4.7 KB47:34:04
5news.snarked.org278.0 KB16.0 KB293.9 KB0.0 KB/s5.7 KB47:40:00
6feeder.erje.net206.8 KB515.3 KB722.1 KB0.0 KB/s4.3 KB47:40:00
7news.uzoreto.com171.9 KB364.6 KB536.5 KB0.0 KB/s4.3 KB47:40:00
8fu-berlin.de140.0 KB0.0 KB140.0 KB0.0 KB/s5.8 KB47:40:00
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 910.0 MB5.3 MB15.3 MB0.0 KB/s3.5 KB429:07:02
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10462.9 MB 476 6 000:07:27
2shell3 16 4521.5 MB 50 2 003:09:36
TOTAL: 2 302 14984.4 MB 526 8 003:17:21

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10462.9 MB 476 6 000:07:27
2? 16 4521.5 MB 50 2 003:09:36
TOTAL: 2 302 14984.4 MB 526 8 003:17:03

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 3.880 1.630 0.00003:09:36
ftupet.com 46.060 7.320 0.00000:07:27
89.35.118.240 0.200 0.038 0.00000:00:06
scan-141.security.ipip.net 0.200 0.038 0.00000:00:03
ppp121-44-200-194.bras1.syd2.internode.on.net 0.604 0.116 0.00000:00:02
42-3-135-116.static.netvigator.com 0.200 0.038 0.00000:00:01
mob-5-90-255-39.net.vodafone.it 0.266 0.060 0.00000:00:01
176.33.44.90 0.200 0.042 0.00000:00:00
battery.census.shodan.io 0.206 0.044 0.00000:00:00
pool-108-30-123-92.nycmny.fios.verizon.net 0.206 0.040 0.00000:00:00
TOTAL: 10 52.022 9.366 0.00003:17:21

NNRP no permission clients:

SystemConn
ppp121-44-200-194.bras1.syd2.internode.on.net 6
176.33.44.90 2
scan-141.security.ipip.net 2
pool-108-30-123-92.nycmny.fios.verizon.net 2
battery.census.shodan.io 2
89.35.118.240 2
mob-5-90-255-39.net.vodafone.it 2
42-3-135-116.static.netvigator.com 2
TOTAL: 8 20

NNRP unrecognized commands (by host):

SystemConn
shell3 6
TOTAL: 1 6

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 6
TOTAL: 1 6

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 6 0
TOTAL: 1 6 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1246 83.2%
2alt 76 5.1%
3sci 60 4.0%
4comp 56 3.7%
5misc 28 1.9%
6ba 16 1.1%
7chi 12 0.8%
8rocksolid 2 0.1%
9news 2 0.1%
TOTAL: 9 1498100.0%

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

NewsgroupCount
1rec.arts.tv 560
2rec.food.cooking 510
3rec.bicycles.tech 144
4sci.electronics.repair 60
5comp.sys.mac.system 54
6alt.stupidity 24
7alt.comp.os.windows-10 16
8ba.food 16
9misc.consumers.frugal-living 16
10alt.online-service.comcast 14
11rec.radio.broadcasting 12
12misc.phone.mobile.iphone 12
13chi.weather 10
14alt.free.newsservers 10
15alt.hvac 8
16rec.outdoors.rv-travel 6
17rec.audio.high-end 4
18rec.radio.swap 4
19rec.gardens.edible 4
20alt.video.digital-tv 2
21comp.sys.raspberry-pi 2
22rocksolid.nodes 2
23news.software.readers 2
24rec.bicycles.rides 2
25alt.security.alarms 2
26chi.eats 2
TOTAL: 26 1498