Daily Usenet report for news.ripco.com

Nov 14 00:01:03 -- Nov 14 23:58:05

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 14 08:21:52 remote5bge0 overchan[29172]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 23449 34.7%4.0 MB 39.7%
innd 23036 34.1%3.5 MB 35.0%
nnrpd 17461 25.8%1.8 MB 17.9%
innfeed 3641 5.4%765.4 KB 7.4%
controlchan 2 0.0%0.2 KB 0.0%
overchan 1 0.0%0.3 KB 0.0%
TOTAL: 6 67590 100.0%10.1 MB100.0%

History cache:

ReasonCount%Count
Cache misses 213250 53.3%
Do not exist 187040 46.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 400290 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%278 0.000 0.000 0.000
article cleanup00:00:00.472 0.0%46618 0.000 0.010 0.038
article logging00:00:01.008 0.0%47004 0.000 0.021 0.373
article parse00:00:01.666 0.0%106454 0.000 0.016 0.037
article write00:00:45.248 0.0%33052 0.452 1.369 38.693
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.262 0.0%405290 0.000 0.001 0.003
hishave/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.528 0.0%401442 0.002 0.009 0.363
history sync00:00:00.390 0.0%810 0.000 0.481 10.000
history write00:00:08.554 0.0%46612 0.013 0.184 7.821
hiswrite/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
idle47:59:12.946 99.9%444320 168.764 388.803 995.688
nntp read00:00:02.470 0.0%441742 0.001 0.006 0.011
overview write00:00:00.222 0.0%33052 0.000 0.007 0.043
perl filter00:00:58.982 0.0%46606 1.016 1.266 2.493
python filter00:00:01.054 0.0%46610 0.000 0.023 0.069
site send00:00:01.918 0.0%99088 0.004 0.019 0.046
TOTAL: 48:01:54.21648:01:18.720100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.124 0.0%33098 0.000 0.004 0.028
article prepare00:00:00.014 0.0%26056 0.000 0.001 0.031
article read00:00:00.604 0.0%5276 0.000 0.114 4.500
backlog stats00:00:00.240 0.0%402354 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.312 0.0%265942 0.000 0.009 0.016
data write00:00:03.638 0.0%233176 0.007 0.016 0.026
idle47:51:38.492100.0%402354 226.738 428.226 1044.766
status file00:00:04.400 0.0%340 0.000 12.941 42.000
TOTAL: 47:52:02.63247:51:49.824100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:08.484 0.1%6190 1.371 1.371 1.371
idle03:33:22.470 99.0%24796 18.183 516.312200074.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:27.444 0.2%2141952 0.000 0.013 0.056
readart00:00:19.904 0.2%2754 0.000 7.227 36.500
TOTAL: 03:35:27.82003:34:18.302 99.5%----

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 1162 35094 10672 22682 1740 30%94:47:08
2news.snarked.org 52 43648 9616 29004 5028 22%60:16:38
3newsfeed.neva.ru 576 61404 6180 52976 2248 10%280:43:30
4feeder3.feed-ams.uzoreto.com 574 25282 5230 16818 3234 20%47:18:32
5newsfeed.fu-berlin.de 8 14590 666 13756 168 4%43:48:28
6news.lightlink.com 4 15000 454 14290 256 3%62:03:58
7news-in.rahul.net 574 20846 190 20648 8 0%47:18:04
8ripco-out.feeder.erje.net 574 36314 70 35172 1072 0%47:18:18
9news.cmpublishers.com 50 9082 6 9070 6 0%48:00:04
10localhost 148 4 4 0 0 100%00:00:00
TOTAL: 10 3722 261264 33088 214416 13760 12%731:34:40
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org29.1 MB0.0 KB18.2 MB47.3 MB 61%3.3 KB
2ripco-out.feed.uzoreto.com26.7 MB0.0 KB4.0 MB30.7 MB 86%2.5 KB
3newsfeed.neva.ru18.7 MB27.1 KB7.7 MB26.4 MB 70%3.2 KB
4feeder3.feed-ams.uzoreto.com13.5 MB0.0 KB5.5 MB19.0 MB 70%2.3 KB
5news-in.rahul.net8.7 MB0.0 KB282.9 KB8.9 MB 96%46.2 KB
6news.lightlink.com5.4 MB0.0 KB11.5 MB16.9 MB 31%24.3 KB
7newsfeed.fu-berlin.de3.1 MB0.0 KB752.8 KB3.8 MB 80%4.7 KB
8ripco-out.feeder.erje.net171.0 KB0.0 KB8.9 MB9.1 MB 1%8.1 KB
9news.cmpublishers.com17.1 KB0.0 KB10.1 KB27.2 KB 62%2.3 KB
10localhost8.4 KB0.0 KB0.0 KB8.4 KB100%2.1 KB
TOTAL: 10105.2 MB27.1 KB56.9 MB162.1 MB 64%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 14 00:01:03 - 00:59:59 431 2.6% 0.121.2 MB 2.2% 0.34
Nov 14 01:00:00 - 01:59:59 496 3.0% 0.141.5 MB 2.9% 0.43
Nov 14 02:00:00 - 02:59:59 633 3.8% 0.181.7 MB 3.2% 0.48
Nov 14 03:00:00 - 03:59:59 665 4.0% 0.181.8 MB 3.4% 0.50
Nov 14 04:00:00 - 04:59:59 705 4.3% 0.202.1 MB 4.0% 0.59
Nov 14 05:00:00 - 05:59:59 798 4.8% 0.222.4 MB 4.6% 0.68
Nov 14 06:00:00 - 06:59:59 725 4.4% 0.202.6 MB 5.1% 0.75
Nov 14 07:00:00 - 07:59:59 826 5.0% 0.232.2 MB 4.1% 0.61
Nov 14 08:00:00 - 08:59:59 908 5.5% 0.253.0 MB 5.7% 0.84
Nov 14 09:00:00 - 09:59:59 977 5.9% 0.272.6 MB 5.0% 0.74
Nov 14 10:00:00 - 10:59:59 933 5.7% 0.263.2 MB 6.1% 0.90
Nov 14 11:00:00 - 11:59:59 1041 6.3% 0.293.4 MB 6.5% 0.95
Nov 14 12:00:00 - 12:59:59 970 5.9% 0.272.8 MB 5.4% 0.80
Nov 14 13:00:00 - 13:59:59 897 5.4% 0.253.3 MB 6.4% 0.94
Nov 14 14:00:00 - 14:59:59 891 5.4% 0.252.6 MB 5.0% 0.73
Nov 14 15:00:00 - 15:59:59 788 4.8% 0.222.6 MB 5.0% 0.74
Nov 14 16:00:00 - 16:59:59 640 3.9% 0.181.9 MB 3.7% 0.55
Nov 14 17:00:00 - 17:59:59 629 3.8% 0.173.0 MB 5.8% 0.85
Nov 14 18:00:00 - 18:59:59 512 3.1% 0.141.5 MB 3.0% 0.44
Nov 14 19:00:00 - 19:59:59 433 2.6% 0.121.3 MB 2.5% 0.36
Nov 14 20:00:00 - 20:59:59 452 2.7% 0.131.7 MB 3.2% 0.47
Nov 14 21:00:00 - 21:59:59 443 2.7% 0.121.4 MB 2.7% 0.40
Nov 14 22:00:00 - 22:59:59 320 1.9% 0.091.2 MB 2.3% 0.34
Nov 14 23:00:00 - 23:58:05 370 2.2% 0.111.1 MB 2.2% 0.33
TOTAL: 23:57:02 16483 100.0% 0.1951.9 MB 100.0% 0.62
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 2458 74 0 0 5 0 0 0 2379
2feeder3.feed-ams.uzoreto.com 1622 1313 0 0 0 0 0 0 309
3newsfeed.neva.ru 1163 626 0 3 3 0 0 0 531
4ripco-out.feed.uzoreto.com 881 433 0 0 1 0 0 0 447
5ripco-out.feeder.erje.net 537 535 0 0 0 0 0 0 2
6newsfeed.fu-berlin.de 226 0 0 0 0 0 0 0 226
7news.lightlink.com 72 0 0 0 0 0 0 0 72
8news-in.rahul.net 4 0 0 0 0 0 0 0 4
9news.cmpublishers.com 3 1 0 0 0 0 0 0 2
TOTAL: 9 6966 2982 0 3 9 0 0 0 3972

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1910
alt.binaries.ftd 248
fido7.su.pol.news 40
alt.bestjobsusa.computer.jobs 39
gmane.linux.alsa.devel 35
perl.cpan.uploads 30
alt.astrology.pro 28
de.soc.arbeitslos 27
it.comp.os.win.windows10 27
alt.my.job.sucks 26
free.uk.astrology 25
alt.jobs.jobsearch 23
alt.binaries.nospam.female.bodyhair.pubes 21
alc.test 18
att.jobs 18
linux.debian.maint.emacsen 17
free.willey 17
alt.binaries.e-book 17
it.tlc.cellulari.android 15
at.jobs 14
TOTAL: 142 2982

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

GroupsCount
pl.praca.oferowana 4
christnet.bible 3
alt.christnet.religion 1
alt.penthouse.sex.masterbation 1
TOTAL: 4 9

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5255
Too many newsgroups 1504
Binary in non-binary group 492
EMP (phl) 158
Poison newsgroup 36
Scoring filter (8) 28
Scoring filter (16) 22
Scoring filter (9) 20
Scoring filter (10) 12
Attached HTML file 8
Scoring filter (18) 4
Scoring filter (11) 4
Too many test groups in crosspost 4
U2 violation - invalid distribution 2
Scoring filter (14) 2
TOTAL: 15 7551

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
ripco-out.feed.uzoreto.com 3
TOTAL: 1 3
Bad Message-ID's offered
ripco-out.feeder.erje.net 20
feeder3.feed-ams.uzoreto.com 2
TOTAL: 2 22
Huge articles
newsfeed.fu-berlin.de 4
TOTAL: 1 4
Including strange strings
newsfeed.fu-berlin.de 141
newsfeed.neva.ru 37
ripco-out.feed.uzoreto.com 10
feeder3.feed-ams.uzoreto.com 5
TOTAL: 4 193
TOTAL: 4 222

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 11576 2618 5522 16 0 0 22%47:40:02
2rahul.net 25788 924 14446 46 0 2 3%47:40:02
3feeder.erje.net 31838 322 30450 304 0 0 1%47:41:12
4news.cmpublishers.com 44288 150 30782 1634 0 16 0%47:40:02
5fu-berlin.de 29950 46 29902 0 0 42 0%47:50:18
6news.snarked.org 39274 42 23100 0 0 142 0%47:40:36
7newsfeed.neva.ru 27126 24 26382 190 0 0 0%47:43:10
8news.uzoreto.com 17540 18 16412 156 0 0 0%47:40:02
9remote6hme0.ripco.com 0 0 0 0 0 8 0%47:40:02
TOTAL: 9 227380 4144 176996 2346 0 210 1%429:15:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com8.1 MB58.8 KB8.1 MB0.0 KB/s3.2 KB47:40:02
2rahul.net3.3 MB114.1 KB3.4 MB0.0 KB/s3.6 KB47:40:02
3feeder.erje.net1.0 MB1.1 MB2.1 MB0.0 KB/s3.5 KB47:41:12
4news.cmpublishers.com518.1 KB4.4 MB4.9 MB0.0 KB/s2.8 KB47:40:02
5news.snarked.org293.1 KB0.0 KB293.1 KB0.0 KB/s7.0 KB47:40:36
6fu-berlin.de270.4 KB0.0 KB270.4 KB0.0 KB/s5.9 KB47:50:18
7newsfeed.neva.ru219.3 KB442.5 KB661.8 KB0.0 KB/s3.1 KB47:43:10
8news.uzoreto.com142.2 KB567.2 KB709.4 KB0.0 KB/s4.1 KB47:40:02
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
TOTAL: 913.8 MB6.7 MB20.5 MB0.0 KB/s3.2 KB429:15:26
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 11683.1 MB 470 2 000:06:47
2shell3 28 4161.2 MB 44 2 001:46:48
TOTAL: 2 314 15844.3 MB 514 4 003:35:21

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 11683.1 MB 470 2 000:06:47
2? 28 4161.2 MB 44 2 001:46:48
3*.direct-adsl.nl 10 00.0 KB 0 0 001:16:01
4*.7-3.cable.virginm.net 2 00.0 KB 0 0 000:25:07
5unresolved 16 00.0 KB 0 0 000:00:37
TOTAL: 5 342 15844.3 MB 514 4 003:35:21

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 7.490 3.602 0.00001:46:48
ip5657965a.direct-adsl.nl 1.712 1.090 0.00001:16:01
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 0.372 0.416 0.00000:25:07
ftupet.com 46.342 7.552 0.00000:06:47
162.243.158.16 0.198 0.040 0.00000:00:19
185.254.68.84 1.342 0.178 0.00000:00:09
190.2.132.87 0.342 0.054 0.00000:00:03
109.236.87.235 0.204 0.044 0.00000:00:02
95.174.67.148 0.198 0.040 0.00000:00:01
TOTAL: 9 58.200 13.016 0.00003:35:21

Curious NNRP server explorers [Top 20]:

SystemConn
ip5657965a.direct-adsl.nl 10
185.254.68.84 8
95.174.67.148 2
109.236.87.235 2
162.243.158.16 2
190.2.132.87 2
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 2
TOTAL: 7 28

NNRP unrecognized commands (by host):

SystemConn
shell3 6
TOTAL: 1 6

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 6
TOTAL: 1 6

NNRP client timeouts [Top 20]:

SystemConnPeer
ip5657965a.direct-adsl.nl 2 0
shell3 2 0
TOTAL: 2 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1364 86.1%
2comp 114 7.2%
3chi 34 2.1%
4alt 32 2.0%
5sci 20 1.3%
6news 10 0.6%
7ba 8 0.5%
8misc 2 0.1%
TOTAL: 8 1584100.0%

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

NewsgroupCount
1rec.arts.tv 656
2rec.food.cooking 592
3rec.bicycles.tech 102
4comp.sys.apple2 60
5comp.sys.mac.system 36
6alt.stupidity 26
7sci.electronics.repair 20
8chi.general 20
9chi.weather 12
10ba.food 8
11comp.sys.mac.apps 6
12rec.radio.broadcasting 6
13comp.protocols.dns.bind 6
14rec.bicycles.misc 4
15alt.hvac 4
16rec.radio.swap 4
17comp.mail.sendmail 4
18news.software.readers 4
19news.admin.net-abuse.email 4
20comp.unix.bsd.freebsd.misc 2
21alt.free.newsservers 2
22chi.eats 2
23news.software.nntp 2
24misc.consumers.frugal-living 2
TOTAL: 24 1584