Daily Usenet report for news.ripco.com

Aug 29 00:01:02 -- Aug 29 23:58:04

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Aug 29 04:09:28 remote5bge0 overchan[6982]: [ID 702911 news.error] input line too long, skipping
Aug 29 04:43:11 remote5bge0 overchan[6982]: [ID 702911 news.error] input line too long, skipping
Aug 29 08:42:35 remote5bge0 overchan[6982]: [ID 702911 news.error] input line too long, skipping
Aug 29 10:04:59 remote5bge0 overchan[6982]: [ID 702911 news.error] input line too long, skipping
Aug 29 10:18:56 remote5bge0 overchan[6982]: [ID 702911 news.error] input line too long, skipping
Aug 29 12:47:49 remote5bge0 overchan[6982]: [ID 702911 news.error] input line too long, skipping
Aug 29 13:17:11 remote5bge0 overchan[6982]: [ID 702911 news.error] input line too long, skipping
Aug 29 13:32:49 remote5bge0 overchan[6982]: [ID 702911 news.error] input line too long, skipping
Aug 29 15:15:12 remote5bge0 overchan[6982]: [ID 702911 news.error] input line too long, skipping
Aug 29 15:53:31 remote5bge0 overchan[6982]: [ID 702911 news.error] input line too long, skipping
Aug 29 18:11:28 remote5bge0 overchan[6982]: [ID 702911 news.error] input line too long, skipping
Aug 29 19:15:11 remote5bge0 overchan[6982]: [ID 702911 news.error] input line too long, skipping
Aug 29 22:28:34 remote5bge0 overchan[6982]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 20808 35.0%3.7 MB 41.2%
innd 17699 29.8%2.8 MB 30.7%
nnrpd 17178 28.9%1.8 MB 19.7%
innfeed 3730 6.3%771.1 KB 8.3%
overchan 13 0.0%1.7 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 59430 100.0%9.0 MB100.0%

History cache:

ReasonCount%Count
Cache misses 170124 51.9%
Do not exist 157440 48.1%
Positive hits 0 0.0%
Negative hits 0 0.0%
TOTAL: 4 327564 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.522 0.0%41112 0.000 0.013 0.083
article logging00:00:00.926 0.0%41450 0.000 0.022 0.902
article parse00:00:01.584 0.0%108544 0.000 0.015 0.038
article write00:02:06.332 0.1%24652 1.795 5.125 231.903
artlog/artparse00:00:00.000 0.0%16 0.000 0.000 0.000
data move00:00:00.378 0.0%345098 0.000 0.001 0.006
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.922 0.0%328084 0.002 0.009 0.018
history sync00:00:00.214 0.0%790 0.000 0.271 2.500
history write00:00:05.338 0.0%41120 0.014 0.130 1.037
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:36:29.200 99.8%383122 103.572 447.349 1251.630
nntp read00:00:03.094 0.0%382536 0.002 0.008 0.017
overview write00:00:00.204 0.0%24652 0.000 0.008 0.051
perl filter00:01:03.440 0.0%41104 1.096 1.543 4.339
python filter00:00:01.406 0.0%41106 0.000 0.034 0.113
site send00:00:01.772 0.0%73942 0.000 0.024 0.048
TOTAL: 47:42:09.99647:39:57.332 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.304 0.0%45186 0.000 0.007 0.045
article prepare00:00:00.010 0.0%15808 0.000 0.001 0.028
article read00:00:01.968 0.0%3426 0.000 0.574 17.750
backlog stats00:00:00.258 0.0%391966 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.474 0.0%240216 0.002 0.010 0.023
data write00:00:04.196 0.0%215628 0.009 0.019 0.041
idle47:34:23.318100.0%391966 131.476 436.934 985.133
status file00:00:05.652 0.0%396 1.000 14.273 94.133
TOTAL: 47:34:58.15047:34:38.180100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:06:39.052 95.5%17480 0.333 228.779 66005.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.810 0.1%318974 0.000 0.012 1.000
readart00:00:17.938 0.4%1792 2.333 10.010 44.000
TOTAL: 01:09:46.11601:07:00.800 96.1%----

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 29782 10716 16462 2604 35%94:38:58
2news.snarked.org 50 23672 6186 17208 278 26%56:49:42
3newsfeed.neva.ru 602 29686 3654 24808 1224 12%269:56:12
4feeder3.feed-ams.uzoreto.com 574 11744 2338 7024 2382 19%47:19:24
5newsfeed.fu-berlin.de 4 18038 876 17132 30 4%62:29:14
6ripco-out.news.tnetconsulting.net 2 23272 510 22740 22 2%38:13:14
7news-in.rahul.net 452 15136 114 14840 182 0%37:29:40
8news.lightlink.com 14 4696 28 4560 108 0%03:00:18
9ripco-out.feeder.erje.net 574 35488 12 26078 9398 0%47:16:44
10news.cmpublishers.com 52 7038 8 7030 0 0%47:58:52
11localhost 148 2 2 0 0 100%00:00:00
TOTAL: 11 3620 198554 24444 157882 16228 12%705:12:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com25.8 MB0.0 KB5.0 MB30.8 MB 83%2.4 KB
2news.snarked.org18.3 MB0.0 KB1.2 MB19.5 MB 94%3.1 KB
3ripco-out.news.tnetconsulting.net14.0 MB0.0 KB643.4 KB14.6 MB 95%28.2 KB
4newsfeed.neva.ru11.2 MB0.0 KB3.2 MB14.5 MB 77%3.0 KB
5news-in.rahul.net7.3 MB149.9 KB11.8 MB19.3 MB 38%66.6 KB
6feeder3.feed-ams.uzoreto.com5.9 MB0.0 KB4.2 MB10.2 MB 58%2.2 KB
7newsfeed.fu-berlin.de5.6 MB0.0 KB1.8 MB7.4 MB 75%8.4 KB
8news.lightlink.com2.2 MB0.0 KB5.3 MB7.5 MB 29%56.8 KB
9news.cmpublishers.com28.6 KB0.0 KB0.0 KB28.6 KB100%3.6 KB
10ripco-out.feeder.erje.net14.5 KB0.0 KB16.7 MB16.7 MB 0%1.8 KB
11localhost3.5 KB0.0 KB0.0 KB3.5 KB100%1.7 KB
TOTAL: 1190.5 MB149.9 KB49.9 MB140.5 MB 64%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 29 00:01:02 - 00:59:59 263 2.1% 0.07998.1 KB 2.1% 0.28
Aug 29 01:00:00 - 01:59:59 398 3.2% 0.111.2 MB 2.6% 0.34
Aug 29 02:00:00 - 02:59:59 390 3.2% 0.111.2 MB 2.6% 0.33
Aug 29 03:00:00 - 03:59:59 439 3.6% 0.121.5 MB 3.2% 0.41
Aug 29 04:00:00 - 04:59:59 460 3.7% 0.131.6 MB 3.5% 0.45
Aug 29 05:00:00 - 05:59:59 606 4.9% 0.171.7 MB 3.7% 0.48
Aug 29 06:00:00 - 06:59:59 520 4.2% 0.141.6 MB 3.5% 0.45
Aug 29 07:00:00 - 07:59:59 763 6.2% 0.212.1 MB 4.6% 0.60
Aug 29 08:00:00 - 08:59:59 586 4.7% 0.161.8 MB 3.9% 0.50
Aug 29 09:00:00 - 09:59:59 575 4.7% 0.162.0 MB 4.3% 0.56
Aug 29 10:00:00 - 10:59:59 739 6.0% 0.212.9 MB 6.4% 0.82
Aug 29 11:00:00 - 11:59:59 779 6.3% 0.223.0 MB 6.7% 0.86
Aug 29 12:00:00 - 12:59:59 653 5.3% 0.181.8 MB 4.1% 0.53
Aug 29 13:00:00 - 13:59:59 642 5.2% 0.182.0 MB 4.3% 0.56
Aug 29 14:00:00 - 14:59:59 750 6.1% 0.212.0 MB 4.5% 0.58
Aug 29 15:00:00 - 15:59:59 614 5.0% 0.172.6 MB 5.8% 0.75
Aug 29 16:00:00 - 16:59:59 590 4.8% 0.161.9 MB 4.2% 0.55
Aug 29 17:00:00 - 17:59:59 524 4.2% 0.152.1 MB 4.7% 0.61
Aug 29 18:00:00 - 18:59:59 400 3.2% 0.111.2 MB 2.6% 0.34
Aug 29 19:00:00 - 19:59:59 358 2.9% 0.101.1 MB 2.5% 0.32
Aug 29 20:00:00 - 20:59:59 295 2.4% 0.081.2 MB 2.6% 0.33
Aug 29 21:00:00 - 21:59:59 350 2.8% 0.104.9 MB 10.8% 1.40
Aug 29 22:00:00 - 22:59:59 350 2.8% 0.101.1 MB 2.4% 0.30
Aug 29 23:00:00 - 23:58:04 302 2.4% 0.092.1 MB 4.5% 0.61
TOTAL: 23:57:02 12346 100.0% 0.1445.5 MB 100.0% 0.54
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feeder.erje.net 4700 4696 0 0 0 0 0 0 4
2ripco-out.feed.uzoreto.com 1310 995 0 0 1 0 0 0 314
3feeder3.feed-ams.uzoreto.com 1191 886 0 0 4 0 0 0 301
4newsfeed.neva.ru 649 321 0 0 2 0 0 0 326
5news.lightlink.com 202 1 0 3 0 0 0 0 198
6newsfeed.fu-berlin.de 156 0 0 0 0 0 0 0 156
7news.snarked.org 141 40 0 0 0 0 0 0 101
8news-in.rahul.net 91 0 0 2 0 0 0 0 89
9ripco-out.news.tnetconsulting.net 20 9 0 0 0 0 0 0 11
10news.cmpublishers.com 2 1 0 0 0 0 0 0 1
TOTAL: 10 8462 6949 0 5 7 0 0 0 1501

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.de 4292
free.usenet 1908
alt.binaries.ftd 165
it.tlc.cellulari.android 57
free.it.scienza.fisica 27
scinet.stats 24
perl.cpan.uploads 24
alt.binaries.pictures.purebeauty 23
alt.binaries.e-book 20
fido7.su.pol.news 19
alt.binaries.pictures.wallpaper 18
alt.binaries.pictures.rail 17
alt.slack.goathead 15
it.comp.os.win.windows10 14
alt.binaries.pictures.earlmiller 14
fido7.ru.android 13
free.willey 12
scot.general 11
alt.binaries.pictures.scenic 11
alt.bestjobsusa.computer.jobs 9
TOTAL: 135 6949

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

GroupsCount
pl.praca.oferowana 4
alt.christnet.religion 2
bit.listserv.catholic 1
TOTAL: 3 7

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1390
Too many newsgroups 787
EMP (phl) 226
Binary in non-binary group 142
Scoring filter (8) 42
Scoring filter (9) 42
Scoring filter (10) 14
Scoring filter (11) 14
Scoring filter (15) 2
TOTAL: 9 2659

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 20
ripco-out.feed.uzoreto.com 2
TOTAL: 2 22
Including strange strings
newsfeed.fu-berlin.de 139
newsfeed.neva.ru 26
ripco-out.feed.uzoreto.com 4
TOTAL: 3 169
No colon-space in header
ripco-out.feed.uzoreto.com 5
feeder3.feed-ams.uzoreto.com 2
ripco-out.feeder.erje.net 1
TOTAL: 3 8
TOTAL: 3 199

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 20384 800 12256 8 0 4998 3%47:35:36
2feeder.erje.net 30612 760 21068 392 0 0 2%47:34:28
3news.lightlink.com 16042 202 15644 64 0 6404 1%47:34:36
4news.cmpublishers.com 36806 144 22876 1238 0 20 0%47:44:36
5news.tnetconsulting.net 36698 108 23766 6 0 26 0%47:50:42
6news.snarked.org 31258 50 18122 18 0 30 0%47:40:04
7fu-berlin.de 22230 40 22190 0 0 0 0%47:38:02
8news.uzoreto.com 11652 30 11048 70 0 0 0%47:40:04
9newsfeed.neva.ru 21646 14 20966 6 0 0 0%47:52:02
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:06
TOTAL: 10 227334 2148 167936 1808 0 11478 0%430:22:16
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net12.4 MB13.6 KB12.4 MB0.1 KB/s15.7 KB47:35:36
2feeder.erje.net2.0 MB1.1 MB3.1 MB0.0 KB/s2.7 KB47:34:28
3news.lightlink.com1.8 MB509.5 KB2.3 MB0.0 KB/s8.9 KB47:34:36
4news.cmpublishers.com582.2 KB3.5 MB4.1 MB0.0 KB/s3.0 KB47:44:36
5news.tnetconsulting.net276.2 KB18.5 KB294.8 KB0.0 KB/s2.6 KB47:50:42
6news.snarked.org190.3 KB30.4 KB220.7 KB0.0 KB/s3.2 KB47:40:04
7fu-berlin.de80.8 KB0.0 KB80.8 KB0.0 KB/s2.0 KB47:38:02
8news.uzoreto.com71.4 KB201.2 KB272.7 KB0.0 KB/s2.7 KB47:40:04
9newsfeed.neva.ru32.5 KB9.2 KB41.6 KB0.0 KB/s2.1 KB47:52:02
10remote6hme0.ripco.com0.0 KB17.6 KB17.6 KB0.0 KB/s2.9 KB01:12:06
TOTAL: 1017.4 MB5.3 MB22.8 MB0.0 KB/s5.9 KB430:22:16
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 8522.4 MB 382 2 000:08:08
2shell3.ripco.com 10 86465.3 KB 16 0 001:01:24
TOTAL: 2 296 9382.8 MB 398 2 001:09:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 8522.4 MB 382 2 000:08:08
2*.ripco.com 10 86465.3 KB 16 0 001:01:24
TOTAL: 2 296 9382.8 MB 398 2 001:09:32

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 2.262 1.352 0.00001:01:24
ftupet.com 46.684 21.270 0.00000:08:08
60.217.72.12 0.452 0.126 0.00000:00:02
33.20.97.83.ro.ovo.sc 0.202 0.048 0.00000:00:01
192.241.219.187 0.200 0.048 0.00000:00:00
TOTAL: 5 49.800 22.844 0.00001:09:36

NNRP no permission clients:

SystemConn
60.217.72.12 4
33.20.97.83.ro.ovo.sc 2
192.241.219.187 2
TOTAL: 3 8

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3.ripco.com 4 0
TOTAL: 1 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 920 98.1%
2news 6 0.6%
3alt 4 0.4%
4chi 4 0.4%
5comp 2 0.2%
6sci 2 0.2%
TOTAL: 6 938100.0%

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

NewsgroupCount
1rec.arts.tv 432
2rec.food.cooking 422
3rec.bicycles.tech 52
4rec.radio.broadcasting 6
5chi.weather 4
6alt.games.warcraft 4
7rec.bicycles.misc 4
8news.software.nntp 4
9rec.radio.swap 2
10rec.video.cable-tv 2
11comp.risks 2
12sci.electronics.repair 2
13news.admin.net-abuse.usenet 2
TOTAL: 13 938