Daily Usenet report for news.ripco.com

Oct 29 00:01:03 -- Oct 29 23:57:54

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Oct 29 02:09:22 remote5bge0 overchan[4785]: [ID 702911 news.error] input line too long, skipping
Oct 29 02:09:22 remote5bge0 overchan[4785]: [ID 702911 news.error] input line too long, skipping
Oct 29 02:09:22 remote5bge0 overchan[4785]: [ID 702911 news.error] input line too long, skipping
Oct 29 06:22:10 remote5bge0 overchan[4785]: [ID 702911 news.error] input line too long, skipping
Oct 29 21:32:06 remote5bge0 overchan[4785]: [ID 702911 news.error] input line too long, skipping
Oct 29 21:32:15 remote5bge0 overchan[4785]: [ID 702911 news.error] input line too long, skipping
Oct 29 22:08:37 remote5bge0 overchan[4785]: [ID 702911 news.error] input line too long, skipping
Oct 29 22:08:37 remote5bge0 overchan[4785]: [ID 702911 news.error] input line too long, skipping
Oct 29 22:08:37 remote5bge0 overchan[4785]: [ID 702911 news.error] input line too long, skipping
Oct 29 22:18:35 remote5bge0 overchan[4785]: [ID 702911 news.error] input line too long, skipping
Oct 29 22:18:35 remote5bge0 overchan[4785]: [ID 702911 news.error] input line too long, skipping
Oct 29 22:18:35 remote5bge0 overchan[4785]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 33648 40.2%4.1 MB 33.2%
inn 24253 29.0%4.2 MB 33.6%
innd 22237 26.6%3.4 MB 27.3%
innfeed 3600 4.3%765.4 KB 6.0%
overchan 12 0.0%1.4 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 83752 100.0%12.5 MB100.0%

History cache:

ReasonCount%Count
Cache misses 222208 54.5%
Do not exist 185842 45.5%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 408050 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%130 0.000 0.000 0.000
article cleanup00:00:00.466 0.0%48026 0.000 0.010 0.040
article logging00:00:00.814 0.0%48480 0.000 0.017 0.330
article parse00:00:01.806 0.0%110834 0.000 0.016 0.035
article write00:00:41.944 0.0%35324 0.457 1.187 15.289
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.284 0.0%417852 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:04.008 0.0%409370 0.001 0.010 0.537
history sync00:00:00.424 0.0%770 0.000 0.551 4.000
history write00:00:06.018 0.0%48006 0.034 0.125 5.118
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:39:27.370 99.9%455872 175.076 376.350 1036.791
nntp read00:00:02.346 0.0%453344 0.001 0.005 0.014
overview write00:00:00.224 0.0%35324 0.000 0.006 0.035
perl filter00:01:00.196 0.0%48006 1.008 1.254 2.435
python filter00:00:01.324 0.0%48020 0.000 0.028 0.075
site send00:00:02.100 0.0%105896 0.000 0.020 0.047
TOTAL: 47:42:07.70047:41:29.324100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.152 0.0%35492 0.000 0.004 0.027
article prepare00:00:00.008 0.0%28928 0.000 0.000 0.012
article read00:00:00.612 0.0%5990 0.000 0.102 3.429
backlog stats00:00:00.204 0.0%426522 0.000 0.000 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.376 0.0%284824 0.000 0.008 0.016
data write00:00:03.688 0.0%249836 0.003 0.015 0.031
idle47:50:47.870100.0%426522 245.594 403.843 1038.647
status file00:00:05.904 0.0%332 0.000 17.783 204.000
TOTAL: 47:51:13.12847:51:00.814100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:02.214 0.0%114858 0.000 0.019 0.071
idle56:05:36.094 99.9%150118 17.525 1345.182300444.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:43.048 0.0%1837762 0.000 0.023 7.000
readart00:00:18.934 0.0%2114 0.000 8.956 75.000
TOTAL: 56:08:39.82656:06:40.290 99.9%----

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 1164 41184 12404 24246 4534 30%101:04:02
2news.snarked.org 50 44600 11520 29100 3980 25%61:17:22
3newsfeed.neva.ru 578 66996 6736 58150 2110 10%279:51:54
4feeder3.feed-ams.uzoreto.com 582 19210 3390 14960 860 17%48:55:38
5newsfeed.fu-berlin.de 4 18788 684 18076 28 3%51:00:40
6news.lightlink.com 2 15166 364 14524 278 2%69:50:20
7news-in.rahul.net 574 21086 180 20904 2 0%47:29:18
8ripco-out.feeder.erje.net 574 39012 94 37962 956 0%47:17:00
9news.cmpublishers.com 52 10122 34 10078 10 0%48:00:04
10localhost 158 14 14 0 0 100%00:00:00
TOTAL: 10 3738 276178 35420 228000 12758 12%754:46:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org32.0 MB0.0 KB14.0 MB46.1 MB 69%3.0 KB
2ripco-out.feed.uzoreto.com29.8 MB0.0 KB9.5 MB39.2 MB 75%2.4 KB
3newsfeed.neva.ru19.4 MB42.7 KB10.0 MB29.4 MB 65%3.4 KB
4feeder3.feed-ams.uzoreto.com9.4 MB0.0 KB2.0 MB11.4 MB 82%2.7 KB
5news-in.rahul.net8.4 MB0.0 KB2.3 KB8.4 MB 99%47.1 KB
6news.lightlink.com4.4 MB5.4 KB14.8 MB19.2 MB 22%30.6 KB
7newsfeed.fu-berlin.de2.9 MB0.0 KB60.4 KB2.9 MB 97%4.2 KB
8ripco-out.feeder.erje.net169.2 KB0.0 KB9.2 MB9.4 MB 1%9.2 KB
9news.cmpublishers.com85.3 KB10.8 KB18.0 KB114.0 KB 74%2.6 KB
10localhost32.3 KB0.0 KB0.0 KB32.3 KB100%2.3 KB
TOTAL: 10106.5 MB58.9 KB59.6 MB166.2 MB 64%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 29 00:01:03 - 00:59:59 337 1.9% 0.101.3 MB 2.5% 0.38
Oct 29 01:00:00 - 01:59:59 387 2.2% 0.111.0 MB 1.9% 0.29
Oct 29 02:00:00 - 02:59:59 519 2.9% 0.141.4 MB 2.6% 0.40
Oct 29 03:00:00 - 03:59:59 696 3.9% 0.191.6 MB 2.9% 0.44
Oct 29 04:00:00 - 04:59:59 774 4.4% 0.212.1 MB 4.0% 0.60
Oct 29 05:00:00 - 05:59:59 918 5.2% 0.262.5 MB 4.8% 0.72
Oct 29 06:00:00 - 06:59:59 769 4.4% 0.212.1 MB 4.0% 0.61
Oct 29 07:00:00 - 07:59:59 838 4.7% 0.232.3 MB 4.3% 0.65
Oct 29 08:00:00 - 08:59:59 870 4.9% 0.242.4 MB 4.5% 0.68
Oct 29 09:00:00 - 09:59:59 998 5.6% 0.283.0 MB 5.6% 0.85
Oct 29 10:00:00 - 10:59:59 1000 5.7% 0.282.8 MB 5.2% 0.79
Oct 29 11:00:00 - 11:59:59 1012 5.7% 0.283.1 MB 5.9% 0.89
Oct 29 12:00:00 - 12:59:59 1004 5.7% 0.283.1 MB 5.7% 0.87
Oct 29 13:00:00 - 13:59:59 1009 5.7% 0.282.7 MB 5.1% 0.77
Oct 29 14:00:00 - 14:59:59 943 5.3% 0.262.6 MB 4.9% 0.74
Oct 29 15:00:00 - 15:59:59 998 5.6% 0.283.1 MB 5.8% 0.87
Oct 29 16:00:00 - 16:59:59 957 5.4% 0.273.2 MB 6.0% 0.91
Oct 29 17:00:00 - 17:59:59 824 4.7% 0.232.7 MB 5.1% 0.77
Oct 29 18:00:00 - 18:59:59 681 3.9% 0.192.3 MB 4.3% 0.65
Oct 29 19:00:00 - 19:59:59 570 3.2% 0.162.2 MB 4.1% 0.62
Oct 29 20:00:00 - 20:59:59 466 2.6% 0.131.7 MB 3.1% 0.47
Oct 29 21:00:00 - 21:59:59 382 2.2% 0.111.2 MB 2.2% 0.33
Oct 29 22:00:00 - 22:59:59 406 2.3% 0.111.4 MB 2.6% 0.39
Oct 29 23:00:00 - 23:57:54 315 1.8% 0.091.5 MB 2.9% 0.45
TOTAL: 23:56:51 17673 100.0% 0.2053.1 MB 100.0% 0.63
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2277 1618 0 0 4 0 0 0 655
2news.snarked.org 1994 84 0 0 6 0 0 0 1904
3newsfeed.neva.ru 1113 595 0 7 0 0 0 0 511
4ripco-out.feeder.erje.net 479 473 0 0 0 0 0 0 6
5feeder3.feed-ams.uzoreto.com 435 255 0 0 1 0 0 0 179
6newsfeed.fu-berlin.de 165 0 0 0 0 0 0 0 165
7news.lightlink.com 111 1 0 1 0 0 0 0 109
8news.cmpublishers.com 5 0 0 2 0 0 0 0 3
9news-in.rahul.net 1 0 0 0 0 0 0 0 1
TOTAL: 9 6580 3026 0 10 11 0 0 0 3533

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1956
alt.binaries.ftd 240
it.tlc.cellulari.android 78
alt.astrology.pro 66
fido7.su.pol.news 50
perl.cpan.uploads 44
free.it.scienza.fisica 37
it.comp.os.win.windows10 29
alt.binaries.e-book 25
free.uk.astrology 24
free.willey 23
abg.english 21
alt.binaries.pictures.rail 20
alt.binaries.nl 18
alt.bestjobsusa.computer.jobs 13
alt.binaries.drwho 12
free.ucp 12
alt.music.pink-floyd.publius 12
alt.binaries.pictures.scenic 10
alt.jobs.jobsearch 10
TOTAL: 162 3026

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

GroupsCount
christnet.bible 3
alt.penthouse.sex.sissy.slut 2
alt.penthouse.sex.voyeurism 1
alt.christnet.religion 1
pl.praca.oferowana 1
alt.penthouse.sex.wanted.escorts.ads 1
bit.listserv.catholic 1
alt.penthouse.sex.masterbation 1
TOTAL: 8 11

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4168
Too many newsgroups 1574
Binary in non-binary group 392
EMP (phl) 240
Attached HTML file 66
Scoring filter (8) 52
Scoring filter (16) 50
Scoring filter (9) 50
Scoring filter (10) 14
Scoring filter (14) 4
Scoring filter (18) 2
Scoring filter (11) 2
Scoring filter (17) 2
TOTAL: 13 6616

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 14
TOTAL: 1 14
Including strange strings
newsfeed.fu-berlin.de 150
newsfeed.neva.ru 55
ripco-out.feed.uzoreto.com 12
feeder3.feed-ams.uzoreto.com 5
news.snarked.org 4
ripco-out.feeder.erje.net 1
TOTAL: 6 227
TOTAL: 2 241

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 12712 3588 5884 14 0 0 28%47:45:42
2rahul.net 29692 1346 15492 64 0 0 4%47:40:10
3feeder.erje.net 34374 104 32502 228 0 0 0%47:40:10
4news.snarked.org 40182 94 23478 6 0 96 0%47:40:10
5news.uzoreto.com 20304 88 18802 198 0 0 0%47:40:06
6news.cmpublishers.com 44710 66 33710 1154 0 56 0%47:33:38
7fu-berlin.de 32030 66 31960 0 0 0 0%47:38:56
8newsfeed.neva.ru 29586 36 28246 176 0 56 0%47:40:10
9remote6hme0.ripco.com 0 0 0 0 0 14 0%47:40:00
TOTAL: 9 243590 5388 190074 1840 0 222 2%428:59:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com9.5 MB34.8 KB9.5 MB0.1 KB/s2.7 KB47:45:42
2rahul.net4.7 MB145.9 KB4.9 MB0.0 KB/s3.5 KB47:40:10
3feeder.erje.net519.2 KB708.9 KB1.2 MB0.0 KB/s3.7 KB47:40:10
4news.snarked.org495.6 KB10.1 KB505.6 KB0.0 KB/s5.1 KB47:40:10
5fu-berlin.de308.9 KB0.0 KB308.9 KB0.0 KB/s4.7 KB47:38:56
6newsfeed.neva.ru249.4 KB460.8 KB710.1 KB0.0 KB/s3.3 KB47:40:10
7news.uzoreto.com246.6 KB817.1 KB1.0 MB0.0 KB/s3.7 KB47:40:06
8news.cmpublishers.com193.9 KB2.9 MB3.1 MB0.0 KB/s2.6 KB47:33:38
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 916.1 MB5.0 MB21.2 MB0.0 KB/s3.0 KB428:59:02
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 8402.2 MB 380 12 000:07:05
2shell3 14 340783.3 KB 28 2 002:01:25
3a85-139-63-33.cpe.netcabo.pt 10 26212.7 KB 18 0 004:06:30
475-151-74-61-independence.hfc.comcastbusiness.net 8 42.9 KB 4 0 000:13:13
TOTAL: 4 318 12103.2 MB 430 14 056:08:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 8402.2 MB 380 12 000:07:05
2? 14 340783.3 KB 28 2 002:01:25
3*.cpe.netcabo.pt 10 26212.7 KB 18 0 004:06:30
4*.hfc.comcastbusiness.net 8 42.9 KB 4 0 000:13:13
5*.dsl.bell.ca 20 00.0 KB 0 0 001:12:48
6*.7-3.cable.virginm.net 2 00.0 KB 0 0 000:20:31
7unresolved 150 00.0 KB 0 0 048:06:56
TOTAL: 7 490 12103.2 MB 430 14 056:08:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.117.188.98 5.260 4.216 0.00022:35:32
209.58.184.105 6.780 1.904 0.00014:37:57
185.244.215.90 4.126 1.030 0.00008:11:11
a85-139-63-33.cpe.netcabo.pt 1.740 0.728 0.00004:06:30
212.117.188.73 1.226 0.316 0.00002:41:54
shell3 11.880 3.988 0.00002:01:25
nrbaon0431w-lp130-01-174-95-37-204.dsl.bell.ca 2.274 0.896 0.00001:12:48
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 0.296 0.214 0.00000:20:31
75-151-74-61-independence.hfc.comcastbusiness.net 1.484 1.270 0.00000:13:13
ftupet.com 45.858 7.422 0.00000:07:05
107.170.222.250 0.198 0.040 0.00000:00:19
? 0.234 0.058 0.00000:00:00
TOTAL: 12 81.356 22.082 0.00056:08:30

Curious NNRP server explorers [Top 20]:

SystemConn
209.58.184.105 64
185.244.215.90 40
212.117.188.98 32
nrbaon0431w-lp130-01-174-95-37-204.dsl.bell.ca 20
212.117.188.73 12
107.170.222.250 2
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 2
TOTAL: 7 172

NNRP unrecognized commands (by host):

SystemConn
shell3 6
TOTAL: 1 6

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 6
TOTAL: 1 6

NNRP client timeouts [Top 20]:

SystemConnPeer
209.58.184.105 64 0
185.244.215.90 40 0
212.117.188.98 20 16
212.117.188.73 12 0
shell3 4 0
TOTAL: 5 140 16

Newsgroup request counts (by category):

CategoryCountPct
1rec 1038 85.8%
2comp 66 5.5%
3alt 44 3.6%
4chi 38 3.1%
5ba 8 0.7%
6news 6 0.5%
7misc 4 0.3%
8it 2 0.2%
9houston 2 0.2%
10tor 2 0.2%
TOTAL: 10 1210100.0%

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

NewsgroupCount
1rec.arts.tv 780
2rec.food.cooking 192
3rec.bicycles.tech 50
4comp.sys.mac.system 42
5chi.general 34
6alt.stupidity 26
7comp.sys.mac.apps 8
8rec.radio.swap 8
9ba.food 8
10comp.os.minix 8
11news.software.nntp 6
12rec.radio.broadcasting 4
13alt.comp.freeware 4
14chi.weather 4
15misc.consumers.frugal-living 4
16comp.lang.c 2
17houston.general 2
18alt.anonymous.email 2
19alt.hack.nl 2
20rec.collecting.coins 2
21it.sociale.adozione 2
22rec.bicycles.misc 2
23alt.2600 2
24alt.dbs.echostar 2
25tor.general 2
26alt.video.dvd 2
27alt.linux 2
28comp.lang.lisp 2
29comp.protocols.dns.bind 2
30comp.sys.ibm.pc.games.rpg 2
31alt.free.newsservers 2
TOTAL: 31 1210