Daily Usenet report for news.ripco.com

Mar 25 00:01:01 -- Mar 25 23:57:48

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Mar 25 06:07:48 remote5bge0 overchan[3116]: [ID 702911 news.error] input line too long, skipping
Mar 25 06:36:11 remote5bge0 overchan[3116]: [ID 702911 news.error] input line too long, skipping
Mar 25 06:52:58 remote5bge0 overchan[3116]: [ID 702911 news.error] input line too long, skipping
Mar 25 07:14:17 remote5bge0 overchan[3116]: [ID 702911 news.error] input line too long, skipping
Mar 25 07:47:55 remote5bge0 overchan[3116]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 21731 35.0%4.3 MB 43.3%
nnrpd 18646 30.0%2.0 MB 20.0%
innd 18179 29.2%2.8 MB 28.7%
innfeed 3610 5.8%800.4 KB 7.9%
overchan 5 0.0%0.6 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 62173 100.0%9.9 MB100.0%

History cache:

ReasonCount%Count
Cache misses 205492 52.2%
Do not exist 188522 47.8%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 394014 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%138 0.000 0.000 0.000
article cleanup00:00:00.486 0.0%43058 0.000 0.011 0.041
article logging00:00:01.018 0.0%43562 0.000 0.023 0.976
article parse00:00:01.540 0.0%106956 0.000 0.014 0.039
article write00:01:19.340 0.0%34500 1.255 2.300 90.870
artlog/artparse00:00:00.002 0.0%8 0.000 0.250 1.000
data move00:00:00.388 0.0%404584 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:02.882 0.0%396202 0.003 0.007 0.023
history sync00:00:00.196 0.0%804 0.000 0.244 1.500
history write00:00:03.454 0.0%43062 0.018 0.080 1.113
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:57:00.678 99.8%446122 217.103 386.936 1169.768
nntp read00:00:03.420 0.0%446598 0.003 0.008 0.021
overview write00:00:00.326 0.0%34500 0.000 0.009 0.061
perl filter00:01:02.244 0.0%43054 1.201 1.446 2.569
python filter00:00:01.564 0.0%43062 0.000 0.036 0.094
site send00:00:03.170 0.0%103398 0.008 0.031 0.071
TOTAL: 48:02:18.46647:59:40.708 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.134 0.0%34578 0.000 0.004 0.074
article prepare00:00:00.008 0.0%22240 0.000 0.000 0.010
article read00:00:00.578 0.0%4392 0.000 0.132 4.438
backlog stats00:00:00.250 0.0%530648 0.000 0.000 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.712 0.0%335350 0.000 0.005 0.013
data write00:00:04.394 0.0%301128 0.004 0.015 0.032
idle47:52:59.748100.0%530648 180.917 324.848 969.900
status file00:00:02.664 0.0%362 0.667 7.359 71.000
TOTAL: 47:53:28.86047:53:09.488100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:34:09.410 97.8%18000 17.928 713.856 28460.662
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.638 0.1%979038 0.000 0.009 1.000
readart00:00:20.116 0.2%2060 2.750 9.765 42.000
TOTAL: 03:38:54.03403:34:38.164 98.1%----

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 41750 15784 21362 4604 37%94:39:38
2news.snarked.org 46 29654 7382 21276 996 24%52:09:50
3newsfeed.neva.ru 586 43914 5778 36876 1260 13%276:47:50
4feeder3.feed-ams.uzoreto.com 574 14418 3390 10328 700 23%47:19:48
5ripco-out.news.tnetconsulting.net 2 42124 758 41276 90 1%53:55:26
6newsfeed.fu-berlin.de 6 14650 734 13892 24 5%46:14:32
7news-in.rahul.net 574 15456 278 15120 58 1%47:29:38
8news.lightlink.com 2 7250 198 6878 174 2%48:31:16
9ripco-out.feeder.erje.net 574 35310 106 34466 738 0%47:27:42
10news.cmpublishers.com 50 8914 14 8900 0 0%48:00:10
11localhost 154 8 8 0 0 100%00:00:00
TOTAL: 11 3716 253448 34430 210374 8644 13%762:35:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com37.7 MB10.5 KB9.7 MB47.4 MB 79%2.4 KB
2news.snarked.org20.1 MB0.0 KB2.3 MB22.3 MB 89%2.7 KB
3newsfeed.neva.ru15.7 MB0.0 KB3.2 MB18.9 MB 83%2.8 KB
4news-in.rahul.net14.3 MB0.0 KB2.9 MB17.1 MB 83%52.2 KB
5ripco-out.news.tnetconsulting.net12.7 MB0.0 KB2.5 MB15.1 MB 83%18.3 KB
6feeder3.feed-ams.uzoreto.com8.1 MB0.0 KB1.6 MB9.7 MB 83%2.4 KB
7newsfeed.fu-berlin.de4.9 MB0.0 KB194.7 KB5.1 MB 96%6.9 KB
8news.lightlink.com2.1 MB0.0 KB9.0 MB11.2 MB 18%30.7 KB
9ripco-out.feeder.erje.net169.9 KB0.0 KB6.6 MB6.7 MB 2%8.2 KB
10news.cmpublishers.com55.7 KB0.0 KB0.0 KB55.7 KB100%4.0 KB
11localhost29.7 KB0.0 KB0.0 KB29.7 KB100%3.7 KB
TOTAL: 11115.8 MB10.5 KB37.9 MB153.6 MB 75%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 25 00:01:01 - 00:59:59 290 1.7% 0.081.1 MB 1.9% 0.32
Mar 25 01:00:00 - 01:59:59 387 2.2% 0.112.1 MB 3.7% 0.61
Mar 25 02:00:00 - 02:59:59 542 3.2% 0.151.9 MB 3.2% 0.53
Mar 25 03:00:00 - 03:59:59 644 3.7% 0.181.9 MB 3.2% 0.53
Mar 25 04:00:00 - 04:59:59 807 4.7% 0.221.8 MB 3.2% 0.52
Mar 25 05:00:00 - 05:59:59 901 5.2% 0.252.4 MB 4.2% 0.69
Mar 25 06:00:00 - 06:59:59 901 5.2% 0.253.0 MB 5.1% 0.84
Mar 25 07:00:00 - 07:59:59 915 5.3% 0.252.3 MB 3.9% 0.65
Mar 25 08:00:00 - 08:59:59 923 5.4% 0.263.1 MB 5.4% 0.89
Mar 25 09:00:00 - 09:59:59 1101 6.4% 0.314.2 MB 7.2% 1.19
Mar 25 10:00:00 - 10:59:59 952 5.5% 0.262.6 MB 4.5% 0.75
Mar 25 11:00:00 - 11:59:59 1081 6.3% 0.303.8 MB 6.6% 1.09
Mar 25 12:00:00 - 12:59:59 1029 6.0% 0.293.0 MB 5.1% 0.84
Mar 25 13:00:00 - 13:59:59 1014 5.9% 0.283.5 MB 6.1% 1.01
Mar 25 14:00:00 - 14:59:59 872 5.1% 0.243.5 MB 5.9% 0.98
Mar 25 15:00:00 - 15:59:59 888 5.2% 0.252.4 MB 4.1% 0.68
Mar 25 16:00:00 - 16:59:59 853 5.0% 0.242.7 MB 4.7% 0.78
Mar 25 17:00:00 - 17:59:59 748 4.3% 0.214.1 MB 7.0% 1.15
Mar 25 18:00:00 - 18:59:59 548 3.2% 0.152.2 MB 3.7% 0.62
Mar 25 19:00:00 - 19:59:59 470 2.7% 0.131.7 MB 2.8% 0.47
Mar 25 20:00:00 - 20:59:59 397 2.3% 0.111.2 MB 2.1% 0.34
Mar 25 21:00:00 - 21:59:59 329 1.9% 0.091.0 MB 1.8% 0.29
Mar 25 22:00:00 - 22:59:59 311 1.8% 0.091.4 MB 2.3% 0.39
Mar 25 23:00:00 - 23:57:48 300 1.7% 0.091.4 MB 2.4% 0.41
TOTAL: 23:56:47 17203 100.0% 0.2058.2 MB 100.0% 0.69
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2311 1632 0 1 0 0 0 0 678
2newsfeed.neva.ru 696 375 0 0 3 0 0 0 318
3news.snarked.org 513 392 0 0 2 0 0 0 119
4ripco-out.feeder.erje.net 370 368 0 0 0 0 0 0 2
5feeder3.feed-ams.uzoreto.com 354 223 0 0 1 0 0 0 130
6newsfeed.fu-berlin.de 171 0 0 0 0 0 0 0 171
7news.lightlink.com 57 0 0 1 0 0 0 0 56
8news-in.rahul.net 29 0 0 0 0 0 0 0 29
9ripco-out.news.tnetconsulting.net 27 17 0 0 0 0 0 0 10
TOTAL: 9 4528 3007 0 2 6 0 0 0 1513

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2153
alt.binaries.ftd 166
fido7.su.pol.news 56
scot.general 53
free.it.scienza.fisica 47
perl.cpan.uploads 43
it.comp.os.win.windows10 43
alt.binaries.nl 36
alt.bestjobsusa.computer.jobs 26
it.tlc.cellulari.android 17
alt.my.job.sucks 14
free.ucp 14
alt.binaries.nospam.breasts.natural 13
alt.jobs.jobsearch 13
alt.binaries.e-book 13
grisbi.bugsreports 12
alt.binaries.pictures.rail 11
alt.binaries.pictures.scenic 10
alt.binaries.mac.osx.apps 9
linux.debian.ports.arm 9
TOTAL: 139 3007

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

GroupsCount
pl.praca.oferowana 4
christnet.theology 1
alt.christnet.christnews 1
TOTAL: 3 6

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1340
Too many newsgroups 700
Binary in non-binary group 220
EMP (phl) 178
Scoring filter (11) 34
Scoring filter (8) 16
Scoring filter (10) 10
Scoring filter (9) 8
U2 violation - invalid distribution 4
HTML post 2
Poison newsgroup 2
TOTAL: 11 2514

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 22
ripco-out.feed.uzoreto.com 2
feeder3.feed-ams.uzoreto.com 2
TOTAL: 3 26
Including strange strings
newsfeed.fu-berlin.de 162
newsfeed.neva.ru 61
news.snarked.org 16
ripco-out.feed.uzoreto.com 9
feeder3.feed-ams.uzoreto.com 4
TOTAL: 5 252
No colon-space in header
ripco-out.feeder.erje.net 2
ripco-out.feed.uzoreto.com 2
TOTAL: 2 4
TOTAL: 3 282

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 11036 1692 6224 6 0 10 15%47:40:04
2rahul.net 24902 858 13296 36 0 18 3%47:40:04
3news.cmpublishers.com 50342 258 31654 1772 0 62 0%47:37:54
4news.tnetconsulting.net 56856 232 33356 14 0 76 0%47:43:46
5news.uzoreto.com 14972 86 14268 226 0 12 0%47:40:10
6news.snarked.org 44712 58 26478 20 0 54 0%47:41:44
7fu-berlin.de 30726 40 30686 0 0 0 0%47:40:10
8feeder.erje.net 33128 28 32106 146 0 0 0%47:40:04
9newsfeed.neva.ru 30260 26 28360 30 0 22 0%47:40:10
10remote6hme0.ripco.com 8 2 0 6 0 0 25%01:32:08
TOTAL: 10 296942 3280 216428 2256 0 254 1%430:36:14
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com6.5 MB20.2 KB6.6 MB0.0 KB/s4.0 KB47:40:04
2rahul.net5.8 MB86.7 KB5.9 MB0.0 KB/s6.7 KB47:40:04
3news.tnetconsulting.net832.5 KB28.6 KB861.1 KB0.0 KB/s3.5 KB47:43:46
4news.cmpublishers.com775.3 KB4.6 MB5.4 MB0.0 KB/s2.7 KB47:37:54
5news.uzoreto.com372.5 KB955.1 KB1.3 MB0.0 KB/s4.3 KB47:40:10
6news.snarked.org361.3 KB59.3 KB420.6 KB0.0 KB/s5.4 KB47:41:44
7fu-berlin.de353.3 KB0.0 KB353.3 KB0.0 KB/s8.8 KB47:40:10
8newsfeed.neva.ru231.8 KB142.8 KB374.7 KB0.0 KB/s6.7 KB47:40:10
9feeder.erje.net76.4 KB531.7 KB608.1 KB0.0 KB/s3.5 KB47:40:04
10remote6hme0.ripco.com4.8 KB32.8 KB37.6 KB0.0 KB/s4.7 KB01:32:08
TOTAL: 1015.3 MB6.4 MB21.7 MB0.0 KB/s4.0 KB430:36:14
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 8122.1 MB 384 6 000:07:31
2shell3 18 4301.4 MB 54 2 003:28:36
TOTAL: 2 304 12423.5 MB 438 8 003:38:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 8122.1 MB 384 6 000:07:31
2? 18 4301.4 MB 54 2 003:28:36
TOTAL: 2 304 12423.5 MB 438 8 003:36:08

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 4.986 2.928 0.00003:28:36
ftupet.com 46.360 20.760 0.00000:07:31
84-105-134-55.cable.dynamic.v4.ziggo.nl 35.544 9.306 0.00000:02:21
worker-18.sfj.corp.censys.io 0.200 0.050 0.00000:00:00
TOTAL: 4 87.090 33.044 0.00003:38:29

NNRP no permission clients:

SystemConn
84-105-134-55.cable.dynamic.v4.ziggo.nl 352
worker-18.sfj.corp.censys.io 2
TOTAL: 2 354

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 976 78.6%
2alt 158 12.7%
3comp 62 5.0%
4misc 26 2.1%
5chi 14 1.1%
6news 4 0.3%
7gnu 2 0.2%
TOTAL: 7 1242100.0%

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

NewsgroupCount
1rec.food.cooking 452
2rec.arts.tv 440
3alt.comp.os.windows-10 102
4rec.bicycles.tech 58
5alt.stupidity 32
6misc.phone.mobile.iphone 22
7comp.protocols.dns.bind 18
8comp.sys.mac.system 16
9rec.gardens.edible 14
10alt.security.alarms 12
11comp.internet.services.video.youtube 12
12rec.radio.broadcasting 10
13chi.weather 10
14comp.unix.bsd.freebsd.misc 8
15comp.mobile.android 6
16alt.internet.wireless 4
17misc.consumers.frugal-living 4
18news.groups.questions 4
19alt.video.digital-tv 2
20alt.marketing.online.ebay 2
21chi.forsale 2
22comp.mobile.ipad 2
23rec.radio.swap 2
24gnu.utils.bug 2
25alt.dss.hack 2
26chi.general 2
27alt.free.newsservers 2
TOTAL: 27 1242