Daily Usenet report for news.ripco.com

Oct 10 00:01:02 -- Oct 10 23:57:56

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Oct 10 01:02:04 remote5bge0 overchan[3096]: [ID 702911 news.error] input line too long, skipping
Oct 10 07:16:37 remote5bge0 overchan[3096]: [ID 702911 news.error] input line too long, skipping
Oct 10 08:25:23 remote5bge0 overchan[3096]: [ID 702911 news.error] input line too long, skipping
Oct 10 10:05:16 remote5bge0 overchan[3096]: [ID 702911 news.error] input line too long, skipping
Oct 10 10:56:40 remote5bge0 overchan[3096]: [ID 702911 news.error] input line too long, skipping
Oct 10 13:31:23 remote5bge0 overchan[3096]: [ID 702911 news.error] input line too long, skipping
Oct 10 13:50:09 remote5bge0 overchan[3096]: [ID 702911 news.error] input line too long, skipping
Oct 10 16:03:56 remote5bge0 overchan[3096]: [ID 702911 news.error] input line too long, skipping
Oct 10 18:35:14 remote5bge0 overchan[3096]: [ID 702911 news.error] input line too long, skipping
Oct 10 18:47:00 remote5bge0 overchan[3096]: [ID 702911 news.error] input line too long, skipping
Oct 10 19:15:14 remote5bge0 overchan[3096]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 17729 31.9%2.8 MB 32.1%
nnrpd 17280 31.1%1.8 MB 20.9%
inn 16921 30.4%3.3 MB 37.9%
innfeed 3641 6.6%797.5 KB 9.1%
overchan 11 0.0%1.5 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 55584 100.0%8.6 MB100.0%

History cache:

ReasonCount%Count
Cache misses 156422 51.0%
Do not exist 150538 49.0%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 306960 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%90 0.000 0.000 0.000
article cleanup00:00:00.390 0.0%33578 0.000 0.012 0.071
article logging00:00:00.768 0.0%33952 0.000 0.023 0.142
article parse00:00:01.162 0.0%83234 0.000 0.014 0.047
article write00:01:17.806 0.0%24304 1.430 3.201 69.135
artlog/artparse00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:00.332 0.0%301436 0.000 0.001 0.008
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.724 0.0%308988 0.000 0.009 0.020
history sync00:00:00.322 0.0%808 0.000 0.399 4.333
history write00:00:03.322 0.0%33588 0.022 0.099 3.045
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:57:20.352 99.8%339402 147.236 508.660 1408.481
nntp read00:00:02.894 0.0%337922 0.003 0.009 0.021
overview write00:00:00.282 0.0%24304 0.000 0.012 0.048
perl filter00:00:50.372 0.0%33578 1.222 1.500 2.000
python filter00:00:01.310 0.0%33580 0.000 0.039 0.111
site send00:00:01.756 0.0%72864 0.004 0.024 0.065
TOTAL: 48:02:10.16447:59:43.792 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.306 0.0%40746 0.000 0.008 0.047
article prepare00:00:00.004 0.0%22384 0.000 0.000 0.015
article read00:00:00.564 0.0%4158 0.000 0.136 11.833
backlog stats00:00:00.342 0.0%362098 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.350 0.0%224144 0.003 0.010 0.027
data write00:00:04.128 0.0%200308 0.007 0.021 0.070
idle47:37:24.838100.0%362098 137.898 473.476 1333.239
status file00:00:02.232 0.0%388 0.000 5.753 26.000
TOTAL: 47:37:54.88247:37:34.764100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:03:31.126 95.4%17912 18.417 413.752 24422.039
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:06.316 0.1%581000 0.000 0.011 1.000
readart00:00:21.222 0.3%2370 2.267 8.954 38.500
TOTAL: 02:09:31.29402:03:58.664 95.7%----

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 28910 8660 16592 3658 29%94:38:58
2feeder3.feed-ams.uzoreto.com 574 15980 5356 7868 2756 33%47:20:10
3news.snarked.org 50 23188 4770 18120 298 20%54:11:02
4newsfeed.neva.ru 602 25970 4194 20626 1150 16%272:42:34
5ripco-out.news.tnetconsulting.net 16 31944 818 31020 106 2%34:01:48
6newsfeed.fu-berlin.de 4 12452 434 11990 28 3%47:47:02
7news-in.rahul.net 574 13162 122 13022 18 0%47:18:20
8ripco-out.feeder.erje.net 574 27402 62 26064 1276 0%47:17:58
9news.lightlink.com 2 7890 60 7772 58 0%52:29:26
10news.cmpublishers.com 50 8316 20 8276 20 0%48:00:00
11localhost 148 2 2 0 0 100%00:00:04
TOTAL: 11 3742 195216 24498 161350 9368 12%745:47:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com21.8 MB0.0 KB7.4 MB29.2 MB 74%2.4 KB
2feeder3.feed-ams.uzoreto.com13.8 MB0.0 KB4.9 MB18.7 MB 73%2.4 KB
3news.snarked.org13.5 MB0.0 KB1.1 MB14.5 MB 92%2.9 KB
4newsfeed.neva.ru12.7 MB0.0 KB2.9 MB15.6 MB 81%3.0 KB
5news-in.rahul.net6.6 MB0.0 KB1.1 MB7.7 MB 85%56.3 KB
6ripco-out.news.tnetconsulting.net5.3 MB0.0 KB1.2 MB6.5 MB 80%7.2 KB
7newsfeed.fu-berlin.de3.3 MB0.0 KB999.5 KB4.2 MB 76%9.4 KB
8news.lightlink.com989.1 KB0.0 KB3.9 MB4.9 MB 19%42.2 KB
9ripco-out.feeder.erje.net167.1 KB0.0 KB12.2 MB12.3 MB 1%9.4 KB
10news.cmpublishers.com39.5 KB0.0 KB53.5 KB93.0 KB 42%2.3 KB
11localhost4.0 KB0.0 KB0.0 KB4.0 KB100%2.0 KB
TOTAL: 1178.0 MB0.0 KB35.8 MB113.8 MB 68%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 10 00:01:02 - 00:59:59 224 1.8% 0.06647.6 KB 1.6% 0.18
Oct 10 01:00:00 - 01:59:59 290 2.4% 0.08920.0 KB 2.3% 0.26
Oct 10 02:00:00 - 02:59:59 492 4.1% 0.141.3 MB 3.4% 0.38
Oct 10 03:00:00 - 03:59:59 512 4.2% 0.141.7 MB 4.5% 0.49
Oct 10 04:00:00 - 04:59:59 583 4.8% 0.161.5 MB 3.8% 0.42
Oct 10 05:00:00 - 05:59:59 622 5.1% 0.172.2 MB 5.7% 0.62
Oct 10 06:00:00 - 06:59:59 607 5.0% 0.171.7 MB 4.3% 0.47
Oct 10 07:00:00 - 07:59:59 537 4.4% 0.151.5 MB 4.0% 0.44
Oct 10 08:00:00 - 08:59:59 723 6.0% 0.202.2 MB 5.6% 0.62
Oct 10 09:00:00 - 09:59:59 686 5.7% 0.193.3 MB 8.5% 0.93
Oct 10 10:00:00 - 10:59:59 729 6.0% 0.202.4 MB 6.1% 0.67
Oct 10 11:00:00 - 11:59:59 748 6.2% 0.213.0 MB 7.7% 0.84
Oct 10 12:00:00 - 12:59:59 698 5.8% 0.192.0 MB 5.1% 0.57
Oct 10 13:00:00 - 13:59:59 608 5.0% 0.171.5 MB 3.9% 0.43
Oct 10 14:00:00 - 14:59:59 586 4.8% 0.162.4 MB 6.2% 0.68
Oct 10 15:00:00 - 15:59:59 620 5.1% 0.171.7 MB 4.5% 0.49
Oct 10 16:00:00 - 16:59:59 590 4.9% 0.161.6 MB 4.1% 0.45
Oct 10 17:00:00 - 17:59:59 477 3.9% 0.131.3 MB 3.4% 0.38
Oct 10 18:00:00 - 18:59:59 353 2.9% 0.10992.4 KB 2.5% 0.28
Oct 10 19:00:00 - 19:59:59 256 2.1% 0.07777.2 KB 2.0% 0.22
Oct 10 20:00:00 - 20:59:59 287 2.4% 0.08926.4 KB 2.3% 0.26
Oct 10 21:00:00 - 21:59:59 263 2.2% 0.07645.4 KB 1.6% 0.18
Oct 10 22:00:00 - 22:59:59 350 2.9% 0.101.6 MB 4.0% 0.44
Oct 10 23:00:00 - 23:57:56 276 2.3% 0.081.0 MB 2.6% 0.30
TOTAL: 23:56:54 12117 100.0% 0.1438.6 MB 100.0% 0.46
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1835 1266 0 0 6 0 0 0 563
2feeder3.feed-ams.uzoreto.com 1410 1107 0 0 1 0 0 0 302
3ripco-out.feeder.erje.net 637 625 0 0 0 0 0 0 12
4newsfeed.neva.ru 610 384 0 0 4 0 0 0 222
5news.snarked.org 145 74 0 0 4 0 0 0 67
6newsfeed.fu-berlin.de 121 0 0 0 0 0 0 0 121
7ripco-out.news.tnetconsulting.net 25 11 0 0 0 0 0 0 14
8news-in.rahul.net 9 0 0 0 0 0 0 0 9
9news.cmpublishers.com 7 0 0 0 0 0 0 0 7
10news.lightlink.com 5 0 0 0 0 0 0 0 5
TOTAL: 10 4804 3467 0 0 15 0 0 0 1322

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2523
alt.binaries.ftd 380
scot.general 40
alt.bestjobsusa.computer.jobs 38
it.tlc.cellulari.android 33
alt.binaries.nospam.breasts.natural 28
scinet.stats 26
alt.binaries.e-book 25
free.willey 23
fido7.su.pol.news 19
alt.binaries.pictures.purebeauty 14
aus.jobs 11
alt.my.job.sucks 11
alt.binaries.pictures.earlmiller 11
alt.jobs.jobsearch 11
alt.binaries.pictures.erotica.vintage 11
at.jobs 10
att.jobs 10
alt.binaries.pictures.rail 10
it.comp.os.win.windows10 10
TOTAL: 111 3467

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

GroupsCount
pl.praca.oferowana 7
fr.comp.securite 5
fr.bienvenue 1
bit.listserv.catholic 1
alt.christnet.christnews 1
TOTAL: 5 15

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1112
EMP (md5) 814
EMP (phl) 226
Binary in non-binary group 68
Scoring filter (8) 26
Scoring filter (9) 14
HTML post 2
TOTAL: 7 2262

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 20
feeder3.feed-ams.uzoreto.com 2
TOTAL: 2 22
Including strange strings
newsfeed.fu-berlin.de 106
newsfeed.neva.ru 40
feeder3.feed-ams.uzoreto.com 32
ripco-out.feed.uzoreto.com 9
TOTAL: 4 187
No colon-space in header
ripco-out.feeder.erje.net 5
TOTAL: 1 5
TOTAL: 3 214

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 27060 1648 20714 618 0 0 6%47:51:30
2news.lightlink.com 11756 960 5600 138 0 0 8%47:40:04
3rahul.net 21452 902 11264 4 0 14 4%47:40:02
4news.cmpublishers.com 35562 60 22838 966 0 20 0%47:32:40
5news.tnetconsulting.net 26968 50 23424 34 0 16568 0%47:38:50
6fu-berlin.de 21882 50 21832 0 0 0 0%47:40:04
7news.uzoreto.com 10056 28 9722 102 0 0 0%47:34:26
8news.snarked.org 32388 24 19212 2 0 26 0%47:40:02
9newsfeed.neva.ru 20616 10 19940 4 0 0 0%47:40:04
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:10
TOTAL: 10 207746 3732 154546 1874 0 16628 1%430:09:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1feeder.erje.net4.4 MB1.6 MB6.1 MB0.0 KB/s2.7 KB47:51:30
2news.lightlink.com3.3 MB629.6 KB3.9 MB0.0 KB/s3.6 KB47:40:04
3rahul.net3.1 MB57.8 KB3.2 MB0.0 KB/s3.6 KB47:40:02
4news.cmpublishers.com217.3 KB2.6 MB2.8 MB0.0 KB/s2.8 KB47:32:40
5news.snarked.org170.2 KB4.4 KB174.6 KB0.0 KB/s6.7 KB47:40:02
6news.tnetconsulting.net156.4 KB60.6 KB217.1 KB0.0 KB/s2.6 KB47:38:50
7fu-berlin.de150.5 KB0.0 KB150.5 KB0.0 KB/s3.0 KB47:40:04
8news.uzoreto.com104.7 KB213.0 KB317.7 KB0.0 KB/s2.4 KB47:34:26
9newsfeed.neva.ru99.1 KB46.0 KB145.1 KB0.0 KB/s10.4 KB47:40:04
10remote6hme0.ripco.com0.0 KB29.5 KB29.5 KB0.0 KB/s4.9 KB01:12:10
TOTAL: 1011.7 MB5.3 MB17.0 MB0.0 KB/s3.1 KB430:09:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9902.7 MB 396 2 000:11:03
2shell3.ripco.com 6 3881.1 MB 56 0 001:58:14
TOTAL: 2 292 13783.8 MB 452 2 002:09:21

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9902.7 MB 396 2 000:11:03
2*.ripco.com 6 3881.1 MB 56 0 001:58:14
TOTAL: 2 292 13783.8 MB 452 2 002:09:17

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 2.762 2.216 0.00001:58:14
ftupet.com 48.060 21.412 0.00000:11:03
23.81.234.17 0.806 0.208 0.00000:00:01
scan-141.security.ipip.net 0.206 0.050 0.00000:00:01
108-83-48-88.lightspeed.cicril.sbcglobal.net 0.200 0.052 0.00000:00:00
162.243.128.237 0.202 0.054 0.00000:00:00
TOTAL: 6 52.236 23.992 0.00002:09:21

NNRP no permission clients:

SystemConn
23.81.234.17 8
162.243.128.237 2
scan-141.security.ipip.net 2
108-83-48-88.lightspeed.cicril.sbcglobal.net 2
TOTAL: 4 14

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 1210 87.8%
2alt 50 3.6%
3sci 44 3.2%
4comp 30 2.2%
5seattle 14 1.0%
6news 12 0.9%
7misc 12 0.9%
8chi 6 0.4%
TOTAL: 8 1378100.0%

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

NewsgroupCount
1rec.arts.tv 596
2rec.food.cooking 560
3sci.electronics.repair 44
4alt.comp.os.windows-10 38
5comp.mobile.android 18
6rec.bicycles.tech 18
7seattle.general 14
8misc.consumers.frugal-living 10
9rec.radio.shortwave 8
10rec.audio.tubes 6
11rec.puzzles 6
12news.software.nntp 6
13rec.radio.broadcasting 6
14rec.gardens.edible 4
15comp.sys.apple2 4
16news.admin.hierarchies 4
17alt.free.newsservers 4
18comp.sys.mac.apps 4
19rec.radio.scanner 4
20alt.tv.tech.hdtv 4
21chi.weather 4
22misc.phone.mobile.iphone 2
23news.admin.net-abuse.usenet 2
24alt.hvac 2
25rec.radio.swap 2
26comp.sys.mac.system 2
27comp.risks 2
28alt.video.digital-tv 2
29chi.eats 2
TOTAL: 29 1378