Daily Usenet report for news.ripco.com

Oct 8 00:01:02 -- Oct 8 23:57:59

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Oct 8 03:01:50 remote5bge0 overchan[14468]: [ID 702911 news.error] input line too long, skipping
Oct 8 03:09:35 remote5bge0 overchan[14468]: [ID 702911 news.error] input line too long, skipping
Oct 8 03:11:04 remote5bge0 overchan[14468]: [ID 702911 news.error] input line too long, skipping
Oct 8 06:55:51 remote5bge0 overchan[14468]: [ID 702911 news.error] input line too long, skipping
Oct 8 08:43:55 remote5bge0 overchan[14468]: [ID 702911 news.error] input line too long, skipping
Oct 8 11:51:54 remote5bge0 overchan[14468]: [ID 702911 news.error] input line too long, skipping
Oct 8 12:35:52 remote5bge0 overchan[14468]: [ID 702911 news.error] input line too long, skipping
Oct 8 13:33:00 remote5bge0 overchan[14468]: [ID 702911 news.error] input line too long, skipping
Oct 8 13:42:43 remote5bge0 overchan[14468]: [ID 702911 news.error] input line too long, skipping
Oct 8 21:21:07 remote5bge0 overchan[14468]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 19529 33.0%3.8 MB 40.9%
innd 18731 31.7%2.9 MB 31.3%
nnrpd 17214 29.1%1.8 MB 19.2%
innfeed 3694 6.2%823.3 KB 8.6%
overchan 10 0.0%1.5 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 59180 100.0%9.3 MB100.0%

History cache:

ReasonCount%Count
Cache misses 183670 51.9%
Do not exist 170336 48.1%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 354006 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%88 0.000 0.000 0.000
article cleanup00:00:00.556 0.0%38660 0.000 0.014 0.056
article logging00:00:02.946 0.0%38942 0.000 0.076 8.983
article parse00:00:01.448 0.0%97994 0.000 0.015 0.034
article write00:01:52.212 0.1%29730 1.328 3.774 241.317
artlog/artparse00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:00.386 0.0%369616 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.204 0.0%355880 0.002 0.009 0.016
history sync00:00:00.164 0.0%734 0.000 0.223 1.500
history write00:00:03.804 0.0%38660 0.015 0.098 2.492
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:35:54.828 99.8%406286 241.476 421.759 944.679
nntp read00:00:02.870 0.0%405932 0.000 0.007 0.016
overview write00:00:00.342 0.0%29730 0.000 0.012 0.055
perl filter00:00:58.426 0.0%38650 1.195 1.512 3.223
python filter00:00:01.568 0.0%38654 0.008 0.041 0.090
site send00:00:03.090 0.0%89142 0.011 0.035 0.070
TOTAL: 47:41:43.29047:39:05.844 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.160 0.0%29702 0.000 0.005 0.043
article prepare00:00:00.020 0.0%36352 0.000 0.001 0.031
article read00:00:00.592 0.0%5822 0.000 0.102 8.750
backlog stats00:00:00.342 0.0%478780 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.412 0.0%298844 0.003 0.008 0.019
data write00:00:05.752 0.0%269266 0.011 0.021 0.040
idle47:33:42.982100.0%478780 212.922 357.624 1146.451
status file00:00:03.530 0.0%388 0.500 9.098 57.000
TOTAL: 47:34:19.99247:33:55.790100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:04:28.352 95.5%18216 17.846 409.989 29000.312
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:05.828 0.1%504734 0.000 0.012 0.071
readart00:00:20.386 0.3%2558 2.000 7.970 39.000
TOTAL: 02:10:20.58802:04:54.566 95.8%----

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 1148 36496 12390 19156 4950 33%94:49:02
2news.snarked.org 44 26676 6718 19562 396 25%53:07:36
3newsfeed.neva.ru 594 34096 5038 27986 1072 14%276:14:38
4feeder3.feed-ams.uzoreto.com 574 12968 3706 8034 1228 28%47:18:56
5ripco-out.news.tnetconsulting.net 4 30648 778 29770 100 2%40:06:36
6newsfeed.fu-berlin.de 4 14812 408 14398 6 2%47:47:00
7news.lightlink.com 2 5714 182 5354 178 3%33:51:08
8ripco-out.feeder.erje.net 574 31564 52 30638 874 0%47:17:36
9news-in.rahul.net 574 15532 26 15498 8 0%47:18:56
10news.cmpublishers.com 52 8778 18 8726 34 0%48:00:02
11localhost 150 4 4 0 0 100%00:00:00
TOTAL: 11 3720 217288 29320 179122 8846 13%735:51:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com30.2 MB9.3 KB10.0 MB40.2 MB 75%2.4 KB
2news.snarked.org19.3 MB0.0 KB1.2 MB20.5 MB 94%3.0 KB
3ripco-out.news.tnetconsulting.net14.0 MB0.0 KB950.2 KB14.9 MB 93%17.4 KB
4newsfeed.neva.ru12.8 MB0.0 KB2.8 MB15.7 MB 81%2.6 KB
5feeder3.feed-ams.uzoreto.com9.4 MB5.6 KB2.7 MB12.2 MB 77%2.5 KB
6news.lightlink.com2.2 MB114.6 KB6.3 MB8.7 MB 25%24.8 KB
7newsfeed.fu-berlin.de1.9 MB0.0 KB15.8 KB1.9 MB 99%4.8 KB
8news-in.rahul.net266.1 KB5.0 KB28.8 KB299.9 KB 88%8.8 KB
9ripco-out.feeder.erje.net83.2 KB0.0 KB7.8 MB7.9 MB 1%8.7 KB
10news.cmpublishers.com48.2 KB0.0 KB86.1 KB134.3 KB 35%2.6 KB
11localhost4.9 KB0.0 KB0.0 KB4.9 KB100%1.2 KB
TOTAL: 1190.4 MB134.5 KB32.0 MB122.5 MB 73%3.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 8 00:01:02 - 00:59:59 405 2.7% 0.112.7 MB 5.7% 0.77
Oct 8 01:00:00 - 01:59:59 409 2.7% 0.111.2 MB 2.5% 0.33
Oct 8 02:00:00 - 02:59:59 627 4.2% 0.171.6 MB 3.4% 0.45
Oct 8 03:00:00 - 03:59:59 760 5.1% 0.212.0 MB 4.4% 0.58
Oct 8 04:00:00 - 04:59:59 689 4.6% 0.192.1 MB 4.5% 0.60
Oct 8 05:00:00 - 05:59:59 684 4.6% 0.191.9 MB 4.0% 0.53
Oct 8 06:00:00 - 06:59:59 768 5.2% 0.212.1 MB 4.5% 0.60
Oct 8 07:00:00 - 07:59:59 782 5.2% 0.222.4 MB 5.0% 0.67
Oct 8 08:00:00 - 08:59:59 744 5.0% 0.212.4 MB 5.2% 0.69
Oct 8 09:00:00 - 09:59:59 671 4.5% 0.193.0 MB 6.4% 0.85
Oct 8 10:00:00 - 10:59:59 748 5.0% 0.212.2 MB 4.7% 0.63
Oct 8 11:00:00 - 11:59:59 932 6.3% 0.262.7 MB 5.9% 0.78
Oct 8 12:00:00 - 12:59:59 821 5.5% 0.232.1 MB 4.4% 0.59
Oct 8 13:00:00 - 13:59:59 780 5.2% 0.222.2 MB 4.8% 0.63
Oct 8 14:00:00 - 14:59:59 758 5.1% 0.212.0 MB 4.3% 0.57
Oct 8 15:00:00 - 15:59:59 701 4.7% 0.191.8 MB 3.9% 0.52
Oct 8 16:00:00 - 16:59:59 715 4.8% 0.202.6 MB 5.6% 0.75
Oct 8 17:00:00 - 17:59:59 602 4.0% 0.171.9 MB 4.0% 0.54
Oct 8 18:00:00 - 18:59:59 516 3.5% 0.141.7 MB 3.7% 0.49
Oct 8 19:00:00 - 19:59:59 358 2.4% 0.101.2 MB 2.6% 0.34
Oct 8 20:00:00 - 20:59:59 367 2.5% 0.101.1 MB 2.4% 0.32
Oct 8 21:00:00 - 21:59:59 357 2.4% 0.101.2 MB 2.5% 0.33
Oct 8 22:00:00 - 22:59:59 340 2.3% 0.091.5 MB 3.1% 0.41
Oct 8 23:00:00 - 23:57:59 363 2.4% 0.101.2 MB 2.6% 0.35
TOTAL: 23:56:57 14897 100.0% 0.1746.8 MB 100.0% 0.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2485 1653 0 2 2 0 0 0 828
2feeder3.feed-ams.uzoreto.com 618 315 0 1 1 0 0 0 301
3newsfeed.neva.ru 581 344 0 0 3 0 0 0 234
4ripco-out.feeder.erje.net 438 433 0 0 0 0 0 0 5
5news.snarked.org 198 43 0 0 0 0 0 0 155
6news.lightlink.com 134 4 0 1 0 0 0 0 129
7newsfeed.fu-berlin.de 94 0 0 0 0 0 0 0 94
8ripco-out.news.tnetconsulting.net 63 32 0 0 0 0 0 0 31
9news.cmpublishers.com 17 1 0 0 0 0 0 0 16
10news-in.rahul.net 4 0 0 1 0 0 0 0 3
TOTAL: 10 4632 2825 0 5 6 0 0 0 1796

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2063
alt.binaries.ftd 242
alt.binaries.e-book 42
fido7.su.pol.news 38
it.comp.os.win.windows10 31
scinet.stats 27
alt.bestjobsusa.computer.jobs 26
trollnet.cinema 15
alt.binaries.3d.poser 14
fr.comp.usenet.serveurs 13
alt.binaries.test.yenc 12
alt.binaries.nospam.breasts.natural 12
alt.binaries.pictures.purebeauty 9
it.eventi.covid19 9
aioe.news.assistenza 8
free.it.scienza.fisica 8
fido7.ru.mozilla 8
alt.binaries.humor.skewed 8
alt.my.job.sucks 8
aus.jobs 8
TOTAL: 124 2825

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

GroupsCount
pl.praca.oferowana 4
fr.comp.securite 1
bit.listserv.catholic 1
TOTAL: 3 6

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1468
EMP (md5) 1382
EMP (phl) 176
Binary in non-binary group 140
Scoring filter (8) 36
Scoring filter (11) 16
Scoring filter (10) 14
Scoring filter (18) 14
Scoring filter (9) 12
Poison newsgroup 12
HTML post 10
Scoring filter (13) 6
Scoring filter (15) 6
Scoring filter (14) 4
Scoring filter (16) 2
Scoring filter (17) 2
TOTAL: 16 3300

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 30
ripco-out.feed.uzoreto.com 14
feeder3.feed-ams.uzoreto.com 4
TOTAL: 3 48
Including strange strings
newsfeed.fu-berlin.de 90
newsfeed.neva.ru 37
ripco-out.feed.uzoreto.com 10
feeder3.feed-ams.uzoreto.com 3
news.snarked.org 1
TOTAL: 5 141
No colon-space in header
ripco-out.feeder.erje.net 4
TOTAL: 1 4
TOTAL: 3 193

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 31532 3134 23960 1134 0 0 9%47:46:40
2news.lightlink.com 10214 1604 5902 20 0 0 15%47:45:38
3rahul.net 25200 1056 12980 18 0 2 4%47:38:02
4news.cmpublishers.com 46844 232 27428 1634 0 46 0%47:38:14
5news.uzoreto.com 13762 38 13062 74 0 0 0%47:35:30
6news.tnetconsulting.net 43924 34 28650 4 0 28 0%47:40:00
7fu-berlin.de 27040 32 27008 0 0 0 0%47:40:08
8news.snarked.org 37930 28 22446 22 0 14 0%47:40:00
9newsfeed.neva.ru 25488 16 24524 30 0 0 0%47:33:06
10remote6hme0.ripco.com 16 10 0 6 0 0 62%02:28:42
TOTAL: 10 261950 6184 185960 2942 0 90 2%431:26:00
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1feeder.erje.net8.5 MB2.6 MB11.1 MB0.1 KB/s2.7 KB47:46:40
2news.lightlink.com4.7 MB150.7 KB4.9 MB0.0 KB/s3.1 KB47:45:38
3rahul.net4.0 MB45.4 KB4.1 MB0.0 KB/s3.9 KB47:38:02
4news.cmpublishers.com807.2 KB4.1 MB4.9 MB0.0 KB/s2.7 KB47:38:14
5news.tnetconsulting.net148.8 KB21.5 KB170.4 KB0.0 KB/s4.5 KB47:40:00
6news.snarked.org136.0 KB39.4 KB175.4 KB0.0 KB/s3.5 KB47:40:00
7newsfeed.neva.ru117.5 KB77.6 KB195.2 KB0.0 KB/s4.2 KB47:33:06
8news.uzoreto.com104.9 KB160.0 KB264.9 KB0.0 KB/s2.4 KB47:35:30
9fu-berlin.de98.9 KB0.0 KB98.9 KB0.0 KB/s3.1 KB47:40:08
10remote6hme0.ripco.com15.1 KB16.6 KB31.7 KB0.0 KB/s2.0 KB02:28:42
TOTAL: 1018.7 MB7.2 MB25.9 MB0.0 KB/s2.9 KB431:26:00
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10922.9 MB 466 4 000:11:14
2shell3.ripco.com 12 3701.0 MB 44 0 001:58:55
TOTAL: 2 298 14623.9 MB 510 4 002:10:11

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10922.9 MB 466 4 000:11:14
2*.ripco.com 12 3701.0 MB 44 0 001:58:55
TOTAL: 2 298 14623.9 MB 510 4 002:10:10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 3.320 2.428 0.00001:58:55
ftupet.com 46.670 21.502 0.00000:11:14
scan-141.security.ipip.net 0.200 0.052 0.00000:00:00
43.245.222.163 0.202 0.052 0.00000:00:00
TOTAL: 4 50.392 24.034 0.00002:10:11

NNRP no permission clients:

SystemConn
scan-141.security.ipip.net 2
43.245.222.163 2
TOTAL: 2 4

NNRP unrecognized commands (by host):

SystemConn
shell3.ripco.com 6
TOTAL: 1 6

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 6
TOTAL: 1 6

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 1286 88.0%
2alt 46 3.1%
3misc 42 2.9%
4sci 24 1.6%
5comp 24 1.6%
6chi 22 1.5%
7news 18 1.2%
TOTAL: 7 1462100.0%

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

NewsgroupCount
1rec.arts.tv 678
2rec.food.cooking 428
3rec.bicycles.tech 154
4alt.comp.os.windows-10 40
5misc.phone.mobile.iphone 32
6sci.electronics.repair 24
7chi.general 14
8news.software.readers 12
9misc.consumers.frugal-living 10
10rec.radio.broadcasting 8
11comp.sys.apple2 8
12comp.mail.sendmail 8
13news.admin.peering 6
14chi.weather 6
15comp.mobile.android 6
16rec.gardens.edible 6
17rec.outdoors.rv-travel 4
18alt.stupidity 4
19rec.radio.shortwave 4
20alt.games.warcraft 2
21rec.bicycles.misc 2
22rec.radio.swap 2
23comp.sys.mac.system 2
24chi.forsale 2
TOTAL: 24 1462