Daily Usenet report for news.ripco.com

Nov 11 00:01:03 -- Nov 11 23:57:57

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Nov 11 10:53:13 remote5bge0 overchan[17253]: [ID 702911 news.error] input line too long, skipping
Nov 11 14:14:32 remote5bge0 overchan[17253]: [ID 702911 news.error] input line too long, skipping
Nov 11 14:22:43 remote5bge0 overchan[17253]: [ID 702911 news.error] input line too long, skipping
Nov 11 15:23:25 remote5bge0 overchan[17253]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 34937 43.3%4.4 MB 36.3%
innd 21490 26.6%3.3 MB 27.8%
inn 20718 25.7%3.6 MB 29.7%
innfeed 3598 4.5%764.2 KB 6.2%
overchan 4 0.0%0.6 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 80749 100.0%12.0 MB100.0%

History cache:

ReasonCount%Count
Cache misses 177056 50.7%
Do not exist 172184 49.3%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 349240 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.002 0.0%220 0.000 0.009 0.056
article cleanup00:00:00.434 0.0%41216 0.000 0.011 0.062
article logging00:00:00.672 0.0%41578 0.000 0.016 0.197
article parse00:00:01.678 0.0%104340 0.000 0.016 0.049
article write00:00:40.948 0.0%28634 0.411 1.430 25.433
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.264 0.0%368958 0.000 0.001 0.003
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.352 0.0%350892 0.000 0.015 0.779
history sync00:00:00.286 0.0%798 0.000 0.358 3.000
history write00:00:08.320 0.0%41216 0.017 0.202 9.659
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:59:43.106 99.9%401440 225.921 430.408 1582.195
nntp read00:00:02.082 0.0%397350 0.000 0.005 0.013
overview write00:00:00.184 0.0%28634 0.000 0.006 0.034
perl filter00:00:52.764 0.0%41208 0.983 1.280 3.765
python filter00:00:01.008 0.0%41222 0.000 0.024 0.065
site send00:00:01.606 0.0%85836 0.000 0.019 0.049
TOTAL: 48:02:14.62048:01:38.706100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.102 0.0%28688 0.000 0.004 0.042
article prepare00:00:00.004 0.0%16880 0.000 0.000 0.050
article read00:00:00.386 0.0%3380 0.000 0.114 14.200
backlog stats00:00:00.178 0.0%347554 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.792 0.0%228740 0.000 0.008 0.017
data write00:00:03.088 0.0%200794 0.004 0.015 0.030
idle47:53:04.258100.0%347554 231.631 495.993 1633.530
status file00:00:04.066 0.0%338 0.000 12.030 32.000
TOTAL: 47:53:25.69247:53:13.874100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:07.644 0.0%500398 0.000 0.015 0.021
idle96:22:22.560 99.9%534892 0.000 648.622200112.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:35.174 0.0%2091126 0.000 0.017 0.500
readart00:00:19.642 0.0%2612 0.000 7.520 36.500
TOTAL: 96:26:16.76696:23:25.020100.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1150 39006 12918 21272 4816 33%94:38:32
2news.snarked.org 44 36460 7316 26894 2250 20%49:32:42
3newsfeed.neva.ru 560 45504 4648 38940 1916 10%281:51:12
4feeder3.feed-ams.uzoreto.com 574 12696 2290 9592 814 18%47:19:34
5newsfeed.fu-berlin.de 2 15082 902 14002 178 5%50:10:48
6news.lightlink.com 2 17940 442 16250 1248 2%77:23:48
7news-in.rahul.net 574 17164 148 17002 14 0%47:20:28
8ripco-out.feeder.erje.net 574 33088 68 31726 1294 0%47:17:06
9news.cmpublishers.com 50 9082 14 9066 2 0%48:00:00
10localhost 158 14 14 0 0 100%00:00:00
TOTAL: 10 3688 226036 28760 184744 12532 12%743:34:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com32.2 MB4.2 KB9.7 MB41.9 MB 76%2.4 KB
2news.snarked.org21.1 MB0.0 KB7.7 MB28.8 MB 73%3.1 KB
3newsfeed.neva.ru14.5 MB4.2 KB8.6 MB23.1 MB 62%3.6 KB
4news.lightlink.com6.7 MB0.0 KB41.3 MB47.9 MB 13%29.0 KB
5feeder3.feed-ams.uzoreto.com6.4 MB0.0 KB1.6 MB8.0 MB 80%2.6 KB
6news-in.rahul.net5.4 MB0.0 KB1.2 MB6.6 MB 81%41.8 KB
7newsfeed.fu-berlin.de4.1 MB0.0 KB659.2 KB4.8 MB 86%4.5 KB
8ripco-out.feeder.erje.net175.1 KB0.0 KB11.0 MB11.2 MB 1%8.4 KB
9news.cmpublishers.com29.5 KB0.0 KB8.9 KB38.4 KB 76%2.4 KB
10localhost27.8 KB0.0 KB0.0 KB27.8 KB100%2.0 KB
TOTAL: 1090.5 MB8.4 KB81.8 MB172.3 MB 52%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 11 00:01:03 - 00:59:59 269 1.9% 0.08882.4 KB 1.9% 0.25
Nov 11 01:00:00 - 01:59:59 358 2.5% 0.101.1 MB 2.6% 0.32
Nov 11 02:00:00 - 02:59:59 393 2.8% 0.111.0 MB 2.3% 0.29
Nov 11 03:00:00 - 03:59:59 484 3.4% 0.131.5 MB 3.4% 0.43
Nov 11 04:00:00 - 04:59:59 625 4.4% 0.172.0 MB 4.5% 0.57
Nov 11 05:00:00 - 05:59:59 590 4.1% 0.161.6 MB 3.7% 0.46
Nov 11 06:00:00 - 06:59:59 540 3.8% 0.151.4 MB 3.2% 0.41
Nov 11 07:00:00 - 07:59:59 688 4.8% 0.191.8 MB 4.0% 0.50
Nov 11 08:00:00 - 08:59:59 690 4.8% 0.192.1 MB 4.8% 0.60
Nov 11 09:00:00 - 09:59:59 725 5.1% 0.202.1 MB 4.8% 0.61
Nov 11 10:00:00 - 10:59:59 890 6.2% 0.252.8 MB 6.3% 0.79
Nov 11 11:00:00 - 11:59:59 935 6.5% 0.263.5 MB 7.9% 1.00
Nov 11 12:00:00 - 12:59:59 919 6.4% 0.262.3 MB 5.3% 0.67
Nov 11 13:00:00 - 13:59:59 924 6.5% 0.263.2 MB 7.2% 0.91
Nov 11 14:00:00 - 14:59:59 1036 7.3% 0.292.8 MB 6.4% 0.81
Nov 11 15:00:00 - 15:59:59 881 6.2% 0.242.8 MB 6.2% 0.78
Nov 11 16:00:00 - 16:59:59 603 4.2% 0.171.7 MB 3.9% 0.49
Nov 11 17:00:00 - 17:59:59 584 4.1% 0.162.0 MB 4.6% 0.58
Nov 11 18:00:00 - 18:59:59 456 3.2% 0.131.2 MB 2.8% 0.35
Nov 11 19:00:00 - 19:59:59 463 3.2% 0.131.8 MB 4.0% 0.51
Nov 11 20:00:00 - 20:59:59 323 2.3% 0.09928.7 KB 2.0% 0.26
Nov 11 21:00:00 - 21:59:59 286 2.0% 0.08884.4 KB 1.9% 0.25
Nov 11 22:00:00 - 22:59:59 316 2.2% 0.091.3 MB 2.9% 0.36
Nov 11 23:00:00 - 23:57:57 303 2.1% 0.091.5 MB 3.5% 0.45
TOTAL: 23:56:54 14281 100.0% 0.1744.4 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2422 1746 0 1 4 0 0 0 671
2news.snarked.org 1138 53 0 0 4 0 0 0 1081
3newsfeed.neva.ru 926 462 0 1 1 0 0 0 462
4news.lightlink.com 672 3 0 0 0 0 0 0 669
5ripco-out.feeder.erje.net 648 643 0 0 0 0 0 0 5
6feeder3.feed-ams.uzoreto.com 407 222 0 0 0 0 0 0 185
7newsfeed.fu-berlin.de 216 0 0 0 0 0 0 0 216
8news-in.rahul.net 7 0 0 0 0 0 0 0 7
9news.cmpublishers.com 1 1 0 0 0 0 0 0 0
TOTAL: 9 6437 3130 0 2 9 0 0 0 3296

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2105
alt.binaries.ftd 338
alt.astrology.pro 105
alt.binaries.pictures.wallpaper 47
perl.cpan.uploads 41
alt.binaries.e-book 27
free.uk.astrology 21
fido7.su.pol.news 21
alt.binaries.pictures.aviation 19
it.tlc.cellulari.android 18
alt.binaries.drwho 18
free.ucp 17
free.it.scienza.fisica 17
alt.binaries.e-books 15
free.willey 14
alt.binaries.nl 12
alt.clearing.o5 12
alt.binaries.movies.xvid 10
alt.binaries.pictures.scenic 10
alt.binaries.pictures.rail 10
TOTAL: 134 3130

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

GroupsCount
fr.comp.securite 3
christnet.christianlife 1
alt.penthouse.sex.fetish.tickling 1
christnet.theology 1
alt.christnet.religion 1
alt.penthouse.sex.services 1
bit.listserv.catholic 1
TOTAL: 7 9

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3076
Too many newsgroups 1430
Binary in non-binary group 1382
EMP (phl) 156
Scoring filter (16) 52
Attached HTML file 40
Scoring filter (8) 32
Scoring filter (11) 16
Scoring filter (9) 10
Scoring filter (12) 8
Scoring filter (10) 8
Scoring filter (17) 6
Scoring filter (13) 4
Scoring filter (18) 4
HTML post 2
Scoring filter (14) 2
TOTAL: 16 6228

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
feeder3.feed-ams.uzoreto.com 2
TOTAL: 1 2
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
ripco-out.feed.uzoreto.com 2
TOTAL: 2 20
Including strange strings
newsfeed.fu-berlin.de 128
newsfeed.neva.ru 37
ripco-out.feed.uzoreto.com 14
news.snarked.org 1
ripco-out.feeder.erje.net 1
TOTAL: 5 181
TOTAL: 3 203

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10336 1730 5536 10 0 0 16%47:36:42
2rahul.net 22594 760 13000 22 0 10 3%47:40:04
3news.uzoreto.com 13356 86 12314 528 0 0 0%47:40:02
4news.snarked.org 34904 70 20952 8 0 102 0%47:40:04
5news.cmpublishers.com 38284 58 27478 668 0 60 0%47:40:04
6feeder.erje.net 27406 48 26614 106 0 0 0%47:43:48
7fu-berlin.de 25506 32 25474 0 0 0 0%47:40:04
8newsfeed.neva.ru 24652 18 23726 72 0 0 0%47:47:40
9remote6hme0.ripco.com 0 0 0 0 0 8 0%47:40:02
TOTAL: 9 197038 2802 155094 1414 0 180 1%429:08:30
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com4.9 MB21.5 KB4.9 MB0.0 KB/s2.9 KB47:36:42
2rahul.net3.2 MB42.5 KB3.3 MB0.0 KB/s4.3 KB47:40:04
3news.uzoreto.com321.8 KB1.4 MB1.7 MB0.0 KB/s2.8 KB47:40:02
4news.cmpublishers.com239.6 KB2.0 MB2.2 MB0.0 KB/s3.1 KB47:40:04
5news.snarked.org139.0 KB16.8 KB155.8 KB0.0 KB/s2.0 KB47:40:04
6feeder.erje.net138.2 KB380.9 KB519.1 KB0.0 KB/s3.4 KB47:43:48
7fu-berlin.de79.8 KB0.0 KB79.8 KB0.0 KB/s2.5 KB47:40:04
8newsfeed.neva.ru35.0 KB157.9 KB192.9 KB0.0 KB/s2.1 KB47:47:40
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
TOTAL: 99.0 MB4.0 MB13.0 MB0.0 KB/s3.2 KB429:08:30
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 11963.0 MB 470 12 000:06:46
2shell3 14 204533.1 KB 54 2 001:29:59
375-151-74-61-independence.hfc.comcastbusiness.net 8 43.8 KB 4 0 000:12:30
TOTAL: 3 308 14043.6 MB 528 14 096:26:01

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 11963.0 MB 470 12 000:06:46
2? 14 204533.1 KB 54 2 001:29:59
3*.hfc.comcastbusiness.net 8 43.8 KB 4 0 000:12:30
4*.7-3.cable.virginm.net 10 00.0 KB 0 0 000:55:08
5unresolved 430 00.0 KB 0 0 019:53:15
6*.cpe.metrocast.net 8 00.0 KB 0 0 002:05:23
7*.dip0.t-ipconnect.de 2 00.0 KB 0 0 000:20:04
8*.cm-12-2c.dynamic.ziggo.nl 64 00.0 KB 0 0 019:17:53
9*.brbnca.spcsdns.net 4 00.0 KB 0 0 000:00:03
10*.rev.poneytelecom.eu 32 00.0 KB 0 0 052:04:56
TOTAL: 10 858 14043.6 MB 528 14 096:26:01

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
62-210-97-14.rev.poneytelecom.eu 7.576 7.178 0.00052:04:56
5469a4b0.cm-12-2c.dynamic.ziggo.nl 8.036 3.838 0.00019:17:53
185.210.217.243 5.038 7.734 0.00019:11:04
d-72-9-26-236.cpe.metrocast.net 1.312 1.020 0.00002:05:23
shell3 4.584 2.052 0.00001:29:59
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 1.186 0.568 0.00000:55:08
206.255.52.41 2.854 0.694 0.00000:40:14
p5492d5bb.dip0.t-ipconnect.de 0.304 0.144 0.00000:20:04
75-151-74-61-independence.hfc.comcastbusiness.net 1.676 1.272 0.00000:12:30
ftupet.com 47.108 7.492 0.00000:06:46
92.116.2.162 38.796 7.910 0.00000:01:40
74.82.244.103 0.806 0.168 0.00000:00:06
89.238.185.238 0.792 0.166 0.00000:00:06
ip-24-221-51-29.brbnca.spcsdns.net 0.402 0.084 0.00000:00:03
109.202.102.84 0.338 0.044 0.00000:00:02
TOTAL: 15 120.808 40.364 0.00096:26:01

Curious NNRP server explorers [Top 20]:

SystemConn
92.116.2.162 384
5469a4b0.cm-12-2c.dynamic.ziggo.nl 64
62-210-97-14.rev.poneytelecom.eu 32
206.255.52.41 24
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 10
74.82.244.103 8
d-72-9-26-236.cpe.metrocast.net 8
89.238.185.238 8
185.210.217.243 4
ip-24-221-51-29.brbnca.spcsdns.net 4
p5492d5bb.dip0.t-ipconnect.de 2
109.202.102.84 2
TOTAL: 12 550

NNRP unrecognized commands (by host):

SystemConn
shell3 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 4
TOTAL: 1 4

NNRP client timeouts [Top 20]:

SystemConnPeer
62-210-97-14.rev.poneytelecom.eu 32 0
5469a4b0.cm-12-2c.dynamic.ziggo.nl 32 0
206.255.52.41 4 0
shell3 4 0
185.210.217.243 4 0
p5492d5bb.dip0.t-ipconnect.de 2 0
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 2 2
TOTAL: 7 80 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 1262 89.9%
2alt 44 3.1%
3comp 42 3.0%
4news 18 1.3%
5sci 10 0.7%
6chi 8 0.6%
7ba 6 0.4%
8misc 6 0.4%
9gnu 4 0.3%
10de 2 0.1%
11nz 2 0.1%
TOTAL: 11 1404100.0%

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

NewsgroupCount
1rec.food.cooking 656
2rec.arts.tv 546
3rec.bicycles.tech 50
4alt.stupidity 16
5alt.games.warcraft 12
6comp.sys.mac.system 12
7sci.electronics.repair 10
8alt.tasteless 8
9comp.mobile.ipad 8
10comp.mail.sendmail 6
11news.software.nntp 6
12comp.unix.solaris 6
13news.software.readers 6
14ba.food 6
15comp.sys.mac.apps 4
16rec.radio.broadcasting 4
17rec.radio.swap 4
18gnu.utils.bug 4
19misc.phone.mobile.iphone 4
20chi.weather 4
21chi.eats 4
22news.admin.net-abuse.misc 2
23alt.hvac 2
24comp.mail.misc 2
25news.admin.net-abuse.usenet 2
26alt.comp.google 2
27comp.protocols.dns.bind 2
28alt.tv.the-shield 2
29nz.soc.queer 2
30rec.bicycles.misc 2
31de.comp.os.unix.x11 2
32alt.vacation.las-vegas 2
33comp.mobile.android 2
34misc.consumers.frugal-living 2
35news.groups.questions 2
TOTAL: 35 1404