Daily Usenet report for news.ripco.com

Mar 27 00:01:01 -- Mar 27 23:57:58

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Mar 27 00:02:10 remote5bge0 innfeed[9096]: [ID 702911 news.warning] ME tape invalid messageID in /zones/news/spool/innfeed/news.cmpublishers.com.input: <0ee8a5d562e6a27b.16bc2923c727fadf@1c42331113669226.4ae559c13a2eaf3@0502000076BD0004FD830000000000000000@
Mar 27 10:19:06 remote5bge0 overchan[9013]: [ID 702911 news.error] input line too long, skipping
Mar 27 10:20:49 remote5bge0 overchan[9013]: [ID 702911 news.error] input line too long, skipping
Mar 27 10:28:41 remote5bge0 overchan[9013]: [ID 702911 news.error] input line too long, skipping
Mar 27 10:41:09 remote5bge0 overchan[9013]: [ID 702911 news.error] input line too long, skipping
Mar 27 11:03:13 remote5bge0 overchan[9013]: [ID 702911 news.error] input line too long, skipping
Mar 27 11:05:03 remote5bge0 overchan[9013]: [ID 702911 news.error] input line too long, skipping
Mar 27 00:02:10 s_local@remote5bge0 innfeed[9096]: [ID 702911 news.warning] ME tape invalid messageID in /zones/news/spool/innfeed/news.cmpublishers.com.input: <0ee8a5d562e6a27b.16bc2923c727fadf@1c42331113669226.4ae559c13a2eaf3@0502000076BD0004FD830000000000000000@

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 17696 33.0%1.8 MB 22.6%
inn 16822 31.4%3.1 MB 38.4%
innd 15643 29.2%2.5 MB 30.2%
innfeed 3420 6.4%729.8 KB 8.8%
overchan 6 0.0%0.9 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 53589 100.0%8.1 MB100.0%

History cache:

ReasonCount%Count
Cache misses 145100 51.3%
Do not exist 137946 48.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 283046 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%46 0.000 0.000 0.000
article cleanup00:00:00.374 0.0%33210 0.000 0.011 0.052
article logging00:00:00.640 0.0%33620 0.000 0.019 0.224
article parse00:00:01.374 0.0%89686 0.000 0.015 0.039
article write00:01:20.716 0.0%22920 1.328 3.522 181.811
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.372 0.0%291416 0.000 0.001 0.006
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.134 0.0%283220 0.000 0.011 0.535
history sync00:00:00.294 0.0%810 0.000 0.363 4.667
history write00:00:03.904 0.0%33212 0.000 0.118 3.260
idle47:38:03.274 99.9%327724 259.495 523.255 1839.393
nntp read00:00:02.422 0.0%326074 0.000 0.007 0.022
overview write00:00:00.188 0.0%22920 0.000 0.008 0.057
perl filter00:00:50.064 0.0%33210 1.196 1.507 3.034
python filter00:00:01.242 0.0%33212 0.000 0.037 0.135
site send00:00:02.176 0.0%68720 0.008 0.032 0.058
TOTAL: 47:42:09.82847:40:30.174 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.152 0.0%65944 0.000 0.002 0.054
article prepare00:00:00.004 0.0%10688 0.000 0.000 0.031
article read00:00:09.800 0.0%1884 0.000 5.202 150.219
backlog stats00:00:00.492 0.0%338964 0.000 0.001 0.016
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.256 0.0%218826 0.000 0.006 0.017
data write00:00:03.936 0.0%195862 0.006 0.020 0.085
idle47:39:12.846100.0%338964 73.062 506.109 1900.731
status file00:00:02.876 0.0%394 0.750 7.299 33.000
TOTAL: 47:39:56.86647:39:31.362100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:22:21.588 98.7%18452 18.125 853.110 20543.256
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.356 0.1%860820 0.000 0.011 1.000
readart00:00:25.044 0.2%3286 2.500 7.621 35.500
TOTAL: 04:25:52.68204:22:55.988 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 30154 9590 16004 4560 31%94:47:18
2feeder3.feed-ams.uzoreto.com 574 14442 4576 7138 2728 31%47:18:46
3newsfeed.neva.ru 588 40794 3830 35554 1410 9%278:57:26
4news.snarked.org 62 22420 3812 18264 344 17%53:28:06
5newsfeed.fu-berlin.de 2 12952 598 12324 30 4%52:38:02
6ripco-out.news.tnetconsulting.net 4 21306 448 20812 46 2%36:24:30
7news.lightlink.com 2 7564 104 7144 316 1%44:52:16
8ripco-out.feeder.erje.net 576 26382 58 25350 974 0%47:28:58
9localhost 148 2 2 0 0 100%00:00:02
TOTAL: 9 3104 176016 23018 142590 10408 13%655:55:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com23.8 MB0.0 KB8.5 MB32.3 MB 73%2.3 KB
2ripco-out.news.tnetconsulting.net16.0 MB0.0 KB745.9 KB16.7 MB 95%34.6 KB
3feeder3.feed-ams.uzoreto.com12.8 MB0.0 KB5.6 MB18.4 MB 69%2.6 KB
4news.snarked.org12.6 MB0.0 KB1.3 MB13.9 MB 90%3.4 KB
5newsfeed.neva.ru12.4 MB0.0 KB4.1 MB16.4 MB 75%3.2 KB
6news.lightlink.com5.7 MB0.0 KB21.8 MB27.5 MB 20%67.1 KB
7newsfeed.fu-berlin.de4.3 MB0.0 KB98.6 KB4.4 MB 97%7.1 KB
8ripco-out.feeder.erje.net148.6 KB0.0 KB7.5 MB7.7 MB 1%7.6 KB
9localhost4.2 KB0.0 KB0.0 KB4.2 KB100%2.1 KB
TOTAL: 987.7 MB0.0 KB49.6 MB137.3 MB 63%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 27 00:01:01 - 00:59:59 230 2.0% 0.06992.2 KB 2.2% 0.28
Mar 27 01:00:00 - 01:59:59 261 2.3% 0.071.5 MB 3.4% 0.43
Mar 27 02:00:00 - 02:59:59 318 2.8% 0.091.3 MB 3.0% 0.37
Mar 27 03:00:00 - 03:59:59 396 3.5% 0.111.8 MB 4.2% 0.52
Mar 27 04:00:00 - 04:59:59 488 4.3% 0.141.3 MB 3.0% 0.37
Mar 27 05:00:00 - 05:59:59 591 5.2% 0.163.2 MB 7.3% 0.92
Mar 27 06:00:00 - 06:59:59 506 4.4% 0.141.8 MB 4.0% 0.51
Mar 27 07:00:00 - 07:59:59 618 5.4% 0.172.0 MB 4.5% 0.57
Mar 27 08:00:00 - 08:59:59 587 5.1% 0.161.9 MB 4.4% 0.55
Mar 27 09:00:00 - 09:59:59 586 5.1% 0.162.1 MB 4.8% 0.61
Mar 27 10:00:00 - 10:59:59 625 5.4% 0.173.0 MB 6.9% 0.86
Mar 27 11:00:00 - 11:59:59 683 6.0% 0.192.9 MB 6.6% 0.83
Mar 27 12:00:00 - 12:59:59 654 5.7% 0.181.9 MB 4.4% 0.55
Mar 27 13:00:00 - 13:59:59 631 5.5% 0.183.1 MB 7.1% 0.89
Mar 27 14:00:00 - 14:59:59 726 6.3% 0.202.7 MB 6.1% 0.77
Mar 27 15:00:00 - 15:59:59 623 5.4% 0.172.1 MB 4.8% 0.60
Mar 27 16:00:00 - 16:59:59 550 4.8% 0.151.9 MB 4.3% 0.55
Mar 27 17:00:00 - 17:59:59 524 4.6% 0.151.6 MB 3.7% 0.46
Mar 27 18:00:00 - 18:59:59 440 3.8% 0.121.4 MB 3.2% 0.40
Mar 27 19:00:00 - 19:59:59 357 3.1% 0.101.6 MB 3.7% 0.46
Mar 27 20:00:00 - 20:59:59 327 2.9% 0.091.2 MB 2.7% 0.34
Mar 27 21:00:00 - 21:59:59 319 2.8% 0.091.1 MB 2.6% 0.32
Mar 27 22:00:00 - 22:59:59 228 2.0% 0.06832.9 KB 1.8% 0.23
Mar 27 23:00:00 - 23:57:58 201 1.8% 0.06634.4 KB 1.4% 0.18
TOTAL: 23:56:57 11469 100.0% 0.1344.2 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2314 1836 0 0 4 0 0 0 474
2feeder3.feed-ams.uzoreto.com 1378 1014 0 0 2 0 0 0 362
3newsfeed.neva.ru 745 535 0 0 1 0 0 0 209
4ripco-out.feeder.erje.net 488 485 0 0 0 0 0 0 3
5news.snarked.org 173 65 0 0 1 0 0 0 107
6newsfeed.fu-berlin.de 125 0 0 0 0 0 0 0 125
7news.lightlink.com 106 2 0 0 0 0 0 0 104
8ripco-out.news.tnetconsulting.net 24 14 0 0 0 0 0 0 10
TOTAL: 8 5353 3951 0 0 8 0 0 0 1394

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2921
alt.binaries.ftd 250
fr.misc.actualite.covid19 72
alt.news.misc 59
de.soc.arbeitslos 53
alt.bestjobsusa.computer.jobs 37
alt.jobs.jobsearch 23
uk.net.news.moderation 22
free.willey 21
free.it.scienza.fisica 20
fido7.su.pol.news 19
eternal-september.test 18
alt.binaries.pictures.rail 18
alt.binaries.e-book 18
alt.my.job.sucks 18
alt.binaries.pictures.purebeauty 16
at.jobs 16
att.jobs 15
aus.jobs 14
alt.binaries.pictures.wallpaper 13
TOTAL: 130 3951

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

GroupsCount
christnet.bible 2
fr.bienvenue 2
pl.praca.oferowana 2
alt.christnet.christnews 1
bit.listserv.catholic 1
TOTAL: 5 8

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1250
EMP (md5) 672
EMP (phl) 240
Binary in non-binary group 158
Scoring filter (10) 22
Scoring filter (8) 16
Scoring filter (9) 12
Scoring filter (11) 6
Poison newsgroup 2
HTML post 2
TOTAL: 10 2380

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
TOTAL: 1 18
Including strange strings
newsfeed.fu-berlin.de 110
newsfeed.neva.ru 44
ripco-out.feed.uzoreto.com 34
feeder3.feed-ams.uzoreto.com 14
news.snarked.org 1
ripco-out.feeder.erje.net 1
TOTAL: 6 204
No colon-space in header
ripco-out.feed.uzoreto.com 1
TOTAL: 1 1
TOTAL: 3 223

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9416 648 5244 2 0 0 6%47:40:46
2news.cmpublishers.com 74938 298 63912 1218 0 38 0%47:40:04
3news.uzoreto.com 8420 60 8058 86 0 0 0%47:40:04
4feeder.erje.net 22086 52 21548 144 0 62 0%47:41:30
5fu-berlin.de 20550 30 20520 0 0 0 0%47:51:42
6news.snarked.org 32666 26 18908 42 0 20 0%47:50:40
7newsfeed.neva.ru 19106 22 18964 6 0 0 0%47:40:02
8news.tnetconsulting.net 36606 20 22380 4 0 2 0%47:50:40
9remote6hme0.ripco.com 14 8 0 6 0 0 57%02:16:48
TOTAL: 9 223802 1164 179534 1508 0 122 0%384:12:16
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com2.1 MB134.1 KB2.3 MB0.0 KB/s3.6 KB47:40:46
2news.cmpublishers.com1011.7 KB4.3 MB5.3 MB0.0 KB/s3.6 KB47:40:04
3news.uzoreto.com294.6 KB315.0 KB609.6 KB0.0 KB/s4.2 KB47:40:04
4feeder.erje.net281.8 KB576.6 KB858.4 KB0.0 KB/s4.4 KB47:41:30
5fu-berlin.de174.0 KB0.0 KB174.0 KB0.0 KB/s5.8 KB47:51:42
6news.snarked.org140.3 KB76.8 KB217.0 KB0.0 KB/s3.2 KB47:50:40
7newsfeed.neva.ru109.3 KB39.9 KB149.2 KB0.0 KB/s5.3 KB47:40:02
8news.tnetconsulting.net99.1 KB5.4 KB104.6 KB0.0 KB/s4.4 KB47:50:40
9remote6hme0.ripco.com12.4 KB28.7 KB41.2 KB0.0 KB/s2.9 KB02:16:48
TOTAL: 94.2 MB5.4 MB9.6 MB0.0 KB/s3.7 KB384:12:16
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 12263.0 MB 398 2 000:07:52
2shell3.ripco.com 8 8322.1 MB 50 0 004:17:26
TOTAL: 2 294 20585.1 MB 448 2 004:25:41

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 12263.0 MB 398 2 000:07:52
2*.ripco.com 8 8322.1 MB 50 0 004:17:26
TOTAL: 2 294 20585.1 MB 448 2 004:25:19

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 4.112 3.196 0.00004:17:26
ftupet.com 45.814 19.720 0.00000:07:52
199.167.194.100 10.848 2.570 0.00000:00:21
TOTAL: 3 60.774 25.486 0.00004:25:41

NNRP no permission clients:

SystemConn
199.167.194.100 108
TOTAL: 1 108

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 1380 67.1%
2alt 342 16.6%
3misc 224 10.9%
4comp 74 3.6%
5sci 20 1.0%
6chi 14 0.7%
7news 4 0.2%
TOTAL: 7 2058100.0%

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

NewsgroupCount
1rec.food.cooking 738
2rec.arts.tv 576
3alt.comp.os.windows-10 318
4misc.phone.mobile.iphone 208
5comp.mobile.android 50
6rec.bicycles.tech 34
7sci.electronics.repair 20
8misc.consumers.frugal-living 16
9comp.sys.apple2 16
10rec.antiques.radio+phono 12
11alt.video.digital-tv 10
12chi.general 10
13rec.bicycles.misc 6
14comp.mail.pine 6
15alt.config 4
16rec.radio.shortwave 4
17news.software.readers 4
18alt.online-service.comcast 4
19rec.audio.tubes 4
20chi.weather 4
21alt.video.tape-trading 2
22rec.puzzles 2
23comp.security.ssh 2
24alt.internet.wireless 2
25rec.heraldry 2
26alt.autos.toyota 2
27rec.radio.swap 2
TOTAL: 27 2058