Daily Usenet report for news.ripco.com

Sep 16 00:01:02 -- Sep 16 23:57:59

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Sep 16 06:40:04 remote5bge0 overchan[20845]: [ID 702911 news.error] input line too long, skipping
Sep 16 07:25:47 remote5bge0 overchan[20845]: [ID 702911 news.error] input line too long, skipping
Sep 16 08:40:07 remote5bge0 overchan[20845]: [ID 702911 news.error] input line too long, skipping
Sep 16 09:43:45 remote5bge0 overchan[20845]: [ID 702911 news.error] input line too long, skipping
Sep 16 11:10:33 remote5bge0 overchan[20845]: [ID 702911 news.error] input line too long, skipping
Sep 16 13:27:51 remote5bge0 overchan[20845]: [ID 702911 news.error] input line too long, skipping
Sep 16 14:43:10 remote5bge0 overchan[20845]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 19047 32.6%3.8 MB 41.1%
nnrpd 18362 31.4%1.9 MB 21.0%
innd 17441 29.8%2.7 MB 29.7%
innfeed 3648 6.2%773.9 KB 8.2%
overchan 7 0.0%0.9 KB 0.0%
controlchan 6 0.0%1.1 KB 0.0%
TOTAL: 6 58511 100.0%9.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 189008 58.5%
Cache misses 133852 41.5%
Positive hits 0 0.0%
Negative hits 0 0.0%
TOTAL: 4 322860 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%108 0.000 0.000 0.000
article cleanup00:00:00.524 0.0%37934 0.000 0.014 0.057
article logging00:00:00.872 0.0%38276 0.000 0.023 0.263
article parse00:00:01.352 0.0%95926 0.000 0.014 0.029
article write00:01:43.576 0.1%30574 1.383 3.388 203.291
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.382 0.0%327734 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.880 0.0%324428 0.000 0.009 0.017
history sync00:00:00.228 0.0%820 0.000 0.278 1.500
history write00:00:04.184 0.0%37936 0.016 0.110 6.079
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:56:38.350 99.8%370518 283.717 465.830 1158.795
nntp read00:00:03.058 0.0%370194 0.002 0.008 0.022
overview write00:00:00.296 0.0%30574 0.000 0.010 0.055
perl filter00:00:54.952 0.0%37934 1.230 1.449 2.192
python filter00:00:01.436 0.0%37938 0.000 0.038 0.125
site send00:00:02.920 0.0%91682 0.007 0.032 0.063
TOTAL: 48:02:16.81047:59:35.010 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.126 0.0%30488 0.000 0.004 0.024
article prepare00:00:00.002 0.0%5536 0.000 0.000 0.042
article read00:00:00.312 0.0%1148 0.000 0.272 9.750
backlog stats00:00:00.300 0.0%389848 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.690 0.0%249130 0.000 0.007 0.025
data write00:00:04.840 0.0%218966 0.008 0.022 0.050
idle47:50:24.628100.0%389848 243.731 441.774 1197.688
status file00:00:03.200 0.0%360 1.000 8.889 39.000
TOTAL: 47:50:53.71447:50:35.098100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:11:31.478 90.7%17976 17.846 439.001 21436.973
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:06.148 0.1%575312 0.000 0.011 2.000
readart00:00:19.774 0.2%2362 1.775 8.372 36.500
TOTAL: 02:25:00.51202:11:57.400 91.0%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
news@sfere.anjou.terraraq.org.uk002002
TOTAL002002

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 25828 10696 13148 1984 41%94:47:20
2feeder3.feed-ams.uzoreto.com 574 21508 10260 8018 3230 47%47:18:58
3newsfeed.neva.ru 598 15754 7850 6616 1288 49%276:47:32
4newsfeed.fu-berlin.de 2 18064 598 17444 22 3%60:47:54
5ripco-out.news.tnetconsulting.net 2 27684 568 27088 28 2%40:13:34
6news-in.rahul.net 574 14782 294 14460 28 1%47:19:08
7ripco-out.feeder.erje.net 574 30334 52 29658 624 0%47:17:54
8news.lightlink.com 2 9792 46 9706 40 0%52:29:26
9news.cmpublishers.com 52 7402 38 7346 18 0%47:59:48
10localhost 150 4 4 0 0 100%00:00:00
TOTAL: 10 3676 171152 30406 133484 7262 17%715:01:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com28.4 MB0.0 KB4.6 MB33.0 MB 86%2.7 KB
2newsfeed.neva.ru26.8 MB0.0 KB4.2 MB31.0 MB 86%3.5 KB
3feeder3.feed-ams.uzoreto.com26.2 MB0.0 KB6.2 MB32.5 MB 80%2.5 KB
4ripco-out.news.tnetconsulting.net10.7 MB0.0 KB239.0 KB10.9 MB 97%18.8 KB
5news-in.rahul.net5.1 MB0.0 KB163.4 KB5.2 MB 96%16.6 KB
6newsfeed.fu-berlin.de4.2 MB0.0 KB266.3 KB4.4 MB 94%7.3 KB
7news.lightlink.com1.7 MB0.0 KB2.6 MB4.3 MB 39%51.1 KB
8ripco-out.feeder.erje.net204.7 KB0.0 KB4.2 MB4.4 MB 4%6.7 KB
9news.cmpublishers.com102.2 KB0.0 KB38.5 KB140.7 KB 72%2.5 KB
10localhost12.2 KB0.0 KB0.0 KB12.2 KB100%3.1 KB
TOTAL: 10103.4 MB0.0 KB22.6 MB125.9 MB 82%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 16 00:01:02 - 00:59:59 407 2.7% 0.122.2 MB 4.2% 0.63
Sep 16 01:00:00 - 01:59:59 502 3.3% 0.141.4 MB 2.7% 0.40
Sep 16 02:00:00 - 02:59:59 546 3.6% 0.151.6 MB 3.2% 0.47
Sep 16 03:00:00 - 03:59:59 673 4.4% 0.191.9 MB 3.6% 0.53
Sep 16 04:00:00 - 04:59:59 715 4.7% 0.202.4 MB 4.7% 0.70
Sep 16 05:00:00 - 05:59:59 715 4.7% 0.202.3 MB 4.5% 0.67
Sep 16 06:00:00 - 06:59:59 591 3.9% 0.161.9 MB 3.7% 0.55
Sep 16 07:00:00 - 07:59:59 662 4.3% 0.183.0 MB 5.8% 0.86
Sep 16 08:00:00 - 08:59:59 894 5.9% 0.252.6 MB 5.0% 0.73
Sep 16 09:00:00 - 09:59:59 912 6.0% 0.252.6 MB 5.0% 0.74
Sep 16 10:00:00 - 10:59:59 875 5.7% 0.243.1 MB 5.9% 0.87
Sep 16 11:00:00 - 11:59:59 852 5.6% 0.242.9 MB 5.5% 0.82
Sep 16 12:00:00 - 12:59:59 774 5.1% 0.212.9 MB 5.5% 0.82
Sep 16 13:00:00 - 13:59:59 820 5.4% 0.232.4 MB 4.7% 0.69
Sep 16 14:00:00 - 14:59:59 765 5.0% 0.212.2 MB 4.2% 0.62
Sep 16 15:00:00 - 15:59:59 826 5.4% 0.232.6 MB 4.9% 0.73
Sep 16 16:00:00 - 16:59:59 872 5.7% 0.243.1 MB 5.9% 0.88
Sep 16 17:00:00 - 17:59:59 618 4.1% 0.173.1 MB 6.0% 0.89
Sep 16 18:00:00 - 18:59:59 542 3.6% 0.151.8 MB 3.4% 0.51
Sep 16 19:00:00 - 19:59:59 391 2.6% 0.111.2 MB 2.2% 0.33
Sep 16 20:00:00 - 20:59:59 340 2.2% 0.091.1 MB 2.0% 0.30
Sep 16 21:00:00 - 21:59:59 326 2.1% 0.09965.4 KB 1.8% 0.27
Sep 16 22:00:00 - 22:59:59 282 1.9% 0.08925.8 KB 1.7% 0.26
Sep 16 23:00:00 - 23:57:59 319 2.1% 0.092.0 MB 3.8% 0.58
TOTAL: 23:56:57 15219 100.0% 0.1852.0 MB 100.0% 0.62
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feeder3.feed-ams.uzoreto.com 1632 1218 0 0 1 0 0 0 413
2ripco-out.feed.uzoreto.com 999 557 0 0 7 0 0 0 435
3newsfeed.neva.ru 700 406 0 0 4 0 0 0 290
4ripco-out.feeder.erje.net 312 311 0 0 0 0 0 0 1
5newsfeed.fu-berlin.de 107 0 0 0 0 0 0 0 107
6ripco-out.news.tnetconsulting.net 28 7 0 0 0 0 0 0 21
7news.lightlink.com 27 6 0 0 0 0 0 0 21
8news-in.rahul.net 14 0 0 0 0 0 0 0 14
9news.cmpublishers.com 9 0 0 0 0 0 0 0 9
TOTAL: 9 3828 2505 0 0 12 0 0 0 1311

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1734
alt.binaries.ftd 135
scot.general 88
fido7.su.pol.news 39
alt.bestjobsusa.computer.jobs 36
scinet.stats 30
it.tlc.cellulari.android 24
free.software 24
it.comp.os.win.windows10 20
free.willey 17
alt.jobs.jobsearch 16
alt.binaries.pictures.scenic 14
alt.my.job.sucks 14
alt.binaries.e-book 14
mozilla.test 12
att.jobs 11
alt.binaries.3d.poser 11
nl.comp.os.linux.techniek 11
alt.binaries.nospam.breasts.natural 10
fr.usenet.abus.nocem 10
TOTAL: 122 2505

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

GroupsCount
pl.praca.oferowana 9
fr.bienvenue 1
rec.travel.resorts.all-inclusive 1
bit.listserv.catholic 1
TOTAL: 4 12

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1146
EMP (md5) 700
Binary in non-binary group 214
EMP (phl) 92
Scoring filter (9) 62
Scoring filter (8) 14
Scoring filter (10) 12
Scoring filter (18) 10
Scoring filter (11) 8
Scoring filter (12) 6
Scoring filter (15) 6
Scoring filter (17) 2
HTML post 2
Scoring filter (14) 2
Scoring filter (16) 2
TOTAL: 15 2278

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 103
newsfeed.neva.ru 53
feeder3.feed-ams.uzoreto.com 11
ripco-out.feed.uzoreto.com 3
news.lightlink.com 1
TOTAL: 5 171
No colon-space in header
ripco-out.feed.uzoreto.com 1
TOTAL: 1 1
TOTAL: 3 190

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 13964 480 7274 114 0 0 3%47:40:04
2rahul.net 23722 356 13676 4 0 0 1%47:40:04
3feeder.erje.net 30912 156 27308 50 0 0 0%47:47:28
4fu-berlin.de 27710 32 27678 0 0 0 0%47:36:04
5news.tnetconsulting.net 50674 14 29634 0 0 52 0%47:47:48
6news.cmpublishers.com 40192 10 29824 134 0 44 0%47:40:04
7news.uzoreto.com 9094 8 8988 6 0 0 0%47:40:06
8newsfeed.neva.ru 22742 6 22434 6 0 0 0%47:35:50
9news.snarked.org 0 0 0 0 0 29340 0%47:40:04
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:10
TOTAL: 10 219016 1062 166816 320 0 29436 0%430:19:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net4.4 MB23.2 KB4.4 MB0.0 KB/s12.4 KB47:40:04
2news.lightlink.com3.1 MB1.1 MB4.2 MB0.0 KB/s7.2 KB47:40:04
3feeder.erje.net465.7 KB164.3 KB630.0 KB0.0 KB/s3.1 KB47:47:28
4fu-berlin.de143.9 KB0.0 KB143.9 KB0.0 KB/s4.5 KB47:36:04
5news.tnetconsulting.net97.1 KB0.0 KB97.1 KB0.0 KB/s6.9 KB47:47:48
6news.uzoreto.com74.9 KB22.8 KB97.7 KB0.0 KB/s7.0 KB47:40:06
7newsfeed.neva.ru46.8 KB40.0 KB86.9 KB0.0 KB/s7.2 KB47:35:50
8news.cmpublishers.com37.7 KB385.6 KB423.3 KB0.0 KB/s2.9 KB47:40:04
9news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:04
10remote6hme0.ripco.com0.0 KB24.5 KB24.5 KB0.0 KB/s4.1 KB01:12:10
TOTAL: 108.3 MB1.7 MB10.0 MB0.0 KB/s7.4 KB430:19:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9922.3 MB 396 2 000:10:32
2shell3.ripco.com 10 3761.2 MB 36 2 002:06:15
TOTAL: 2 296 13683.5 MB 432 4 002:24:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9922.3 MB 396 2 000:10:32
2*.ripco.com 10 3761.2 MB 36 2 002:06:15
TOTAL: 2 296 13683.5 MB 432 4 002:17:09

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 3.146 2.060 0.00002:06:15
ftupet.com 46.500 20.980 0.00000:10:32
84-105-134-55.cable.dynamic.v4.ziggo.nl 29.198 7.818 0.00000:07:28
? 0.450 0.110 0.00000:00:21
185.100.87.248 0.252 0.076 0.00000:00:00
192.241.213.134 0.202 0.052 0.00000:00:00
winnti-scanner-victims-will-be-notified.threatsinkhole.com 0.200 0.050 0.00000:00:00
TOTAL: 7 79.948 31.146 0.00002:24:40

NNRP no permission clients:

SystemConn
84-105-134-55.cable.dynamic.v4.ziggo.nl 288
185.100.87.248 2
winnti-scanner-victims-will-be-notified.threatsinkhole.com 2
192.241.213.134 2
TOTAL: 4 294

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 1142 83.5%
2comp 118 8.6%
3misc 62 4.5%
4sci 12 0.9%
5seattle 12 0.9%
6alt 10 0.7%
7chi 8 0.6%
8news 4 0.3%
TOTAL: 8 1368100.0%

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

NewsgroupCount
1rec.arts.tv 584
2rec.food.cooking 400
3rec.bicycles.tech 148
4comp.sys.mac.system 58
5misc.phone.mobile.iphone 44
6comp.mobile.android 32
7comp.security.ssh 16
8misc.consumers.frugal-living 16
9seattle.general 12
10sci.electronics.repair 12
11comp.sys.mac.apps 10
12alt.stupidity 8
13rec.radio.broadcasting 6
14chi.general 4
15chi.weather 4
16comp.mail.pine 2
17misc.transport.rail.americas 2
18news.announce.newgroups 2
19rec.radio.swap 2
20rec.heraldry 2
21alt.free.newsservers 2
22news.groups 2
TOTAL: 22 1368