Daily Usenet report for news.ripco.com

Oct 22 00:01:03 -- Oct 22 23:57:42

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Oct 22 06:16:47 remote5bge0 overchan[15814]: [ID 702911 news.error] input line too long, skipping
Oct 22 06:16:47 remote5bge0 overchan[15814]: [ID 702911 news.error] input line too long, skipping
Oct 22 06:16:47 remote5bge0 overchan[15814]: [ID 702911 news.error] input line too long, skipping
Oct 22 07:30:04 remote5bge0 overchan[15814]: [ID 702911 news.error] input line too long, skipping
Oct 22 07:32:00 remote5bge0 overchan[15814]: [ID 702911 news.error] input line too long, skipping
Oct 22 09:10:46 remote5bge0 overchan[15814]: [ID 702911 news.error] input line too long, skipping
Oct 22 09:18:05 remote5bge0 overchan[15814]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 33264 40.4%4.1 MB 33.6%
inn 23296 28.3%4.0 MB 32.5%
innd 22185 26.9%3.4 MB 27.9%
innfeed 3615 4.4%741.0 KB 5.9%
overchan 7 0.0%1.1 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 82369 100.0%12.3 MB100.0%

History cache:

ReasonCount%Count
Cache misses 202592 52.2%
Do not exist 185374 47.8%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 387966 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%706 0.000 0.000 0.000
article cleanup00:00:00.476 0.0%46358 0.000 0.010 0.050
article logging00:00:00.788 0.0%46688 0.000 0.017 0.286
article parse00:00:01.712 0.0%106988 0.000 0.016 0.035
article write00:00:42.538 0.0%33362 0.377 1.275 35.981
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.260 0.0%397166 0.000 0.001 0.004
hishave/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.316 0.0%389900 0.002 0.009 0.487
history sync00:00:00.396 0.0%802 0.000 0.494 5.500
history write00:00:04.760 0.0%46354 0.018 0.103 5.293
hiswrite/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
idle47:59:47.704 99.9%434426 216.490 397.738 1182.344
nntp read00:00:02.140 0.0%432318 0.000 0.005 0.014
overview write00:00:00.208 0.0%33362 0.000 0.006 0.036
perl filter00:00:59.842 0.0%46342 0.891 1.291 2.566
python filter00:00:01.234 0.0%46346 0.000 0.027 0.089
site send00:00:01.892 0.0%100030 0.000 0.019 0.043
TOTAL: 48:02:22.18848:01:47.266100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.574 0.0%33404 0.000 0.017 0.061
article prepare00:00:00.002 0.0%17920 0.000 0.000 0.013
article read00:00:00.456 0.0%3896 0.000 0.117 18.500
backlog stats00:00:00.214 0.0%390266 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.592 0.0%260014 0.002 0.010 0.022
data write00:00:03.624 0.0%226966 0.003 0.016 0.039
idle47:33:37.594100.0%390266 179.096 438.720 1369.904
status file00:00:04.340 0.0%340 5.000 12.765 30.000
TOTAL: 47:34:01.88447:33:49.396100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:10.058 0.0%500338 0.000 0.020 0.171
idle104:00:53.602100.0%534506 4.333 700.560268114.846
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:46.442 0.0%2529572 0.000 0.018 0.143
readart00:00:18.974 0.0%2316 0.000 8.193 36.500
TOTAL: 104:03:49.906104:02:09.076100.0%----

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
1ripco-out.feed.uzoreto.com 1154 42942 11480 26750 4712 26%94:38:10
2news.snarked.org 52 42886 9864 28992 4030 23%58:23:22
3newsfeed.neva.ru 580 59234 6340 50902 1992 10%281:08:50
4feeder3.feed-ams.uzoreto.com 574 16590 4640 11136 814 27%47:24:18
5newsfeed.fu-berlin.de 4 15052 550 14468 34 3%51:00:38
6news.lightlink.com 2 9592 186 8892 514 1%45:01:30
7news-in.rahul.net 574 18126 182 17940 4 1%47:30:10
8ripco-out.feeder.erje.net 576 36280 68 35286 926 0%47:17:28
9news.cmpublishers.com 48 9258 68 9172 18 0%48:00:00
10localhost 148 4 4 0 0 100%00:00:02
TOTAL: 10 3712 249964 33382 203538 13044 13%720:24:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com28.7 MB0.0 KB9.1 MB37.8 MB 75%2.4 KB
2news.snarked.org28.6 MB0.0 KB14.9 MB43.5 MB 65%3.2 KB
3newsfeed.neva.ru17.0 MB5.8 KB6.2 MB23.2 MB 73%2.8 KB
4feeder3.feed-ams.uzoreto.com10.7 MB3.7 KB1.7 MB12.4 MB 86%2.3 KB
5news-in.rahul.net8.2 MB0.0 KB297.0 KB8.5 MB 96%46.6 KB
6news.lightlink.com3.7 MB0.0 KB20.0 MB23.7 MB 15%34.6 KB
7newsfeed.fu-berlin.de2.3 MB0.0 KB4.9 MB7.2 MB 31%12.6 KB
8ripco-out.feeder.erje.net230.2 KB0.0 KB7.7 MB7.9 MB 2%8.2 KB
9news.cmpublishers.com159.0 KB8.0 KB51.3 KB218.3 KB 72%2.5 KB
10localhost5.5 KB0.0 KB0.0 KB5.5 KB100%1.4 KB
TOTAL: 1099.5 MB17.5 KB64.7 MB164.3 MB 60%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 22 00:01:03 - 00:59:59 339 2.0% 0.10923.5 KB 1.8% 0.26
Oct 22 01:00:00 - 01:59:59 505 3.0% 0.141.4 MB 2.7% 0.39
Oct 22 02:00:00 - 02:59:59 645 3.9% 0.181.7 MB 3.4% 0.48
Oct 22 03:00:00 - 03:59:59 675 4.1% 0.192.0 MB 4.1% 0.57
Oct 22 04:00:00 - 04:59:59 838 5.0% 0.232.7 MB 5.4% 0.76
Oct 22 05:00:00 - 05:59:59 892 5.4% 0.252.2 MB 4.4% 0.62
Oct 22 06:00:00 - 06:59:59 856 5.1% 0.242.7 MB 5.4% 0.76
Oct 22 07:00:00 - 07:59:59 860 5.2% 0.242.0 MB 4.1% 0.58
Oct 22 08:00:00 - 08:59:59 855 5.1% 0.242.4 MB 4.9% 0.70
Oct 22 09:00:00 - 09:59:59 944 5.7% 0.262.5 MB 5.1% 0.72
Oct 22 10:00:00 - 10:59:59 1014 6.1% 0.283.4 MB 6.8% 0.96
Oct 22 11:00:00 - 11:59:59 1100 6.6% 0.313.3 MB 6.6% 0.93
Oct 22 12:00:00 - 12:59:59 914 5.5% 0.252.7 MB 5.3% 0.75
Oct 22 13:00:00 - 13:59:59 834 5.0% 0.232.5 MB 5.0% 0.71
Oct 22 14:00:00 - 14:59:59 879 5.3% 0.242.4 MB 4.8% 0.68
Oct 22 15:00:00 - 15:59:59 939 5.6% 0.262.7 MB 5.5% 0.77
Oct 22 16:00:00 - 16:59:59 783 4.7% 0.222.7 MB 5.5% 0.78
Oct 22 17:00:00 - 17:59:59 620 3.7% 0.172.0 MB 4.1% 0.58
Oct 22 18:00:00 - 18:59:59 456 2.7% 0.131.7 MB 3.5% 0.50
Oct 22 19:00:00 - 19:59:59 373 2.2% 0.101.2 MB 2.4% 0.34
Oct 22 20:00:00 - 20:59:59 328 2.0% 0.091.1 MB 2.3% 0.32
Oct 22 21:00:00 - 21:59:59 422 2.5% 0.121.5 MB 3.0% 0.42
Oct 22 22:00:00 - 22:59:59 239 1.4% 0.07749.1 KB 1.5% 0.21
Oct 22 23:00:00 - 23:57:42 328 2.0% 0.091.1 MB 2.3% 0.33
TOTAL: 23:56:39 16638 100.0% 0.1949.6 MB 100.0% 0.59
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2364 1794 0 0 6 0 0 0 564
2news.snarked.org 2015 55 0 0 3 0 0 0 1957
3newsfeed.neva.ru 1045 478 0 2 2 0 0 0 563
4ripco-out.feeder.erje.net 463 460 0 0 0 0 0 0 3
5feeder3.feed-ams.uzoreto.com 408 302 0 1 2 0 0 0 103
6news.lightlink.com 237 0 0 0 0 0 0 0 237
7newsfeed.fu-berlin.de 116 0 0 0 0 0 0 0 116
8news.cmpublishers.com 8 2 0 0 0 0 0 0 6
9news-in.rahul.net 2 0 0 0 0 0 0 0 2
TOTAL: 9 6658 3091 0 3 13 0 0 0 3551

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2252
alt.binaries.ftd 201
it.tlc.cellulari.android 79
fido7.su.pol.news 39
it.comp.os.win.windows10 32
alt.binaries.e-book 29
perl.cpan.uploads 28
alt.binaries.drwho 23
alt.binaries.nl 18
free.willey 17
free.it.scienza.fisica 15
mozilla.dev.platform 14
alt.astrology.pro 14
free.ucp 12
alt.binaries.pictures.erotica.vintage 12
alt.binaries.pictures.scenic 10
mi.jobs 10
gmane.linux.alsa.devel 8
nl.comp.os.linux.techniek 8
alt.binaries.test.yenc 8
TOTAL: 149 3091

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

GroupsCount
fr.comp.lang.php 8
fr.comp.securite 3
alt.penthouse.sex.masterbation 1
rec.travel.resorts.all-inclusive 1
TOTAL: 4 13

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5110
Too many newsgroups 1032
EMP (phl) 202
Binary in non-binary group 164
EMP (fsl) 78
Scoring filter (8) 56
Attached HTML file 42
Scoring filter (16) 40
Scoring filter (9) 14
Scoring filter (18) 8
HTML post 8
Scoring filter (10) 2
U2 violation - invalid distribution 2
Poison newsgroup 2
TOTAL: 14 6760

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
ripco-out.feed.uzoreto.com 4
feeder3.feed-ams.uzoreto.com 1
TOTAL: 2 5
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
TOTAL: 1 18
Huge articles
newsfeed.fu-berlin.de 2
TOTAL: 1 2
Including strange strings
newsfeed.fu-berlin.de 100
newsfeed.neva.ru 54
ripco-out.feed.uzoreto.com 8
feeder3.feed-ams.uzoreto.com 3
TOTAL: 4 165
TOTAL: 4 190

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9522 2422 4770 30 0 8 25%47:40:04
2rahul.net 23240 796 12780 26 0 20 3%47:40:04
3news.snarked.org 40486 60 23218 18 0 250 0%47:53:08
4news.cmpublishers.com 43208 48 31902 870 0 24 0%47:40:04
5news.uzoreto.com 17520 34 16650 80 0 30 0%47:43:10
6feeder.erje.net 32822 22 31402 14 0 0 0%47:45:12
7fu-berlin.de 30362 22 30340 0 0 0 0%47:40:04
8newsfeed.neva.ru 27548 10 26784 40 0 0 0%47:52:54
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:04
TOTAL: 9 224708 3414 177846 1078 0 338 1%429:34:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com7.1 MB192.8 KB7.3 MB0.0 KB/s3.0 KB47:40:04
2rahul.net2.9 MB54.7 KB2.9 MB0.0 KB/s3.6 KB47:40:04
3news.snarked.org223.0 KB33.3 KB256.3 KB0.0 KB/s3.3 KB47:53:08
4news.cmpublishers.com139.5 KB2.2 MB2.4 MB0.0 KB/s2.7 KB47:40:04
5feeder.erje.net128.0 KB37.2 KB165.1 KB0.0 KB/s4.6 KB47:45:12
6fu-berlin.de120.7 KB0.0 KB120.7 KB0.0 KB/s5.5 KB47:40:04
7news.uzoreto.com88.4 KB319.0 KB407.4 KB0.0 KB/s3.6 KB47:43:10
8newsfeed.neva.ru83.3 KB90.6 KB173.9 KB0.0 KB/s3.5 KB47:52:54
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:04
TOTAL: 910.7 MB3.0 MB13.7 MB0.0 KB/s3.1 KB429:34:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10302.8 MB 446 4 000:06:57
2shell3 12 244696.7 KB 24 0 001:35:16
375-151-74-61-independence.hfc.comcastbusiness.net 8 45.1 KB 4 0 000:13:41
TOTAL: 3 306 12783.5 MB 474 4 0104:03:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10302.8 MB 446 4 000:06:57
2? 12 244696.7 KB 24 0 001:35:16
3*.hfc.comcastbusiness.net 8 45.1 KB 4 0 000:13:41
4*.cinci.res.rr.com 32 00.0 KB 0 0 000:03:03
5*.7-3.cable.virginm.net 32 00.0 KB 0 0 045:46:06
6unresolved 12 00.0 KB 0 0 056:18:35
TOTAL: 6 382 12783.5 MB 474 4 0104:03:42

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.11.163.217 0.432 0.160 0.00056:00:18
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 15.250 20.482 0.00045:46:06
shell3 9.004 3.434 0.00001:35:16
102.253.51.116 0.692 0.292 0.00000:18:01
75-151-74-61-independence.hfc.comcastbusiness.net 1.542 1.310 0.00000:13:41
ftupet.com 46.776 7.358 0.00000:06:57
cpe-74-140-148-218.cinci.res.rr.com 3.242 0.762 0.00000:03:03
93.190.142.43 0.556 0.298 0.00000:00:15
TOTAL: 8 77.494 34.096 0.000104:03:42

Curious NNRP server explorers [Top 20]:

SystemConn
cpe-74-140-148-218.cinci.res.rr.com 32
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 32
102.253.51.116 6
66.11.163.217 4
93.190.142.43 2
TOTAL: 5 76

NNRP unrecognized commands (by host):

SystemConn
shell3 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 30 20
66.11.163.217 4 0
shell3 2 0
TOTAL: 3 36 20

Newsgroup request counts (by category):

CategoryCountPct
1rec 1170 91.5%
2comp 38 3.0%
3sci 20 1.6%
4chi 16 1.3%
5ba 12 0.9%
6news 8 0.6%
7alt 6 0.5%
8misc 6 0.5%
9uk 2 0.2%
TOTAL: 9 1278100.0%

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

NewsgroupCount
1rec.arts.tv 750
2rec.food.cooking 328
3rec.bicycles.tech 84
4comp.sys.mac.system 32
5sci.electronics.repair 20
6chi.weather 10
7ba.food 10
8news.admin.net-abuse.email 6
9comp.protocols.dns.bind 6
10chi.general 6
11misc.consumers.frugal-living 6
12rec.radio.broadcasting 4
13rec.radio.swap 4
14alt.autos.nissan.maxima 2
15news.software.readers 2
16uk.rec.cycling 2
17ba.general 2
18alt.tasteless 2
19alt.free.newsservers 2
TOTAL: 19 1278