Daily Usenet report for news.ripco.com

Oct 5 00:01:02 -- Oct 5 23:57:49

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Oct 5 00:31:35 remote5bge0 overchan[27380]: [ID 702911 news.error] input line too long, skipping
Oct 5 06:07:54 remote5bge0 overchan[27380]: [ID 702911 news.error] input line too long, skipping
Oct 5 06:52:55 remote5bge0 overchan[27380]: [ID 702911 news.error] input line too long, skipping
Oct 5 09:22:06 remote5bge0 overchan[27380]: [ID 702911 news.error] input line too long, skipping
Oct 5 13:46:56 remote5bge0 overchan[27380]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 19691 33.2%3.0 MB 34.4%
inn 18463 31.2%3.2 MB 36.3%
nnrpd 17424 29.4%1.8 MB 20.5%
innfeed 3648 6.2%790.8 KB 8.7%
overchan 5 0.0%0.8 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 59233 100.0%8.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 182934 58.8%
Cache misses 128360 41.2%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 311294 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%140 0.000 0.000 0.000
article cleanup00:00:00.296 0.0%36642 0.000 0.008 0.037
article logging00:00:00.492 0.0%36900 0.000 0.013 0.222
article parse00:00:01.446 0.0%86352 0.000 0.017 0.045
article write00:00:41.576 0.0%25848 0.292 1.608 22.679
artlog/artparse00:00:00.000 0.0%8 0.000 0.000 0.000
data move00:00:00.230 0.0%308330 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.428 0.0%311892 0.002 0.008 0.017
history sync00:00:00.196 0.0%770 0.000 0.255 4.667
history write00:00:03.120 0.0%36650 0.011 0.085 2.778
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:39:51.136 99.9%346492 273.255 495.224 1837.196
nntp read00:00:01.894 0.0%344374 0.000 0.005 0.014
overview write00:00:00.136 0.0%25848 0.000 0.005 0.060
perl filter00:00:48.780 0.0%36642 1.068 1.331 2.566
python filter00:00:00.888 0.0%36646 0.000 0.024 0.105
site send00:00:01.756 0.0%77540 0.000 0.023 0.055
TOTAL: 47:42:01.26447:41:34.374100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.104 0.0%26022 0.000 0.004 0.027
article prepare00:00:00.006 0.0%2736 0.000 0.002 0.083
article read00:00:00.208 0.0%600 0.000 0.347 35.500
backlog stats00:00:00.182 0.0%297804 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.608 0.0%198674 0.000 0.008 0.027
data write00:00:02.726 0.0%173906 0.000 0.016 0.034
idle47:39:49.544100.0%297804 342.831 576.183 1898.054
status file00:00:02.144 0.0%340 0.000 6.306 42.000
TOTAL: 47:40:06.03247:39:56.522100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:38:24.328 99.1%18140 9.000 523.943 17207.103
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:07.204 0.1%736784 0.000 0.010 1.000
readart00:00:19.964 0.2%2444 0.129 8.169 66.500
TOTAL: 02:39:52.42402:38:51.496 99.4%----

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
1feeder3.feed-ams.uzoreto.com 574 21240 8502 9022 3716 40%47:19:14
2ripco-out.feed.uzoreto.com 1146 25118 8268 15080 1770 32%94:19:02
3newsfeed.neva.ru 600 21436 5090 12368 3978 23%272:19:02
4news.snarked.org 44 24474 2146 22150 178 8%48:23:40
5news-in.rahul.net 574 14814 810 13962 42 5%47:29:10
6newsfeed.fu-berlin.de 2 12306 492 11784 30 3%45:11:58
7news.cmpublishers.com 50 8418 404 7982 32 4%48:00:02
8news.lightlink.com 2 9244 164 8892 188 1%49:48:38
9ripco-out.feeder.erje.net 574 28128 22 27236 870 0%47:28:58
10localhost 150 4 4 0 0 100%00:00:00
TOTAL: 10 3716 165182 25902 128476 10804 15%700:19:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder3.feed-ams.uzoreto.com23.1 MB0.0 KB8.4 MB31.5 MB 73%2.6 KB
2ripco-out.feed.uzoreto.com22.2 MB0.0 KB5.2 MB27.3 MB 81%2.8 KB
3newsfeed.neva.ru15.9 MB0.0 KB14.1 MB30.0 MB 52%3.4 KB
4news-in.rahul.net10.4 MB0.0 KB1.1 MB11.5 MB 90%13.8 KB
5news.snarked.org6.7 MB0.0 KB741.4 KB7.5 MB 90%3.3 KB
6newsfeed.fu-berlin.de4.1 MB0.0 KB303.3 KB4.4 MB 93%8.6 KB
7news.cmpublishers.com1.3 MB0.0 KB134.3 KB1.5 MB 90%3.4 KB
8news.lightlink.com1.1 MB0.0 KB7.2 MB8.3 MB 13%24.2 KB
9ripco-out.feeder.erje.net119.1 KB0.0 KB8.4 MB8.5 MB 1%9.8 KB
10localhost7.1 KB0.0 KB0.0 KB7.1 KB100%1.8 KB
TOTAL: 1084.9 MB0.0 KB45.5 MB130.4 MB 65%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 5 00:01:02 - 00:59:59 268 2.1% 0.08794.8 KB 1.8% 0.22
Oct 5 01:00:00 - 01:59:59 342 2.6% 0.101.2 MB 2.9% 0.35
Oct 5 02:00:00 - 02:59:59 426 3.3% 0.121.0 MB 2.5% 0.30
Oct 5 03:00:00 - 03:59:59 451 3.5% 0.131.4 MB 3.4% 0.41
Oct 5 04:00:00 - 04:59:59 642 5.0% 0.182.1 MB 4.9% 0.59
Oct 5 05:00:00 - 05:59:59 648 5.0% 0.182.0 MB 4.6% 0.56
Oct 5 06:00:00 - 06:59:59 655 5.1% 0.181.8 MB 4.2% 0.51
Oct 5 07:00:00 - 07:59:59 611 4.7% 0.171.7 MB 4.0% 0.49
Oct 5 08:00:00 - 08:59:59 680 5.3% 0.192.6 MB 6.2% 0.75
Oct 5 09:00:00 - 09:59:59 741 5.7% 0.211.9 MB 4.6% 0.55
Oct 5 10:00:00 - 10:59:59 677 5.2% 0.192.1 MB 5.0% 0.60
Oct 5 11:00:00 - 11:59:59 725 5.6% 0.202.2 MB 5.2% 0.63
Oct 5 12:00:00 - 12:59:59 697 5.4% 0.192.0 MB 4.8% 0.58
Oct 5 13:00:00 - 13:59:59 753 5.8% 0.212.1 MB 5.0% 0.60
Oct 5 14:00:00 - 14:59:59 754 5.8% 0.212.3 MB 5.4% 0.65
Oct 5 15:00:00 - 15:59:59 654 5.1% 0.182.1 MB 4.9% 0.59
Oct 5 16:00:00 - 16:59:59 669 5.2% 0.192.4 MB 5.7% 0.69
Oct 5 17:00:00 - 17:59:59 499 3.9% 0.141.7 MB 4.1% 0.49
Oct 5 18:00:00 - 18:59:59 458 3.5% 0.131.6 MB 3.7% 0.44
Oct 5 19:00:00 - 19:59:59 401 3.1% 0.112.6 MB 6.2% 0.74
Oct 5 20:00:00 - 20:59:59 448 3.5% 0.121.5 MB 3.6% 0.43
Oct 5 21:00:00 - 21:59:59 267 2.1% 0.071019.2 KB 2.4% 0.28
Oct 5 22:00:00 - 22:59:59 221 1.7% 0.06698.6 KB 1.6% 0.19
Oct 5 23:00:00 - 23:57:49 249 1.9% 0.071.3 MB 3.2% 0.39
TOTAL: 23:56:47 12936 100.0% 0.1542.2 MB 100.0% 0.50
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2018 1076 0 0 7 0 0 0 935
2feeder3.feed-ams.uzoreto.com 1861 1254 0 0 0 0 0 0 607
3ripco-out.feed.uzoreto.com 888 413 0 0 2 0 0 0 473
4ripco-out.feeder.erje.net 435 433 0 0 0 0 0 0 2
5newsfeed.fu-berlin.de 102 0 0 0 0 0 0 0 102
6news.lightlink.com 98 2 0 0 0 0 0 0 96
7news.snarked.org 90 22 0 0 1 0 0 0 67
8news-in.rahul.net 21 1 0 0 0 0 0 0 20
9news.cmpublishers.com 14 0 0 0 0 0 0 0 14
TOTAL: 9 5527 3201 0 0 10 0 0 0 2316

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1842
alt.binaries.boneless 560
alt.binaries.ftd 259
free.willey 53
perl.cpan.uploads 28
fido7.su.pol.news 26
scot.general 20
it.comp.os.win.windows10 19
muc.lists.freebsd.fs 18
alt.binaries.pictures.purebeauty 17
alt.binaries.e-book 17
alt.bestjobsusa.computer.jobs 16
it.tlc.cellulari.android 16
alt.binaries.pictures.rail 15
free.it.scienza.fisica 10
alt.binaries.pictures.wallpaper 10
alt.binaries.nospam.female.bodyhair.pubes 9
panix.chat.politics 9
de.soc.arbeitslos 6
alt.binaries.sounds.lossless 6
TOTAL: 180 3201

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

GroupsCount
pl.praca.oferowana 7
christnet.theology 1
alt.penthouse.sex.masterbation 1
bit.listserv.catholic 1
TOTAL: 4 10

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1906
Too many newsgroups 1068
Binary in non-binary group 1034
EMP (phl) 216
Scoring filter (8) 96
Scoring filter (9) 26
Scoring filter (10) 12
Scoring filter (12) 6
Scoring filter (11) 2
TOTAL: 9 4366

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
TOTAL: 1 18
Including strange strings
newsfeed.fu-berlin.de 89
newsfeed.neva.ru 33
ripco-out.feed.uzoreto.com 4
feeder3.feed-ams.uzoreto.com 3
TOTAL: 4 129
No colon-space in header
ripco-out.feed.uzoreto.com 2
feeder3.feed-ams.uzoreto.com 1
TOTAL: 2 3
TOTAL: 3 150

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 18614 190 11452 6 0 0 1%47:40:04
2news.lightlink.com 11024 62 6088 0 0 0 0%47:40:04
3feeder.erje.net 23892 46 23516 158 0 0 0%47:48:52
4news.snarked.org 35496 28 23334 28 0 160 0%47:40:04
5fu-berlin.de 23714 24 23690 0 0 0 0%47:35:02
6news.cmpublishers.com 31468 14 25186 108 0 24 0%47:40:04
7news.uzoreto.com 8814 6 8782 4 0 0 0%47:50:18
8newsfeed.neva.ru 20832 4 20744 6 0 0 0%47:47:14
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:02
TOTAL: 9 173854 374 142792 310 0 190 0%429:21:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net2.1 MB159.9 KB2.3 MB0.0 KB/s11.8 KB47:40:04
2fu-berlin.de448.6 KB0.0 KB448.6 KB0.0 KB/s18.7 KB47:35:02
3news.snarked.org277.8 KB81.0 KB358.8 KB0.0 KB/s6.4 KB47:40:04
4news.lightlink.com246.3 KB0.0 KB246.3 KB0.0 KB/s4.0 KB47:40:04
5feeder.erje.net220.1 KB327.5 KB547.5 KB0.0 KB/s2.7 KB47:48:52
6newsfeed.neva.ru131.3 KB69.5 KB200.8 KB0.0 KB/s20.1 KB47:47:14
7news.uzoreto.com70.7 KB7.6 KB78.3 KB0.0 KB/s7.8 KB47:50:18
8news.cmpublishers.com63.8 KB315.6 KB379.4 KB0.0 KB/s3.1 KB47:40:04
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
TOTAL: 93.5 MB961.0 KB4.5 MB0.0 KB/s6.7 KB429:21:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9762.7 MB 428 2 000:07:24
2shell3 10 4901.3 MB 62 2 002:32:06
TOTAL: 2 296 14664.1 MB 490 4 002:39:45

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9762.7 MB 428 2 000:07:24
2? 10 4901.3 MB 62 2 002:32:06
TOTAL: 2 296 14664.1 MB 490 4 002:39:31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 3.514 1.904 0.00002:32:06
ftupet.com 45.148 7.312 0.00000:07:24
80.82.65.74 4.428 0.868 0.00000:00:09
124-169-29-35.dyn.iinet.net.au 0.604 0.118 0.00000:00:04
TOTAL: 4 53.694 10.202 0.00002:39:45

NNRP no permission clients:

SystemConn
80.82.65.74 44
124-169-29-35.dyn.iinet.net.au 6
TOTAL: 2 50

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1206 82.3%
2misc 114 7.8%
3comp 108 7.4%
4alt 12 0.8%
5sci 12 0.8%
6news 10 0.7%
7chi 4 0.3%
TOTAL: 7 1466100.0%

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

NewsgroupCount
1rec.arts.tv 808
2rec.food.cooking 274
3rec.bicycles.tech 82
4misc.phone.mobile.iphone 74
5comp.mobile.android 64
6misc.consumers.frugal-living 38
7rec.gardens.edible 28
8comp.sys.mac.system 16
9sci.electronics.repair 12
10news.software.readers 8
11alt.free.newsservers 8
12rec.radio.broadcasting 6
13comp.mobile.ipad 6
14comp.mail.sendmail 6
15comp.internet.services.google 6
16comp.sys.apple2 4
17rec.radio.swap 4
18chi.weather 4
19rec.arts.tv.x-factor 2
20misc.transport.rail.americas 2
21rec.bicycles.misc 2
22comp.unix.bsd.freebsd.misc 2
23alt.config 2
24comp.mail.misc 2
25alt.security.alarms 2
26comp.protocols.dns.bind 2
27news.groups 2
TOTAL: 27 1466