Daily Usenet report for news.ripco.com

May 14 00:01:01 -- May 14 23:57:51

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

May 14 00:32:26 remote5bge0 overchan[4840]: [ID 702911 news.error] input line too long, skipping
May 14 00:47:33 remote5bge0 overchan[4840]: [ID 702911 news.error] input line too long, skipping
May 14 06:45:46 remote5bge0 overchan[4840]: [ID 702911 news.error] input line too long, skipping
May 14 08:42:56 remote5bge0 overchan[4840]: [ID 702911 news.error] input line too long, skipping
May 14 09:24:52 remote5bge0 overchan[4840]: [ID 702911 news.error] input line too long, skipping
May 14 14:55:47 remote5bge0 overchan[4840]: [ID 702911 news.error] input line too long, skipping
May 14 18:16:48 remote5bge0 overchan[4840]: [ID 702911 news.error] input line too long, skipping
May 14 19:47:07 remote5bge0 overchan[4840]: [ID 702911 news.error] input line too long, skipping
May 14 20:06:36 remote5bge0 overchan[4840]: [ID 702911 news.error] input line too long, skipping
May 14 20:37:28 remote5bge0 overchan[4840]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 30495 43.7%5.2 MB 49.0%
innd 18299 26.2%2.9 MB 26.8%
nnrpd 17303 24.8%1.8 MB 16.9%
innfeed 3652 5.2%785.4 KB 7.2%
overchan 10 0.0%1.3 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 69761 100.0%10.6 MB100.0%

History cache:

ReasonCount%Count
Cache misses 309654 58.2%
Do not exist 222298 41.8%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 531952 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%120 0.000 0.000 0.000
article cleanup00:00:00.542 0.0%60486 0.000 0.009 0.042
article logging00:00:01.176 0.0%60896 0.000 0.019 0.383
article parse00:00:02.002 0.0%140188 0.000 0.014 0.033
article write00:01:44.638 0.1%31530 1.206 3.319 76.853
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.392 0.0%429676 0.000 0.001 0.006
hishave/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.534 0.0%533000 0.003 0.009 0.022
history sync00:00:00.414 0.0%774 0.000 0.535 4.000
history write00:00:09.118 0.0%60486 0.020 0.151 1.710
hiswrite/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
idle47:35:42.860 99.8%487602 122.653 351.399 1323.373
nntp read00:00:03.524 0.0%489036 0.002 0.007 0.017
overview write00:00:00.260 0.0%31530 0.000 0.008 0.038
perl filter00:01:31.510 0.1%60484 1.245 1.513 2.453
python filter00:00:01.894 0.0%60494 0.000 0.031 0.106
site send00:00:02.296 0.0%94558 0.000 0.024 0.060
TOTAL: 47:42:06.37847:39:25.160 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.534 0.0%45750 0.000 0.012 0.055
article prepare00:00:00.010 0.0%27952 0.000 0.000 0.031
article read00:00:00.620 0.0%4798 0.000 0.129 5.769
backlog stats00:00:00.308 0.0%455922 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.258 0.0%291438 0.003 0.011 0.023
data write00:00:04.542 0.0%260246 0.006 0.017 0.034
idle47:52:56.042100.0%455922 110.743 378.082 919.313
status file00:00:02.932 0.0%376 1.000 7.798 90.000
TOTAL: 47:53:27.99247:53:08.246100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:46:59.312 98.7%18490 7.667 541.877 29198.812
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:06.602 0.1%664318 0.000 0.010 0.042
readart00:00:21.444 0.2%2798 2.028 7.664 74.000
TOTAL: 02:49:14.88402:47:27.358 98.9%----

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 129036 10884 114568 3584 8%94:49:58
2news.snarked.org 48 28660 7554 20450 656 26%54:30:54
3newsfeed.neva.ru 572 39432 5884 31686 1862 14%277:02:50
4feeder3.feed-ams.uzoreto.com 574 18394 5680 10748 1966 30%47:19:40
5ripco-out.news.tnetconsulting.net 6 33268 724 32508 36 2%28:18:28
6newsfeed.fu-berlin.de 4 15040 560 14444 36 3%45:56:22
7news.lightlink.com 2 6730 150 6564 16 2%43:34:40
8news-in.rahul.net 574 16312 140 16134 38 0%47:20:54
9ripco-out.feeder.erje.net 574 72582 44 51812 20726 0%47:14:56
10news.cmpublishers.com 52 9062 28 9012 22 0%47:59:40
11localhost 156 10 10 0 0 100%00:00:02
TOTAL: 11 3710 368526 31658 307926 28942 8%734:08:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com29.2 MB0.0 KB7.7 MB36.9 MB 79%2.6 KB
2news.snarked.org22.5 MB0.0 KB1.6 MB24.1 MB 93%3.0 KB
3newsfeed.neva.ru16.6 MB2.7 KB5.0 MB21.6 MB 76%2.9 KB
4feeder3.feed-ams.uzoreto.com13.9 MB0.0 KB3.6 MB17.6 MB 79%2.4 KB
5ripco-out.news.tnetconsulting.net10.0 MB0.0 KB1.1 MB11.2 MB 89%15.0 KB
6newsfeed.fu-berlin.de5.5 MB0.0 KB2.0 MB7.5 MB 73%12.9 KB
7news.lightlink.com4.1 MB0.0 KB741.9 KB4.8 MB 84%29.5 KB
8news-in.rahul.net1.7 MB0.0 KB694.7 KB2.4 MB 71%13.9 KB
9ripco-out.feeder.erje.net247.7 KB0.0 KB37.5 MB37.7 MB 0%1.9 KB
10news.cmpublishers.com53.8 KB0.0 KB45.7 KB99.5 KB 54%2.0 KB
11localhost28.9 KB0.0 KB0.0 KB28.9 KB100%2.9 KB
TOTAL: 11103.8 MB2.7 KB60.0 MB163.8 MB 63%2.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 14 00:01:01 - 00:59:59 386 2.4% 0.111.3 MB 2.4% 0.37
May 14 01:00:00 - 01:59:59 442 2.8% 0.121.3 MB 2.4% 0.37
May 14 02:00:00 - 02:59:59 552 3.5% 0.151.6 MB 3.0% 0.46
May 14 03:00:00 - 03:59:59 562 3.6% 0.161.7 MB 3.2% 0.48
May 14 04:00:00 - 04:59:59 784 5.0% 0.222.4 MB 4.4% 0.67
May 14 05:00:00 - 05:59:59 628 4.0% 0.172.0 MB 3.8% 0.57
May 14 06:00:00 - 06:59:59 717 4.5% 0.202.3 MB 4.3% 0.65
May 14 07:00:00 - 07:59:59 804 5.1% 0.223.1 MB 5.9% 0.89
May 14 08:00:00 - 08:59:59 861 5.5% 0.242.4 MB 4.6% 0.70
May 14 09:00:00 - 09:59:59 876 5.5% 0.242.5 MB 4.7% 0.72
May 14 10:00:00 - 10:59:59 1043 6.6% 0.294.4 MB 8.3% 1.26
May 14 11:00:00 - 11:59:59 835 5.3% 0.232.8 MB 5.3% 0.81
May 14 12:00:00 - 12:59:59 870 5.5% 0.242.9 MB 5.4% 0.82
May 14 13:00:00 - 13:59:59 934 5.9% 0.263.6 MB 6.7% 1.02
May 14 14:00:00 - 14:59:59 912 5.8% 0.253.1 MB 5.8% 0.89
May 14 15:00:00 - 15:59:59 847 5.4% 0.242.4 MB 4.4% 0.67
May 14 16:00:00 - 16:59:59 703 4.5% 0.202.8 MB 5.2% 0.79
May 14 17:00:00 - 17:59:59 601 3.8% 0.172.8 MB 5.2% 0.79
May 14 18:00:00 - 18:59:59 557 3.5% 0.151.8 MB 3.4% 0.52
May 14 19:00:00 - 19:59:59 517 3.3% 0.141.5 MB 2.7% 0.41
May 14 20:00:00 - 20:59:59 414 2.6% 0.121.3 MB 2.4% 0.36
May 14 21:00:00 - 21:59:59 355 2.2% 0.101.7 MB 3.1% 0.47
May 14 22:00:00 - 22:59:59 273 1.7% 0.08849.0 KB 1.6% 0.24
May 14 23:00:00 - 23:57:51 323 2.0% 0.091018.1 KB 1.9% 0.29
TOTAL: 23:56:50 15796 100.0% 0.1853.4 MB 100.0% 0.63
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feeder.erje.net 10364 10363 0 0 0 0 0 0 1
2ripco-out.feed.uzoreto.com 1799 1218 0 0 1 0 0 0 580
3feeder3.feed-ams.uzoreto.com 990 789 0 0 0 0 0 0 201
4newsfeed.neva.ru 981 537 0 1 0 0 0 0 443
5news.snarked.org 329 263 0 0 3 0 0 0 63
6newsfeed.fu-berlin.de 156 0 0 0 0 0 0 0 156
7ripco-out.news.tnetconsulting.net 30 8 0 0 0 0 0 0 22
8news.lightlink.com 22 6 0 0 0 0 0 0 16
9news-in.rahul.net 19 0 0 0 0 0 0 0 19
10news.cmpublishers.com 9 5 0 0 0 0 0 0 4
TOTAL: 10 14699 13189 0 1 4 0 0 0 1505

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.test 9890
free.usenet 2442
alt.binaries.ftd 194
fido7.su.pol.news 41
it.comp.os.win.windows10 37
perl.cpan.uploads 33
scot.general 30
alt.binaries.pictures.scenic 27
it.tlc.cellulari.android 26
free.it.scienza.fisica 22
alt.binaries.pictures.purebeauty 19
alt.binaries.e-book 19
alt.alan.c.sanderson.looks.like.a.dork 16
alt.music.pink-floyd.publius 15
it.eventi.covid19 14
nl.comp.os.linux.techniek 11
alt.binaries.mma 11
free.willey 10
alt.binaries.sounds.lossless.jazz 10
alt.binaries.humor.skewed 10
TOTAL: 143 13189

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

GroupsCount
pl.praca.oferowana 1
alt.christnet.religion 1
christnet.theology 1
bit.listserv.catholic 1
TOTAL: 4 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1306
Too many newsgroups 948
Binary in non-binary group 144
EMP (phl) 134
Scoring filter (8) 38
Scoring filter (9) 12
Scoring filter (16) 8
Scoring filter (10) 4
Scoring filter (11) 2
HTML post 2
TOTAL: 10 2598

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
ripco-out.feed.uzoreto.com 4
TOTAL: 2 22
Huge articles
newsfeed.fu-berlin.de 2
TOTAL: 1 2
Including strange strings
newsfeed.fu-berlin.de 139
newsfeed.neva.ru 54
feeder3.feed-ams.uzoreto.com 6
ripco-out.feed.uzoreto.com 4
news.snarked.org 1
TOTAL: 5 204
No colon-space in header
ripco-out.feed.uzoreto.com 1
TOTAL: 1 1
TOTAL: 4 229

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 34832 1826 26854 602 0 0 5%47:47:06
2news.lightlink.com 11168 1572 6448 18 0 16 14%47:40:00
3rahul.net 25768 744 14104 14 0 32 2%47:40:06
4news.tnetconsulting.net 38722 228 30674 24 0 13998 0%47:52:36
5news.cmpublishers.com 45376 210 29470 1450 0 50 0%47:40:02
6news.uzoreto.com 15176 42 14462 120 0 0 0%47:40:06
7fu-berlin.de 28628 34 28594 0 0 0 0%47:40:06
8news.snarked.org 39072 28 23774 0 0 100 0%47:40:04
9newsfeed.neva.ru 26040 22 25522 18 0 0 0%47:40:06
10remote6hme0.ripco.com 16 10 0 6 0 0 62%02:42:30
TOTAL: 10 264798 4716 199902 2252 0 14196 1%432:02:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net7.7 MB31.1 KB7.8 MB0.0 KB/s10.5 KB47:40:06
2feeder.erje.net5.6 MB1.2 MB6.8 MB0.0 KB/s2.9 KB47:47:06
3news.lightlink.com5.2 MB86.9 KB5.3 MB0.0 KB/s3.4 KB47:40:00
4news.cmpublishers.com705.2 KB4.0 MB4.7 MB0.0 KB/s2.9 KB47:40:02
5news.tnetconsulting.net588.1 KB124.7 KB712.8 KB0.0 KB/s2.8 KB47:52:36
6news.uzoreto.com175.4 KB482.7 KB658.1 KB0.0 KB/s4.1 KB47:40:06
7fu-berlin.de118.3 KB0.0 KB118.3 KB0.0 KB/s3.5 KB47:40:06
8news.snarked.org100.0 KB0.0 KB100.0 KB0.0 KB/s3.6 KB47:40:04
9newsfeed.neva.ru67.1 KB57.1 KB124.1 KB0.0 KB/s3.1 KB47:40:06
10remote6hme0.ripco.com25.7 KB38.0 KB63.7 KB0.0 KB/s4.0 KB02:42:30
TOTAL: 1020.3 MB6.0 MB26.3 MB0.0 KB/s3.9 KB432:02:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 11242.9 MB 460 2 000:07:36
2shell3 16 5481.6 MB 48 8 002:41:28
TOTAL: 2 302 16724.5 MB 508 10 002:49:05

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 11242.9 MB 460 2 000:07:36
2? 16 5481.6 MB 48 8 002:41:28
TOTAL: 2 302 16724.5 MB 508 10 002:49:05

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 4.154 6.054 0.00002:41:28
ftupet.com 46.816 21.698 0.00000:07:36
TOTAL: 2 50.970 27.752 0.00002:49:05

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 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1458 87.2%
2comp 100 6.0%
3misc 62 3.7%
4alt 26 1.6%
5chi 22 1.3%
6sci 2 0.1%
7news 2 0.1%
TOTAL: 7 1672100.0%

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

NewsgroupCount
1rec.arts.tv 844
2rec.food.cooking 460
3rec.bicycles.tech 120
4misc.phone.mobile.iphone 58
5comp.mail.sendmail 30
6comp.mobile.android 22
7chi.general 18
8comp.unix.bsd.freebsd.misc 14
9rec.boats.paddle 14
10alt.online-service.comcast 12
11comp.sys.mac.system 12
12comp.unix.solaris 8
13alt.stupidity 8
14comp.protocols.dns.bind 8
15rec.outdoors.rv-travel 8
16comp.sys.apple2 6
17rec.radio.broadcasting 6
18alt.security.alarms 4
19chi.weather 4
20rec.puzzles 4
21misc.consumers.frugal-living 4
22rec.radio.swap 2
23sci.electronics.repair 2
24alt.satellite.gps.garmin 2
25news.groups.questions 2
TOTAL: 25 1672