Daily Usenet report for news.ripco.com

Jul 18 00:01:01 -- Jul 18 23:57:43

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Jul 18 00:12:52 remote5bge0 overchan[11155]: [ID 702911 news.error] input line too long, skipping
Jul 18 03:18:21 remote5bge0 overchan[11155]: [ID 702911 news.error] input line too long, skipping
Jul 18 10:01:03 remote5bge0 overchan[11155]: [ID 702911 news.error] input line too long, skipping
Jul 18 10:10:49 remote5bge0 overchan[11155]: [ID 702911 news.error] input line too long, skipping
Jul 18 13:06:10 remote5bge0 overchan[11155]: [ID 702911 news.error] input line too long, skipping
Jul 18 13:31:43 remote5bge0 overchan[11155]: [ID 702911 news.error] input line too long, skipping
Jul 18 13:33:47 remote5bge0 overchan[11155]: [ID 702911 news.error] input line too long, skipping
Jul 18 13:37:31 remote5bge0 overchan[11155]: [ID 702911 news.error] input line too long, skipping
Jul 18 14:10:05 remote5bge0 overchan[11155]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 17982 32.5%2.8 MB 32.7%
nnrpd 17220 31.2%1.8 MB 20.9%
inn 16290 29.5%3.2 MB 37.7%
innfeed 3762 6.8%758.0 KB 8.7%
overchan 9 0.0%1.0 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 55265 100.0%8.5 MB100.0%

History cache:

ReasonCount%Count
Cache misses 164472 53.5%
Do not exist 143128 46.5%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 307600 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%160 0.000 0.000 0.000
article cleanup00:00:00.458 0.0%32298 0.000 0.014 0.054
article logging00:00:00.700 0.0%32624 0.000 0.021 0.230
article parse00:00:01.264 0.0%85338 0.000 0.015 0.041
article write00:01:22.644 0.0%24782 1.333 3.335 262.302
artlog/artparse00:00:00.000 0.0%8 0.000 0.000 0.000
data move00:00:00.356 0.0%325402 0.000 0.001 0.008
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:05.402 0.0%308612 0.001 0.018 0.625
history sync00:00:00.228 0.0%800 0.000 0.285 2.000
history write00:00:04.906 0.0%32306 0.009 0.152 4.727
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:57:38.984 99.8%359680 261.905 480.035 1117.266
nntp read00:00:02.390 0.0%355860 0.000 0.007 0.015
overview write00:00:00.260 0.0%24782 0.000 0.010 0.065
perl filter00:00:47.914 0.0%32298 1.189 1.483 2.141
python filter00:00:01.230 0.0%32300 0.000 0.038 0.135
site send00:00:01.858 0.0%74324 0.006 0.025 0.089
TOTAL: 48:02:08.32848:00:08.594 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.166 0.0%39820 0.000 0.004 0.043
article prepare00:00:00.010 0.0%22224 0.000 0.000 0.015
article read00:00:00.742 0.0%4264 0.000 0.174 14.400
backlog stats00:00:00.260 0.0%365446 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.710 0.0%219438 0.000 0.008 0.018
data write00:00:03.562 0.0%194626 0.007 0.018 0.034
idle47:37:18.106100.0%365446 146.319 469.120 1197.042
status file00:00:03.096 0.0%444 0.333 6.973 40.000
TOTAL: 47:37:46.97847:37:27.652100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:23:58.858 89.5%17618 17.333 81.670 9492.911
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.728 0.2%293124 0.000 0.009 0.058
readart00:00:17.522 1.1%2256 1.842 7.767 35.500
TOTAL: 00:26:47.23200:24:19.108 90.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 56 25272 6774 17996 502 26%55:44:54
2feeder3.feed-ams.uzoreto.com 574 16910 6618 8120 2172 39%47:19:32
3ripco-out.feed.uzoreto.com 1148 25434 6498 16200 2736 25%94:37:50
4newsfeed.neva.ru 604 32200 3308 27708 1184 10%271:01:04
5ripco-out.news.tnetconsulting.net 2 25442 892 24482 68 3%42:02:36
6newsfeed.fu-berlin.de 4 13638 424 13174 40 3%48:01:32
7news.lightlink.com 2 7928 152 7708 68 1%43:52:52
8news-in.rahul.net 574 13858 92 13710 56 0%47:21:38
9ripco-out.feeder.erje.net 574 26558 26 25824 708 0%47:19:12
10news.cmpublishers.com 50 7240 6 7230 4 0%47:59:58
11localhost 148 2 2 0 0 100%00:00:00
TOTAL: 11 3736 194482 24792 162152 7538 12%745:21:08
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org19.4 MB0.0 KB1.2 MB20.5 MB 94%2.9 KB
2ripco-out.feed.uzoreto.com17.9 MB0.0 KB6.0 MB24.0 MB 74%2.7 KB
3ripco-out.news.tnetconsulting.net16.2 MB0.0 KB2.2 MB18.4 MB 87%19.6 KB
4feeder3.feed-ams.uzoreto.com15.5 MB0.0 KB3.7 MB19.1 MB 80%2.2 KB
5newsfeed.neva.ru11.8 MB0.0 KB2.8 MB14.7 MB 80%3.3 KB
6newsfeed.fu-berlin.de5.0 MB0.0 KB964.1 KB5.9 MB 84%13.0 KB
7news-in.rahul.net4.6 MB0.0 KB4.2 MB8.8 MB 52%60.6 KB
8news.lightlink.com1.7 MB0.0 KB4.8 MB6.5 MB 25%30.2 KB
9ripco-out.feeder.erje.net97.8 KB0.0 KB4.2 MB4.3 MB 2%6.0 KB
10news.cmpublishers.com12.3 KB0.0 KB6.8 KB19.1 KB 64%1.9 KB
11localhost5.3 KB0.0 KB0.0 KB5.3 KB100%2.6 KB
TOTAL: 1192.1 MB0.0 KB30.1 MB122.1 MB 75%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 18 00:01:01 - 00:59:59 320 2.6% 0.09976.2 KB 2.1% 0.28
Jul 18 01:00:00 - 01:59:59 312 2.5% 0.091.1 MB 2.3% 0.30
Jul 18 02:00:00 - 02:59:59 458 3.7% 0.131.4 MB 3.0% 0.39
Jul 18 03:00:00 - 03:59:59 500 4.0% 0.141.5 MB 3.3% 0.42
Jul 18 04:00:00 - 04:59:59 560 4.5% 0.162.6 MB 5.8% 0.75
Jul 18 05:00:00 - 05:59:59 596 4.8% 0.172.1 MB 4.6% 0.59
Jul 18 06:00:00 - 06:59:59 580 4.7% 0.161.8 MB 3.9% 0.50
Jul 18 07:00:00 - 07:59:59 663 5.4% 0.183.4 MB 7.4% 0.96
Jul 18 08:00:00 - 08:59:59 607 4.9% 0.171.8 MB 4.0% 0.51
Jul 18 09:00:00 - 09:59:59 613 5.0% 0.172.0 MB 4.5% 0.58
Jul 18 10:00:00 - 10:59:59 764 6.2% 0.212.0 MB 4.5% 0.58
Jul 18 11:00:00 - 11:59:59 715 5.8% 0.204.2 MB 9.3% 1.19
Jul 18 12:00:00 - 12:59:59 585 4.7% 0.162.1 MB 4.6% 0.60
Jul 18 13:00:00 - 13:59:59 606 4.9% 0.172.4 MB 5.4% 0.69
Jul 18 14:00:00 - 14:59:59 685 5.5% 0.192.5 MB 5.5% 0.71
Jul 18 15:00:00 - 15:59:59 630 5.1% 0.171.8 MB 3.9% 0.50
Jul 18 16:00:00 - 16:59:59 611 4.9% 0.171.8 MB 4.0% 0.51
Jul 18 17:00:00 - 17:59:59 510 4.1% 0.142.2 MB 4.8% 0.62
Jul 18 18:00:00 - 18:59:59 473 3.8% 0.131.4 MB 3.1% 0.40
Jul 18 19:00:00 - 19:59:59 400 3.2% 0.111.7 MB 3.7% 0.47
Jul 18 20:00:00 - 20:59:59 338 2.7% 0.091.3 MB 2.8% 0.36
Jul 18 21:00:00 - 21:59:59 320 2.6% 0.091.8 MB 3.9% 0.50
Jul 18 22:00:00 - 22:59:59 278 2.2% 0.08904.8 KB 2.0% 0.25
Jul 18 23:00:00 - 23:57:43 247 2.0% 0.07708.0 KB 1.5% 0.20
TOTAL: 23:56:42 12371 100.0% 0.1445.2 MB 100.0% 0.54
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1373 853 0 0 2 0 0 0 518
2feeder3.feed-ams.uzoreto.com 1092 895 0 0 1 0 0 0 196
3newsfeed.neva.ru 628 381 0 0 2 0 0 0 245
4ripco-out.feeder.erje.net 354 354 0 0 0 0 0 0 0
5news.snarked.org 249 155 0 0 1 0 0 0 93
6newsfeed.fu-berlin.de 130 0 0 0 0 0 0 0 130
7ripco-out.news.tnetconsulting.net 38 4 0 0 0 0 0 0 34
8news-in.rahul.net 28 0 0 0 0 0 0 0 28
9news.lightlink.com 25 0 0 0 0 0 0 0 25
10news.cmpublishers.com 2 0 0 0 0 0 0 0 2
TOTAL: 10 3919 2642 0 0 6 0 0 0 1271

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2028
alt.binaries.ftd 134
alt.binaries.pictures.rail 35
scinet.stats 29
alt.binaries.pictures.erotica.vintage 27
alt.binaries.e-book 27
perl.cpan.uploads 26
it.comp.os.win.windows10 21
fido7.su.pol.news 20
scot.general 20
free.willey 10
alt.paranormal.spells 10
abg.test04 10
alt.binaries.mma 10
alt.binaries.test.yenc 9
linux.debian.maint.python 9
alt.bestjobsusa.computer.jobs 8
fr.rec.loisirs-creatifs 8
trollnet.cinema 7
alt.binaries.pictures.purebeauty 7
TOTAL: 116 2642

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

GroupsCount
pl.praca.oferowana 4
gnu.bash.bug 1
bit.listserv.catholic 1
TOTAL: 3 6

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1030
EMP (md5) 800
EMP (phl) 184
Binary in non-binary group 106
Scoring filter (10) 20
Scoring filter (8) 20
Scoring filter (9) 18
Scoring filter (11) 12
Scoring filter (18) 4
Scoring filter (13) 4
Scoring filter (15) 4
Scoring filter (16) 2
HTML post 2
U2 violation - invalid distribution 2
TOTAL: 14 2208

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 32
ripco-out.feed.uzoreto.com 10
feeder3.feed-ams.uzoreto.com 6
TOTAL: 3 48
Including strange strings
newsfeed.fu-berlin.de 118
newsfeed.neva.ru 37
feeder3.feed-ams.uzoreto.com 5
ripco-out.feed.uzoreto.com 3
TOTAL: 4 163
No colon-space in header
ripco-out.feed.uzoreto.com 2
feeder3.feed-ams.uzoreto.com 2
TOTAL: 2 4
TOTAL: 3 215

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 28902 2378 20958 504 0 0 8%47:40:02
2rahul.net 23270 960 12088 18 0 6 4%47:44:44
3news.cmpublishers.com 35678 88 22788 1400 0 88 0%47:36:04
4news.tnetconsulting.net 48732 64 36380 6 0 2244 0%47:47:04
5news.uzoreto.com 11692 32 11090 42 0 0 0%47:40:04
6fu-berlin.de 22354 24 22330 0 0 0 0%47:48:56
7news.snarked.org 30338 22 17770 14 0 92 0%47:37:00
8news.lightlink.com 0 0 0 0 0 7156 0%47:40:02
9newsfeed.neva.ru 0 0 0 0 0 21328 0%47:40:04
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:04
TOTAL: 10 200972 3568 143404 1990 0 30914 1%430:26:04
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1feeder.erje.net6.3 MB1.5 MB7.8 MB0.0 KB/s2.8 KB47:40:02
2rahul.net4.6 MB112.8 KB4.7 MB0.0 KB/s4.9 KB47:44:44
3news.cmpublishers.com367.6 KB4.3 MB4.7 MB0.0 KB/s3.2 KB47:36:04
4news.tnetconsulting.net316.1 KB10.8 KB326.9 KB0.0 KB/s4.7 KB47:47:04
5news.snarked.org222.9 KB215.5 KB438.4 KB0.0 KB/s12.2 KB47:37:00
6news.uzoreto.com161.1 KB148.3 KB309.3 KB0.0 KB/s4.2 KB47:40:04
7fu-berlin.de90.3 KB0.0 KB90.3 KB0.0 KB/s3.8 KB47:48:56
8news.lightlink.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
9newsfeed.neva.ru0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:04
10remote6hme0.ripco.com0.0 KB32.5 KB32.5 KB0.0 KB/s5.4 KB01:12:04
TOTAL: 1012.0 MB6.3 MB18.3 MB0.0 KB/s3.4 KB430:26:04
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10943.0 MB 412 2 000:07:56
2shell3.ripco.com 4 66155.9 KB 16 0 000:18:37
TOTAL: 2 290 11603.2 MB 428 2 000:26:38

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10943.0 MB 412 2 000:07:56
2*.ripco.com 4 66155.9 KB 16 0 000:18:37
TOTAL: 2 290 11603.2 MB 428 2 000:26:33

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 1.210 0.690 0.00000:18:37
ftupet.com 46.860 20.850 0.00000:07:56
58.92.183.58.megaegg.ne.jp 0.398 0.096 0.00000:00:02
scan-141.security.ipip.net 0.198 0.048 0.00000:00:01
162.243.128.37 0.202 0.052 0.00000:00:00
TOTAL: 5 48.868 21.736 0.00000:26:38

NNRP no permission clients:

SystemConn
58.92.183.58.megaegg.ne.jp 4
scan-141.security.ipip.net 2
162.243.128.37 2
TOTAL: 3 8

Newsgroup request counts (by category):

CategoryCountPct
1rec 1096 94.5%
2comp 32 2.8%
3sci 18 1.6%
4chi 8 0.7%
5ba 2 0.2%
6houston 2 0.2%
7news 2 0.2%
TOTAL: 7 1160100.0%

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

NewsgroupCount
1rec.arts.tv 584
2rec.food.cooking 454
3rec.bicycles.tech 50
4comp.sys.mac.system 20
5sci.electronics.repair 18
6comp.sys.mac.apps 12
7chi.weather 4
8chi.general 4
9rec.radio.swap 4
10rec.puzzles 4
11houston.general 2
12news.admin.net-abuse.usenet 2
13ba.food 2
TOTAL: 13 1160