Daily Usenet report for news.ripco.com

Nov 1 00:01:02 -- Nov 1 23:57:56

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Nov 1 03:50:01 s_local@remote5bge0 controlchan[25111]: [ID 702911 news.notice] Multiple control headers in article <yXAN3-6XZ-1@gated-at.bofh.it>
Nov 1 03:50:01 remote5bge0 controlchan[25111]: [ID 702911 news.notice] Multiple control headers in article <yXAN3-6XZ-1@gated-at.bofh.it>
Nov 1 08:21:32 remote5bge0 overchan[26736]: [ID 702911 news.error] input line too long, skipping
Nov 1 21:44:27 remote5bge0 overchan[26736]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 29137 36.7%4.5 MB 38.5%
inn 28390 35.8%4.4 MB 38.3%
nnrpd 17986 22.7%1.9 MB 16.4%
innfeed 3752 4.7%795.7 KB 6.7%
controlchan 18 0.0%3.1 KB 0.0%
overchan 4 0.0%0.5 KB 0.0%
TOTAL: 6 79287 100.0%11.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 225434 58.2%
Cache misses 162050 41.8%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 387484 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%92 0.000 0.000 0.000
article cleanup00:00:00.586 0.0%56428 0.000 0.010 0.033
article logging00:00:00.820 0.0%56840 0.000 0.014 0.233
article parse00:00:02.032 0.0%140948 0.002 0.014 0.031
article write00:00:45.894 0.0%27740 0.327 1.654 77.421
artlog/artparse00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:00.414 0.0%412726 0.000 0.001 0.004
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.306 0.0%391296 0.001 0.008 0.018
history sync00:00:00.356 0.0%788 0.000 0.452 2.667
history write00:00:05.142 0.0%56424 0.023 0.091 0.462
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:58:51.708 99.9%463034 231.333 373.043 837.010
nntp read00:00:02.630 0.0%462054 0.001 0.006 0.013
overview write00:00:00.144 0.0%27740 0.000 0.005 0.029
perl filter00:01:14.404 0.0%56414 1.088 1.319 2.094
python filter00:00:01.340 0.0%56434 0.000 0.024 0.055
site send00:00:01.710 0.0%83172 0.000 0.021 0.058
TOTAL: 48:02:02.36248:01:10.486100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.272 0.0%27714 0.000 0.010 0.039
article prepare00:00:00.014 0.0%20616 0.000 0.001 0.036
article read00:00:00.658 0.0%4248 0.000 0.155 23.667
backlog stats00:00:00.168 0.0%343000 0.000 0.000 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.726 0.0%222466 0.000 0.008 0.024
data write00:00:02.922 0.0%196352 0.003 0.015 0.031
idle47:34:57.654100.0%343000 264.339 499.410 1253.190
status file00:00:01.564 0.0%344 0.000 4.547 30.000
TOTAL: 47:35:20.53247:35:04.978100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:09:38.610 98.5%19846 0.136 391.949 17697.151
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.102 0.1%394350 0.000 0.010 1.000
readart00:00:17.502 0.2%1872 0.000 9.349 70.000
TOTAL: 02:11:36.80002:10:00.214 98.8%----

Control commands to INND:

CommandNumber
L 2
flush 2
go 6
logmode 2
mode 6
name 5
pause 4
paused 4
reload 4
reserve 4
TOTAL: 10 39

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de002002
usenet@zybrkat.org002022
TOTAL004024

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 34266 9162 19080 6024 26%94:37:20
2news.snarked.org 44 26404 8360 17590 454 31%47:18:04
3newsfeed.neva.ru 570 65948 5224 41414 19310 7%280:03:02
4feeder3.feed-ams.uzoreto.com 574 16458 3852 11096 1510 23%47:10:04
5newsfeed.fu-berlin.de 4 13472 556 12898 18 4%45:48:50
6news-in.rahul.net 574 16536 182 16304 50 1%47:28:18
7news.lightlink.com 2 8706 176 8450 80 2%49:11:52
8ripco-out.feeder.erje.net 574 29372 62 28276 1034 0%47:28:00
9news.cmpublishers.com 52 7546 46 7480 20 0%47:59:56
10localhost 166 20 20 0 0 100%00:00:00
TOTAL: 10 3708 218728 27640 162588 28500 12%707:05:26
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org25.3 MB0.0 KB1.4 MB26.7 MB 94%3.1 KB
2ripco-out.feed.uzoreto.com22.9 MB0.0 KB16.7 MB39.6 MB 57%2.7 KB
3newsfeed.neva.ru17.0 MB22.8 KB88.5 MB105.6 MB 16%4.4 KB
4feeder3.feed-ams.uzoreto.com9.5 MB9.8 KB4.5 MB14.0 MB 67%2.7 KB
5news-in.rahul.net2.4 MB0.0 KB2.0 MB4.3 MB 54%19.2 KB
6newsfeed.fu-berlin.de1.7 MB0.0 KB216.6 KB1.9 MB 88%3.4 KB
7localhost923.5 KB0.0 KB0.0 KB923.5 KB100%46.2 KB
8news.lightlink.com770.0 KB0.0 KB3.6 MB4.4 MB 17%17.5 KB
9news.cmpublishers.com131.8 KB0.0 KB43.9 KB175.7 KB 75%2.7 KB
10ripco-out.feeder.erje.net121.1 KB3.2 KB11.0 MB11.1 MB 1%10.3 KB
TOTAL: 1080.6 MB35.8 KB128.0 MB208.7 MB 38%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 1 00:01:02 - 00:59:59 231 1.7% 0.07858.6 KB 2.1% 0.24
Nov 1 01:00:00 - 01:59:59 375 2.7% 0.101.6 MB 4.0% 0.46
Nov 1 02:00:00 - 02:59:59 381 2.7% 0.111.1 MB 2.6% 0.30
Nov 1 03:00:00 - 03:59:59 603 4.4% 0.171.4 MB 3.6% 0.41
Nov 1 04:00:00 - 04:59:59 648 4.7% 0.182.3 MB 5.6% 0.65
Nov 1 05:00:00 - 05:59:59 666 4.8% 0.182.0 MB 5.0% 0.58
Nov 1 06:00:00 - 06:59:59 688 5.0% 0.192.0 MB 4.9% 0.56
Nov 1 07:00:00 - 07:59:59 684 4.9% 0.191.9 MB 4.6% 0.53
Nov 1 08:00:00 - 08:59:59 734 5.3% 0.201.9 MB 4.7% 0.54
Nov 1 09:00:00 - 09:59:59 798 5.8% 0.222.2 MB 5.4% 0.62
Nov 1 10:00:00 - 10:59:59 866 6.2% 0.242.2 MB 5.5% 0.63
Nov 1 11:00:00 - 11:59:59 828 6.0% 0.232.2 MB 5.4% 0.63
Nov 1 12:00:00 - 12:59:59 803 5.8% 0.222.1 MB 5.1% 0.59
Nov 1 13:00:00 - 13:59:59 722 5.2% 0.201.9 MB 4.7% 0.54
Nov 1 14:00:00 - 14:59:59 679 4.9% 0.192.2 MB 5.5% 0.63
Nov 1 15:00:00 - 15:59:59 653 4.7% 0.182.2 MB 5.3% 0.61
Nov 1 16:00:00 - 16:59:59 641 4.6% 0.181.8 MB 4.4% 0.50
Nov 1 17:00:00 - 17:59:59 586 4.2% 0.161.8 MB 4.5% 0.52
Nov 1 18:00:00 - 18:59:59 493 3.6% 0.141.5 MB 3.6% 0.42
Nov 1 19:00:00 - 19:59:59 429 3.1% 0.121.3 MB 3.2% 0.37
Nov 1 20:00:00 - 20:59:59 361 2.6% 0.101.0 MB 2.6% 0.30
Nov 1 21:00:00 - 21:59:59 344 2.5% 0.101.0 MB 2.6% 0.30
Nov 1 22:00:00 - 22:59:59 337 2.4% 0.091.0 MB 2.5% 0.29
Nov 1 23:00:00 - 23:57:56 306 2.2% 0.091.0 MB 2.6% 0.31
TOTAL: 23:56:54 13856 100.0% 0.1640.5 MB 100.0% 0.48
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 9766 4629 0 3 3 0 0 0 5131
2ripco-out.feed.uzoreto.com 3019 1842 0 0 0 0 0 0 1177
3feeder3.feed-ams.uzoreto.com 759 338 0 3 1 0 0 0 417
4ripco-out.feeder.erje.net 517 515 0 1 0 0 0 0 1
5news.snarked.org 237 91 0 0 2 0 0 0 144
6newsfeed.fu-berlin.de 142 0 0 0 0 0 0 0 142
7news.lightlink.com 59 2 0 0 0 0 0 0 57
8news-in.rahul.net 25 0 0 0 0 0 0 0 25
9news.cmpublishers.com 10 3 0 0 0 0 0 0 7
TOTAL: 9 14534 7420 0 7 6 0 0 0 7101

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.boneless 4245
free.usenet 2299
alt.binaries.ftd 249
alt.binaries.nl 42
perl.cpan.uploads 36
fido7.su.pol.news 35
free.it.scienza.fisica 26
scot.general 22
alt.binaries.pictures.earlmiller 17
it.tlc.cellulari.android 17
alt.bestjobsusa.computer.jobs 16
mozilla.dev.platform 16
alt.binaries.pictures.scenic 15
it.comp.os.win.windows10 15
alt.binaries.pictures.erotica.vintage 15
alt.binaries.e-book 15
nl.comp.os.linux.techniek 14
alt.binaries.test.yenc 13
alt.binaries.humor.skewed 12
free.willey 9
TOTAL: 151 7420

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

GroupsCount
pl.praca.oferowana 2
bit.listserv.catholic 2
alt.christnet.religion 1
alt.christnet.christnews 1
TOTAL: 4 6

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 9038
EMP (md5) 3464
Too many newsgroups 978
EMP (phl) 188
Scoring filter (8) 52
Scoring filter (10) 16
Scoring filter (9) 16
Scoring filter (12) 10
HTML post 10
Scoring filter (16) 4
Scoring filter (11) 2
Scoring filter (14) 2
TOTAL: 12 13780

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 138
newsfeed.neva.ru 50
news.snarked.org 9
ripco-out.feed.uzoreto.com 5
feeder3.feed-ams.uzoreto.com 4
TOTAL: 5 206
No colon-space in header
feeder3.feed-ams.uzoreto.com 3
ripco-out.feeder.erje.net 1
TOTAL: 2 4
TOTAL: 3 228

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9862 2042 4928 8 0 0 20%47:47:56
2rahul.net 22234 958 12610 16 0 4 4%47:47:56
3news.cmpublishers.com 40896 248 25730 1418 0 74 0%47:47:56
4news.uzoreto.com 14694 60 14186 104 0 0 0%47:47:56
5news.snarked.org 31384 54 18870 6 0 62 0%47:47:56
6fu-berlin.de 25316 54 25262 0 0 0 0%47:47:56
7feeder.erje.net 25234 46 24836 106 0 10 0%47:36:36
8newsfeed.neva.ru 23020 14 22286 32 0 0 0%47:47:56
9remote6hme0.ripco.com 0 0 0 0 0 10 0%47:47:56
TOTAL: 9 192640 3476 148708 1690 0 160 1%430:00:04
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com6.3 MB19.7 KB6.4 MB0.0 KB/s3.2 KB47:47:56
2rahul.net3.5 MB48.0 KB3.5 MB0.0 KB/s3.7 KB47:47:56
3news.cmpublishers.com982.6 KB4.3 MB5.3 MB0.0 KB/s3.2 KB47:47:56
4fu-berlin.de491.0 KB0.0 KB491.0 KB0.0 KB/s9.1 KB47:47:56
5news.snarked.org300.6 KB48.5 KB349.2 KB0.0 KB/s5.8 KB47:47:56
6news.uzoreto.com230.8 KB506.2 KB737.0 KB0.0 KB/s4.5 KB47:47:56
7feeder.erje.net217.0 KB491.0 KB708.0 KB0.0 KB/s4.7 KB47:36:36
8newsfeed.neva.ru92.6 KB179.5 KB272.1 KB0.0 KB/s5.9 KB47:47:56
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:47:56
TOTAL: 912.1 MB5.6 MB17.6 MB0.0 KB/s3.5 KB430:00:04
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 7602.3 MB 362 4 000:07:43
2shell3 24 3481.2 MB 50 16 002:03:00
TOTAL: 2 310 11083.5 MB 412 20 002:11:26

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 7602.3 MB 362 4 000:07:43
2? 24 3481.2 MB 50 16 002:03:00
TOTAL: 2 310 11083.5 MB 412 20 002:10:44

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 4.324 1.680 0.00002:03:00
ftupet.com 45.196 8.008 0.00000:07:43
d54c176a7.access.telenet.be 17.672 4.072 0.00000:00:41
14.53.187.118 0.202 0.042 0.00000:00:00
73.225.248.31 0.208 0.044 0.00000:00:00
TOTAL: 5 67.602 13.846 0.00002:11:26

NNRP no permission clients:

SystemConn
d54c176a7.access.telenet.be 176
14.53.187.118 2
73.225.248.31 2
TOTAL: 3 180

NNRP unrecognized commands (by host):

SystemConn
shell3 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 4
TOTAL: 1 4

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 908 81.9%
2alt 74 6.7%
3comp 46 4.2%
4misc 44 4.0%
5sci 18 1.6%
6chi 10 0.9%
7news 8 0.7%
TOTAL: 7 1108100.0%

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

NewsgroupCount
1rec.arts.tv 628
2rec.food.cooking 216
3rec.bicycles.tech 46
4misc.phone.mobile.iphone 42
5alt.comp.os.windows-10 32
6comp.sys.mac.system 22
7sci.electronics.repair 18
8alt.stupidity 18
9comp.sys.apple2 14
10alt.video.digital-tv 8
11rec.radio.broadcasting 6
12alt.security.alarms 6
13chi.weather 6
14alt.free.newsservers 6
15rec.heraldry 4
16rec.bicycles.misc 4
17chi.forsale 4
18rec.radio.swap 4
19comp.internet.services.video.youtube 4
20comp.mobile.ipad 2
21news.admin.hierarchies 2
22comp.mobile.android 2
23alt.video.tape-trading 2
24news.admin.net-abuse.email 2
25alt.video.dvd 2
26comp.protocols.dns.bind 2
27news.groups 2
28news.software.nntp 2
29misc.consumers.frugal-living 2
TOTAL: 29 1108