Daily Usenet report for news.ripco.com

Oct 5 00:01:04 -- Oct 5 23:57:52

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Oct 5 10:56:38 remote5bge0 overchan[1799]: [ID 702911 news.error] input line too long, skipping
Oct 5 11:03:36 remote5bge0 overchan[1799]: [ID 702911 news.error] input line too long, skipping
Oct 5 13:04:47 remote5bge0 overchan[1799]: [ID 702911 news.error] input line too long, skipping
Oct 5 13:26:24 remote5bge0 overchan[1799]: [ID 702911 news.error] input line too long, skipping
Oct 5 14:27:11 remote5bge0 overchan[1799]: [ID 702911 news.error] input line too long, skipping
Oct 5 16:47:06 remote5bge0 overchan[1799]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 33642 42.7%4.1 MB 35.5%
inn 22561 28.7%3.9 MB 33.3%
innd 18867 24.0%2.9 MB 24.9%
innfeed 3622 4.6%753.9 KB 6.3%
controlchan 8 0.0%1.4 KB 0.0%
overchan 6 0.0%1.1 KB 0.0%
TOTAL: 6 78706 100.0%11.7 MB100.0%

History cache:

ReasonCount%Count
Cache misses 196206 51.2%
Do not exist 187008 48.8%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 383214 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%104 0.000 0.000 0.000
article cleanup00:00:00.490 0.0%44686 0.000 0.011 0.040
article logging00:00:00.800 0.0%45236 0.000 0.018 0.225
article parse00:00:01.834 0.0%107958 0.000 0.017 0.044
article write00:00:41.614 0.0%32626 0.438 1.275 19.327
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.260 0.0%389628 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.990 0.0%384792 0.001 0.008 0.018
history sync00:00:00.356 0.0%800 0.000 0.445 13.000
history write00:00:03.926 0.0%44678 0.016 0.088 2.164
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:59:34.538 99.9%426456 221.525 405.140 1318.503
nntp read00:00:02.304 0.0%424122 0.000 0.005 0.012
overview write00:00:00.216 0.0%32626 0.000 0.007 0.048
perl filter00:00:58.592 0.0%44670 1.042 1.312 3.216
python filter00:00:01.154 0.0%44674 0.000 0.026 0.098
site send00:00:02.452 0.0%97818 0.005 0.025 0.050
TOTAL: 48:02:10.69448:01:31.526100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.154 0.0%32864 0.000 0.005 0.029
article prepare00:00:00.004 0.0%8856 0.000 0.000 0.028
article read00:00:00.330 0.0%1892 0.000 0.174 37.000
backlog stats00:00:00.256 0.0%379772 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.130 0.0%254434 0.000 0.008 0.022
data write00:00:04.044 0.0%222286 0.002 0.018 0.034
idle47:51:38.442100.0%379772 275.184 453.689 1841.172
status file00:00:04.738 0.0%344 0.000 13.773 47.000
TOTAL: 47:52:02.96047:51:50.098100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.762 0.0%46324 0.000 0.016 0.111
idle29:57:38.162 99.9%80158 0.333 1345.570300294.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:22.158 0.0%788512 0.000 0.028 0.250
readart00:00:20.612 0.0%2454 0.000 8.399 39.500
TOTAL: 30:00:14.51029:58:21.694 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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de002002
TOTAL002002

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1154 54062 14568 34430 5064 26%94:52:52
2news.snarked.org 54 40738 8986 28488 3264 22%59:06:02
3newsfeed.neva.ru 572 54214 7152 44786 2276 13%280:32:56
4newsfeed.fu-berlin.de 2 16492 904 15532 56 5%51:30:02
5news.lightlink.com 2 9818 418 9232 168 4%44:22:30
6news-in.rahul.net 574 19848 254 19442 152 1%47:21:42
7ripco-out.feeder.erje.net 574 35652 74 34582 996 0%47:17:36
8news.cmpublishers.com 52 9720 74 9640 6 0%47:59:10
9localhost 148 4 4 0 0 100%00:00:00
TOTAL: 9 3132 240548 32434 196132 11982 13%673:02:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com37.1 MB1.7 KB9.7 MB46.8 MB 79%2.4 KB
2news.snarked.org25.6 MB0.0 KB11.0 MB36.6 MB 69%3.1 KB
3newsfeed.neva.ru21.4 MB8.2 KB9.7 MB31.1 MB 68%3.4 KB
4news.lightlink.com14.3 MB0.0 KB6.7 MB21.0 MB 68%36.8 KB
5news-in.rahul.net7.2 MB0.0 KB7.8 MB15.0 MB 47%37.8 KB
6newsfeed.fu-berlin.de4.1 MB0.0 KB337.9 KB4.5 MB 92%4.8 KB
7ripco-out.feeder.erje.net341.4 KB0.0 KB8.9 MB9.2 MB 3%8.8 KB
8news.cmpublishers.com240.9 KB9.3 KB16.7 KB267.0 KB 90%3.3 KB
9localhost15.9 KB0.0 KB0.0 KB15.9 KB100%4.0 KB
TOTAL: 9110.3 MB19.2 KB54.2 MB164.5 MB 67%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 5 00:01:04 - 00:59:59 398 2.4% 0.111.2 MB 2.2% 0.34
Oct 5 01:00:00 - 01:59:59 507 3.1% 0.141.6 MB 2.9% 0.45
Oct 5 02:00:00 - 02:59:59 650 4.0% 0.182.0 MB 3.5% 0.56
Oct 5 03:00:00 - 03:59:59 834 5.1% 0.232.9 MB 5.2% 0.81
Oct 5 04:00:00 - 04:59:59 795 4.9% 0.222.6 MB 4.7% 0.74
Oct 5 05:00:00 - 05:59:59 834 5.1% 0.232.3 MB 4.2% 0.66
Oct 5 06:00:00 - 06:59:59 840 5.2% 0.233.5 MB 6.3% 0.98
Oct 5 07:00:00 - 07:59:59 766 4.7% 0.211.9 MB 3.4% 0.53
Oct 5 08:00:00 - 08:59:59 776 4.8% 0.222.8 MB 5.1% 0.80
Oct 5 09:00:00 - 09:59:59 948 5.8% 0.263.3 MB 5.9% 0.93
Oct 5 10:00:00 - 10:59:59 961 5.9% 0.274.1 MB 7.4% 1.16
Oct 5 11:00:00 - 11:59:59 816 5.0% 0.232.8 MB 5.1% 0.80
Oct 5 12:00:00 - 12:59:59 966 5.9% 0.272.8 MB 5.0% 0.79
Oct 5 13:00:00 - 13:59:59 952 5.9% 0.263.6 MB 6.6% 1.03
Oct 5 14:00:00 - 14:59:59 826 5.1% 0.232.2 MB 4.1% 0.64
Oct 5 15:00:00 - 15:59:59 809 5.0% 0.222.8 MB 5.1% 0.80
Oct 5 16:00:00 - 16:59:59 746 4.6% 0.212.6 MB 4.7% 0.73
Oct 5 17:00:00 - 17:59:59 523 3.2% 0.152.0 MB 3.6% 0.56
Oct 5 18:00:00 - 18:59:59 471 2.9% 0.131.4 MB 2.6% 0.41
Oct 5 19:00:00 - 19:59:59 438 2.7% 0.121.4 MB 2.5% 0.39
Oct 5 20:00:00 - 20:59:59 447 2.7% 0.121.6 MB 2.8% 0.45
Oct 5 21:00:00 - 21:59:59 357 2.2% 0.101.1 MB 2.1% 0.32
Oct 5 22:00:00 - 22:59:59 269 1.7% 0.07990.6 KB 1.8% 0.28
Oct 5 23:00:00 - 23:57:52 337 2.1% 0.101.7 MB 3.1% 0.51
TOTAL: 23:56:48 16266 100.0% 0.1955.0 MB 100.0% 0.65
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2543 1887 0 1 4 0 0 0 651
2news.snarked.org 1660 85 0 0 2 0 0 0 1573
3newsfeed.neva.ru 1200 646 0 2 7 0 0 0 545
4ripco-out.feeder.erje.net 498 495 0 0 0 0 0 0 3
5newsfeed.fu-berlin.de 220 0 0 0 0 0 0 0 220
6news.lightlink.com 96 9 0 0 0 0 0 0 87
7news-in.rahul.net 76 0 0 0 0 0 0 0 76
8news.cmpublishers.com 2 1 0 1 0 0 0 0 0
TOTAL: 8 6295 3123 0 4 13 0 0 0 3155

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2124
alt.binaries.ftd 250
perl.cpan.uploads 63
fido7.su.pol.news 46
it.comp.os.win.windows10 40
alt.binaries.pictures.erotica.vintage 39
fr.rec.loisirs-creatifs 34
gmane.linux.alsa.devel 30
free.it.scienza.fisica 22
alt.bestjobsusa.computer.jobs 20
alt.binaries.pictures.scenic 16
alt.binaries.e-book 16
alt.binaries.pictures.wallpaper 15
free.willey 14
alt.jobs.jobsearch 14
alt.binaries.nl 13
nl.comp.sys.android 13
perl.perl6.users 13
alt.binaries.pictures.rail 13
free.ucp 12
TOTAL: 144 3123

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

GroupsCount
pl.praca.oferowana 6
fr.comp.securite 3
alt.christnet.religion 1
christnet.theology 1
alt.penthouse.sex.masterbation 1
bit.listserv.catholic 1
TOTAL: 6 13

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4028
Too many newsgroups 1164
Binary in non-binary group 280
EMP (phl) 140
Scoring filter (8) 48
Attached HTML file 34
Scoring filter (9) 18
Scoring filter (10) 8
Scoring filter (16) 8
Scoring filter (13) 4
Scoring filter (11) 4
U2 violation - invalid distribution 4
Scoring filter (18) 4
Scoring filter (12) 2
Scoring filter (15) 2
HTML post 2
Scoring filter (14) 2
Angle-bracket bot 2
TOTAL: 18 5754

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
ripco-out.feed.uzoreto.com 4
TOTAL: 1 4
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
TOTAL: 1 18
Including strange strings
newsfeed.fu-berlin.de 197
newsfeed.neva.ru 61
ripco-out.feed.uzoreto.com 11
news.snarked.org 6
TOTAL: 4 275
TOTAL: 3 297

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10194 1008 6056 10 0 0 9%47:40:00
2rahul.net 25082 638 14800 30 0 70 2%47:46:52
3news.snarked.org 38594 48 23094 26 0 232 0%47:35:26
4news.cmpublishers.com 42486 22 31722 244 0 24 0%47:40:00
5feeder.erje.net 31532 20 30886 30 0 6 0%47:36:40
6fu-berlin.de 29142 16 29126 0 0 0 0%47:40:00
7news.uzoreto.com 18160 10 17370 12 0 54 0%47:51:42
8newsfeed.neva.ru 25760 8 25152 92 0 0 0%47:33:58
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:00
TOTAL: 9 220950 1770 178206 444 0 392 0%429:04:38
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com2.8 MB32.7 KB2.9 MB0.0 KB/s2.9 KB47:40:00
2rahul.net2.6 MB56.4 KB2.7 MB0.0 KB/s4.1 KB47:46:52
3news.snarked.org232.1 KB93.7 KB325.8 KB0.0 KB/s4.4 KB47:35:26
4feeder.erje.net141.1 KB74.6 KB215.7 KB0.0 KB/s4.3 KB47:36:40
5fu-berlin.de94.6 KB0.0 KB94.6 KB0.0 KB/s5.9 KB47:40:00
6newsfeed.neva.ru88.5 KB256.2 KB344.6 KB0.0 KB/s3.4 KB47:33:58
7news.cmpublishers.com83.4 KB736.8 KB820.2 KB0.0 KB/s3.1 KB47:40:00
8news.uzoreto.com78.6 KB33.9 KB112.5 KB0.0 KB/s5.1 KB47:51:42
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 96.2 MB1.3 MB7.4 MB0.0 KB/s3.4 KB429:04:38
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10322.6 MB 446 2 000:06:57
2shell3 16 3841.2 MB 30 2 001:58:18
375-151-74-61-independence.hfc.comcastbusiness.net 8 45.4 KB 4 0 000:13:21
TOTAL: 3 310 14203.8 MB 480 4 030:00:05

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10322.6 MB 446 2 000:06:57
2? 16 3841.2 MB 30 2 001:58:18
3*.hfc.comcastbusiness.net 8 45.4 KB 4 0 000:13:21
4*.hsd1.pa.comcast.net 8 00.0 KB 0 0 001:12:12
5*.17-1.cable.virginm.net 2 00.0 KB 0 0 000:00:08
6unresolved 200 00.0 KB 0 0 025:57:59
7*.cpe.metrocast.net 8 00.0 KB 0 0 000:31:07
TOTAL: 7 528 14203.8 MB 480 4 030:00:05

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
173.248.148.82 13.546 3.788 0.00016:08:30
94.242.254.181 3.386 0.956 0.00008:29:23
shell3 3.620 1.610 0.00001:58:18
61.14.210.7 0.798 0.180 0.00001:20:06
c-71-207-55-82.hsd1.pa.comcast.net 0.902 0.284 0.00001:12:12
d-72-9-26-236.cpe.metrocast.net 0.954 0.472 0.00000:31:07
75-151-74-61-independence.hfc.comcastbusiness.net 1.696 1.344 0.00000:13:21
ftupet.com 46.580 7.464 0.00000:06:57
cpc105460-brad21-2-0-cust144.17-1.cable.virginm.net 0.300 0.148 0.00000:00:08
? 0.242 0.056 0.00000:00:00
TOTAL: 10 72.024 16.302 0.00030:00:05

Curious NNRP server explorers [Top 20]:

SystemConn
173.248.148.82 128
61.14.210.7 40
94.242.254.181 32
d-72-9-26-236.cpe.metrocast.net 8
c-71-207-55-82.hsd1.pa.comcast.net 8
cpc105460-brad21-2-0-cust144.17-1.cable.virginm.net 2
TOTAL: 6 218

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
173.248.148.82 64 0
94.242.254.181 32 0
61.14.210.7 8 0
c-71-207-55-82.hsd1.pa.comcast.net 6 0
shell3 4 0
TOTAL: 5 114 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1352 95.2%
2comp 42 3.0%
3alt 12 0.8%
4chi 6 0.4%
5sci 6 0.4%
6microsoft 2 0.1%
TOTAL: 6 1420100.0%

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

NewsgroupCount
1rec.arts.tv 800
2rec.food.cooking 464
3rec.bicycles.tech 74
4comp.sys.mac.system 24
5alt.stupidity 8
6comp.sys.mac.apps 6
7sci.electronics.repair 6
8rec.radio.broadcasting 4
9rec.radio.swap 4
10chi.weather 4
11rec.gardens.edible 4
12comp.home.automation 2
13rec.video.satellite.tvro 2
14chi.forsale 2
15microsoft.public.word.pagelayout 2
16comp.mail.sendmail 2
17comp.unix.solaris 2
18alt.collecting.juke-boxes 2
19comp.security.ssh 2
20comp.protocols.dns.bind 2
21comp.sys.ibm.pc.games.rpg 2
22alt.satellite.gps.garmin 2
TOTAL: 22 1420