Daily Usenet report for news.ripco.com

May 7 00:01:01 -- May 7 23:57:42

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

May 7 06:44:10 remote5bge0 overchan[21199]: [ID 702911 news.error] input line too long, skipping
May 7 08:45:17 remote5bge0 overchan[21199]: [ID 702911 news.error] input line too long, skipping
May 7 12:23:10 remote5bge0 overchan[21199]: [ID 702911 news.error] input line too long, skipping
May 7 13:06:04 remote5bge0 overchan[21199]: [ID 702911 news.error] input line too long, skipping
May 7 15:09:00 remote5bge0 overchan[21199]: [ID 702911 news.error] input line too long, skipping
May 7 17:55:58 remote5bge0 overchan[21199]: [ID 702911 news.error] input line too long, skipping
May 7 18:21:06 remote5bge0 overchan[21199]: [ID 702911 news.error] input line too long, skipping
May 7 18:37:18 remote5bge0 overchan[21199]: [ID 702911 news.error] input line too long, skipping
May 7 22:19:35 remote5bge0 overchan[21199]: [ID 702911 news.error] input line too long, skipping
May 7 23:32:43 remote5bge0 overchan[21199]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 20720 34.1%4.1 MB 42.3%
innd 18673 30.8%2.9 MB 30.1%
nnrpd 17414 28.7%1.8 MB 18.8%
innfeed 3858 6.4%862.3 KB 8.8%
overchan 10 0.0%1.5 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 60677 100.0%9.6 MB100.0%

History cache:

ReasonCount%Count
Cache misses 193490 50.5%
Do not exist 189576 49.5%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 383066 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%104 0.000 0.000 0.000
article cleanup00:00:00.438 0.0%40936 0.000 0.011 0.036
article logging00:00:00.756 0.0%41364 0.000 0.018 0.180
article parse00:00:01.490 0.0%102400 0.000 0.015 0.036
article write00:01:44.380 0.1%32068 1.475 3.255 42.678
artlog/artparse00:00:00.000 0.0%8 0.000 0.000 0.000
data move00:00:00.380 0.0%394754 0.000 0.001 0.005
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.424 0.0%384376 0.002 0.009 0.019
history sync00:00:00.276 0.0%790 0.000 0.349 2.500
history write00:00:04.250 0.0%40944 0.016 0.104 4.192
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:36:17.486 99.8%431648 237.209 397.031 1050.060
nntp read00:00:03.128 0.0%432730 0.002 0.007 0.015
overview write00:00:00.286 0.0%32068 0.000 0.009 0.051
perl filter00:01:01.750 0.0%40936 1.207 1.508 2.577
python filter00:00:01.454 0.0%40946 0.000 0.036 0.137
site send00:00:03.206 0.0%96120 0.000 0.033 0.064
TOTAL: 47:41:59.83047:39:22.704 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.150 0.0%32320 0.000 0.005 0.036
article prepare00:00:00.000 0.0%10864 0.000 0.000 0.000
article read00:00:00.708 0.0%2074 0.000 0.341 8.222
backlog stats00:00:00.344 0.0%472654 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.306 0.0%305574 0.000 0.008 0.016
data write00:00:04.312 0.0%273826 0.005 0.016 0.031
idle47:52:44.476100.0%472654 220.955 364.674 993.296
status file00:00:05.426 0.0%402 0.750 13.498 78.200
TOTAL: 47:53:17.71647:52:57.722100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:19:55.000 98.9%18368 0.333 653.038 48654.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.974 0.0%564154 0.000 0.009 0.064
readart00:00:20.972 0.2%2782 0.000 7.538 69.000
TOTAL: 03:22:08.75603:20:20.946 99.1%----

Control commands to INND:

CommandNumber
L 2
flush 2
go 4
logmode 2
mode 290
name 5
pause 2
paused 2
reserve 4
TOTAL: 9 313

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 29818 9382 18268 2168 31%94:38:48
2news.snarked.org 46 29120 7720 20574 826 26%53:21:08
3feeder3.feed-ams.uzoreto.com 574 21866 7294 11926 2646 33%47:19:20
4newsfeed.neva.ru 604 38168 6032 30304 1832 15%278:41:20
5ripco-out.news.tnetconsulting.net 6 34226 650 33506 70 1%48:18:46
6newsfeed.fu-berlin.de 4 14030 584 13422 24 4%45:56:22
7news.lightlink.com 2 8182 202 7688 292 2%43:34:40
8news-in.rahul.net 574 15978 138 15808 32 0%47:20:24
9ripco-out.feeder.erje.net 574 33756 96 32688 972 0%47:17:44
10localhost 156 10 10 0 0 100%00:00:02
11news.cmpublishers.com 52 9388 8 9378 2 0%47:58:44
TOTAL: 11 3740 234542 32116 193562 8864 13%754:27:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com23.6 MB0.0 KB4.8 MB28.4 MB 82%2.5 KB
2news.snarked.org22.8 MB0.0 KB2.1 MB24.9 MB 91%3.0 KB
3feeder3.feed-ams.uzoreto.com18.2 MB0.0 KB4.9 MB23.1 MB 78%2.4 KB
4newsfeed.neva.ru17.4 MB0.0 KB4.3 MB21.6 MB 80%2.8 KB
5ripco-out.news.tnetconsulting.net8.5 MB0.0 KB1.1 MB9.6 MB 88%13.7 KB
6news-in.rahul.net4.1 MB0.0 KB825.1 KB4.9 MB 83%29.3 KB
7newsfeed.fu-berlin.de3.0 MB0.0 KB1.7 MB4.7 MB 64%7.9 KB
8news.lightlink.com2.6 MB0.0 KB11.1 MB13.7 MB 19%28.4 KB
9ripco-out.feeder.erje.net185.6 KB0.0 KB7.7 MB7.8 MB 2%7.5 KB
10localhost40.8 KB0.0 KB0.0 KB40.8 KB100%4.1 KB
11news.cmpublishers.com20.1 KB0.0 KB2.4 KB22.5 KB 89%2.2 KB
TOTAL: 11100.5 MB0.0 KB38.4 MB138.8 MB 72%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 7 00:01:01 - 00:59:59 298 1.9% 0.081.0 MB 2.0% 0.29
May 7 01:00:00 - 01:59:59 439 2.7% 0.121.3 MB 2.7% 0.38
May 7 02:00:00 - 02:59:59 587 3.7% 0.161.6 MB 3.2% 0.46
May 7 03:00:00 - 03:59:59 727 4.5% 0.202.1 MB 4.3% 0.61
May 7 04:00:00 - 04:59:59 799 5.0% 0.223.0 MB 6.1% 0.86
May 7 05:00:00 - 05:59:59 636 4.0% 0.181.9 MB 3.9% 0.55
May 7 06:00:00 - 06:59:59 695 4.3% 0.192.2 MB 4.4% 0.62
May 7 07:00:00 - 07:59:59 767 4.8% 0.212.2 MB 4.4% 0.62
May 7 08:00:00 - 08:59:59 996 6.2% 0.282.9 MB 5.8% 0.82
May 7 09:00:00 - 09:59:59 834 5.2% 0.232.8 MB 5.7% 0.81
May 7 10:00:00 - 10:59:59 902 5.6% 0.252.9 MB 5.8% 0.82
May 7 11:00:00 - 11:59:59 962 6.0% 0.272.6 MB 5.3% 0.75
May 7 12:00:00 - 12:59:59 933 5.8% 0.262.8 MB 5.6% 0.79
May 7 13:00:00 - 13:59:59 969 6.0% 0.272.9 MB 5.8% 0.82
May 7 14:00:00 - 14:59:59 901 5.6% 0.252.6 MB 5.3% 0.75
May 7 15:00:00 - 15:59:59 839 5.2% 0.232.3 MB 4.6% 0.65
May 7 16:00:00 - 16:59:59 745 4.6% 0.212.3 MB 4.7% 0.66
May 7 17:00:00 - 17:59:59 657 4.1% 0.182.0 MB 4.0% 0.56
May 7 18:00:00 - 18:59:59 539 3.4% 0.151.8 MB 3.7% 0.52
May 7 19:00:00 - 19:59:59 463 2.9% 0.132.0 MB 4.1% 0.58
May 7 20:00:00 - 20:59:59 368 2.3% 0.101.1 MB 2.2% 0.31
May 7 21:00:00 - 21:59:59 353 2.2% 0.101.0 MB 2.1% 0.30
May 7 22:00:00 - 22:59:59 339 2.1% 0.091.1 MB 2.2% 0.31
May 7 23:00:00 - 23:57:42 313 1.9% 0.09980.0 KB 1.9% 0.28
TOTAL: 23:56:41 16061 100.0% 0.1949.6 MB 100.0% 0.59
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feeder3.feed-ams.uzoreto.com 1351 1103 0 0 4 0 0 0 244
2ripco-out.feed.uzoreto.com 1089 612 0 0 4 0 0 0 473
3newsfeed.neva.ru 965 473 0 0 2 0 0 0 490
4ripco-out.feeder.erje.net 486 484 0 0 0 0 0 0 2
5news.snarked.org 407 318 0 0 1 0 0 0 88
6news.lightlink.com 196 0 0 0 0 0 0 0 196
7newsfeed.fu-berlin.de 123 0 0 0 0 0 0 0 123
8ripco-out.news.tnetconsulting.net 25 7 0 0 0 0 0 0 18
9news-in.rahul.net 16 0 0 0 0 0 0 0 16
10news.cmpublishers.com 1 0 0 0 0 0 0 0 1
TOTAL: 10 4659 2997 0 0 11 0 0 0 1651

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2103
alt.binaries.ftd 217
free.it.scienza.fisica 56
fido7.su.pol.news 53
scot.general 50
it.comp.os.win.windows10 38
perl.cpan.uploads 37
alt.binaries.3d.poser 29
alt.binaries.pictures.scenic 25
alt.binaries.e-book 24
free.willey 19
alt.binaries.backup 17
it.eventi.covid19 16
alt.binaries.nospam.breasts.natural 15
alt.bestjobsusa.computer.jobs 14
it.tlc.cellulari.android 13
alt.binaries.test.yenc 13
alt.binaries.sounds.lossless.jazz 9
alt.my.job.sucks 7
alt.binaries.mac.games 7
TOTAL: 143 2997

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

GroupsCount
pl.praca.oferowana 4
rec.travel.resorts.all-inclusive 3
christnet.bible 2
dk.bolig 1
bit.listserv.catholic 1
TOTAL: 5 11

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1702
Too many newsgroups 634
EMP (phl) 284
Binary in non-binary group 188
Scoring filter (8) 28
Scoring filter (9) 12
Scoring filter (10) 6
Scoring filter (13) 4
Scoring filter (18) 2
Scoring filter (11) 2
Attached HTML file 2
TOTAL: 11 2864

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 38
ripco-out.feed.uzoreto.com 12
feeder3.feed-ams.uzoreto.com 12
TOTAL: 3 62
Including strange strings
newsfeed.fu-berlin.de 111
newsfeed.neva.ru 71
feeder3.feed-ams.uzoreto.com 27
ripco-out.feed.uzoreto.com 4
news.snarked.org 2
TOTAL: 5 215
No colon-space in header
ripco-out.feeder.erje.net 2
ripco-out.feed.uzoreto.com 2
TOTAL: 2 4
TOTAL: 3 281

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 24926 678 13926 44 0 18 2%47:40:08
2news.lightlink.com 10954 598 6792 34 0 14 5%47:40:06
3feeder.erje.net 35672 410 30052 322 0 0 1%47:40:02
4remote6hme0.ripco.com 106 64 0 42 0 4 60%15:07:04
5news.cmpublishers.com 45792 38 31430 264 0 58 0%47:40:02
6fu-berlin.de 29008 34 28974 0 0 0 0%47:40:18
7news.snarked.org 39212 26 23746 6 0 60 0%47:47:08
8news.tnetconsulting.net 45170 24 31296 2 0 38 0%47:46:44
9news.uzoreto.com 15324 20 15046 32 0 0 0%47:48:52
10newsfeed.neva.ru 26558 14 25920 14 0 0 0%47:40:08
TOTAL: 10 272722 1906 207182 760 0 192 0%444:30:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net3.0 MB126.3 KB3.2 MB0.0 KB/s4.5 KB47:40:08
2news.lightlink.com2.7 MB155.4 KB2.8 MB0.0 KB/s4.6 KB47:40:06
3feeder.erje.net1.5 MB1.1 MB2.6 MB0.0 KB/s3.7 KB47:40:02
4remote6hme0.ripco.com280.7 KB171.8 KB452.5 KB0.0 KB/s4.3 KB15:07:04
5news.uzoreto.com229.6 KB69.2 KB298.8 KB0.0 KB/s5.7 KB47:48:52
6fu-berlin.de195.6 KB0.0 KB195.6 KB0.0 KB/s5.8 KB47:40:18
7news.tnetconsulting.net172.8 KB6.6 KB179.3 KB0.0 KB/s6.9 KB47:46:44
8news.snarked.org172.5 KB53.2 KB225.7 KB0.0 KB/s7.1 KB47:47:08
9news.cmpublishers.com169.9 KB681.0 KB851.0 KB0.0 KB/s2.8 KB47:40:02
10newsfeed.neva.ru132.1 KB50.7 KB182.8 KB0.0 KB/s6.5 KB47:40:08
TOTAL: 108.5 MB2.4 MB11.0 MB0.0 KB/s4.2 KB444:30:32
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 11603.3 MB 436 2 000:07:46
2shell3 22 4601.8 MB 36 8 003:14:08
TOTAL: 2 308 16205.1 MB 472 10 003:21:59

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 11603.3 MB 436 2 000:07:46
2? 22 4601.8 MB 36 8 003:14:08
TOTAL: 2 308 16205.1 MB 472 10 003:21:55

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 4.674 2.700 0.00003:14:08
ftupet.com 46.340 21.442 0.00000:07:46
223.71.167.164 0.200 0.054 0.00000:00:03
162.243.140.180 0.206 0.056 0.00000:00:00
worker-18.sfj.corp.censys.io 0.202 0.050 0.00000:00:00
TOTAL: 5 51.622 24.302 0.00003:21:59

NNRP no permission clients:

SystemConn
162.243.140.180 2
223.71.167.164 2
worker-18.sfj.corp.censys.io 2
TOTAL: 3 6

NNRP unrecognized commands (by host):

SystemConn
shell3 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 6 0
TOTAL: 1 6 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1438 88.8%
2comp 66 4.1%
3chi 54 3.3%
4sci 26 1.6%
5alt 24 1.5%
6news 6 0.4%
7misc 4 0.2%
8ba 2 0.1%
TOTAL: 8 1620100.0%

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

NewsgroupCount
1rec.arts.tv 956
2rec.food.cooking 378
3rec.bicycles.tech 88
4chi.general 46
5comp.sys.mac.system 46
6sci.electronics.repair 26
7alt.stupidity 12
8comp.protocols.dns.bind 12
9rec.radio.broadcasting 6
10comp.mail.sendmail 6
11alt.satellite.gps.garmin 6
12chi.forsale 4
13news.software.readers 4
14alt.games.warcraft 4
15chi.weather 4
16rec.gardens.edible 4
17rec.puzzles 4
18misc.consumers.frugal-living 4
19rec.radio.swap 2
20comp.sys.ibm.pc.games.strategic 2
21news.admin.net-abuse.usenet 2
22ba.food 2
23alt.free.newsservers 2
TOTAL: 23 1620