Daily Usenet report for news.ripco.com

Dec 16 00:01:02 -- Dec 16 23:57:06

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Dec 16 08:57:28 remote5bge0 overchan[21825]: [ID 702911 news.error] input line too long, skipping
Dec 16 10:52:38 remote5bge0 overchan[21825]: [ID 702911 news.error] input line too long, skipping
Dec 16 10:57:30 remote5bge0 overchan[21825]: [ID 702911 news.error] input line too long, skipping
Dec 16 13:21:33 remote5bge0 overchan[21825]: [ID 702911 news.error] input line too long, skipping
Dec 16 13:31:36 remote5bge0 overchan[21825]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 18378 31.9%3.5 MB 39.2%
innd 18357 31.8%2.9 MB 31.8%
nnrpd 17296 30.0%1.8 MB 20.0%
innfeed 3602 6.2%819.3 KB 8.9%
overchan 5 0.0%0.7 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 57640 100.0%9.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 164110 50.1%
Cache misses 163528 49.9%
Positive hits 0 0.0%
Negative hits 0 0.0%
TOTAL: 4 327638 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%150 0.000 0.000 0.000
article cleanup00:00:00.488 0.0%36484 0.000 0.013 0.067
article logging00:00:00.756 0.0%36818 0.000 0.021 0.231
article parse00:00:01.330 0.0%92490 0.000 0.014 0.035
article write00:02:21.414 0.1%26946 1.354 5.248 729.795
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.388 0.0%335412 0.000 0.001 0.007
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.128 0.0%329092 0.002 0.010 0.020
history sync00:00:00.230 0.0%802 0.000 0.287 23.500
history write00:00:08.312 0.0%36474 0.000 0.228 21.781
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:55:57.988 99.8%374146 254.874 461.205 1768.711
nntp read00:00:03.124 0.0%373562 0.002 0.008 0.018
overview write00:00:00.280 0.0%26946 0.000 0.010 0.051
perl filter00:00:54.472 0.0%36472 1.234 1.494 2.646
python filter00:00:01.510 0.0%36476 0.000 0.041 0.113
site send00:00:02.656 0.0%80788 0.007 0.033 0.065
TOTAL: 48:02:10.98647:59:36.076 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.124 0.0%27128 0.000 0.005 0.031
article prepare00:00:00.008 0.0%26560 0.000 0.000 0.023
article read00:00:00.614 0.0%4084 0.000 0.150 23.000
backlog stats00:00:00.244 0.0%433338 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.626 0.0%268272 0.000 0.006 0.015
data write00:00:04.928 0.0%241500 0.008 0.020 0.042
idle47:37:42.488100.0%433338 211.560 395.678 1755.014
status file00:00:19.338 0.0%354 0.000 54.627 8790.000
TOTAL: 47:38:27.85647:38:09.370100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:44:45.522 96.1%18050 5.333 348.228 15130.210
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:05.934 0.1%578514 0.000 0.010 1.000
readart00:00:19.062 0.3%2254 0.000 8.457 36.000
TOTAL: 01:48:59.77001:45:10.518 96.5%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feeder3.feed-ams.uzoreto.com 574 18780 8374 8434 1972 44%47:28:26
2ripco-out.feed.uzoreto.com 1150 27600 7290 16224 4086 26%94:46:58
3newsfeed.neva.ru 582 30218 5062 23508 1648 16%276:36:04
4news.snarked.org 50 26226 4736 21064 426 18%53:53:56
5newsfeed.fu-berlin.de 2 10674 586 10052 36 5%44:04:18
6ripco-out.news.tnetconsulting.net 2 31564 546 30898 120 1%52:58:18
7news.lightlink.com 2 6558 158 6302 98 2%44:03:24
8news-in.rahul.net 574 13260 76 13168 16 0%47:22:12
9ripco-out.feeder.erje.net 574 28408 52 27238 1118 0%47:15:28
10news.cmpublishers.com 50 7350 8 7334 8 0%48:00:02
11localhost 150 4 4 0 0 100%00:00:00
TOTAL: 11 3710 200642 26892 164222 9528 13%756:29:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder3.feed-ams.uzoreto.com21.0 MB3.0 KB4.3 MB25.4 MB 82%2.5 KB
2ripco-out.feed.uzoreto.com17.0 MB5.9 KB7.3 MB24.3 MB 69%2.2 KB
3newsfeed.neva.ru14.9 MB11.5 KB5.6 MB20.5 MB 72%3.1 KB
4news.snarked.org14.2 MB0.0 KB1.4 MB15.6 MB 90%3.1 KB
5ripco-out.news.tnetconsulting.net13.4 MB2.0 KB1.7 MB15.1 MB 88%23.2 KB
6newsfeed.fu-berlin.de3.7 MB0.0 KB615.5 KB4.3 MB 85%7.0 KB
7news.lightlink.com1.6 MB0.0 KB5.6 MB7.2 MB 22%28.8 KB
8news-in.rahul.net1.1 MB0.0 KB1.3 MB2.4 MB 44%26.9 KB
9ripco-out.feeder.erje.net81.5 KB0.0 KB8.9 MB9.0 MB 0%7.9 KB
10news.cmpublishers.com25.7 KB0.0 KB14.8 KB40.5 KB 63%2.5 KB
11localhost9.4 KB0.0 KB0.0 KB9.4 KB100%2.4 KB
TOTAL: 1187.0 MB22.4 KB36.8 MB123.8 MB 70%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 16 00:01:02 - 00:59:59 269 2.0% 0.081.7 MB 4.0% 0.50
Dec 16 01:00:00 - 01:59:59 343 2.6% 0.101.1 MB 2.4% 0.30
Dec 16 02:00:00 - 02:59:59 458 3.4% 0.131.5 MB 3.4% 0.41
Dec 16 03:00:00 - 03:59:59 622 4.6% 0.171.8 MB 4.2% 0.51
Dec 16 04:00:00 - 04:59:59 596 4.4% 0.171.6 MB 3.6% 0.45
Dec 16 05:00:00 - 05:59:59 716 5.3% 0.202.5 MB 5.7% 0.70
Dec 16 06:00:00 - 06:59:59 642 4.8% 0.181.8 MB 4.3% 0.52
Dec 16 07:00:00 - 07:59:59 699 5.2% 0.192.0 MB 4.6% 0.57
Dec 16 08:00:00 - 08:59:59 736 5.5% 0.203.1 MB 7.2% 0.88
Dec 16 09:00:00 - 09:59:59 890 6.6% 0.252.7 MB 6.2% 0.76
Dec 16 10:00:00 - 10:59:59 777 5.8% 0.222.2 MB 5.1% 0.63
Dec 16 11:00:00 - 11:59:59 744 5.5% 0.212.9 MB 6.6% 0.81
Dec 16 12:00:00 - 12:59:59 762 5.7% 0.212.3 MB 5.3% 0.64
Dec 16 13:00:00 - 13:59:59 807 6.0% 0.222.4 MB 5.6% 0.69
Dec 16 14:00:00 - 14:59:59 831 6.2% 0.232.6 MB 6.1% 0.75
Dec 16 15:00:00 - 15:59:59 709 5.3% 0.201.8 MB 4.2% 0.52
Dec 16 16:00:00 - 16:59:59 664 4.9% 0.182.2 MB 5.1% 0.63
Dec 16 17:00:00 - 17:59:59 504 3.7% 0.141.7 MB 3.9% 0.48
Dec 16 18:00:00 - 18:59:59 348 2.6% 0.10954.1 KB 2.2% 0.27
Dec 16 19:00:00 - 19:59:59 284 2.1% 0.08771.5 KB 1.7% 0.21
Dec 16 20:00:00 - 20:59:59 286 2.1% 0.081.1 MB 2.5% 0.30
Dec 16 21:00:00 - 21:59:59 326 2.4% 0.091006.8 KB 2.3% 0.28
Dec 16 22:00:00 - 22:59:59 220 1.6% 0.06564.0 KB 1.3% 0.16
Dec 16 23:00:00 - 23:57:06 210 1.6% 0.061.1 MB 2.5% 0.32
TOTAL: 23:56:04 13443 100.0% 0.1643.1 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2054 1526 0 2 4 0 0 0 522
2feeder3.feed-ams.uzoreto.com 995 624 0 1 1 0 0 0 369
3newsfeed.neva.ru 880 433 0 2 5 0 0 0 440
4ripco-out.feeder.erje.net 560 558 0 0 0 0 0 0 2
5news.snarked.org 224 67 0 0 2 0 0 0 155
6newsfeed.fu-berlin.de 103 0 0 0 0 0 0 0 103
7news.lightlink.com 64 4 0 0 0 0 0 0 60
8ripco-out.news.tnetconsulting.net 44 27 0 1 0 0 0 0 16
9news-in.rahul.net 8 0 0 0 0 0 0 0 8
10news.cmpublishers.com 3 2 0 0 0 0 0 0 1
TOTAL: 10 4935 3241 0 6 12 0 0 0 1676

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2369
alt.binaries.ftd 325
fido7.su.pol.news 45
alt.bestjobsusa.computer.jobs 40
scinet.stats 32
alt.binaries.nospam.breasts.natural 31
alt.binaries.pictures.purebeauty 26
alt.binaries.e-book 24
alt.binaries.pictures.earlmiller 23
free.it.scienza.fisica 18
alt.jobs.jobsearch 15
at.jobs 13
it.tlc.cellulari.android 12
alt.my.job.sucks 12
it.comp.os.win.windows7 9
scot.general 9
alt.binaries.pictures.scenic 9
aioe.news.assistenza 8
alt.binaries.multimedia.erotica.amateur 8
rocksolid.programming 7
TOTAL: 121 3241

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

GroupsCount
pl.praca.oferowana 7
christnet.bible 2
bit.listserv.catholic 1
christnet.theology 1
alt.christnet.christnews 1
TOTAL: 5 12

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1122
Too many newsgroups 1122
EMP (phl) 322
Binary in non-binary group 196
Scoring filter (11) 164
Scoring filter (8) 18
Scoring filter (9) 14
Scoring filter (10) 14
HTML post 12
Scoring filter (14) 8
Scoring filter (12) 8
Poison newsgroup 6
Scoring filter (13) 4
Scoring filter (16) 4
Scoring filter (20) 2
TOTAL: 15 3016

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 24
TOTAL: 1 24
Including strange strings
newsfeed.fu-berlin.de 89
newsfeed.neva.ru 53
feeder3.feed-ams.uzoreto.com 9
ripco-out.feed.uzoreto.com 9
news.snarked.org 6
ripco-out.feeder.erje.net 1
TOTAL: 6 167
No colon-space in header
ripco-out.feed.uzoreto.com 1
TOTAL: 1 1
TOTAL: 3 192

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 30478 2344 22808 438 0 50 7%47:40:06
2news.lightlink.com 8914 1420 4978 10 0 0 15%47:44:50
3rahul.net 21248 640 11064 2 0 0 3%47:40:06
4news.cmpublishers.com 41310 96 25194 1174 0 136 0%47:35:08
5news.tnetconsulting.net 40106 74 26256 14 0 50 0%47:42:38
6fu-berlin.de 23888 58 23830 0 0 0 0%47:39:46
7news.uzoreto.com 11140 56 10558 142 0 0 0%47:40:06
8news.snarked.org 37422 56 21636 24 0 132 0%47:39:24
9newsfeed.neva.ru 22262 46 21652 36 0 0 0%47:40:06
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:08
TOTAL: 10 236774 4790 167976 1846 0 368 2%430:14:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1feeder.erje.net6.8 MB1.1 MB7.9 MB0.0 KB/s2.9 KB47:40:06
2news.lightlink.com4.9 MB35.3 KB5.0 MB0.0 KB/s3.6 KB47:44:50
3rahul.net3.5 MB19.9 KB3.5 MB0.0 KB/s5.5 KB47:40:06
4news.cmpublishers.com303.4 KB3.1 MB3.4 MB0.0 KB/s2.7 KB47:35:08
5fu-berlin.de232.3 KB0.0 KB232.3 KB0.0 KB/s4.0 KB47:39:46
6news.snarked.org220.8 KB185.2 KB406.0 KB0.0 KB/s5.1 KB47:39:24
7news.tnetconsulting.net196.9 KB38.7 KB235.6 KB0.0 KB/s2.7 KB47:42:38
8news.uzoreto.com187.8 KB488.7 KB676.5 KB0.0 KB/s3.4 KB47:40:06
9newsfeed.neva.ru128.8 KB159.9 KB288.7 KB0.0 KB/s3.5 KB47:40:06
10remote6hme0.ripco.com0.0 KB28.6 KB28.6 KB0.0 KB/s4.8 KB01:12:08
TOTAL: 1016.5 MB5.1 MB21.6 MB0.0 KB/s3.3 KB430:14:18
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9582.8 MB 416 2 000:09:04
2shell3.ripco.com 16 336982.3 KB 40 2 001:39:18
TOTAL: 2 302 12943.8 MB 456 4 001:48:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9582.8 MB 416 2 000:09:04
2*.ripco.com 16 336982.3 KB 40 2 001:39:18
TOTAL: 2 302 12943.8 MB 456 4 001:48:45

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 3.866 2.422 0.00001:39:18
ftupet.com 45.880 21.562 0.00000:09:04
? 0.454 0.110 0.00000:00:21
178.62.81.220 1.412 0.358 0.00000:00:02
185.100.87.246 0.256 0.078 0.00000:00:01
162.243.128.133 0.202 0.050 0.00000:00:00
worker-18.sfj.censys-scanner.com 0.200 0.050 0.00000:00:00
census3.shodan.io 0.200 0.050 0.00000:00:00
TOTAL: 8 52.470 24.680 0.00001:48:49

NNRP no permission clients:

SystemConn
178.62.81.220 14
162.243.128.133 2
census3.shodan.io 2
worker-18.sfj.censys-scanner.com 2
185.100.87.246 2
TOTAL: 5 22

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 1136 87.8%
2alt 50 3.9%
3misc 42 3.2%
4comp 34 2.6%
5sci 10 0.8%
6news 10 0.8%
7seattle 6 0.5%
8chi 6 0.5%
TOTAL: 8 1294100.0%

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

NewsgroupCount
1rec.arts.tv 574
2rec.food.cooking 452
3rec.bicycles.tech 90
4misc.phone.mobile.iphone 36
5alt.comp.os.windows-10 28
6comp.sys.mac.system 22
7alt.stupidity 16
8sci.electronics.repair 10
9comp.internet.services.google 8
10rec.radio.shortwave 8
11misc.consumers.frugal-living 6
12seattle.general 6
13chi.weather 6
14rec.radio.broadcasting 6
15alt.online-service.comcast 4
16rec.bicycles.misc 4
17news.admin.net-abuse.usenet 4
18comp.mobile.android 4
19news.groups 2
20rec.radio.swap 2
21alt.security.alarms 2
22news.admin.peering 2
23news.admin.hierarchies 2
TOTAL: 23 1294