Daily Usenet report for news.ripco.com

Aug 1 00:01:02 -- Aug 1 23:57:53

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Aug 1 00:24:19 remote5bge0 overchan[19645]: [ID 702911 news.error] input line too long, skipping
Aug 1 03:26:00 remote5bge0 overchan[19645]: [ID 702911 news.error] input line too long, skipping
Aug 1 08:32:31 remote5bge0 overchan[19645]: [ID 702911 news.error] input line too long, skipping
Aug 1 09:13:51 remote5bge0 overchan[19645]: [ID 702911 news.error] input line too long, skipping
Aug 1 10:36:54 remote5bge0 overchan[19645]: [ID 702911 news.error] input line too long, skipping
Aug 1 12:53:18 remote5bge0 overchan[19645]: [ID 702911 news.error] input line too long, skipping
Aug 1 23:56:14.002 - r

Log entries by program:

Program nameLines%LinesSize%Size
innd 17815 31.9%2.8 MB 32.1%
nnrpd 17240 30.9%1.8 MB 20.7%
inn 17051 30.5%3.4 MB 38.6%
innfeed 3712 6.6%762.0 KB 8.6%
controlchan 8 0.0%1.6 KB 0.0%
overchan 6 0.0%0.7 KB 0.0%
TOTAL: 6 55832 100.0%8.7 MB100.0%

History cache:

ReasonCount%Count
Cache misses 168278 53.3%
Do not exist 147406 46.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 315684 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%66 0.000 0.000 0.000
article cleanup00:00:00.432 0.0%33852 0.000 0.013 0.050
article logging00:00:00.680 0.0%34216 0.000 0.020 0.299
article parse00:00:01.272 0.0%87524 0.000 0.015 0.048
article write00:01:23.706 0.0%25986 1.255 3.221 54.524
artlog/artparse00:00:00.000 0.0%8 0.000 0.000 0.000
data move00:00:00.290 0.0%327272 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:02.272 0.0%318908 0.001 0.007 0.020
history sync00:00:00.204 0.0%802 0.000 0.254 4.333
history write00:00:04.788 0.0%33860 0.000 0.141 10.143
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:57:28.104 99.8%363538 162.412 474.911 987.893
nntp read00:00:02.374 0.0%359842 0.002 0.007 0.014
overview write00:00:00.256 0.0%25986 0.000 0.010 0.049
perl filter00:00:49.958 0.0%33852 1.169 1.476 2.580
python filter00:00:01.336 0.0%33866 0.000 0.039 0.143
site send00:00:02.440 0.0%77902 0.005 0.031 0.079
TOTAL: 48:02:12.89047:59:58.112 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.166 0.0%27524 0.000 0.006 0.041
article prepare00:00:00.002 0.0%8136 0.000 0.000 0.013
article read00:00:00.388 0.0%1672 0.000 0.232 8.000
backlog stats00:00:00.250 0.0%393348 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.870 0.0%245766 0.000 0.008 0.017
data write00:00:04.124 0.0%220672 0.008 0.019 0.039
idle47:36:11.482100.0%393348 175.950 435.674 896.615
status file00:00:03.108 0.0%376 1.000 8.266 51.000
TOTAL: 47:36:42.22247:36:21.390100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:15:54.962 84.3%19900 0.000 47.988 4826.406
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.470 0.2%216406 0.000 0.011 0.125
readart00:00:18.432 1.6%2388 1.800 7.719 39.000
TOTAL: 00:18:52.62800:16:15.864 86.2%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de002002
TOTAL002002

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 27628 8464 15962 3202 30%94:38:42
2news.snarked.org 64 26554 6062 19716 776 22%54:10:00
3feeder3.feed-ams.uzoreto.com 574 15790 4960 9258 1572 31%47:19:42
4newsfeed.neva.ru 614 33298 4570 27416 1312 13%278:12:38
5ripco-out.news.tnetconsulting.net 4 23848 850 22942 56 3%38:44:44
6newsfeed.fu-berlin.de 6 18320 602 17654 64 3%64:18:08
7news.lightlink.com 2 7288 128 7012 148 1%43:52:52
8ripco-out.feeder.erje.net 574 28308 62 27400 846 0%47:17:16
9news-in.rahul.net 574 13746 50 13690 6 0%47:21:04
10localhost 160 14 14 0 0 100%00:00:00
11news.cmpublishers.com 50 7322 10 7312 0 0%48:00:10
TOTAL: 11 3770 202116 25772 168362 7982 12%763:55:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com22.1 MB0.0 KB5.8 MB27.9 MB 79%2.4 KB
2news.snarked.org17.6 MB0.0 KB1.7 MB19.4 MB 90%2.9 KB
3newsfeed.neva.ru16.5 MB0.0 KB3.1 MB19.6 MB 84%3.4 KB
4ripco-out.news.tnetconsulting.net13.6 MB0.0 KB1.9 MB15.5 MB 87%17.6 KB
5feeder3.feed-ams.uzoreto.com13.4 MB0.0 KB3.3 MB16.6 MB 80%2.6 KB
6newsfeed.fu-berlin.de4.9 MB0.0 KB4.0 MB9.0 MB 55%13.8 KB
7news.lightlink.com3.8 MB0.0 KB7.2 MB11.0 MB 34%40.9 KB
8localhost912.3 KB0.0 KB0.0 KB912.3 KB100%65.2 KB
9news-in.rahul.net743.5 KB0.0 KB331.6 KB1.0 MB 69%19.2 KB
10ripco-out.feeder.erje.net237.9 KB0.0 KB4.2 MB4.5 MB 5%5.0 KB
11news.cmpublishers.com31.2 KB0.0 KB0.0 KB31.2 KB100%3.1 KB
TOTAL: 1193.8 MB0.0 KB31.6 MB125.4 MB 74%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 1 00:01:02 - 00:59:59 361 2.8% 0.101.7 MB 3.5% 0.48
Aug 1 01:00:00 - 01:59:59 358 2.8% 0.101.7 MB 3.7% 0.49
Aug 1 02:00:00 - 02:59:59 428 3.3% 0.121.2 MB 2.6% 0.34
Aug 1 03:00:00 - 03:59:59 446 3.4% 0.121.5 MB 3.2% 0.43
Aug 1 04:00:00 - 04:59:59 507 3.9% 0.141.8 MB 3.9% 0.51
Aug 1 05:00:00 - 05:59:59 489 3.8% 0.141.5 MB 3.3% 0.43
Aug 1 06:00:00 - 06:59:59 555 4.3% 0.151.7 MB 3.7% 0.50
Aug 1 07:00:00 - 07:59:59 730 5.6% 0.204.1 MB 8.8% 1.17
Aug 1 08:00:00 - 08:59:59 706 5.5% 0.202.3 MB 4.9% 0.65
Aug 1 09:00:00 - 09:59:59 681 5.3% 0.192.6 MB 5.6% 0.74
Aug 1 10:00:00 - 10:59:59 656 5.1% 0.182.2 MB 4.7% 0.63
Aug 1 11:00:00 - 11:59:59 662 5.1% 0.182.9 MB 6.2% 0.82
Aug 1 12:00:00 - 12:59:59 681 5.3% 0.192.2 MB 4.7% 0.63
Aug 1 13:00:00 - 13:59:59 714 5.5% 0.202.4 MB 5.2% 0.69
Aug 1 14:00:00 - 14:59:59 659 5.1% 0.182.2 MB 4.6% 0.61
Aug 1 15:00:00 - 15:59:59 583 4.5% 0.161.7 MB 3.6% 0.48
Aug 1 16:00:00 - 16:59:59 606 4.7% 0.172.1 MB 4.5% 0.60
Aug 1 17:00:00 - 17:59:59 561 4.3% 0.161.6 MB 3.5% 0.46
Aug 1 18:00:00 - 18:59:59 426 3.3% 0.121.2 MB 2.5% 0.33
Aug 1 19:00:00 - 19:59:59 480 3.7% 0.131.3 MB 2.8% 0.37
Aug 1 20:00:00 - 20:59:59 449 3.5% 0.121.2 MB 2.5% 0.34
Aug 1 21:00:00 - 21:59:59 300 2.3% 0.081.2 MB 2.6% 0.35
Aug 1 22:00:00 - 22:59:59 315 2.4% 0.09961.5 KB 2.0% 0.27
Aug 1 23:00:00 - 23:57:53 580 4.5% 0.173.4 MB 7.2% 0.99
TOTAL: 23:56:51 12933 100.0% 0.1546.7 MB 100.0% 0.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1619 1314 0 0 5 0 0 0 300
2feeder3.feed-ams.uzoreto.com 790 493 0 0 2 0 0 0 295
3newsfeed.neva.ru 693 443 0 0 2 0 0 0 248
4ripco-out.feeder.erje.net 423 418 0 0 0 0 0 0 5
5news.snarked.org 392 262 0 0 0 0 0 0 130
6newsfeed.fu-berlin.de 145 0 0 0 0 0 0 0 145
7ripco-out.news.tnetconsulting.net 50 26 0 0 1 0 0 0 23
8news-in.rahul.net 3 0 0 0 0 0 0 0 3
9news.lightlink.com 2 0 0 0 0 0 0 0 2
TOTAL: 9 4117 2956 0 0 10 0 0 0 1151

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2122
alt.binaries.ftd 133
alt.binaries.pictures.erotica.vintage 35
alt.binaries.e-book 35
free.it.scienza.fisica 34
scinet.stats 31
alt.binaries.pictures.rail 31
abg.test04 28
alt.paranormal.spells 25
alt.binaries.pictures.scenic 21
alt.binaries.3d.poser 21
fido7.su.pol.news 19
perl.cpan.uploads 18
alt.binaries.pictures.purebeauty 17
de.soc.usenet 15
free.willey 13
alt.bestjobsusa.computer.jobs 13
linux.debian.maint.emacsen 12
scot.general 12
alt.binaries.pictures.wallpaper 12
TOTAL: 199 2956

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

GroupsCount
pl.praca.oferowana 3
fr.bienvenue 2
fr.comp.lang.php 1
alt.christnet.christnews 1
fr.sci.geosciences 1
fr.comp.applications.libres 1
bit.listserv.catholic 1
TOTAL: 7 10

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 796
EMP (md5) 674
EMP (phl) 360
Binary in non-binary group 66
Scoring filter (8) 26
Scoring filter (9) 8
Scoring filter (16) 6
Scoring filter (10) 4
Scoring filter (11) 2
Scoring filter (15) 2
Scoring filter (14) 2
TOTAL: 11 1946

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 115
newsfeed.neva.ru 35
ripco-out.feed.uzoreto.com 16
news.snarked.org 11
feeder3.feed-ams.uzoreto.com 3
TOTAL: 5 180
No colon-space in header
feeder3.feed-ams.uzoreto.com 2
ripco-out.feeder.erje.net 1
ripco-out.feed.uzoreto.com 1
TOTAL: 3 4
TOTAL: 3 202

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 22610 864 12262 4 0 42 3%47:40:06
2news.uzoreto.com 12436 78 11804 132 0 0 0%47:43:50
3news.snarked.org 32848 60 19490 34 0 1016 0%47:36:12
4news.tnetconsulting.net 43578 54 24554 10 0 292 0%47:40:06
5news.cmpublishers.com 38624 50 24854 554 0 420 0%47:38:06
6feeder.erje.net 25482 48 24852 68 0 0 0%47:40:06
7fu-berlin.de 23524 46 23478 0 0 0 0%47:49:14
8newsfeed.neva.ru 22168 20 21188 6 0 0 0%47:48:14
9news.lightlink.com 0 0 0 0 0 7348 0%47:40:06
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:06
TOTAL: 10 221276 1220 162482 814 0 9118 0%430:28:06
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net7.0 MB6.3 KB7.0 MB0.0 KB/s8.2 KB47:40:06
2news.snarked.org377.3 KB130.7 KB508.0 KB0.0 KB/s5.4 KB47:36:12
3news.tnetconsulting.net319.3 KB22.9 KB342.1 KB0.0 KB/s5.3 KB47:40:06
4news.uzoreto.com263.7 KB501.5 KB765.2 KB0.0 KB/s3.6 KB47:43:50
5feeder.erje.net244.1 KB159.7 KB403.7 KB0.0 KB/s3.5 KB47:40:06
6fu-berlin.de227.9 KB0.0 KB227.9 KB0.0 KB/s5.0 KB47:49:14
7newsfeed.neva.ru155.6 KB49.3 KB204.9 KB0.0 KB/s7.9 KB47:48:14
8news.cmpublishers.com146.5 KB2.3 MB2.4 MB0.0 KB/s4.1 KB47:38:06
9news.lightlink.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:06
10remote6hme0.ripco.com0.0 KB46.4 KB46.4 KB0.0 KB/s7.7 KB01:12:06
TOTAL: 108.7 MB3.2 MB11.8 MB0.0 KB/s6.0 KB430:28:06
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 11663.0 MB 486 2 000:08:11
2shell3.ripco.com 20 54227.8 KB 24 12 000:10:30
TOTAL: 2 306 12203.2 MB 510 14 000:18:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 11663.0 MB 486 2 000:08:11
2*.ripco.com 20 54227.8 KB 24 12 000:10:30
TOTAL: 2 306 12203.2 MB 510 14 000:18:42

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 2.664 1.034 0.00000:10:30
ftupet.com 47.544 21.264 0.00000:08:11
183.136.225.45 0.200 0.050 0.00000:00:00
TOTAL: 3 50.408 22.348 0.00000:18:42

NNRP no permission clients:

SystemConn
183.136.225.45 2
TOTAL: 1 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 1154 94.6%
2comp 28 2.3%
3sci 12 1.0%
4chi 8 0.7%
5alt 6 0.5%
6news 6 0.5%
7seattle 4 0.3%
8houston 2 0.2%
TOTAL: 8 1220100.0%

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

NewsgroupCount
1rec.arts.tv 524
2rec.food.cooking 500
3rec.bicycles.tech 116
4sci.electronics.repair 12
5rec.gardens.edible 10
6comp.sys.mac.system 10
7comp.sys.mac.apps 6
8comp.mail.sendmail 6
9alt.satellite.gps.garmin 6
10chi.forsale 4
11news.admin.net-abuse.email 4
12seattle.general 4
13chi.weather 4
14comp.risks 2
15rec.radio.broadcasting 2
16comp.unix.bsd.freebsd.misc 2
17rec.radio.swap 2
18news.admin.net-abuse.usenet 2
19houston.forsale 2
20comp.protocols.dns.bind 2
TOTAL: 20 1220