Daily Usenet report for news.ripco.com

Oct 19 00:01:02 -- Oct 19 23:58:05

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Oct 19 08:57:04 remote5bge0 overchan[16535]: [ID 702911 news.error] input line too long, skipping
Oct 19 09:08:07 remote5bge0 overchan[16535]: [ID 702911 news.error] input line too long, skipping
Oct 19 09:17:42 remote5bge0 overchan[16535]: [ID 702911 news.error] input line too long, skipping
Oct 19 13:25:28 remote5bge0 overchan[16535]: [ID 702911 news.error] input line too long, skipping
Oct 19 13:36:32 remote5bge0 overchan[16535]: [ID 702911 news.error] input line too long, skipping
Oct 19 13:39:50 remote5bge0 overchan[16535]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 29841 36.8%4.6 MB 39.0%
inn 29597 36.5%4.5 MB 38.6%
nnrpd 17906 22.1%1.9 MB 16.0%
innfeed 3638 4.5%758.6 KB 6.3%
overchan 6 0.0%0.8 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 80990 100.0%11.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 246626 60.7%
Cache misses 159406 39.3%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 406032 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.526 0.0%59004 0.000 0.009 0.042
article logging00:00:00.958 0.0%59324 0.000 0.016 0.250
article parse00:00:02.166 0.0%141844 0.003 0.015 0.030
article write00:00:37.080 0.0%25998 0.384 1.426 16.838
artlog/artparse00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:00.346 0.0%421902 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:03.308 0.0%407696 0.003 0.008 0.027
history sync00:00:00.432 0.0%780 0.000 0.554 3.000
history write00:00:05.392 0.0%59014 0.030 0.091 0.412
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:59:01.188 99.9%475738 188.527 363.102 791.305
nntp read00:00:02.848 0.0%474086 0.001 0.006 0.013
overview write00:00:00.182 0.0%25998 0.000 0.007 0.060
perl filter00:01:15.468 0.0%59004 1.037 1.279 2.173
python filter00:00:01.488 0.0%59006 0.004 0.025 0.066
site send00:00:01.480 0.0%77938 0.000 0.019 0.044
TOTAL: 48:01:57.30048:01:12.862100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.488 0.0%25906 0.000 0.019 0.071
article prepare00:00:00.008 0.0%17864 0.000 0.000 0.028
article read00:00:00.414 0.0%3858 0.000 0.107 24.000
backlog stats00:00:00.186 0.0%328338 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.222 0.0%211180 0.000 0.011 0.021
data write00:00:02.884 0.0%185634 0.003 0.016 0.029
idle47:38:11.196100.0%328338 310.447 522.301 1502.467
status file00:00:02.288 0.0%328 0.000 6.976 27.500
TOTAL: 47:38:30.05247:38:19.686100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:52:57.422 98.7%18210 9.667 569.875 16938.917
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.968 0.1%846738 0.000 0.011 1.000
readart00:00:19.416 0.2%2436 2.679 7.970 36.500
TOTAL: 02:55:12.70402:53:25.806 99.0%----

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
1ripco-out.feed.uzoreto.com 1148 39924 8410 25910 5604 21%94:37:02
2news.snarked.org 50 24954 6326 18326 302 25%51:34:32
3feeder3.feed-ams.uzoreto.com 574 18632 5946 11540 1146 31%47:18:32
4newsfeed.neva.ru 578 63364 4480 34216 24668 7%283:58:46
5newsfeed.fu-berlin.de 2 14286 532 13730 24 3%48:18:52
6news-in.rahul.net 574 14738 246 14410 82 1%47:30:24
7news.cmpublishers.com 50 8682 102 8572 8 1%48:00:04
8ripco-out.feeder.erje.net 574 28738 70 27584 1084 0%47:17:02
9news.lightlink.com 2 8254 68 8044 142 0%49:48:38
10localhost 148 2 2 0 0 100%00:00:00
TOTAL: 10 3700 221574 26182 162332 33060 11%718:23:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com22.0 MB0.0 KB12.8 MB34.8 MB 63%2.5 KB
2news.snarked.org18.5 MB0.0 KB957.5 KB19.4 MB 95%3.0 KB
3feeder3.feed-ams.uzoreto.com15.0 MB0.0 KB3.3 MB18.3 MB 81%2.6 KB
4newsfeed.neva.ru13.1 MB0.0 KB100.9 MB114.0 MB 11%4.0 KB
5news-in.rahul.net7.0 MB0.0 KB2.7 MB9.7 MB 72%30.2 KB
6newsfeed.fu-berlin.de4.0 MB0.0 KB385.8 KB4.4 MB 91%8.1 KB
7news.lightlink.com2.2 MB0.0 KB5.2 MB7.4 MB 29%36.1 KB
8news.cmpublishers.com243.4 KB0.0 KB10.9 KB254.2 KB 95%2.3 KB
9ripco-out.feeder.erje.net181.3 KB0.0 KB10.4 MB10.5 MB 1%9.4 KB
10localhost4.2 KB0.0 KB0.0 KB4.2 KB100%2.1 KB
TOTAL: 1082.2 MB0.0 KB136.5 MB218.7 MB 37%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 19 00:01:02 - 00:59:59 319 2.5% 0.09938.7 KB 2.3% 0.27
Oct 19 01:00:00 - 01:59:59 474 3.7% 0.131.3 MB 3.2% 0.37
Oct 19 02:00:00 - 02:59:59 427 3.3% 0.121.1 MB 2.8% 0.32
Oct 19 03:00:00 - 03:59:59 511 3.9% 0.141.8 MB 4.4% 0.51
Oct 19 04:00:00 - 04:59:59 536 4.1% 0.151.3 MB 3.3% 0.38
Oct 19 05:00:00 - 05:59:59 535 4.1% 0.151.7 MB 4.1% 0.47
Oct 19 06:00:00 - 06:59:59 521 4.0% 0.142.1 MB 5.2% 0.60
Oct 19 07:00:00 - 07:59:59 701 5.4% 0.192.0 MB 4.9% 0.57
Oct 19 08:00:00 - 08:59:59 608 4.7% 0.172.2 MB 5.4% 0.62
Oct 19 09:00:00 - 09:59:59 829 6.4% 0.232.3 MB 5.5% 0.64
Oct 19 10:00:00 - 10:59:59 780 6.0% 0.222.4 MB 5.8% 0.67
Oct 19 11:00:00 - 11:59:59 712 5.5% 0.202.3 MB 5.7% 0.66
Oct 19 12:00:00 - 12:59:59 672 5.2% 0.191.7 MB 4.3% 0.49
Oct 19 13:00:00 - 13:59:59 720 5.6% 0.202.5 MB 6.1% 0.70
Oct 19 14:00:00 - 14:59:59 654 5.0% 0.182.1 MB 5.2% 0.60
Oct 19 15:00:00 - 15:59:59 687 5.3% 0.192.3 MB 5.6% 0.65
Oct 19 16:00:00 - 16:59:59 613 4.7% 0.171.7 MB 4.1% 0.48
Oct 19 17:00:00 - 17:59:59 578 4.5% 0.161.8 MB 4.5% 0.52
Oct 19 18:00:00 - 18:59:59 472 3.6% 0.131.4 MB 3.5% 0.40
Oct 19 19:00:00 - 19:59:59 431 3.3% 0.121.5 MB 3.6% 0.42
Oct 19 20:00:00 - 20:59:59 408 3.1% 0.111.4 MB 3.4% 0.39
Oct 19 21:00:00 - 21:59:59 300 2.3% 0.081.0 MB 2.5% 0.29
Oct 19 22:00:00 - 22:59:59 260 2.0% 0.07729.0 KB 1.7% 0.20
Oct 19 23:00:00 - 23:58:05 222 1.7% 0.061.2 MB 2.9% 0.35
TOTAL: 23:57:03 12970 100.0% 0.1540.7 MB 100.0% 0.48
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 12305 6037 0 0 6 0 0 0 6262
2ripco-out.feed.uzoreto.com 2813 2240 0 0 6 0 0 0 567
3feeder3.feed-ams.uzoreto.com 577 285 0 0 1 0 0 0 291
4ripco-out.feeder.erje.net 544 540 0 0 0 0 0 0 4
5news.snarked.org 152 82 0 0 1 0 0 0 69
6newsfeed.fu-berlin.de 103 0 0 0 0 0 0 0 103
7news.lightlink.com 87 2 0 0 0 0 0 0 85
8news-in.rahul.net 41 3 0 0 0 0 0 0 38
9news.cmpublishers.com 5 1 0 0 0 0 0 0 4
TOTAL: 9 16627 9190 0 0 14 0 0 0 7423

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.boneless 5496
free.usenet 2783
alt.binaries.ftd 246
free.willey 42
alt.binaries.nl 39
perl.cpan.uploads 36
alt.binaries.pictures.rail 29
alt.bestjobsusa.computer.jobs 23
alt.binaries.pictures.wallpaper 22
it.tlc.cellulari.android 20
scot.general 19
fido7.su.pol.news 18
alt.binaries.nospam.female.bodyhair.pubes 17
de.soc.arbeitslos 14
alt.binaries.pictures.scenic 14
it.comp.os.win.windows10 13
ba.forsale 12
alt.binaries.pictures.earlmiller 12
fr.usenet.abus.nocem 12
alt.binaries.e-book 11
TOTAL: 151 9190

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

GroupsCount
pl.praca.oferowana 6
christnet.bible 4
alt.christnet.christnews 2
bit.listserv.catholic 2
TOTAL: 4 14

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 11096
EMP (md5) 2350
Too many newsgroups 760
EMP (phl) 216
Scoring filter (8) 44
Scoring filter (9) 30
Scoring filter (10) 10
Scoring filter (11) 6
Scoring filter (12) 2
TOTAL: 9 14514

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 95
newsfeed.neva.ru 49
ripco-out.feed.uzoreto.com 10
feeder3.feed-ams.uzoreto.com 4
news.snarked.org 2
TOTAL: 5 160
No colon-space in header
ripco-out.feed.uzoreto.com 3
ripco-out.feeder.erje.net 1
feeder3.feed-ams.uzoreto.com 1
TOTAL: 3 5
TOTAL: 3 183

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10868 1426 4958 10 0 0 13%47:40:02
2rahul.net 22038 832 11768 26 0 0 3%47:49:16
3news.cmpublishers.com 35564 164 23816 1570 0 20 0%47:40:02
4news.uzoreto.com 11676 98 11088 84 0 0 0%47:40:02
5feeder.erje.net 23952 52 23650 140 0 0 0%47:40:00
6news.snarked.org 32454 28 19510 2 0 66 0%47:39:26
7fu-berlin.de 23506 16 23490 0 0 0 0%47:39:32
8newsfeed.neva.ru 21882 10 21322 8 0 0 0%47:40:02
9remote6hme0.ripco.com 0 0 0 0 0 10 0%47:40:02
TOTAL: 9 181940 2626 139602 1840 0 96 1%429:08:24
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com4.9 MB25.1 KB5.0 MB0.0 KB/s3.5 KB47:40:02
2rahul.net4.7 MB104.6 KB4.8 MB0.0 KB/s5.7 KB47:49:16
3news.cmpublishers.com498.2 KB4.2 MB4.7 MB0.0 KB/s2.7 KB47:40:02
4news.uzoreto.com361.4 KB265.2 KB626.6 KB0.0 KB/s3.4 KB47:40:02
5feeder.erje.net335.5 KB421.7 KB757.2 KB0.0 KB/s3.9 KB47:40:00
6news.snarked.org138.7 KB5.9 KB144.7 KB0.0 KB/s4.8 KB47:39:26
7newsfeed.neva.ru81.9 KB17.8 KB99.7 KB0.0 KB/s5.5 KB47:40:02
8fu-berlin.de65.8 KB0.0 KB65.8 KB0.0 KB/s4.1 KB47:39:32
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
TOTAL: 911.1 MB5.0 MB16.0 MB0.0 KB/s3.7 KB429:08:24
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 8602.5 MB 374 2 000:07:12
2shell3 12 5841.7 MB 48 0 002:46:46
3c-73-246-79-215.hsd1.il.comcast.net 2 130343.1 KB 4 0 000:00:12
TOTAL: 3 300 15744.5 MB 426 2 002:55:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 8602.5 MB 374 2 000:07:12
2? 12 5841.7 MB 48 0 002:46:46
3*.hsd1.il.comcast.net 2 130343.1 KB 4 0 000:00:12
TOTAL: 3 300 15744.5 MB 426 2 002:54:11

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 4.288 2.718 0.00002:46:46
ftupet.com 44.154 7.652 0.00000:07:12
d54c176a7.access.telenet.be 12.844 2.830 0.00000:00:25
75-131-7-117.dhcp.bufr.ga.charter.com 4.638 1.088 0.00000:00:14
c-73-246-79-215.hsd1.il.comcast.net 0.344 0.050 0.00000:00:12
175.172.71.190 0.200 0.044 0.00000:00:06
122-117-46-164.hinet-ip.hinet.net 0.202 0.044 0.00000:00:01
114-35-198-235.hinet-ip.hinet.net 0.200 0.040 0.00000:00:01
41.38.55.22 0.200 0.040 0.00000:00:00
cpe-96-28-50-221.kya.res.rr.com 0.200 0.040 0.00000:00:00
159.203.193.41 0.200 0.040 0.00000:00:00
TOTAL: 11 67.470 14.586 0.00002:55:03

NNRP no permission clients:

SystemConn
d54c176a7.access.telenet.be 128
75-131-7-117.dhcp.bufr.ga.charter.com 36
159.203.193.41 2
41.38.55.22 2
122-117-46-164.hinet-ip.hinet.net 2
114-35-198-235.hinet-ip.hinet.net 2
175.172.71.190 2
cpe-96-28-50-221.kya.res.rr.com 2
TOTAL: 8 176

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 4 0
TOTAL: 1 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1122 71.3%
2alt 178 11.3%
3sci 130 8.3%
4misc 76 4.8%
5comp 52 3.3%
6chi 8 0.5%
7news 6 0.4%
8houston 2 0.1%
TOTAL: 8 1574100.0%

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

NewsgroupCount
1rec.arts.tv 748
2rec.food.cooking 320
3alt.home.repair 144
4sci.electronics.repair 130
5misc.phone.mobile.iphone 72
6rec.bicycles.tech 34
7comp.mobile.android 16
8comp.protocols.dns.bind 16
9alt.online-service.comcast 10
10comp.sys.mac.apps 8
11rec.radio.broadcasting 8
12alt.comp.os.windows-10 8
13alt.free.newsservers 8
14comp.sys.mac.system 8
15rec.radio.swap 6
16alt.video.digital-tv 4
17rec.bicycles.misc 4
18chi.forsale 4
19news.admin.net-abuse.email 4
20chi.weather 4
21alt.satellite.gps.garmin 4
22misc.consumers.frugal-living 4
23houston.general 2
24rec.audio.high-end 2
25comp.unix.solaris 2
26news.software.readers 2
27comp.sys.sun.hardware 2
TOTAL: 27 1574