Daily Usenet report for news.ripco.com

Oct 23 00:01:03 -- Oct 23 23:57:52

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Oct 23 11:28:12 remote5bge0 overchan[18250]: [ID 702911 news.error] input line too long, skipping
Oct 23 11:32:50 remote5bge0 overchan[18250]: [ID 702911 news.error] input line too long, skipping
Oct 23 11:34:00 remote5bge0 overchan[18250]: [ID 702911 news.error] input line too long, skipping
Oct 23 11:36:53 remote5bge0 overchan[18250]: [ID 702911 news.error] input line too long, skipping
Oct 23 11:42:34 remote5bge0 overchan[18250]: [ID 702911 news.error] input line too long, skipping
Oct 23 12:45:28 remote5bge0 overchan[18250]: [ID 702911 news.error] input line too long, skipping
Oct 23 12:52:52 remote5bge0 overchan[18250]: [ID 702911 news.error] input line too long, skipping
Oct 23 12:56:17 remote5bge0 overchan[18250]: [ID 702911 news.error] input line too long, skipping
Oct 23 13:56:45 remote5bge0 overchan[18250]: [ID 702911 news.error] input line too long, skipping
Oct 23 15:21:52 remote5bge0 overchan[18250]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 33134 40.9%4.1 MB 34.0%
inn 22668 28.0%3.9 MB 32.4%
innd 21466 26.5%3.3 MB 27.4%
innfeed 3636 4.5%767.1 KB 6.2%
overchan 10 0.0%1.3 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 80916 100.0%12.1 MB100.0%

History cache:

ReasonCount%Count
Cache misses 203316 53.8%
Do not exist 174676 46.2%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 377992 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.002 0.0%554 0.000 0.004 0.053
article cleanup00:00:00.438 0.0%45076 0.000 0.010 0.037
article logging00:00:00.776 0.0%45452 0.000 0.017 0.202
article parse00:00:01.630 0.0%105950 0.000 0.015 0.044
article write00:00:39.994 0.0%33352 0.415 1.199 18.507
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.234 0.0%390234 0.000 0.001 0.003
hishave/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.584 0.0%380128 0.002 0.007 0.018
history sync00:00:00.464 0.0%814 0.000 0.570 9.667
history write00:00:04.502 0.0%45076 0.000 0.100 2.796
hiswrite/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
idle47:59:47.760 99.9%425740 202.688 405.853 1168.626
nntp read00:00:02.422 0.0%423442 0.000 0.006 0.014
overview write00:00:00.184 0.0%33352 0.000 0.006 0.034
perl filter00:00:58.234 0.0%45062 0.996 1.292 3.163
python filter00:00:01.172 0.0%45068 0.000 0.026 0.062
site send00:00:01.836 0.0%100032 0.003 0.018 0.034
TOTAL: 48:02:16.03048:01:42.232100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.494 0.0%33298 0.000 0.015 0.062
article prepare00:00:00.004 0.0%23024 0.000 0.000 0.008
article read00:00:00.508 0.0%4818 0.000 0.105 9.000
backlog stats00:00:00.216 0.0%393082 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.920 0.0%260976 0.002 0.011 0.018
data write00:00:03.708 0.0%228098 0.006 0.016 0.031
idle47:52:59.658100.0%393082 260.369 438.534 1109.022
status file00:00:03.346 0.0%348 0.000 9.615 64.000
TOTAL: 47:53:23.36647:53:10.854100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:03.822 0.0%173294 0.000 0.022 0.032
idle23:46:24.200 99.9%207426 1.333 412.601 32421.167
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:10.194 0.0%1035878 0.000 0.010 0.143
readart00:00:19.164 0.0%2760 1.800 6.943 36.000
TOTAL: 23:48:12.28623:46:57.380 99.9%----

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 1148 36122 11132 22882 2108 30%94:39:08
2news.snarked.org 48 41586 10638 27542 3406 25%55:42:56
3newsfeed.neva.ru 582 61304 5700 53932 1672 9%278:56:22
4feeder3.feed-ams.uzoreto.com 574 21856 4896 13980 2980 22%47:19:00
5newsfeed.fu-berlin.de 2 16264 632 15590 42 3%50:42:28
6news-in.rahul.net 574 17918 186 17694 38 1%47:19:02
7news.lightlink.com 2 8324 160 7860 304 1%45:01:30
8ripco-out.feeder.erje.net 574 36142 34 35008 1100 0%47:17:10
9news.cmpublishers.com 52 9108 28 9078 2 0%48:00:04
10localhost 150 6 6 0 0 100%00:00:00
TOTAL: 10 3706 248630 33412 203566 11652 13%714:57:40
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org30.5 MB0.0 KB11.4 MB41.8 MB 72%3.0 KB
2ripco-out.feed.uzoreto.com28.0 MB0.0 KB5.0 MB33.0 MB 84%2.6 KB
3newsfeed.neva.ru15.5 MB0.0 KB7.9 MB23.4 MB 66%3.3 KB
4feeder3.feed-ams.uzoreto.com11.6 MB0.0 KB5.3 MB16.9 MB 68%2.2 KB
5news-in.rahul.net9.3 MB0.0 KB2.6 MB11.9 MB 77%54.6 KB
6newsfeed.fu-berlin.de2.8 MB0.0 KB1.2 MB4.0 MB 70%6.1 KB
7news.lightlink.com2.4 MB0.0 KB11.4 MB13.8 MB 17%30.4 KB
8ripco-out.feeder.erje.net141.6 KB0.0 KB9.6 MB9.7 MB 1%8.8 KB
9news.cmpublishers.com71.1 KB0.0 KB4.3 KB75.4 KB 94%2.5 KB
10localhost18.6 KB0.0 KB0.0 KB18.6 KB100%3.1 KB
TOTAL: 10100.3 MB0.0 KB54.4 MB154.7 MB 64%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 23 00:01:03 - 00:59:59 464 2.8% 0.131.5 MB 3.0% 0.44
Oct 23 01:00:00 - 01:59:59 481 2.9% 0.131.4 MB 2.8% 0.41
Oct 23 02:00:00 - 02:59:59 591 3.6% 0.161.5 MB 3.1% 0.44
Oct 23 03:00:00 - 03:59:59 784 4.7% 0.222.1 MB 4.2% 0.60
Oct 23 04:00:00 - 04:59:59 742 4.5% 0.212.0 MB 4.0% 0.57
Oct 23 05:00:00 - 05:59:59 793 4.8% 0.222.2 MB 4.4% 0.63
Oct 23 06:00:00 - 06:59:59 800 4.8% 0.222.4 MB 4.7% 0.68
Oct 23 07:00:00 - 07:59:59 840 5.1% 0.232.1 MB 4.1% 0.59
Oct 23 08:00:00 - 08:59:59 872 5.2% 0.243.0 MB 6.0% 0.86
Oct 23 09:00:00 - 09:59:59 933 5.6% 0.262.4 MB 4.9% 0.69
Oct 23 10:00:00 - 10:59:59 993 6.0% 0.283.0 MB 5.9% 0.84
Oct 23 11:00:00 - 11:59:59 912 5.5% 0.252.9 MB 5.7% 0.81
Oct 23 12:00:00 - 12:59:59 950 5.7% 0.262.7 MB 5.3% 0.76
Oct 23 13:00:00 - 13:59:59 894 5.4% 0.252.8 MB 5.6% 0.80
Oct 23 14:00:00 - 14:59:59 908 5.5% 0.252.5 MB 5.0% 0.71
Oct 23 15:00:00 - 15:59:59 873 5.3% 0.242.8 MB 5.5% 0.79
Oct 23 16:00:00 - 16:59:59 798 4.8% 0.222.3 MB 4.6% 0.65
Oct 23 17:00:00 - 17:59:59 582 3.5% 0.161.6 MB 3.1% 0.45
Oct 23 18:00:00 - 18:59:59 522 3.1% 0.142.2 MB 4.3% 0.62
Oct 23 19:00:00 - 19:59:59 435 2.6% 0.121.5 MB 3.0% 0.43
Oct 23 20:00:00 - 20:59:59 415 2.5% 0.121.5 MB 2.9% 0.42
Oct 23 21:00:00 - 21:59:59 308 1.9% 0.09967.0 KB 1.9% 0.27
Oct 23 22:00:00 - 22:59:59 371 2.2% 0.101.2 MB 2.4% 0.34
Oct 23 23:00:00 - 23:57:52 358 2.2% 0.101.9 MB 3.7% 0.55
TOTAL: 23:56:49 16619 100.0% 0.1950.3 MB 100.0% 0.60
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 1704 58 0 0 0 0 0 0 1646
2feeder3.feed-ams.uzoreto.com 1496 1200 0 0 1 0 0 0 295
3ripco-out.feed.uzoreto.com 1064 605 0 0 1 0 0 0 458
4newsfeed.neva.ru 890 407 0 0 2 0 0 0 481
5ripco-out.feeder.erje.net 551 536 0 0 0 0 0 0 15
6news.lightlink.com 176 1 0 0 0 0 0 0 175
7newsfeed.fu-berlin.de 145 0 0 0 0 0 0 0 145
8news-in.rahul.net 19 1 0 0 0 0 0 0 18
9news.cmpublishers.com 4 0 0 0 0 0 0 0 4
TOTAL: 9 6049 2808 0 0 4 0 0 0 3237

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1907
alt.binaries.ftd 246
fido7.su.pol.news 51
alt.binaries.drwho 46
perl.cpan.uploads 35
alt.astrology.pro 32
alt.binaries.e-book 30
it.comp.os.win.windows10 29
free.it.scienza.fisica 24
gmane.linux.alsa.devel 18
alt.binaries.nl 18
uk.radio.amateur.moderated 17
free.willey 14
alt.binaries.test.yenc 13
it.tlc.cellulari.android 12
free.ucp 12
mozilla.dev.platform 9
alt.binaries.ctb 9
mozilla.dev.l10n 8
alt.binaries.sounds.lossless 8
TOTAL: 143 2808

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

GroupsCount
bit.listserv.catholic 2
fr.comp.securite 1
alt.christnet.christnews 1
TOTAL: 3 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3932
Too many newsgroups 1230
Binary in non-binary group 582
EMP (phl) 150
Scoring filter (16) 54
Attached HTML file 36
Scoring filter (8) 36
HTML post 12
Scoring filter (13) 10
Scoring filter (12) 10
Scoring filter (9) 10
Scoring filter (11) 6
Scoring filter (17) 6
Scoring filter (18) 4
Scoring filter (10) 4
TOTAL: 15 6082

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
ripco-out.feed.uzoreto.com 3
feeder3.feed-ams.uzoreto.com 3
TOTAL: 2 6
Bad Message-ID's offered
ripco-out.feeder.erje.net 22
ripco-out.feed.uzoreto.com 4
TOTAL: 2 26
Huge articles
newsfeed.fu-berlin.de 2
TOTAL: 1 2
Including strange strings
newsfeed.fu-berlin.de 121
newsfeed.neva.ru 45
ripco-out.feed.uzoreto.com 11
news.snarked.org 6
feeder3.feed-ams.uzoreto.com 5
TOTAL: 5 188
TOTAL: 4 222

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9564 2980 4500 6 0 0 31%47:49:54
2rahul.net 24748 1002 13354 22 0 2 4%47:40:00
3news.uzoreto.com 17372 82 16490 260 0 0 0%47:45:42
4news.cmpublishers.com 43076 70 31800 978 0 8 0%47:40:00
5news.snarked.org 38856 50 22544 16 0 70 0%47:48:08
6feeder.erje.net 30870 30 29418 102 0 6 0%47:36:44
7fu-berlin.de 30186 26 30158 0 0 0 0%47:40:00
8newsfeed.neva.ru 28418 24 27282 104 0 0 0%47:46:56
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:00
TOTAL: 9 223090 4264 175546 1488 0 92 1%429:27:24
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com8.4 MB8.6 KB8.4 MB0.1 KB/s2.9 KB47:49:54
2rahul.net3.4 MB43.5 KB3.4 MB0.0 KB/s3.4 KB47:40:00
3news.uzoreto.com340.5 KB907.3 KB1.2 MB0.0 KB/s3.6 KB47:45:42
4news.cmpublishers.com272.2 KB2.6 MB2.9 MB0.0 KB/s2.8 KB47:40:00
5news.snarked.org197.1 KB27.0 KB224.2 KB0.0 KB/s3.4 KB47:48:08
6feeder.erje.net113.4 KB336.5 KB449.9 KB0.0 KB/s3.4 KB47:36:44
7fu-berlin.de101.6 KB0.0 KB101.6 KB0.0 KB/s3.9 KB47:40:00
8newsfeed.neva.ru84.0 KB332.2 KB416.2 KB0.0 KB/s3.3 KB47:46:56
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 912.9 MB4.2 MB17.1 MB0.0 KB/s3.0 KB429:27:24
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 11883.5 MB 460 2 000:06:56
2shell3 22 378979.6 KB 28 4 002:08:23
375-151-74-61-independence.hfc.comcastbusiness.net 8 45.8 KB 4 0 000:16:55
TOTAL: 3 316 15704.4 MB 492 6 023:48:05

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 11883.5 MB 460 2 000:06:56
2? 22 378979.6 KB 28 4 002:08:23
3*.hfc.comcastbusiness.net 8 45.8 KB 4 0 000:16:55
4*.cinci.res.rr.com 32 00.0 KB 0 0 000:07:57
5*.7-3.cable.virginm.net 6 00.0 KB 0 0 021:07:48
6unresolved 4 00.0 KB 0 0 000:00:04
TOTAL: 6 358 15704.4 MB 492 6 023:48:05

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 5.466 7.722 0.00021:07:48
shell3 4.466 2.002 0.00002:08:23
75-151-74-61-independence.hfc.comcastbusiness.net 1.698 1.344 0.00000:16:55
cpe-74-140-148-218.cinci.res.rr.com 3.334 0.902 0.00000:07:57
ftupet.com 46.894 7.454 0.00000:06:56
89.238.185.116 0.340 0.046 0.00000:00:03
94.242.228.155 0.200 0.040 0.00000:00:01
TOTAL: 7 62.398 19.510 0.00023:48:05

Curious NNRP server explorers [Top 20]:

SystemConn
cpe-74-140-148-218.cinci.res.rr.com 32
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 6
89.238.185.116 2
94.242.228.155 2
TOTAL: 4 42

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
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 6 0
shell3 2 0
TOTAL: 2 8 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1432 91.2%
2comp 52 3.3%
3alt 40 2.5%
4sci 26 1.7%
5chi 8 0.5%
6news 8 0.5%
7sfnet 2 0.1%
8muc 2 0.1%
TOTAL: 8 1570100.0%

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

NewsgroupCount
1rec.arts.tv 934
2rec.food.cooking 422
3rec.bicycles.tech 62
4alt.stupidity 40
5sci.electronics.repair 26
6comp.sys.mac.system 22
7comp.dcom.telecom 20
8news.admin.net-abuse.email 8
9rec.radio.broadcasting 6
10rec.radio.swap 6
11chi.weather 4
12comp.protocols.dns.bind 4
13chi.general 4
14comp.risks 2
15sfnet.keskustelu.politiikka 2
16comp.sys.ibm.pc.games.war-historical 2
17comp.mail.sendmail 2
18rec.puzzles 2
19muc.lists.netbsd.port.i386 2
TOTAL: 19 1570