Daily Usenet report for news.ripco.com

Nov 30 00:01:02 -- Nov 30 23:57:27

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Nov 30 01:19:16 remote5bge0 overchan[10148]: [ID 702911 news.error] input line too long, skipping
Nov 30 06:34:18 remote5bge0 overchan[10148]: [ID 702911 news.error] input line too long, skipping
Nov 30 09:05:33 remote5bge0 overchan[10148]: [ID 702911 news.error] input line too long, skipping
Nov 30 12:40:49 remote5bge0 overchan[10148]: [ID 702911 news.error] input line too long, skipping
Nov 30 23:35:23 remote5bge0 overchan[10148]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 19963 32.9%3.1 MB 34.4%
inn 19041 31.3%3.2 MB 36.0%
nnrpd 18091 29.8%1.9 MB 21.1%
innfeed 3656 6.0%771.0 KB 8.4%
overchan 5 0.0%0.7 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 60758 100.0%9.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 166358 54.5%
Cache misses 138864 45.5%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 305222 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.004 0.0%178 0.000 0.022 0.250
article cleanup00:00:00.372 0.0%37826 0.000 0.010 0.073
article logging00:00:00.476 0.0%38100 0.000 0.012 0.054
article parse00:00:01.556 0.0%90638 0.000 0.017 0.048
article write00:00:40.886 0.0%25328 0.382 1.614 28.812
artlog/artparse00:00:00.000 0.0%12 0.000 0.000 0.000
data move00:00:00.262 0.0%311468 0.000 0.001 0.005
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:02.612 0.0%306694 0.001 0.009 0.017
history sync00:00:00.282 0.0%806 0.000 0.350 13.667
history write00:00:03.120 0.0%37836 0.000 0.082 2.663
hiswrite/artparse00:00:00.002 0.0%2 1.000 1.000 1.000
idle47:39:40.532 99.9%345716 229.812 496.305 1488.940
nntp read00:00:01.890 0.0%344638 0.000 0.005 0.013
overview write00:00:00.176 0.0%25328 0.000 0.007 0.037
perl filter00:00:52.406 0.0%37826 1.063 1.385 2.675
python filter00:00:00.948 0.0%37830 0.000 0.025 0.104
site send00:00:01.888 0.0%75952 0.000 0.025 0.062
TOTAL: 47:42:08.15447:41:27.412100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.084 0.0%25518 0.000 0.003 0.037
article prepare00:00:00.000 0.0%4560 0.000 0.000 0.000
article read00:00:00.228 0.0%1004 0.000 0.227 14.600
backlog stats00:00:00.138 0.0%310738 0.000 0.000 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.132 0.0%202158 0.000 0.006 0.020
data write00:00:02.686 0.0%177726 0.003 0.015 0.041
idle47:35:57.006100.0%310738 321.520 551.452 1695.325
status file00:00:04.686 0.0%348 0.000 13.466 131.400
TOTAL: 47:36:14.27447:36:05.960100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:50:56.084 98.7%18086 9.667 567.073 29099.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.626 0.1%994890 0.000 0.010 1.000
readart00:00:21.744 0.2%2342 0.000 9.284 36.500
TOTAL: 02:53:11.23802:51:27.454 99.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 1148 31160 10012 17724 3424 32%94:52:08
2news.snarked.org 62 24532 6336 17824 372 25%60:14:22
3newsfeed.neva.ru 590 36230 4726 26544 4960 13%276:33:50
4feeder3.feed-ams.uzoreto.com 574 14944 3078 9250 2616 20%47:18:50
5news.lightlink.com 2 12212 614 11376 222 5%69:35:34
6newsfeed.fu-berlin.de 2 11798 468 11270 60 3%44:30:14
7news-in.rahul.net 574 13820 190 13514 116 1%47:20:20
8ripco-out.feeder.erje.net 574 27642 44 26712 886 0%47:27:00
9news.cmpublishers.com 50 7862 30 7814 18 0%47:59:58
10localhost 150 4 4 0 0 100%00:00:00
TOTAL: 10 3726 180204 25502 142028 12674 14%735:52:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com25.4 MB0.0 KB7.9 MB33.3 MB 76%2.5 KB
2news.snarked.org18.2 MB0.0 KB1.8 MB20.0 MB 90%3.1 KB
3newsfeed.neva.ru13.7 MB0.0 KB19.4 MB33.1 MB 41%3.5 KB
4feeder3.feed-ams.uzoreto.com8.2 MB0.0 KB4.8 MB12.9 MB 63%2.3 KB
5news-in.rahul.net6.5 MB0.0 KB4.5 MB11.0 MB 59%36.7 KB
6newsfeed.fu-berlin.de5.1 MB0.0 KB1.5 MB6.6 MB 76%12.8 KB
7news.lightlink.com3.7 MB0.0 KB10.1 MB13.8 MB 26%16.9 KB
8ripco-out.feeder.erje.net150.8 KB0.0 KB9.4 MB9.6 MB 1%10.5 KB
9news.cmpublishers.com73.5 KB0.0 KB33.8 KB107.4 KB 68%2.2 KB
10localhost8.6 KB0.0 KB0.0 KB8.6 KB100%2.2 KB
TOTAL: 1080.9 MB0.0 KB59.5 MB140.4 MB 57%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 30 00:01:02 - 00:59:59 204 1.6% 0.06711.7 KB 1.8% 0.20
Nov 30 01:00:00 - 01:59:59 298 2.4% 0.081.5 MB 3.9% 0.44
Nov 30 02:00:00 - 02:59:59 450 3.6% 0.121.5 MB 3.8% 0.43
Nov 30 03:00:00 - 03:59:59 532 4.2% 0.151.7 MB 4.4% 0.49
Nov 30 04:00:00 - 04:59:59 615 4.9% 0.171.8 MB 4.6% 0.51
Nov 30 05:00:00 - 05:59:59 495 3.9% 0.141.2 MB 3.0% 0.33
Nov 30 06:00:00 - 06:59:59 528 4.2% 0.151.6 MB 4.0% 0.45
Nov 30 07:00:00 - 07:59:59 583 4.6% 0.161.5 MB 3.9% 0.44
Nov 30 08:00:00 - 08:59:59 703 5.6% 0.202.0 MB 5.2% 0.58
Nov 30 09:00:00 - 09:59:59 656 5.2% 0.181.6 MB 4.0% 0.45
Nov 30 10:00:00 - 10:59:59 690 5.4% 0.192.0 MB 5.0% 0.56
Nov 30 11:00:00 - 11:59:59 842 6.6% 0.232.9 MB 7.5% 0.83
Nov 30 12:00:00 - 12:59:59 725 5.7% 0.201.8 MB 4.6% 0.52
Nov 30 13:00:00 - 13:59:59 846 6.7% 0.232.6 MB 6.6% 0.74
Nov 30 14:00:00 - 14:59:59 652 5.1% 0.182.0 MB 5.2% 0.58
Nov 30 15:00:00 - 15:59:59 601 4.7% 0.172.0 MB 5.2% 0.58
Nov 30 16:00:00 - 16:59:59 594 4.7% 0.172.2 MB 5.7% 0.63
Nov 30 17:00:00 - 17:59:59 555 4.4% 0.151.6 MB 4.0% 0.45
Nov 30 18:00:00 - 18:59:59 555 4.4% 0.151.7 MB 4.2% 0.47
Nov 30 19:00:00 - 19:59:59 400 3.2% 0.111.5 MB 3.9% 0.44
Nov 30 20:00:00 - 20:59:59 385 3.0% 0.111.2 MB 3.1% 0.34
Nov 30 21:00:00 - 21:59:59 308 2.4% 0.091.1 MB 2.8% 0.31
Nov 30 22:00:00 - 22:59:59 251 2.0% 0.07815.3 KB 2.0% 0.23
Nov 30 23:00:00 - 23:57:27 195 1.5% 0.06598.5 KB 1.5% 0.17
TOTAL: 23:56:25 12663 100.0% 0.1539.3 MB 100.0% 0.47
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2461 1231 0 0 1 0 0 0 1229
2ripco-out.feed.uzoreto.com 1716 1144 0 0 5 0 0 0 567
3feeder3.feed-ams.uzoreto.com 1308 1099 0 0 0 0 0 0 209
4ripco-out.feeder.erje.net 443 442 0 0 0 0 0 0 1
5news.snarked.org 186 57 0 0 4 0 0 0 125
6newsfeed.fu-berlin.de 125 0 0 0 0 0 0 0 125
7news.lightlink.com 74 3 0 0 0 0 0 0 71
8news-in.rahul.net 57 4 0 0 0 0 0 0 53
9news.cmpublishers.com 8 0 0 0 0 0 0 0 8
TOTAL: 9 6378 3980 0 0 10 0 0 0 2388

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2421
alt.binaries.boneless 803
alt.binaries.ftd 230
alt.binaries.nl 41
alt.binaries.ctb 25
fido7.su.pol.news 22
de.soc.arbeitslos 19
free.it.scienza.fisica 17
alt.binaries.pictures.wallpaper 14
perl.cpan.uploads 13
scot.general 13
free.willey 12
alt.bestjobsusa.computer.jobs 11
alt.binaries.3d.poser 11
alt.binaries.e-book 11
fr.rec.loisirs-creatifs 9
alt.tv.star-trek 8
free.ucp 8
fr.comp.os.android 7
it.tlc.cellulari.android 7
TOTAL: 198 3980

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

GroupsCount
fr.sci.geosciences 3
christnet.theology 2
pl.praca.oferowana 1
alt.christnet.religion 1
alt.penthouse.sex.sissy.slut 1
alt.christnet.christnews 1
bit.listserv.catholic 1
TOTAL: 7 10

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 1770
EMP (md5) 1418
Too many newsgroups 952
EMP (phl) 250
Scoring filter (8) 38
Scoring filter (10) 18
Scoring filter (9) 16
Scoring filter (11) 14
Scoring filter (16) 6
Scoring filter (12) 4
Scoring filter (13) 2
HTML post 2
TOTAL: 12 4490

Miscellaneous innd statistics [Top 10]:

EventServerNumber
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 97
newsfeed.neva.ru 36
ripco-out.feed.uzoreto.com 4
feeder3.feed-ams.uzoreto.com 1
TOTAL: 4 138
No colon-space in header
ripco-out.feed.uzoreto.com 1
feeder3.feed-ams.uzoreto.com 1
TOTAL: 2 2
TOTAL: 4 160

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 19742 376 11552 8 0 6 1%47:42:32
2news.lightlink.com 10094 326 6308 6 0 0 3%47:40:02
3news.snarked.org 31044 26 18648 14 0 200 0%47:41:40
4feeder.erje.net 24062 18 23744 16 0 0 0%47:40:02
5fu-berlin.de 23368 14 23352 0 0 0 0%47:44:00
6news.cmpublishers.com 36218 10 24772 266 0 40 0%47:40:02
7news.uzoreto.com 12192 10 11946 10 0 0 0%47:42:42
8newsfeed.neva.ru 20886 4 20498 38 0 0 0%47:44:22
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:00
TOTAL: 9 177606 784 140820 358 0 252 0%429:15:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net1.8 MB15.5 KB1.8 MB0.0 KB/s4.8 KB47:42:32
2news.lightlink.com1017.0 KB13.2 KB1.0 MB0.0 KB/s3.1 KB47:40:02
3news.snarked.org99.5 KB35.1 KB134.6 KB0.0 KB/s3.4 KB47:41:40
4feeder.erje.net73.3 KB27.2 KB100.6 KB0.0 KB/s3.0 KB47:40:02
5fu-berlin.de64.4 KB0.0 KB64.4 KB0.0 KB/s4.6 KB47:44:00
6news.cmpublishers.com27.7 KB672.3 KB700.0 KB0.0 KB/s2.5 KB47:40:02
7news.uzoreto.com25.9 KB57.9 KB83.8 KB0.0 KB/s4.2 KB47:42:42
8newsfeed.neva.ru8.7 KB116.8 KB125.5 KB0.0 KB/s3.0 KB47:44:22
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 93.1 MB938.1 KB4.0 MB0.0 KB/s3.6 KB429:15:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9202.5 MB 400 2 000:07:18
2shell3 14 5001.5 MB 56 2 002:44:51
TOTAL: 2 300 14204.0 MB 456 4 002:53:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9202.5 MB 400 2 000:07:18
2? 14 5001.5 MB 56 2 002:44:51
TOTAL: 2 300 14204.0 MB 456 4 002:52:10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 4.854 2.646 0.00002:44:51
ftupet.com 46.710 7.908 0.00000:07:18
d54c176a7.access.telenet.be 14.460 3.294 0.00000:00:32
84-105-134-55.cable.dynamic.v4.ziggo.nl 6.436 1.472 0.00000:00:17
109.100.190.15 0.200 0.044 0.00000:00:00
TOTAL: 5 72.660 15.364 0.00002:53:00

NNRP no permission clients:

SystemConn
d54c176a7.access.telenet.be 144
84-105-134-55.cable.dynamic.v4.ziggo.nl 64
109.100.190.15 2
TOTAL: 3 210

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 4 0
TOTAL: 1 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1032 72.7%
2alt 238 16.8%
3misc 58 4.1%
4comp 52 3.7%
5news 16 1.1%
6sci 14 1.0%
7chi 10 0.7%
TOTAL: 7 1420100.0%

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

NewsgroupCount
1rec.food.cooking 526
2rec.arts.tv 434
3alt.comp.os.windows-10 232
4rec.bicycles.tech 52
5misc.phone.mobile.iphone 32
6misc.consumers.frugal-living 22
7comp.sys.apple2 16
8sci.electronics.repair 14
9comp.mobile.android 14
10comp.sys.mac.system 14
11news.software.nntp 12
12rec.radio.broadcasting 10
13chi.weather 10
14comp.unix.bsd.freebsd.misc 4
15rec.radio.swap 4
16misc.phone.mobile 4
17alt.security.alarms 4
18comp.protocols.dns.bind 4
19rec.outdoors.rv-travel 4
20rec.bicycles.misc 2
21news.admin.peering 2
22news.admin.net-abuse.email 2
23alt.dbs.directv 2
TOTAL: 23 1420