Daily Usenet report for news.ripco.com

Apr 25 00:01:02 -- Apr 25 23:56:48

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Apr 25 02:05:28 remote5bge0 overchan[17067]: [ID 702911 news.error] input line too long, skipping
Apr 25 13:27:12 remote5bge0 overchan[17067]: [ID 702911 news.error] input line too long, skipping
Apr 25 14:45:52 remote5bge0 overchan[17067]: [ID 702911 news.error] input line too long, skipping
Apr 25 17:15:48 remote5bge0 overchan[17067]: [ID 702911 news.error] input line too long, skipping
Apr 25 22:25:21 remote5bge0 overchan[17067]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 21297 35.3%4.2 MB 43.6%
innd 18123 30.1%2.8 MB 29.5%
nnrpd 17250 28.6%1.8 MB 18.7%
innfeed 3606 6.0%799.5 KB 8.2%
overchan 5 0.0%0.6 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 60283 100.0%9.6 MB100.0%

History cache:

ReasonCount%Count
Cache misses 205012 52.0%
Do not exist 188970 48.0%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 393982 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%66 0.000 0.000 0.000
article cleanup00:00:00.438 0.0%42044 0.000 0.010 0.039
article logging00:00:00.806 0.0%42480 0.000 0.019 0.221
article parse00:00:01.742 0.0%106304 0.000 0.016 0.115
article write00:01:47.012 0.1%32726 1.818 3.270 99.211
artlog/artparse00:00:00.000 0.0%34 0.000 0.000 0.000
data move00:00:00.466 0.0%405784 0.000 0.001 0.004
hishave/artparse00:00:00.000 0.0%24 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.234 0.0%394518 0.003 0.008 0.022
history sync00:00:00.256 0.0%796 0.000 0.322 1.667
history write00:00:03.378 0.0%42050 0.012 0.080 0.584
hiswrite/artparse00:00:00.006 0.0%24 0.125 0.250 0.500
idle47:36:27.286 99.8%445080 196.785 385.071 1093.662
nntp read00:00:03.268 0.0%445802 0.003 0.007 0.018
overview write00:00:00.274 0.0%32726 0.000 0.008 0.035
perl filter00:01:00.408 0.0%42042 1.209 1.437 2.152
python filter00:00:01.546 0.0%42044 0.000 0.037 0.114
site send00:00:03.184 0.0%98152 0.006 0.032 0.060
TOTAL: 47:42:05.25847:39:33.304 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.152 0.0%33122 0.000 0.005 0.043
article prepare00:00:00.002 0.0%24600 0.000 0.000 0.009
article read00:00:00.690 0.0%5236 0.000 0.132 3.333
backlog stats00:00:00.340 0.0%488544 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.260 0.0%315318 0.000 0.007 0.014
data write00:00:04.406 0.0%282856 0.008 0.016 0.035
idle47:50:57.244100.0%488544 200.917 352.593 958.711
status file00:00:01.864 0.0%354 0.600 5.266 32.000
TOTAL: 47:51:26.97847:51:06.958100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:21:41.080 99.1%18580 18.319 845.053 30346.587
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:06.908 0.0%670448 0.000 0.010 1.000
readart00:00:25.228 0.2%2912 2.188 8.663 43.500
TOTAL: 04:24:05.47004:22:13.216 99.3%----

Control commands to INND:

CommandNumber
L 2
flush 2
go 4
logmode 2
mode 291
name 2
pause 2
paused 2
reserve 4
TOTAL: 9 311

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 36880 10008 22438 4434 27%94:48:24
2news.snarked.org 52 31066 8390 22348 328 27%54:45:24
3feeder3.feed-ams.uzoreto.com 576 18922 7038 10036 1848 37%47:09:26
4newsfeed.neva.ru 582 41142 5376 34210 1556 13%276:16:10
5ripco-out.news.tnetconsulting.net 2 36394 1008 35302 84 2%49:16:02
6newsfeed.fu-berlin.de 2 16310 598 15562 150 3%47:05:30
7news.lightlink.com 2 7076 228 6758 90 3%43:34:40
8news-in.rahul.net 574 16038 116 15882 40 0%47:29:52
9ripco-out.feeder.erje.net 574 35290 36 34324 930 0%47:16:24
10news.cmpublishers.com 50 9026 2 9022 2 0%48:00:02
11localhost 148 2 2 0 0 100%00:00:06
TOTAL: 11 3710 248146 32802 205882 9462 13%755:42:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org25.3 MB0.0 KB1.2 MB26.5 MB 95%3.1 KB
2ripco-out.feed.uzoreto.com24.6 MB0.0 KB8.3 MB32.9 MB 74%2.3 KB
3feeder3.feed-ams.uzoreto.com18.0 MB0.0 KB4.2 MB22.2 MB 81%2.6 KB
4newsfeed.neva.ru16.6 MB0.0 KB4.5 MB21.1 MB 78%3.1 KB
5ripco-out.news.tnetconsulting.net11.1 MB0.0 KB3.5 MB14.6 MB 76%13.7 KB
6newsfeed.fu-berlin.de4.6 MB0.0 KB42.5 MB47.2 MB 9%64.6 KB
7news.lightlink.com3.8 MB143.7 KB5.9 MB9.8 MB 38%31.5 KB
8news-in.rahul.net2.6 MB0.0 KB1.8 MB4.4 MB 58%29.0 KB
9ripco-out.feeder.erje.net172.9 KB0.0 KB6.4 MB6.6 MB 2%7.0 KB
10news.cmpublishers.com4.9 KB0.0 KB2.5 KB7.4 KB 66%1.9 KB
11localhost4.8 KB0.0 KB0.0 KB4.8 KB100%2.4 KB
TOTAL: 11106.9 MB143.7 KB78.2 MB185.3 MB 57%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 25 00:01:02 - 00:59:59 387 2.4% 0.111.1 MB 2.0% 0.31
Apr 25 01:00:00 - 01:59:59 446 2.7% 0.121.8 MB 3.4% 0.52
Apr 25 02:00:00 - 02:59:59 519 3.2% 0.141.5 MB 2.8% 0.43
Apr 25 03:00:00 - 03:59:59 688 4.2% 0.192.2 MB 4.0% 0.62
Apr 25 04:00:00 - 04:59:59 694 4.2% 0.192.2 MB 4.0% 0.61
Apr 25 05:00:00 - 05:59:59 756 4.6% 0.213.1 MB 5.8% 0.89
Apr 25 06:00:00 - 06:59:59 736 4.5% 0.202.2 MB 4.1% 0.63
Apr 25 07:00:00 - 07:59:59 889 5.4% 0.253.3 MB 6.2% 0.95
Apr 25 08:00:00 - 08:59:59 840 5.1% 0.233.0 MB 5.5% 0.85
Apr 25 09:00:00 - 09:59:59 884 5.4% 0.252.7 MB 4.9% 0.76
Apr 25 10:00:00 - 10:59:59 843 5.1% 0.232.6 MB 4.8% 0.73
Apr 25 11:00:00 - 11:59:59 929 5.7% 0.262.4 MB 4.4% 0.68
Apr 25 12:00:00 - 12:59:59 962 5.9% 0.272.5 MB 4.5% 0.70
Apr 25 13:00:00 - 13:59:59 981 6.0% 0.273.1 MB 5.8% 0.88
Apr 25 14:00:00 - 14:59:59 1069 6.5% 0.304.2 MB 7.8% 1.20
Apr 25 15:00:00 - 15:59:59 915 5.6% 0.252.7 MB 5.1% 0.78
Apr 25 16:00:00 - 16:59:59 836 5.1% 0.232.2 MB 4.1% 0.63
Apr 25 17:00:00 - 17:59:59 629 3.8% 0.172.2 MB 4.0% 0.61
Apr 25 18:00:00 - 18:59:59 479 2.9% 0.131.5 MB 2.8% 0.42
Apr 25 19:00:00 - 19:59:59 474 2.9% 0.132.0 MB 3.7% 0.57
Apr 25 20:00:00 - 20:59:59 428 2.6% 0.121.3 MB 2.5% 0.38
Apr 25 21:00:00 - 21:59:59 374 2.3% 0.102.1 MB 4.0% 0.61
Apr 25 22:00:00 - 22:59:59 357 2.2% 0.101.2 MB 2.2% 0.33
Apr 25 23:00:00 - 23:56:48 283 1.7% 0.08910.3 KB 1.6% 0.27
TOTAL: 23:55:46 16398 100.0% 0.1954.0 MB 100.0% 0.64
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2226 1835 0 0 3 0 0 0 388
2feeder3.feed-ams.uzoreto.com 926 612 0 0 1 0 0 0 313
3newsfeed.neva.ru 837 434 0 0 0 0 0 0 403
4ripco-out.feeder.erje.net 465 459 0 0 1 0 0 0 5
5newsfeed.fu-berlin.de 172 0 0 0 0 0 0 0 172
6news.snarked.org 164 76 0 0 0 0 0 0 88
7news.lightlink.com 53 2 0 1 0 0 0 0 50
8ripco-out.news.tnetconsulting.net 35 7 0 0 0 0 0 0 28
9news-in.rahul.net 20 0 0 0 0 0 0 0 20
10news.cmpublishers.com 1 1 0 0 0 0 0 0 0
TOTAL: 10 4899 3426 0 1 5 0 0 0 1467

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2644
alt.binaries.ftd 179
scot.general 39
perl.cpan.uploads 33
alt.binaries.e-book 29
alt.binaries.sounds.lossless.jazz 27
linux.debian.changes 27
a.b.boneless 24
alt.binaries.pictures.rail 23
alt.binaries.pictures.purebeauty 20
alt.binaries.pictures.wallpaper 20
free.willey 18
it.comp.os.win.windows10 16
fr.comp.sys.iphone 15
aioe.news.assistenza 13
it.eventi.covid19 12
alt.binaries.3d.poser 11
alt.binaries.pictures.scenic 10
it.tlc.cellulari.android 9
alt.binaries.test.yenc 9
TOTAL: 136 3426

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

GroupsCount
pl.praca.oferowana 2
fr.comp.lang.php 1
misc.taxes.moderated 1
bit.listserv.catholic 1
TOTAL: 4 5

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1036
EMP (md5) 902
EMP (phl) 278
Binary in non-binary group 210
Scoring filter (8) 18
Scoring filter (9) 10
HTML post 4
Scoring filter (18) 2
Scoring filter (12) 2
Scoring filter (10) 2
TOTAL: 10 2464

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
TOTAL: 1 18
Huge articles
newsfeed.fu-berlin.de 26
TOTAL: 1 26
Including strange strings
newsfeed.fu-berlin.de 149
newsfeed.neva.ru 57
ripco-out.feed.uzoreto.com 9
feeder3.feed-ams.uzoreto.com 2
news.snarked.org 1
TOTAL: 5 218
No colon-space in header
ripco-out.feeder.erje.net 2
ripco-out.feed.uzoreto.com 2
TOTAL: 2 4
TOTAL: 4 266

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10858 1950 6036 10 0 6 17%47:40:02
2rahul.net 26942 874 14306 32 0 8 3%47:44:10
3news.cmpublishers.com 47156 178 29668 2512 0 84 0%47:36:46
4news.uzoreto.com 15862 86 15068 220 0 2 0%47:50:28
5feeder.erje.net 31420 82 30396 68 0 0 0%47:40:10
6news.tnetconsulting.net 47082 30 31752 6 0 94 0%47:40:00
7news.snarked.org 40846 24 23972 8 0 158 0%47:39:34
8fu-berlin.de 29596 18 29578 0 0 0 0%47:40:10
9newsfeed.neva.ru 28204 14 27264 12 0 0 0%47:42:16
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:12
TOTAL: 10 277972 3256 208040 2874 0 352 1%430:25:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com9.3 MB23.2 KB9.3 MB0.1 KB/s4.9 KB47:40:02
2rahul.net7.4 MB199.3 KB7.6 MB0.0 KB/s8.6 KB47:44:10
3news.cmpublishers.com492.0 KB6.6 MB7.0 MB0.0 KB/s2.7 KB47:36:46
4feeder.erje.net363.0 KB267.0 KB630.0 KB0.0 KB/s4.2 KB47:40:10
5news.uzoreto.com264.7 KB1.2 MB1.4 MB0.0 KB/s4.8 KB47:50:28
6news.tnetconsulting.net251.5 KB15.2 KB266.7 KB0.0 KB/s7.4 KB47:40:00
7news.snarked.org227.3 KB26.0 KB253.3 KB0.0 KB/s7.9 KB47:39:34
8fu-berlin.de87.7 KB0.0 KB87.7 KB0.0 KB/s4.9 KB47:40:10
9newsfeed.neva.ru66.7 KB185.1 KB251.8 KB0.0 KB/s9.7 KB47:42:16
10remote6hme0.ripco.com0.0 KB30.8 KB30.8 KB0.0 KB/s5.1 KB01:12:12
TOTAL: 1018.4 MB8.5 MB26.8 MB0.0 KB/s4.5 KB430:25:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9902.5 MB 426 2 000:07:24
2shell3 8 9302.4 MB 52 0 004:16:23
TOTAL: 2 294 19204.9 MB 478 2 004:23:55

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9902.5 MB 426 2 000:07:24
2? 8 9302.4 MB 52 0 004:16:23
TOTAL: 2 294 19204.9 MB 478 2 004:23:47

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 3.534 2.738 0.00004:16:23
ftupet.com 46.496 21.474 0.00000:07:24
dw49-106-186-48.m-zone.jp 0.606 0.154 0.00000:00:03
27.115.124.75 0.206 0.060 0.00000:00:01
27.115.124.9 0.206 0.058 0.00000:00:01
33.20.97.83.ro.ovo.sc 0.200 0.050 0.00000:00:00
27.115.124.10 0.200 0.052 0.00000:00:00
162.243.133.250 0.200 0.050 0.00000:00:00
TOTAL: 8 51.648 24.636 0.00004:23:55

NNRP no permission clients:

SystemConn
dw49-106-186-48.m-zone.jp 6
33.20.97.83.ro.ovo.sc 2
27.115.124.75 2
27.115.124.10 2
27.115.124.9 2
162.243.133.250 2
TOTAL: 6 16

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 6 0
TOTAL: 1 6 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1344 70.0%
2alt 320 16.7%
3comp 98 5.1%
4rocksolid 94 4.9%
5misc 36 1.9%
6chi 14 0.7%
7news 8 0.4%
8sci 6 0.3%
TOTAL: 8 1920100.0%

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

NewsgroupCount
1rec.arts.tv 646
2rec.food.cooking 508
3alt.comp.os.windows-10 286
4rec.outdoors.rv-travel 96
5rec.bicycles.tech 80
6rocksolid.nodes.announce 74
7comp.sys.apple2 60
8misc.phone.mobile.iphone 26
9rocksolid.nodes 20
10comp.sys.mac.system 18
11alt.security.alarms 16
12chi.general 10
13misc.consumers.frugal-living 10
14comp.protocols.dns.bind 8
15sci.electronics.repair 6
16news.software.readers 6
17alt.games.warcraft 6
18comp.home.automation 4
19alt.internet.wireless 4
20rec.audio.tubes 4
21rec.radio.broadcasting 4
22rec.radio.swap 4
23chi.weather 4
24alt.free.newsservers 4
25alt.tv.sopranos 2
26alt.dbs.echostar 2
27news.admin.net-abuse.usenet 2
28rec.video.cable-tv 2
29comp.risks 2
30comp.sys.mac.apps 2
31comp.unix.bsd.freebsd.misc 2
32comp.mobile.android 2
TOTAL: 32 1920