Daily Usenet report for news.ripco.com

Jul 13 00:01:01 -- Jul 13 23:58:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Jul 13 12:23:00 remote5bge0 overchan[2967]: [ID 702911 news.error] input line too long, skipping
Jul 13 12:38:58 remote5bge0 overchan[2967]: [ID 702911 news.error] input line too long, skipping
Jul 13 13:53:25 remote5bge0 overchan[2967]: [ID 702911 news.error] input line too long, skipping
Jul 13 20:18:38 remote5bge0 innfeed[3029]: [ID 702911 news.warning] ME tape invalid messageID in /zones/news/spool/innfeed/newsfeed.neva.ru.input: <qfg1sb$bne$1@gioia.aioe.org@050200001B0800024ABD0000000000000000@
Jul 13 20:18:38 s_local@remote5bge0 innfeed[3029]: [ID 702911 news.warning] ME tape invalid messageID in /zones/news/spool/innfeed/newsfeed.neva.ru.input: <qfg1sb$bne$1@gioia.aioe.org@050200001B0800024ABD0000000000000000@

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 44482 52.0%5.2 MB 43.2%
innd 19277 22.5%3.0 MB 24.4%
inn 18362 21.5%3.2 MB 26.7%
innfeed 3396 4.0%713.7 KB 5.8%
overchan 3 0.0%0.4 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 85522 100.0%12.1 MB100.0%

History cache:

ReasonCount%Count
Cache misses 316696 69.7%
Do not exist 137610 30.3%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 454306 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.408 0.0%36386 0.000 0.011 0.042
article logging00:00:00.658 0.0%36764 0.000 0.018 0.215
article parse00:00:01.478 0.0%86982 0.000 0.017 0.046
article write00:00:38.820 0.0%26542 0.300 1.463 24.942
artlog/artparse00:00:00.000 0.0%12 0.000 0.000 0.000
data move00:00:00.410 0.0%332432 0.000 0.001 0.008
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.334 0.0%455232 0.001 0.018 2.793
history sync00:00:00.360 0.0%824 0.000 0.437 9.667
history write00:00:09.576 0.0%36390 0.018 0.263 28.352
idle47:53:26.744 99.7%375586 60.307 459.034 1131.785
nntp read00:00:02.906 0.0%364196 0.002 0.008 0.018
overview write00:00:00.226 0.0%26542 0.000 0.009 0.048
perl filter00:00:55.294 0.0%36344 1.155 1.521 2.920
python filter00:00:01.452 0.0%36348 0.000 0.040 0.117
site send00:00:02.222 0.0%79566 0.006 0.028 0.064
TOTAL: 48:02:22.49847:55:28.888 99.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.942 0.0%520990 0.000 0.002 0.028
article prepare00:00:00.010 0.0%41596 0.000 0.000 0.018
article read00:00:44.934 0.0%9484 0.000 4.738 18.250
backlog stats00:00:00.316 0.0%504038 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.156 0.0%321454 0.001 0.007 0.021
data write00:00:03.684 0.0%295650 0.004 0.012 0.032
idle47:33:54.368100.0%504038 9.710 339.725 1244.462
status file00:00:02.142 0.0%378 0.000 5.667 52.000
TOTAL: 47:35:19.56047:34:48.552100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:12:55.684 76.6%17962 18.855 444.031150000.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.812 0.0%309316 0.000 0.012 59.000
readart00:00:20.198 0.2%2296 2.731 8.797 78.000
TOTAL: 02:53:30.75202:13:19.694 76.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 41234 9870 27478 3886 23%94:38:40
2news.snarked.org 50 27134 6558 19948 628 24%51:29:06
3newsfeed.neva.ru 434 124670 4924 117466 2280 3%203:04:10
4feeder3.feed-ams.uzoreto.com 574 85018 3796 79680 1542 4%47:18:52
5newsfeed.fu-berlin.de 4 13218 622 12576 20 4%46:14:24
6news-in.rahul.net 574 15658 300 15232 126 1%47:18:26
7news.cmpublishers.com 50 8164 272 7870 22 3%48:00:04
8news.lightlink.com 2 8724 142 8210 372 1%50:46:42
9ripco-out.feeder.erje.net 578 29066 74 28052 940 0%49:03:06
10localhost 150 4 4 0 0 100%00:00:02
TOTAL: 10 3564 352890 26562 316512 9816 7%637:53:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com26.3 MB0.0 KB8.2 MB34.5 MB 76%2.6 KB
2news.snarked.org19.4 MB6.4 KB2.0 MB21.5 MB 90%3.1 KB
3newsfeed.neva.ru14.8 MB13.7 KB7.5 MB22.2 MB 66%3.2 KB
4feeder3.feed-ams.uzoreto.com9.0 MB0.0 KB3.2 MB12.2 MB 73%2.3 KB
5news-in.rahul.net6.1 MB0.0 KB4.4 MB10.5 MB 57%25.2 KB
6newsfeed.fu-berlin.de2.9 MB0.0 KB156.0 KB3.1 MB 95%4.9 KB
7news.lightlink.com1.7 MB79.4 KB15.9 MB17.7 MB 9%35.3 KB
8news.cmpublishers.com815.4 KB0.0 KB56.7 KB872.0 KB 93%3.0 KB
9ripco-out.feeder.erje.net273.8 KB0.0 KB8.9 MB9.2 MB 2%9.2 KB
10localhost9.5 KB0.0 KB0.0 KB9.5 KB100%2.4 KB
TOTAL: 1081.3 MB99.5 KB50.3 MB131.7 MB 61%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 13 00:01:01 - 00:59:59 334 2.5% 0.091.2 MB 2.9% 0.33
Jul 13 01:00:00 - 01:59:59 396 3.0% 0.111.1 MB 2.6% 0.30
Jul 13 02:00:00 - 02:59:59 451 3.4% 0.131.3 MB 3.3% 0.38
Jul 13 03:00:00 - 03:59:59 496 3.7% 0.141.5 MB 3.8% 0.43
Jul 13 04:00:00 - 04:59:59 511 3.9% 0.141.4 MB 3.5% 0.40
Jul 13 05:00:00 - 05:59:59 610 4.6% 0.171.6 MB 3.9% 0.45
Jul 13 06:00:00 - 06:59:59 528 4.0% 0.151.4 MB 3.5% 0.40
Jul 13 07:00:00 - 07:59:59 667 5.0% 0.192.4 MB 6.0% 0.69
Jul 13 08:00:00 - 08:59:59 690 5.2% 0.192.1 MB 5.2% 0.59
Jul 13 09:00:00 - 09:59:59 899 6.8% 0.252.3 MB 5.7% 0.65
Jul 13 10:00:00 - 10:59:59 724 5.5% 0.202.1 MB 5.2% 0.60
Jul 13 11:00:00 - 11:59:59 747 5.6% 0.212.4 MB 6.0% 0.69
Jul 13 12:00:00 - 12:59:59 777 5.9% 0.222.4 MB 6.0% 0.69
Jul 13 13:00:00 - 13:59:59 642 4.8% 0.181.9 MB 4.6% 0.53
Jul 13 14:00:00 - 14:59:59 763 5.8% 0.212.3 MB 5.8% 0.66
Jul 13 15:00:00 - 15:59:59 733 5.5% 0.202.6 MB 6.5% 0.75
Jul 13 16:00:00 - 16:59:59 638 4.8% 0.181.9 MB 4.7% 0.54
Jul 13 17:00:00 - 17:59:59 520 3.9% 0.141.5 MB 3.7% 0.42
Jul 13 18:00:00 - 18:59:59 468 3.5% 0.131.5 MB 3.7% 0.43
Jul 13 19:00:00 - 19:59:59 353 2.7% 0.101.5 MB 3.7% 0.42
Jul 13 20:00:00 - 20:59:59 354 2.7% 0.101.0 MB 2.6% 0.30
Jul 13 21:00:00 - 21:59:59 447 3.4% 0.121.3 MB 3.3% 0.38
Jul 13 22:00:00 - 22:59:59 281 2.1% 0.08881.9 KB 2.1% 0.24
Jul 13 23:00:00 - 23:58:02 224 1.7% 0.06734.5 KB 1.8% 0.21
TOTAL: 23:57:01 13253 100.0% 0.1540.4 MB 100.0% 0.48
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1947 1297 0 0 6 0 0 0 644
2newsfeed.neva.ru 1187 381 0 2 1 0 0 0 803
3feeder3.feed-ams.uzoreto.com 771 442 0 0 1 0 0 0 328
4ripco-out.feeder.erje.net 470 469 0 0 0 0 0 0 1
5news.snarked.org 312 193 0 1 2 0 0 0 116
6news.lightlink.com 185 1 0 1 0 0 0 0 183
7newsfeed.fu-berlin.de 163 1 0 0 0 0 0 0 162
8news-in.rahul.net 63 0 0 0 0 0 0 0 63
9news.cmpublishers.com 11 1 0 0 0 0 0 0 10
TOTAL: 9 5109 2785 0 4 10 0 0 0 2310

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1789
alt.binaries.ftd 208
scot.general 170
free.willey 89
it.tlc.cellulari.android 38
alt.binaries.nl 36
perl.cpan.uploads 33
free.it.scienza.fisica 32
alt.binaries.pictures.rail 28
fido7.su.pol.news 25
alt.binaries.pictures.wallpaper 18
alt.binaries.csv 14
fr.usenet.abus.nocem 14
linux.debian.ports.hurd 10
alt.binaries.e-book 10
alt.binaries.e-book.magazines 9
alt.bestjobsusa.computer.jobs 8
alt.binaries.drwho 8
alt.binaries.sounds.lossless.jazz 7
alt.binaries.pictures.scenic 7
TOTAL: 131 2785

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

GroupsCount
christnet.bible 4
bit.listserv.catholic 2
fr.comp.securite 1
pl.praca.oferowana 1
alt.penthouse.sex.masterbation 1
alt.christnet.christnews 1
TOTAL: 6 10

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2586
Too many newsgroups 948
Binary in non-binary group 474
EMP (phl) 74
Scoring filter (8) 60
Scoring filter (10) 30
Scoring filter (11) 14
Scoring filter (9) 14
Scoring filter (13) 4
Scoring filter (18) 2
Scoring filter (12) 2
TOTAL: 11 4208

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 155
newsfeed.neva.ru 26
ripco-out.feed.uzoreto.com 3
feeder3.feed-ams.uzoreto.com 1
TOTAL: 4 185
No colon-space in header
feeder3.feed-ams.uzoreto.com 4
ripco-out.feed.uzoreto.com 2
TOTAL: 2 6
TOTAL: 3 209

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 11340 1686 5352 14 0 6 14%47:40:02
2rahul.net 22078 984 12232 8 0 6 4%47:40:02
3news.uzoreto.com 12718 152 12270 80 0 0 1%47:53:20
4feeder.erje.net 25984 116 25046 182 0 0 0%47:40:04
5newsfeed.neva.ru 496850 114 487708 6446 6 21716 0%47:47:12
6fu-berlin.de 24210 102 24108 0 0 0 0%47:40:04
7news.cmpublishers.com 35266 74 25488 396 0 36 0%47:43:22
8news.snarked.org 32240 30 19636 6 0 16 0%47:40:02
9remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:16
TOTAL: 9 660692 3258 611840 7138 6 21780 0%382:56:24
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com4.8 MB25.8 KB4.8 MB0.0 KB/s2.9 KB47:40:02
2rahul.net3.0 MB56.3 KB3.1 MB0.0 KB/s3.2 KB47:40:02
3news.uzoreto.com662.1 KB296.9 KB959.0 KB0.0 KB/s4.1 KB47:53:20
4feeder.erje.net533.0 KB440.2 KB973.1 KB0.0 KB/s3.3 KB47:40:04
5fu-berlin.de467.4 KB0.0 KB467.4 KB0.0 KB/s4.6 KB47:40:04
6newsfeed.neva.ru279.6 KB26.7 MB27.0 MB0.2 KB/s4.2 KB47:47:12
7news.cmpublishers.com263.8 KB1.4 MB1.7 MB0.0 KB/s3.7 KB47:43:22
8news.snarked.org152.5 KB18.1 KB170.6 KB0.0 KB/s4.7 KB47:40:02
9remote6hme0.ripco.com0.0 KB31.6 KB31.6 KB0.0 KB/s5.3 KB01:12:16
TOTAL: 910.2 MB29.0 MB39.2 MB0.0 KB/s3.9 KB382:56:24
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10283.0 MB 470 2 000:08:39
2shell3 8 238808.3 KB 26 2 002:06:01
TOTAL: 2 294 12663.8 MB 496 4 002:50:04

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10283.0 MB 470 2 000:08:39
2? 8 238808.3 KB 26 2 002:06:01
TOTAL: 2 294 12663.8 MB 496 4 002:14:41

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 2.150 0.988 0.00002:06:01
81.92.203.117 447.938 123.684 0.00000:28:27
ftupet.com 47.466 21.892 0.00000:08:39
d54c176a7.access.telenet.be 55.026 14.710 0.00000:03:45
cpc150131-smal18-2-0-cust414.19-1.cable.virginm.net 68.386 21.474 0.00000:02:54
185.212.171.9 3.228 0.894 0.00000:00:12
ppp121-44-245-244.bras2.syd2.internode.on.net 0.404 0.098 0.00000:00:01
unused-89-185-44-204.fr.clara.net 0.200 0.048 0.00000:00:00
li850-105.members.linode.com 0.200 0.050 0.00000:00:00
li1720-150.members.linode.com 0.200 0.050 0.00000:00:00
198.199.97.21 0.200 0.050 0.00000:00:00
li396-166.members.linode.com 0.200 0.050 0.00000:00:00
TOTAL: 12 625.598 183.988 0.00002:50:04

NNRP no permission clients:

SystemConn
81.92.203.117 4426
cpc150131-smal18-2-0-cust414.19-1.cable.virginm.net 556
d54c176a7.access.telenet.be 544
185.212.171.9 32
ppp121-44-245-244.bras2.syd2.internode.on.net 4
li850-105.members.linode.com 2
li1720-150.members.linode.com 2
unused-89-185-44-204.fr.clara.net 2
li396-166.members.linode.com 2
198.199.97.21 2
TOTAL: 10 5572

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 6 0
TOTAL: 1 6 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1208 95.4%
2comp 28 2.2%
3news 12 0.9%
4sci 8 0.6%
5alt 6 0.5%
6chi 4 0.3%
TOTAL: 6 1266100.0%

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

NewsgroupCount
1rec.arts.tv 574
2rec.food.cooking 448
3rec.bicycles.tech 170
4comp.sys.mac.system 14
5sci.electronics.repair 8
6comp.protocols.dns.bind 8
7rec.radio.broadcasting 6
8news.software.readers 6
9rec.radio.swap 4
10alt.dss.hack 4
11comp.sys.ibm.pc.games.strategic 4
12news.admin.net-abuse.email 4
13chi.weather 4
14rec.gardens.edible 4
15comp.home.automation 2
16rec.bicycles.misc 2
17news.admin.net-abuse.usenet 2
18alt.satellite.gps.garmin 2
TOTAL: 18 1266