Daily Usenet report for news.ripco.com

Oct 26 00:01:02 -- Oct 26 23:57:57

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Oct 26 05:27:28 remote5bge0 overchan[9325]: [ID 702911 news.error] input line too long, skipping
Oct 26 10:51:11 remote5bge0 overchan[9325]: [ID 702911 news.error] input line too long, skipping
Oct 26 12:58:34 remote5bge0 overchan[9325]: [ID 702911 news.error] input line too long, skipping
Oct 26 13:04:57 remote5bge0 overchan[9325]: [ID 702911 news.error] input line too long, skipping
Oct 26 20:23:16 remote5bge0 overchan[9325]: [ID 702911 news.error] input line too long, skipping
Oct 26 23:57:22.248

Log entries by program:

Program nameLines%LinesSize%Size
inn 33398 38.3%4.9 MB 39.5%
innd 32316 37.1%4.9 MB 39.6%
nnrpd 17742 20.4%1.9 MB 14.9%
innfeed 3626 4.2%768.5 KB 6.0%
overchan 5 0.0%0.9 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 87089 100.0%12.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 269430 66.1%
Cache misses 138072 33.9%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 407502 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%128 0.000 0.000 0.000
article cleanup00:00:00.580 0.0%66334 0.000 0.009 0.032
article logging00:00:00.892 0.0%66616 0.000 0.013 0.113
article parse00:00:02.244 0.0%149728 0.003 0.015 0.039
article write00:00:37.570 0.0%23986 0.329 1.566 36.139
artlog/artparse00:00:00.000 0.0%8 0.000 0.000 0.000
data move00:00:00.310 0.0%424708 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:03.244 0.0%408604 0.001 0.008 0.017
history sync00:00:00.424 0.0%784 0.000 0.541 3.500
history write00:00:06.594 0.0%66340 0.032 0.099 0.545
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:38:52.506 99.9%485706 205.884 353.161 1027.947
nntp read00:00:02.838 0.0%485344 0.002 0.006 0.011
overview write00:00:00.158 0.0%23986 0.000 0.007 0.030
perl filter00:01:23.008 0.0%66330 1.047 1.251 2.008
python filter00:00:01.702 0.0%66336 0.000 0.026 0.064
site send00:00:01.816 0.0%71922 0.000 0.025 0.067
TOTAL: 47:41:58.86047:41:13.886100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.084 0.0%23980 0.000 0.004 0.032
article prepare00:00:00.002 0.0%17808 0.000 0.000 0.009
article read00:00:00.474 0.0%3746 0.000 0.127 6.545
backlog stats00:00:00.154 0.0%305004 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.194 0.0%195600 0.000 0.006 0.017
data write00:00:02.774 0.0%171888 0.004 0.016 0.039
idle47:36:33.362100.0%305004 308.395 561.938 1650.800
status file00:00:01.826 0.0%332 0.000 5.500 56.000
TOTAL: 47:36:47.46247:36:39.870100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:40:26.744 98.8%19038 18.906 505.659 60586.800
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.100 0.1%912592 0.000 0.010 1.000
readart00:00:23.874 0.2%3002 0.000 7.953 36.500
TOTAL: 02:42:25.57402:40:59.718 99.1%----

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
1feeder3.feed-ams.uzoreto.com 574 19208 7780 9040 2388 40%47:19:56
2news.snarked.org 46 23208 5790 17006 412 24%47:34:08
3ripco-out.feed.uzoreto.com 1146 24338 5666 13904 4768 23%94:59:24
4newsfeed.neva.ru 578 70756 3840 33418 33498 5%283:16:38
5newsfeed.fu-berlin.de 2 14222 560 13624 38 3%48:18:52
6news-in.rahul.net 574 14134 210 13864 60 1%47:19:22
7news.cmpublishers.com 52 7808 92 7712 4 1%47:59:12
8ripco-out.feeder.erje.net 574 26028 56 24992 980 0%47:17:54
9news.lightlink.com 2 4904 54 4770 80 1%28:47:22
10localhost 152 6 6 0 0 100%00:00:00
TOTAL: 10 3700 204612 24054 138330 42228 11%692:52:48
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder3.feed-ams.uzoreto.com18.4 MB0.0 KB6.8 MB25.1 MB 73%2.5 KB
2news.snarked.org17.2 MB0.0 KB1.5 MB18.7 MB 91%3.1 KB
3ripco-out.feed.uzoreto.com15.5 MB0.0 KB11.9 MB27.3 MB 56%2.7 KB
4newsfeed.neva.ru13.0 MB2.3 KB107.5 MB120.5 MB 10%3.3 KB
5news-in.rahul.net5.6 MB0.0 KB1.9 MB7.5 MB 74%28.5 KB
6newsfeed.fu-berlin.de4.5 MB0.0 KB901.8 KB5.4 MB 83%9.2 KB
7news.lightlink.com735.1 KB0.0 KB4.1 MB4.8 MB 15%36.5 KB
8news.cmpublishers.com233.3 KB0.0 KB4.5 KB237.8 KB 98%2.5 KB
9ripco-out.feeder.erje.net214.6 KB0.0 KB10.9 MB11.2 MB 1%11.0 KB
10localhost10.8 KB0.0 KB0.0 KB10.8 KB100%1.8 KB
TOTAL: 1075.3 MB2.3 KB145.5 MB220.8 MB 34%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 26 00:01:02 - 00:59:59 302 2.5% 0.09809.1 KB 2.2% 0.23
Oct 26 01:00:00 - 01:59:59 357 3.0% 0.101.2 MB 3.4% 0.35
Oct 26 02:00:00 - 02:59:59 524 4.4% 0.151.6 MB 4.5% 0.46
Oct 26 03:00:00 - 03:59:59 504 4.2% 0.141.3 MB 3.6% 0.38
Oct 26 04:00:00 - 04:59:59 543 4.5% 0.152.0 MB 5.4% 0.56
Oct 26 05:00:00 - 05:59:59 515 4.3% 0.141.3 MB 3.7% 0.38
Oct 26 06:00:00 - 06:59:59 499 4.2% 0.141.6 MB 4.4% 0.46
Oct 26 07:00:00 - 07:59:59 592 4.9% 0.161.7 MB 4.5% 0.47
Oct 26 08:00:00 - 08:59:59 588 4.9% 0.161.8 MB 4.9% 0.51
Oct 26 09:00:00 - 09:59:59 785 6.5% 0.222.1 MB 5.8% 0.60
Oct 26 10:00:00 - 10:59:59 664 5.5% 0.182.1 MB 5.8% 0.61
Oct 26 11:00:00 - 11:59:59 623 5.2% 0.171.9 MB 5.2% 0.55
Oct 26 12:00:00 - 12:59:59 764 6.4% 0.212.2 MB 6.1% 0.64
Oct 26 13:00:00 - 13:59:59 689 5.7% 0.192.4 MB 6.5% 0.68
Oct 26 14:00:00 - 14:59:59 635 5.3% 0.181.8 MB 4.9% 0.51
Oct 26 15:00:00 - 15:59:59 576 4.8% 0.162.1 MB 5.8% 0.61
Oct 26 16:00:00 - 16:59:59 630 5.2% 0.172.1 MB 5.7% 0.59
Oct 26 17:00:00 - 17:59:59 485 4.0% 0.131.3 MB 3.6% 0.37
Oct 26 18:00:00 - 18:59:59 372 3.1% 0.101.1 MB 2.9% 0.30
Oct 26 19:00:00 - 19:59:59 333 2.8% 0.09967.5 KB 2.6% 0.27
Oct 26 20:00:00 - 20:59:59 303 2.5% 0.08947.9 KB 2.5% 0.26
Oct 26 21:00:00 - 21:59:59 259 2.2% 0.07926.0 KB 2.5% 0.26
Oct 26 22:00:00 - 22:59:59 236 2.0% 0.07774.1 KB 2.1% 0.22
Oct 26 23:00:00 - 23:57:57 228 1.9% 0.07608.9 KB 1.6% 0.18
TOTAL: 23:56:55 12006 100.0% 0.1436.6 MB 100.0% 0.43
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 16924 9860 0 1 0 0 0 0 7063
2ripco-out.feed.uzoreto.com 2387 1803 0 0 1 0 0 0 583
3feeder3.feed-ams.uzoreto.com 1199 554 0 0 3 0 0 0 642
4ripco-out.feeder.erje.net 490 485 0 0 0 0 0 0 5
5news.snarked.org 216 54 0 0 1 0 0 0 161
6newsfeed.fu-berlin.de 122 0 0 0 0 0 0 0 122
7news-in.rahul.net 30 0 0 0 0 0 0 0 30
8news.lightlink.com 21 0 0 0 0 0 0 0 21
9news.cmpublishers.com 3 1 0 0 0 0 0 0 2
TOTAL: 9 21392 12757 0 1 5 0 0 0 8629

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.boneless 9474
free.usenet 2542
alt.binaries.ftd 316
free.ucp 35
perl.cpan.uploads 32
alt.binaries.pictures.rail 25
free.it.scienza.fisica 23
fido7.su.pol.news 19
scot.general 19
it.comp.os.win.windows10 17
alt.binaries.pictures.wallpaper 13
alt.binaries.e-book 10
alt.binaries.3d.poser 9
alt.binaries.pictures.scenic 9
alt.bestjobsusa.computer.jobs 9
grisbi.bugsreports 9
alt.binaries.nospam.female.bodyhair.pubes 8
alt.binaries.nospam.breasts.natural 8
it.tlc.cellulari.android 8
alt.binaries.mac.osx.apps 6
TOTAL: 106 12757

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

GroupsCount
christnet.bible 3
alt.christnet.religion 1
bit.listserv.catholic 1
TOTAL: 3 5

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 13396
EMP (md5) 2240
Too many newsgroups 1020
EMP (phl) 262
Scoring filter (8) 22
Scoring filter (11) 8
Scoring filter (10) 6
Scoring filter (9) 6
Scoring filter (12) 4
Scoring filter (13) 2
Attached HTML file 2
Scoring filter (20) 2
Too many test groups in crosspost 2
TOTAL: 13 16972

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 110
newsfeed.neva.ru 26
feeder3.feed-ams.uzoreto.com 5
ripco-out.feed.uzoreto.com 2
TOTAL: 4 143
No colon-space in header
feeder3.feed-ams.uzoreto.com 2
ripco-out.feeder.erje.net 1
ripco-out.feed.uzoreto.com 1
TOTAL: 3 4
TOTAL: 3 165

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9724 1500 4524 8 0 0 15%47:40:04
2rahul.net 19782 604 11136 20 0 0 3%47:41:24
3news.cmpublishers.com 33688 224 21792 1614 0 0 0%47:40:04
4news.uzoreto.com 10378 76 10096 68 0 0 0%47:35:42
5feeder.erje.net 22060 56 21742 144 0 0 0%47:40:04
6fu-berlin.de 21934 48 21886 0 0 0 0%47:40:04
7news.snarked.org 29580 46 17788 6 0 62 0%47:40:04
8newsfeed.neva.ru 21066 26 20080 12 0 0 0%47:52:04
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:02
TOTAL: 9 168212 2580 129044 1872 0 68 1%429:09:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com5.4 MB38.9 KB5.4 MB0.0 KB/s3.7 KB47:40:04
2rahul.net2.1 MB51.5 KB2.1 MB0.0 KB/s3.5 KB47:41:24
3fu-berlin.de757.3 KB0.0 KB757.3 KB0.0 KB/s15.8 KB47:40:04
4news.cmpublishers.com636.5 KB4.2 MB4.8 MB0.0 KB/s2.7 KB47:40:04
5news.uzoreto.com258.5 KB250.0 KB508.5 KB0.0 KB/s3.5 KB47:35:42
6feeder.erje.net239.6 KB482.6 KB722.2 KB0.0 KB/s3.6 KB47:40:04
7news.snarked.org162.0 KB12.9 KB174.8 KB0.0 KB/s3.4 KB47:40:04
8newsfeed.neva.ru64.9 KB50.2 KB115.1 KB0.0 KB/s3.0 KB47:52:04
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
TOTAL: 99.5 MB5.1 MB14.6 MB0.0 KB/s3.4 KB429:09:32
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1c-73-246-79-215.hsd1.il.comcast.net 2 10403.1 MB 8 0 000:00:35
2ftupet.com 286 7401.9 MB 396 2 000:07:19
3shell3 12 4801.3 MB 54 4 002:33:49
TOTAL: 3 300 22606.3 MB 458 6 002:42:17

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.hsd1.il.comcast.net 2 10403.1 MB 8 0 000:00:35
2*.com 286 7401.9 MB 396 2 000:07:19
3? 12 4801.3 MB 54 4 002:33:49
TOTAL: 3 300 22606.3 MB 458 6 002:41:44

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 4.392 2.320 0.00002:33:49
ftupet.com 46.314 7.628 0.00000:07:19
c-73-246-79-215.hsd1.il.comcast.net 0.390 0.144 0.00000:00:35
d54c176a7.access.telenet.be 11.270 2.504 0.00000:00:23
ip-95-87-37-103.trakiacable.bg 0.200 0.040 0.00000:00:06
ppp118-211-195-152.bras1.syd2.internode.on.net 0.200 0.040 0.00000:00:01
178-116-140-107.access.telenet.be 0.206 0.042 0.00000:00:01
TOTAL: 7 62.972 12.718 0.00002:42:17

NNRP no permission clients:

SystemConn
d54c176a7.access.telenet.be 112
ppp118-211-195-152.bras1.syd2.internode.on.net 2
ip-95-87-37-103.trakiacable.bg 2
178-116-140-107.access.telenet.be 2
TOTAL: 4 118

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 6 0
TOTAL: 1 6 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1894 83.8%
2comp 140 6.2%
3misc 56 2.5%
4alt 46 2.0%
5chi 42 1.9%
6sci 40 1.8%
7news 20 0.9%
8ba 12 0.5%
9rocksolid 10 0.4%
TOTAL: 9 2260100.0%

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

NewsgroupCount
1rec.arts.tv 1372
2rec.food.cooking 412
3rec.bicycles.tech 100
4comp.sys.mac.system 94
5misc.phone.mobile.iphone 52
6sci.electronics.repair 40
7comp.mobile.android 40
8alt.comp.os.windows-10 22
9chi.forsale 16
10news.software.nntp 16
11chi.eats 14
12ba.food 12
13chi.general 8
14alt.online-service.comcast 6
15rec.radio.broadcasting 6
16rocksolid.shared.general 6
17alt.internet.wireless 6
18rocksolid.nodes.announce 4
19rec.radio.swap 4
20news.admin.net-abuse.usenet 4
21alt.security.alarms 4
22alt.comp.google 4
23chi.weather 4
24comp.protocols.dns.bind 4
25misc.consumers.frugal-living 4
26alt.cellular.t-mobile 2
27comp.mail.sendmail 2
28alt.free.newsservers 2
TOTAL: 28 2260