Daily Usenet report for news.ripco.com

Oct 23 00:01:02 -- Oct 23 23:57:51

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Oct 23 00:19:31 remote5bge0 overchan[15793]: [ID 702911 news.error] input line too long, skipping
Oct 23 04:17:51 remote5bge0 overchan[15793]: [ID 702911 news.error] input line too long, skipping
Oct 23 13:46:47 remote5bge0 overchan[15793]: [ID 702911 news.error] input line too long, skipping
Oct 23 14:51:34 remote5bge0 overchan[15793]: [ID 702911 news.error] input line too long, skipping
Oct 23 14:54:49 remote5bge0 overchan[15793]: [ID 702911 news.error] input line too long, skipping
Oct 23 15:07:28 remote5bge0 overchan[15793]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 19082 31.6%2.0 MB 21.7%
inn 18921 31.3%3.6 MB 38.8%
innd 18727 31.0%2.9 MB 31.1%
innfeed 3644 6.0%807.5 KB 8.4%
overchan 6 0.0%1.0 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 60382 100.0%9.4 MB100.0%

History cache:

ReasonCount%Count
Cache misses 173382 50.2%
Do not exist 172240 49.8%
Positive hits 0 0.0%
Negative hits 0 0.0%
TOTAL: 4 345622 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%110 0.000 0.000 0.000
article cleanup00:00:00.486 0.0%37570 0.000 0.013 0.058
article logging00:00:00.852 0.0%37918 0.000 0.022 0.108
article parse00:00:01.572 0.0%101724 0.000 0.015 0.036
article write00:01:27.212 0.1%27592 1.514 3.161 51.643
artlog/artparse00:00:00.000 0.0%12 0.000 0.000 0.000
data move00:00:00.390 0.0%358320 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.868 0.0%346734 0.002 0.008 0.017
history sync00:00:00.172 0.0%806 0.000 0.213 1.500
history write00:00:03.526 0.0%37580 0.026 0.094 0.761
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:56:38.664 99.8%396460 206.494 435.350 1073.732
nntp read00:00:03.158 0.0%395808 0.002 0.008 0.018
overview write00:00:00.290 0.0%27592 0.000 0.011 0.044
perl filter00:00:57.772 0.0%37568 1.205 1.538 2.494
python filter00:00:01.548 0.0%37572 0.000 0.041 0.113
site send00:00:01.992 0.0%82734 0.000 0.024 0.056
TOTAL: 48:02:18.43647:59:20.502 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.302 0.0%27852 0.000 0.011 0.071
article prepare00:00:00.006 0.0%11232 0.000 0.001 0.028
article read00:00:00.436 0.0%2292 0.000 0.190 14.600
backlog stats00:00:00.300 0.0%427856 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.618 0.0%269702 0.002 0.010 0.018
data write00:00:04.660 0.0%242624 0.008 0.019 0.034
idle47:53:02.032100.0%427856 238.141 402.897 1000.332
status file00:00:01.904 0.0%374 0.000 5.091 90.000
TOTAL: 47:53:32.90247:53:12.258100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:53:18.014 94.0%18234 0.333 372.821 25340.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.084 0.1%759600 0.000 0.011 1.000
readart00:00:20.822 0.3%2330 0.077 8.936 38.500
TOTAL: 02:00:31.79601:53:46.920 94.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
1feeder3.feed-ams.uzoreto.com 574 25092 9696 10954 4442 38%47:18:54
2ripco-out.feed.uzoreto.com 1148 26948 5704 19106 2138 21%94:39:32
3news.snarked.org 38 25208 5400 19352 456 21%50:05:10
4newsfeed.neva.ru 606 30142 5388 23240 1514 17%275:33:58
5ripco-out.news.tnetconsulting.net 4 31782 568 31060 154 1%50:09:36
6newsfeed.fu-berlin.de 2 13098 480 12586 32 3%47:28:50
7news.lightlink.com 2 9642 428 8984 230 4%52:29:26
8ripco-out.feeder.erje.net 574 29134 46 28144 944 0%47:20:06
9news-in.rahul.net 574 14938 30 14834 74 0%47:19:32
10news.cmpublishers.com 52 7812 14 7798 0 0%47:59:48
11localhost 150 4 4 0 0 100%00:00:02
TOTAL: 11 3724 213800 27758 176058 9984 12%760:24:54
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder3.feed-ams.uzoreto.com25.5 MB0.0 KB10.6 MB36.0 MB 70%2.6 KB
2ripco-out.news.tnetconsulting.net19.5 MB0.0 KB3.8 MB23.2 MB 83%32.9 KB
3news.snarked.org15.9 MB7.0 KB2.1 MB18.0 MB 88%3.2 KB
4newsfeed.neva.ru15.8 MB0.0 KB3.6 MB19.5 MB 81%2.9 KB
5ripco-out.feed.uzoreto.com13.9 MB0.0 KB5.1 MB19.0 MB 73%2.5 KB
6newsfeed.fu-berlin.de5.8 MB0.0 KB1.1 MB7.0 MB 83%13.9 KB
7news.lightlink.com4.8 MB0.0 KB9.7 MB14.5 MB 33%22.5 KB
8news-in.rahul.net261.9 KB0.0 KB5.3 MB5.6 MB 4%55.0 KB
9ripco-out.feeder.erje.net115.7 KB0.0 KB6.5 MB6.6 MB 1%6.8 KB
10news.cmpublishers.com69.9 KB0.0 KB0.0 KB69.9 KB100%5.0 KB
11localhost11.6 KB0.0 KB0.0 KB11.6 KB100%2.9 KB
TOTAL: 11101.6 MB7.0 KB47.8 MB149.4 MB 68%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 23 00:01:02 - 00:59:59 344 2.5% 0.101.6 MB 3.2% 0.45
Oct 23 01:00:00 - 01:59:59 472 3.4% 0.131.3 MB 2.7% 0.38
Oct 23 02:00:00 - 02:59:59 542 3.9% 0.151.6 MB 3.2% 0.45
Oct 23 03:00:00 - 03:59:59 597 4.3% 0.172.5 MB 5.2% 0.72
Oct 23 04:00:00 - 04:59:59 681 4.9% 0.191.7 MB 3.6% 0.50
Oct 23 05:00:00 - 05:59:59 708 5.1% 0.203.2 MB 6.5% 0.90
Oct 23 06:00:00 - 06:59:59 623 4.5% 0.172.0 MB 4.2% 0.58
Oct 23 07:00:00 - 07:59:59 662 4.8% 0.182.4 MB 4.9% 0.69
Oct 23 08:00:00 - 08:59:59 720 5.2% 0.202.2 MB 4.6% 0.63
Oct 23 09:00:00 - 09:59:59 782 5.7% 0.223.6 MB 7.4% 1.03
Oct 23 10:00:00 - 10:59:59 773 5.6% 0.212.7 MB 5.5% 0.76
Oct 23 11:00:00 - 11:59:59 688 5.0% 0.192.1 MB 4.2% 0.59
Oct 23 12:00:00 - 12:59:59 675 4.9% 0.191.9 MB 3.9% 0.54
Oct 23 13:00:00 - 13:59:59 835 6.1% 0.233.5 MB 7.2% 0.99
Oct 23 14:00:00 - 14:59:59 683 5.0% 0.192.5 MB 5.2% 0.72
Oct 23 15:00:00 - 15:59:59 609 4.4% 0.172.0 MB 4.1% 0.57
Oct 23 16:00:00 - 16:59:59 606 4.4% 0.172.1 MB 4.4% 0.61
Oct 23 17:00:00 - 17:59:59 457 3.3% 0.131.6 MB 3.3% 0.46
Oct 23 18:00:00 - 18:59:59 531 3.9% 0.151.4 MB 2.8% 0.39
Oct 23 19:00:00 - 19:59:59 448 3.3% 0.121.4 MB 2.8% 0.39
Oct 23 20:00:00 - 20:59:59 342 2.5% 0.101.2 MB 2.5% 0.35
Oct 23 21:00:00 - 21:59:59 358 2.6% 0.102.1 MB 4.3% 0.60
Oct 23 22:00:00 - 22:59:59 328 2.4% 0.091.0 MB 2.1% 0.29
Oct 23 23:00:00 - 23:57:51 301 2.2% 0.091.1 MB 2.2% 0.32
TOTAL: 23:56:49 13765 100.0% 0.1648.8 MB 100.0% 0.58
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feeder3.feed-ams.uzoreto.com 2236 1706 0 0 2 0 0 0 528
2ripco-out.feed.uzoreto.com 1081 614 0 0 12 0 0 0 455
3newsfeed.neva.ru 800 424 0 0 3 0 0 0 373
4ripco-out.feeder.erje.net 472 468 0 0 0 0 0 0 4
5news.snarked.org 218 48 0 1 0 0 0 0 169
6news.lightlink.com 119 1 0 0 0 0 0 0 118
7newsfeed.fu-berlin.de 119 0 0 0 1 0 0 0 118
8ripco-out.news.tnetconsulting.net 74 34 0 0 0 0 0 0 40
9news-in.rahul.net 37 0 0 0 0 0 0 0 37
TOTAL: 9 5156 3295 0 1 18 0 0 0 1842

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2405
alt.binaries.ftd 209
it.tlc.cellulari.android 44
fido7.su.pol.news 41
alt.bestjobsusa.computer.jobs 39
dating 39
alt.binaries.e-book 32
scinet.stats 30
alt.binaries.nospam.breasts.natural 27
it.comp.os.win.windows10 18
alt.binaries.pictures.earlmiller 18
alt.jobs.jobsearch 17
panix.chat.politics 16
at.jobs 12
alt.binaries.test.yenc 12
scot.general 12
att.jobs 11
alt.binaries.sounds.lossless.classical 11
aus.jobs 11
uk.net.news.moderation 11
TOTAL: 139 3295

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

GroupsCount
pl.praca.oferowana 7
fr.comp.lang.php 4
fr.comp.applications.libres 4
fr.sci.geosciences 1
rec.travel.resorts.all-inclusive 1
bit.listserv.catholic 1
TOTAL: 6 18

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1600
Too many newsgroups 1300
EMP (phl) 158
Binary in non-binary group 156
Scoring filter (9) 30
Scoring filter (8) 28
Scoring filter (11) 16
Scoring filter (10) 14
HTML post 6
Scoring filter (15) 6
Scoring filter (13) 4
Scoring filter (12) 4
Scoring filter (17) 2
Scoring filter (16) 2
TOTAL: 14 3326

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 38
ripco-out.feed.uzoreto.com 20
feeder3.feed-ams.uzoreto.com 8
TOTAL: 3 66
Including strange strings
newsfeed.fu-berlin.de 102
newsfeed.neva.ru 44
feeder3.feed-ams.uzoreto.com 15
ripco-out.feed.uzoreto.com 13
TOTAL: 4 174
No colon-space in header
ripco-out.feed.uzoreto.com 4
ripco-out.feeder.erje.net 2
TOTAL: 2 6
TOTAL: 3 246

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10370 872 6264 14 0 0 8%47:35:48
2rahul.net 23188 618 12356 26 0 0 2%47:48:06
3fu-berlin.de 25036 110 24926 0 0 0 0%47:40:08
4news.cmpublishers.com 42066 80 26258 698 0 244 0%47:40:04
5feeder.erje.net 26878 76 26298 70 0 12 0%47:38:46
6news.snarked.org 36798 50 22020 14 0 58 0%47:42:34
7newsfeed.neva.ru 22868 24 21976 22 0 0 0%47:43:28
8news.uzoreto.com 12066 18 11508 78 0 0 0%47:36:22
9news.tnetconsulting.net 41774 16 26742 0 0 44 0%47:38:20
10remote6hme0.ripco.com 8 2 0 6 0 0 25%01:32:12
TOTAL: 10 241052 1866 178348 928 0 358 0%430:35:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net7.9 MB62.5 KB8.0 MB0.0 KB/s12.7 KB47:48:06
2news.lightlink.com4.9 MB85.0 KB5.0 MB0.0 KB/s5.8 KB47:35:48
3fu-berlin.de1.7 MB0.0 KB1.7 MB0.0 KB/s16.3 KB47:40:08
4news.snarked.org415.0 KB18.8 KB433.8 KB0.0 KB/s6.8 KB47:42:34
5news.tnetconsulting.net336.2 KB0.0 KB336.2 KB0.0 KB/s21.0 KB47:38:20
6feeder.erje.net283.6 KB194.5 KB478.1 KB0.0 KB/s3.3 KB47:38:46
7news.cmpublishers.com266.6 KB2.0 MB2.3 MB0.0 KB/s3.0 KB47:40:04
8newsfeed.neva.ru93.4 KB92.1 KB185.5 KB0.0 KB/s4.0 KB47:43:28
9news.uzoreto.com70.8 KB316.4 KB387.2 KB0.0 KB/s4.0 KB47:36:22
10remote6hme0.ripco.com2.3 KB25.6 KB27.9 KB0.0 KB/s3.5 KB01:32:12
TOTAL: 1016.0 MB2.8 MB18.8 MB0.0 KB/s6.9 KB430:35:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9722.7 MB 432 2 000:08:44
2shell3.ripco.com 24 384947.1 KB 46 2 001:47:39
TOTAL: 2 310 13563.6 MB 478 4 002:00:07

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9722.7 MB 432 2 000:08:44
2*.ripco.com 24 384947.1 KB 46 2 001:47:39
TOTAL: 2 310 13563.6 MB 478 4 001:56:24

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 5.400 7.218 0.00001:47:39
ftupet.com 47.614 21.408 0.00000:08:44
84-105-134-55.cable.dynamic.v4.ziggo.nl 42.122 11.392 0.00000:03:38
138.197.214.237 2.228 0.542 0.00000:00:03
192.241.235.198 0.204 0.054 0.00000:00:00
TOTAL: 5 97.568 40.614 0.00002:00:07

NNRP no permission clients:

SystemConn
84-105-134-55.cable.dynamic.v4.ziggo.nl 416
138.197.214.237 22
192.241.235.198 2
TOTAL: 3 440

NNRP unrecognized commands (by host):

SystemConn
shell3.ripco.com 10
TOTAL: 1 10

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 10
TOTAL: 1 10

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3.ripco.com 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1082 79.8%
2alt 120 8.8%
3misc 78 5.8%
4sci 32 2.4%
5comp 26 1.9%
6seattle 8 0.6%
7chi 8 0.6%
8news 2 0.1%
TOTAL: 8 1356100.0%

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

NewsgroupCount
1rec.food.cooking 552
2rec.arts.tv 372
3rec.bicycles.tech 146
4alt.comp.os.windows-10 92
5misc.phone.mobile.iphone 70
6sci.electronics.repair 32
7alt.stupidity 24
8comp.sys.mac.system 14
9misc.consumers.frugal-living 8
10seattle.general 8
11comp.sys.apple2 6
12alt.marketing.online.ebay 4
13comp.mobile.android 4
14chi.general 4
15chi.weather 4
16rec.radio.broadcasting 4
17rec.outdoors.rv-travel 4
18comp.unix.bsd.freebsd.misc 2
19news.admin.net-abuse.email 2
20rec.radio.shortwave 2
21rec.radio.swap 2
TOTAL: 21 1356