Daily Usenet report for news.ripco.com

Aug 31 00:01:01 -- Aug 31 23:55:30

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Aug 31 00:36:13 remote5bge0 overchan[5839]: [ID 702911 news.error] input line too long, skipping
Aug 31 06:45:47 remote5bge0 overchan[5839]: [ID 702911 news.error] input line too long, skipping
Aug 31 10:21:10 remote5bge0 overchan[5839]: [ID 702911 news.error] input line too long, skipping
Aug 31 16:37:43 remote5bge0 overchan[5839]: [ID 702911 news.error] input line too long, skipping
Aug 31 16:39:11 remote5bge0 overchan[5839]: [ID 702911 news.error] input line too long, skipping
Aug 31 20:50:48 remote5bge0 overchan[5839]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 20012 33.5%3.1 MB 34.9%
inn 18457 30.9%3.2 MB 35.9%
nnrpd 17622 29.5%1.8 MB 20.8%
innfeed 3598 6.0%759.0 KB 8.4%
controlchan 10 0.0%1.8 KB 0.0%
overchan 6 0.0%0.9 KB 0.0%
TOTAL: 6 59705 100.0%8.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 152028 51.8%
Cache misses 141630 48.2%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 293658 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%214 0.000 0.000 0.000
article cleanup00:00:00.334 0.0%36594 0.000 0.009 0.035
article logging00:00:00.514 0.0%36972 0.000 0.014 0.158
article parse00:00:01.522 0.0%89314 0.000 0.017 0.046
article write00:00:30.454 0.0%25956 0.244 1.173 14.172
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.172 0.0%305656 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.302 0.0%295412 0.001 0.008 0.015
history sync00:00:00.158 0.0%810 0.000 0.195 1.500
history write00:00:02.872 0.0%36598 0.000 0.078 0.758
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle48:00:12.102 99.9%338874 293.355 509.960 1514.937
nntp read00:00:01.992 0.0%336238 0.000 0.006 0.012
overview write00:00:00.132 0.0%25956 0.000 0.005 0.037
perl filter00:00:46.150 0.0%36584 1.019 1.261 1.691
python filter00:00:00.896 0.0%36586 0.000 0.024 0.107
site send00:00:01.434 0.0%77792 0.004 0.018 0.044
TOTAL: 48:02:12.06248:01:41.034100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.110 0.0%26088 0.000 0.004 0.032
article prepare00:00:00.006 0.0%14464 0.000 0.000 0.025
article read00:00:00.384 0.0%3194 0.000 0.120 14.000
backlog stats00:00:00.174 0.0%310176 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.576 0.0%204008 0.000 0.008 0.019
data write00:00:03.004 0.0%178856 0.004 0.017 0.029
idle47:36:21.482100.0%310176 326.760 552.530 2238.565
status file00:00:01.646 0.0%338 0.000 4.870 20.000
TOTAL: 47:36:38.03047:36:28.382100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:51:36.754 97.2%17590 0.333 176.052157143.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.468 0.1%223944 0.000 0.011 1.000
readart00:00:16.978 0.5%1456 2.667 11.661 36.000
TOTAL: 00:53:04.99200:51:56.200 97.8%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
usenet@film.rlss.okayama-u.ac.jp002022
TOTAL002022

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 34324 10018 20098 4208 29%94:35:18
2news.snarked.org 42 24382 7958 15804 620 32%49:59:04
3newsfeed.neva.ru 604 39906 4648 31242 4016 11%276:39:22
4feeder3.feed-ams.uzoreto.com 574 10278 2002 7646 630 19%47:27:20
5newsfeed.fu-berlin.de 2 11302 416 10872 14 3%43:28:28
6news.cmpublishers.com 50 7908 308 7582 18 3%48:00:18
7news-in.rahul.net 574 13580 190 13342 48 1%47:19:24
8ripco-out.feeder.erje.net 574 28554 90 27502 962 0%47:18:12
9news.lightlink.com 2 562 2 560 0 0%07:24:36
10localhost 148 2 2 0 0 100%00:00:00
TOTAL: 10 3718 170798 25634 134648 10516 15%662:12:02
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com25.0 MB0.0 KB9.5 MB34.5 MB 72%2.5 KB
2news.snarked.org22.5 MB0.0 KB2.3 MB24.8 MB 90%3.0 KB
3newsfeed.neva.ru14.2 MB0.0 KB31.5 MB45.7 MB 31%5.4 KB
4feeder3.feed-ams.uzoreto.com5.3 MB0.0 KB1.6 MB6.9 MB 76%2.7 KB
5news-in.rahul.net3.9 MB0.0 KB2.0 MB5.9 MB 66%25.4 KB
6newsfeed.fu-berlin.de2.1 MB0.0 KB2.0 MB4.1 MB 50%9.7 KB
7news.cmpublishers.com816.8 KB0.0 KB61.1 KB877.8 KB 93%2.7 KB
8ripco-out.feeder.erje.net157.1 KB0.0 KB8.8 MB8.9 MB 1%8.7 KB
9news.lightlink.com5.5 KB0.0 KB0.0 KB5.5 KB100%2.7 KB
10localhost3.9 KB0.0 KB0.0 KB3.9 KB100%1.9 KB
TOTAL: 1074.0 MB0.0 KB57.8 MB131.8 MB 56%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 31 00:01:01 - 00:59:59 269 2.1% 0.08739.1 KB 1.9% 0.21
Aug 31 01:00:00 - 01:59:59 401 3.1% 0.111.5 MB 4.0% 0.42
Aug 31 02:00:00 - 02:59:59 495 3.8% 0.141.4 MB 3.8% 0.40
Aug 31 03:00:00 - 03:59:59 476 3.7% 0.131.2 MB 3.3% 0.35
Aug 31 04:00:00 - 04:59:59 537 4.1% 0.151.3 MB 3.5% 0.37
Aug 31 05:00:00 - 05:59:59 558 4.3% 0.151.4 MB 3.8% 0.41
Aug 31 06:00:00 - 06:59:59 551 4.3% 0.151.4 MB 3.9% 0.41
Aug 31 07:00:00 - 07:59:59 631 4.9% 0.181.6 MB 4.4% 0.47
Aug 31 08:00:00 - 08:59:59 736 5.7% 0.202.1 MB 5.6% 0.59
Aug 31 09:00:00 - 09:59:59 766 5.9% 0.212.1 MB 5.7% 0.60
Aug 31 10:00:00 - 10:59:59 723 5.6% 0.202.0 MB 5.4% 0.57
Aug 31 11:00:00 - 11:59:59 669 5.2% 0.191.7 MB 4.6% 0.49
Aug 31 12:00:00 - 12:59:59 669 5.2% 0.191.9 MB 5.1% 0.53
Aug 31 13:00:00 - 13:59:59 723 5.6% 0.202.0 MB 5.4% 0.57
Aug 31 14:00:00 - 14:59:59 690 5.3% 0.191.9 MB 5.1% 0.54
Aug 31 15:00:00 - 15:59:59 663 5.1% 0.182.4 MB 6.4% 0.68
Aug 31 16:00:00 - 16:59:59 678 5.2% 0.191.9 MB 5.1% 0.53
Aug 31 17:00:00 - 17:59:59 587 4.5% 0.161.9 MB 5.0% 0.53
Aug 31 18:00:00 - 18:59:59 485 3.7% 0.131.7 MB 4.7% 0.49
Aug 31 19:00:00 - 19:59:59 390 3.0% 0.111.2 MB 3.1% 0.33
Aug 31 20:00:00 - 20:59:59 421 3.3% 0.121.2 MB 3.1% 0.33
Aug 31 21:00:00 - 21:59:59 331 2.6% 0.091009.8 KB 2.7% 0.28
Aug 31 22:00:00 - 22:59:59 299 2.3% 0.081.0 MB 2.8% 0.30
Aug 31 23:00:00 - 23:55:30 202 1.6% 0.06603.6 KB 1.6% 0.18
TOTAL: 23:54:29 12950 100.0% 0.1537.1 MB 100.0% 0.44
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2108 1376 0 0 8 0 0 0 724
2newsfeed.neva.ru 2073 940 0 0 4 0 0 0 1129
3ripco-out.feeder.erje.net 483 476 0 0 0 0 0 0 7
4news.snarked.org 324 148 0 0 1 0 0 0 175
5feeder3.feed-ams.uzoreto.com 315 181 0 0 1 0 0 0 133
6newsfeed.fu-berlin.de 118 0 0 0 0 0 0 0 118
7news.lightlink.com 54 0 0 0 0 0 0 0 54
8news-in.rahul.net 24 1 0 0 0 0 0 0 23
9news.cmpublishers.com 8 0 0 0 0 0 0 0 8
TOTAL: 9 5507 3122 0 0 14 0 0 0 2371

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1663
alt.binaries.boneless 510
alt.binaries.ftd 217
scot.general 60
perl.cpan.uploads 57
fido7.su.pol.news 31
alt.binaries.nl 30
alt.binaries.pictures.rail 21
free.it.scienza.fisica 20
de.soc.arbeitslos 19
linux.debian.maint.python 19
alt.binaries.nospam.female.bodyhair.pubes 17
alt.binaries.pictures.wallpaper 17
it.tlc.cellulari.android 16
de.rec.sf.startrek 14
fr.usenet.abus.nocem 12
linux.debian.changes 12
alt.binaries.e-book 12
alt.binaries.pictures.earlmiller 11
alt.binaries.nospam.female.bodyhair 11
TOTAL: 215 3122

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

GroupsCount
christnet.bible 6
pl.praca.oferowana 5
bit.listserv.catholic 2
alt.christnet.religion 1
TOTAL: 4 14

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 1742
EMP (md5) 1166
Too many newsgroups 1088
EMP (phl) 208
Scoring filter (8) 98
Scoring filter (9) 26
Scoring filter (10) 6
Scoring filter (13) 4
Scoring filter (11) 4
Scoring filter (12) 2
Attached HTML file 2
Scoring filter (15) 2
HTML post 2
TOTAL: 13 4350

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 112
newsfeed.neva.ru 64
news.snarked.org 8
ripco-out.feed.uzoreto.com 4
ripco-out.feeder.erje.net 1
TOTAL: 5 189
No colon-space in header
ripco-out.feed.uzoreto.com 1
feeder3.feed-ams.uzoreto.com 1
TOTAL: 2 2
TOTAL: 3 209

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9446 1662 4430 4 0 0 17%47:46:46
2rahul.net 19760 528 11650 6 0 22 2%47:36:08
3news.cmpublishers.com 34770 124 24230 1054 0 60 0%47:38:32
4news.uzoreto.com 13834 36 13534 48 0 0 0%47:40:04
5news.snarked.org 29162 24 17434 20 0 224 0%47:40:04
6fu-berlin.de 23484 20 23462 0 0 2 0%47:40:04
7feeder.erje.net 24730 12 24060 70 0 0 0%47:40:04
8newsfeed.neva.ru 21332 4 21114 8 0 0 0%47:48:16
9remote6hme0.ripco.com 0 0 0 0 0 12 0%47:40:04
TOTAL: 9 176518 2410 139914 1210 0 320 1%429:10:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com4.3 MB8.8 KB4.3 MB0.0 KB/s2.6 KB47:46:46
2rahul.net1.8 MB60.0 KB1.8 MB0.0 KB/s3.5 KB47:36:08
3news.cmpublishers.com370.7 KB2.8 MB3.1 MB0.0 KB/s2.7 KB47:38:32
4news.uzoreto.com137.0 KB190.5 KB327.4 KB0.0 KB/s3.9 KB47:40:04
5news.snarked.org136.5 KB57.3 KB193.8 KB0.0 KB/s4.4 KB47:40:04
6newsfeed.neva.ru70.6 KB29.0 KB99.6 KB0.0 KB/s8.3 KB47:48:16
7fu-berlin.de64.1 KB0.0 KB64.1 KB0.0 KB/s3.2 KB47:40:04
8feeder.erje.net36.6 KB137.1 KB173.7 KB0.0 KB/s2.1 KB47:40:04
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:04
TOTAL: 96.8 MB3.2 MB10.0 MB0.0 KB/s2.8 KB429:10:02
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 288 6641.8 MB 372 2 000:07:47
2shell3 54 126564.8 KB 14 0 000:44:50
TOTAL: 2 342 7902.3 MB 386 2 000:52:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 288 6641.8 MB 372 2 000:07:47
2? 54 126564.8 KB 14 0 000:44:50
TOTAL: 2 342 7902.3 MB 386 2 000:52:38

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 6.108 1.634 0.00000:44:50
ftupet.com 45.802 7.486 0.00000:07:47
84-105-134-55.cable.dynamic.v4.ziggo.nl 6.434 1.380 0.00000:00:17
TOTAL: 3 58.344 10.500 0.00000:52:56

NNRP no permission clients:

SystemConn
84-105-134-55.cable.dynamic.v4.ziggo.nl 64
TOTAL: 1 64

Newsgroup request counts (by category):

CategoryCountPct
1rec 734 92.9%
2comp 16 2.0%
3chi 10 1.3%
4ba 8 1.0%
5sci 8 1.0%
6news 8 1.0%
7alt 4 0.5%
8soc 2 0.3%
TOTAL: 8 790100.0%

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

NewsgroupCount
1rec.arts.tv 362
2rec.food.cooking 300
3rec.bicycles.tech 48
4comp.sys.mac.system 16
5rec.gardens.edible 14
6sci.electronics.repair 8
7news.software.readers 6
8rec.radio.broadcasting 6
9ba.food 6
10chi.forsale 6
11alt.games.warcraft 4
12chi.weather 4
13rec.radio.swap 4
14soc.history.what-if 2
15ba.internet 2
16news.admin.net-abuse.email 2
TOTAL: 16 790