Daily Usenet report for news.ripco.com

Nov 5 00:01:02 -- Nov 5 23:57:27

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Nov 5 08:37:56 remote5bge0 overchan[3064]: [ID 702911 news.error] input line too long, skipping
Nov 5 08:53:55 remote5bge0 overchan[3064]: [ID 702911 news.error] input line too long, skipping
Nov 5 09:56:48 remote5bge0 overchan[3064]: [ID 702911 news.error] input line too long, skipping
Nov 5 11:50:11 remote5bge0 overchan[3064]: [ID 702911 news.error] input line too long, skipping
Nov 5 13:22:17 remote5bge0 overchan[3064]: [ID 702911 news.error] input line too long, skipping
Nov 5 13:49:25 remote5bge0 overchan[3064]: [ID 702911 news.error] input line too long, skipping
Nov 5 20:34:24 remote5bge0 overchan[3064]: [ID 702911 news.error] input line too long, skipping
Nov 5 21:37:40 remote5bge0 overchan[3064]: [ID 702911 news.error] input line too long, skipping
Nov 5 23:45:25 remote5bge0 overchan[3064]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 18842 32.9%3.7 MB 40.8%
innd 17893 31.2%2.8 MB 31.1%
nnrpd 16754 29.2%1.7 MB 19.3%
innfeed 3814 6.7%812.1 KB 8.8%
overchan 9 0.0%1.5 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 57314 100.0%9.0 MB100.0%

History cache:

ReasonCount%Count
Cache misses 167612 50.9%
Do not exist 161788 49.1%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 329400 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%62 0.000 0.000 0.000
article cleanup00:00:00.536 0.0%37194 0.000 0.014 0.059
article logging00:00:00.760 0.0%37636 0.000 0.020 0.193
article parse00:00:01.360 0.0%95708 0.000 0.014 0.050
article write00:01:25.712 0.0%29284 1.726 2.927 49.792
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.400 0.0%338562 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.870 0.0%330588 0.002 0.009 0.028
history sync00:00:00.200 0.0%726 0.000 0.275 2.000
history write00:00:03.556 0.0%37192 0.017 0.096 1.569
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:36:27.636 99.8%374770 250.383 457.314 1275.804
nntp read00:00:02.976 0.0%374302 0.004 0.008 0.017
overview write00:00:00.294 0.0%29284 0.000 0.010 0.048
perl filter00:00:55.890 0.0%37188 1.137 1.503 3.417
python filter00:00:01.436 0.0%37190 0.000 0.039 0.121
site send00:00:02.842 0.0%87776 0.000 0.032 0.057
TOTAL: 47:41:37.42447:39:06.468 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.172 0.0%35644 0.000 0.005 0.051
article prepare00:00:00.004 0.0%24656 0.000 0.000 0.019
article read00:00:00.672 0.0%4624 0.000 0.145 71.000
backlog stats00:00:00.266 0.0%463756 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.000 0.0%286022 0.000 0.007 0.020
data write00:00:05.480 0.0%257680 0.009 0.021 0.041
idle47:50:28.868100.0%463756 222.199 371.378 1287.775
status file00:00:02.548 0.0%448 0.636 5.688 42.000
TOTAL: 47:51:00.77847:50:40.010100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:20:46.024 97.7%17592 18.806 480.106 23659.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:10.816 0.1%1116438 0.000 0.010 0.047
readart00:00:18.926 0.2%2546 0.000 7.434 36.000
TOTAL: 02:24:05.56202:21:15.766 98.0%----

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 1160 30976 9748 19042 2186 31%94:04:58
2news.snarked.org 46 26294 6782 19016 496 25%54:17:50
3feeder3.feed-ams.uzoreto.com 574 17522 5902 8876 2744 33%45:49:58
4newsfeed.neva.ru 592 29888 5414 23352 1122 18%282:55:54
5ripco-out.news.tnetconsulting.net 10 34260 874 33220 166 2%53:52:32
6newsfeed.fu-berlin.de 12 11398 468 10920 10 4%47:26:12
7news.cmpublishers.com 48 7066 118 6836 112 1%48:00:00
8ripco-out.feeder.erje.net 570 29216 98 28326 792 0%50:53:56
9news-in.rahul.net 578 13438 86 13298 54 0%50:32:24
10news.lightlink.com 6 2408 6 2250 152 0%24:13:04
11localhost 148 2 2 0 0 100%00:00:02
TOTAL: 11 3744 202468 29498 165136 7834 14%752:06:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com23.5 MB0.0 KB4.7 MB28.2 MB 83%2.4 KB
2news.snarked.org18.1 MB0.0 KB1.9 MB20.0 MB 90%2.8 KB
3ripco-out.news.tnetconsulting.net15.4 MB0.0 KB2.4 MB17.7 MB 86%17.5 KB
4newsfeed.neva.ru15.2 MB0.0 KB3.2 MB18.4 MB 82%2.9 KB
5feeder3.feed-ams.uzoreto.com14.0 MB0.0 KB5.1 MB19.2 MB 73%2.3 KB
6newsfeed.fu-berlin.de5.9 MB0.0 KB130.6 KB6.0 MB 97%12.8 KB
7news-in.rahul.net4.7 MB205.8 KB1.5 MB6.4 MB 73%47.0 KB
8news.cmpublishers.com323.6 KB0.0 KB182.0 KB505.6 KB 63%2.2 KB
9ripco-out.feeder.erje.net257.3 KB0.0 KB6.6 MB6.8 MB 3%7.8 KB
10news.lightlink.com237.6 KB0.0 KB5.9 MB6.1 MB 3%39.5 KB
11localhost3.6 KB0.0 KB0.0 KB3.6 KB100%1.8 KB
TOTAL: 1197.5 MB205.8 KB31.5 MB129.3 MB 75%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 5 00:01:02 - 00:59:59 357 2.4% 0.101.1 MB 2.3% 0.31
Nov 5 01:00:00 - 01:59:59 496 3.4% 0.142.2 MB 4.5% 0.61
Nov 5 02:00:00 - 02:59:59 689 4.7% 0.192.2 MB 4.5% 0.62
Nov 5 03:00:00 - 03:59:59 740 5.0% 0.212.0 MB 4.2% 0.58
Nov 5 04:00:00 - 04:59:59 720 4.9% 0.202.4 MB 5.0% 0.68
Nov 5 05:00:00 - 05:59:59 735 5.0% 0.202.3 MB 4.9% 0.67
Nov 5 06:00:00 - 06:59:59 652 4.4% 0.182.6 MB 5.5% 0.75
Nov 5 07:00:00 - 07:59:59 786 5.4% 0.222.5 MB 5.1% 0.70
Nov 5 08:00:00 - 08:59:59 742 5.1% 0.212.4 MB 4.9% 0.67
Nov 5 09:00:00 - 09:59:59 948 6.5% 0.263.7 MB 7.7% 1.05
Nov 5 10:00:00 - 10:59:59 817 5.6% 0.232.4 MB 5.0% 0.68
Nov 5 11:00:00 - 11:59:59 757 5.2% 0.212.6 MB 5.4% 0.74
Nov 5 12:00:00 - 12:59:59 754 5.1% 0.212.3 MB 4.8% 0.65
Nov 5 13:00:00 - 13:59:59 755 5.2% 0.212.2 MB 4.6% 0.62
Nov 5 14:00:00 - 14:59:59 744 5.1% 0.212.0 MB 4.1% 0.56
Nov 5 15:00:00 - 15:59:59 683 4.7% 0.193.1 MB 6.5% 0.88
Nov 5 16:00:00 - 16:59:59 605 4.1% 0.171.8 MB 3.8% 0.52
Nov 5 17:00:00 - 17:59:59 554 3.8% 0.152.5 MB 5.1% 0.70
Nov 5 18:00:00 - 18:59:59 485 3.3% 0.131.2 MB 2.4% 0.33
Nov 5 19:00:00 - 19:59:59 387 2.6% 0.111.1 MB 2.3% 0.31
Nov 5 20:00:00 - 20:59:59 367 2.5% 0.101.0 MB 2.2% 0.29
Nov 5 21:00:00 - 21:59:59 324 2.2% 0.09930.6 KB 1.9% 0.26
Nov 5 22:00:00 - 22:59:59 287 2.0% 0.08865.9 KB 1.8% 0.24
Nov 5 23:00:00 - 23:57:27 271 1.8% 0.08895.5 KB 1.8% 0.26
TOTAL: 23:56:25 14655 100.0% 0.1748.1 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feeder3.feed-ams.uzoreto.com 1385 1072 0 0 1 0 0 0 312
2ripco-out.feed.uzoreto.com 1122 806 0 0 3 0 0 0 313
3newsfeed.neva.ru 611 389 0 0 1 0 0 0 221
4ripco-out.feeder.erje.net 395 389 0 0 0 0 0 0 6
5news.snarked.org 253 165 0 0 0 0 0 0 88
6news.lightlink.com 161 0 0 0 0 0 0 0 161
7newsfeed.fu-berlin.de 128 0 0 0 0 0 0 0 128
8news.cmpublishers.com 56 48 0 0 0 0 0 0 8
9ripco-out.news.tnetconsulting.net 49 29 0 0 0 0 0 0 20
10news-in.rahul.net 27 2 0 3 0 0 0 0 22
TOTAL: 10 4187 2900 0 3 5 0 0 0 1279

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2076
alt.binaries.ftd 209
free.it.scienza.fisica 49
scot.general 44
alt.bestjobsusa.computer.jobs 39
fido7.su.pol.news 35
scinet.stats 32
alt.binaries.e-book 27
it.tlc.cellulari.android 23
it.comp.os.win.windows10 21
alt.jobs.jobsearch 19
alt.my.job.sucks 18
it.eventi.covid19 17
alt.binaries.pictures.scenic 16
alt.binaries.pictures.earlmiller 13
at.jobs 13
fr.comp.sys.iphone 10
uk.net.news.moderation 10
alt.binaries.3d.poser 9
sk.rec.tatry 8
TOTAL: 120 2900

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

GroupsCount
pl.praca.oferowana 4
bit.listserv.catholic 1
TOTAL: 2 5

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 912
Too many newsgroups 772
EMP (phl) 192
Binary in non-binary group 136
Scoring filter (8) 30
Scoring filter (10) 16
Scoring filter (11) 14
HTML post 12
Scoring filter (9) 6
Poison newsgroup 6
Scoring filter (13) 4
Scoring filter (15) 2
Scoring filter (18) 2
TOTAL: 13 2104

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 28
ripco-out.feed.uzoreto.com 10
feeder3.feed-ams.uzoreto.com 2
TOTAL: 3 40
Including strange strings
newsfeed.fu-berlin.de 124
newsfeed.neva.ru 55
ripco-out.feed.uzoreto.com 29
feeder3.feed-ams.uzoreto.com 12
news.snarked.org 5
TOTAL: 5 225
No colon-space in header
ripco-out.feed.uzoreto.com 2
TOTAL: 1 2
TOTAL: 3 267

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 30274 1308 26430 448 0 1130 4%47:45:50
2news.lightlink.com 11340 1164 5296 182 0 188 10%47:49:54
3rahul.net 22526 772 11790 26 0 388 3%47:35:18
4news.cmpublishers.com 44368 116 26858 1832 0 98 0%47:44:32
5fu-berlin.de 26334 72 26182 0 0 1098 0%47:36:24
6news.uzoreto.com 13642 44 13028 88 0 1050 0%47:50:38
7newsfeed.neva.ru 24170 42 23590 6 0 1164 0%47:50:14
8news.snarked.org 37518 26 22128 8 0 34 0%47:40:04
9news.tnetconsulting.net 47708 20 28568 0 0 1276 0%47:50:48
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:06
TOTAL: 10 257886 3564 183870 2596 0 6426 1%430:55:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net11.2 MB78.0 KB11.2 MB0.1 KB/s14.4 KB47:35:18
2news.lightlink.com5.6 MB859.9 KB6.4 MB0.0 KB/s4.9 KB47:49:54
3feeder.erje.net3.6 MB1.1 MB4.8 MB0.0 KB/s2.8 KB47:45:50
4news.cmpublishers.com409.9 KB4.5 MB4.9 MB0.0 KB/s2.6 KB47:44:32
5fu-berlin.de356.1 KB0.0 KB356.1 KB0.0 KB/s4.9 KB47:36:24
6newsfeed.neva.ru171.6 KB21.2 KB192.8 KB0.0 KB/s4.0 KB47:50:14
7news.uzoreto.com164.5 KB273.4 KB437.9 KB0.0 KB/s3.3 KB47:50:38
8news.snarked.org109.2 KB18.1 KB127.2 KB0.0 KB/s3.7 KB47:40:04
9news.tnetconsulting.net90.8 KB0.0 KB90.8 KB0.0 KB/s4.5 KB47:50:48
10remote6hme0.ripco.com0.0 KB21.5 KB21.5 KB0.0 KB/s3.6 KB01:12:06
TOTAL: 1021.7 MB6.8 MB28.5 MB0.0 KB/s4.7 KB430:55:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 276 11243.0 MB 440 2 000:08:29
2shell3.ripco.com 18 296772.7 KB 40 0 002:15:24
TOTAL: 2 294 14203.8 MB 480 2 002:23:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 276 11243.0 MB 440 2 000:08:29
2*.ripco.com 18 296772.7 KB 40 0 002:15:24
TOTAL: 2 294 14203.8 MB 480 2 002:23:54

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 5.812 8.578 0.00002:15:24
ftupet.com 45.444 20.734 0.00000:08:29
scan-141.security.ipip.net 0.200 0.048 0.00000:00:01
scanner-09.ch1.censys-scanner.com 0.200 0.050 0.00000:00:00
138.99.216.171 0.200 0.048 0.00000:00:00
TOTAL: 5 51.856 29.458 0.00002:23:56

NNRP no permission clients:

SystemConn
scan-141.security.ipip.net 2
scanner-09.ch1.censys-scanner.com 2
138.99.216.171 2
TOTAL: 3 6

NNRP unrecognized commands (by host):

SystemConn
shell3.ripco.com 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 4
TOTAL: 1 4

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 1240 87.3%
2comp 50 3.5%
3sci 50 3.5%
4alt 34 2.4%
5misc 34 2.4%
6chi 12 0.8%
TOTAL: 6 1420100.0%

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

NewsgroupCount
1rec.arts.tv 568
2rec.food.cooking 546
3rec.bicycles.tech 104
4sci.electronics.repair 50
5comp.mobile.android 28
6misc.phone.mobile.iphone 28
7alt.stupidity 22
8comp.sys.mac.system 10
9alt.games.warcraft 8
10rec.radio.broadcasting 8
11chi.weather 8
12comp.sys.apple2 8
13rec.outdoors.rv-travel 6
14misc.consumers.frugal-living 6
15chi.general 4
16comp.mail.sendmail 4
17rec.radio.shortwave 4
18rec.radio.swap 4
19alt.online-service.comcast 2
20alt.autos.toyota 2
TOTAL: 20 1420