Daily Usenet report for news.ripco.com

Mar 11 00:01:01 -- Mar 11 23:57:11

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Mar 11 11:41:40 remote5bge0 overchan[3046]: [ID 702911 news.error] input line too long, skipping
Mar 11 11:43:11 remote5bge0 overchan[3046]: [ID 702911 news.error] input line too long, skipping
Mar 11 11:49:58 remote5bge0 overchan[3046]: [ID 702911 news.error] input line too long, skipping
Mar 11 13:36:33 remote5bge0 overchan[3046]: [ID 702911 news.error] input line too long, skipping
Mar 11 22:00:03 remote5bge0 overchan[20513]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 20011 33.3%3.7 MB 40.2%
innd 18423 30.6%2.9 MB 30.9%
nnrpd 17870 29.7%1.9 MB 20.2%
innfeed 3806 6.3%824.9 KB 8.7%
overchan 7 0.0%0.8 KB 0.0%
controlchan 4 0.0%0.4 KB 0.0%
TOTAL: 6 60121 100.0%9.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 171252 50.3%
Cache misses 168946 49.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 340198 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%80 0.000 0.000 0.000
article cleanup00:00:00.496 0.0%39354 0.000 0.013 0.045
article logging00:00:00.750 0.0%39866 0.000 0.019 0.125
article parse00:00:01.448 0.0%100780 0.000 0.014 0.036
article write00:01:07.084 0.0%31232 0.985 2.148 78.524
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.328 0.0%354234 0.000 0.001 0.006
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.374 0.0%342010 0.000 0.007 0.017
history sync00:00:00.150 0.0%784 0.000 0.191 1.000
history write00:00:03.186 0.0%39350 0.008 0.081 1.633
hiswrite/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
idle47:37:43.788 99.8%396274 232.024 432.690 1534.036
nntp read00:00:02.328 0.0%393654 0.000 0.006 0.013
overview write00:00:00.214 0.0%31232 0.000 0.007 0.043
perl filter00:00:55.682 0.0%39348 1.070 1.415 2.673
python filter00:00:01.354 0.0%39358 0.000 0.034 0.106
site send00:00:02.534 0.0%93666 0.004 0.027 0.160
TOTAL: 47:42:09.87047:40:01.716 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.204 0.0%78150 0.000 0.003 0.032
article prepare00:00:00.006 0.0%25448 0.000 0.000 0.012
article read00:00:00.690 0.0%4528 0.000 0.152 12.000
backlog stats00:00:00.276 0.0%447106 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.962 0.0%287582 0.000 0.007 0.015
data write00:00:03.926 0.0%256486 0.006 0.015 0.028
idle47:35:17.354100.0%447106 87.100 383.169 1432.631
status file00:00:02.472 0.0%368 1.000 6.717 162.000
TOTAL: 47:35:46.85447:35:26.890100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:42:38.410 91.7%17760 18.778 144.055 24467.647
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.176 0.1%464700 0.000 0.009 1.000
readart00:00:17.356 0.6%2442 0.000 7.107 36.500
TOTAL: 00:46:29.02400:42:59.942 92.5%----

Control commands to INND:

CommandNumber
L 2
flush 2
go 4
logmode 2
mode 111
name 2
pause 2
paused 2
reserve 4
shutdown 6
TOTAL: 10 137

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1152 38976 14948 20478 3550 38%94:46:12
2news.snarked.org 54 29174 7244 20904 1026 24%55:55:26
3newsfeed.neva.ru 618 38456 5088 31912 1456 13%276:21:32
4feeder3.feed-ams.uzoreto.com 574 11276 2676 7630 970 23%47:23:00
5newsfeed.fu-berlin.de 6 12926 486 12414 26 3%42:55:02
6news-in.rahul.net 574 14906 300 14582 24 2%47:25:12
7news.lightlink.com 4 6496 104 6188 204 1%39:24:20
8ripco-out.news.tnetconsulting.net 12 5094 84 4986 24 1%05:40:52
9ripco-out.feeder.erje.net 574 32822 38 32016 768 0%47:19:38
10news.cmpublishers.com 52 9084 22 9050 12 0%47:59:08
11localhost 156 10 10 0 0 100%00:00:00
TOTAL: 11 3776 199220 31000 160160 8060 15%705:10:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com37.3 MB0.0 KB8.1 MB45.3 MB 82%2.5 KB
2news.snarked.org19.4 MB0.0 KB2.5 MB21.9 MB 88%2.7 KB
3newsfeed.neva.ru15.2 MB3.4 KB6.5 MB21.8 MB 69%3.4 KB
4news-in.rahul.net13.4 MB0.0 KB767.5 KB14.1 MB 94%44.7 KB
5feeder3.feed-ams.uzoreto.com7.4 MB3.1 KB2.4 MB9.8 MB 75%2.8 KB
6newsfeed.fu-berlin.de3.1 MB0.0 KB2.4 MB5.5 MB 56%11.0 KB
7news.lightlink.com2.3 MB0.0 KB8.7 MB11.0 MB 21%36.5 KB
8ripco-out.news.tnetconsulting.net687.8 KB0.0 KB556.3 KB1.2 MB 55%11.5 KB
9ripco-out.feeder.erje.net86.0 KB0.0 KB4.8 MB4.9 MB 1%6.3 KB
10news.cmpublishers.com84.6 KB0.0 KB28.2 KB112.7 KB 75%3.3 KB
11localhost21.9 KB0.0 KB0.0 KB21.9 KB100%2.2 KB
TOTAL: 1199.0 MB6.5 KB36.7 MB135.7 MB 72%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 11 00:01:01 - 00:59:59 336 2.1% 0.091.4 MB 2.7% 0.40
Mar 11 01:00:00 - 01:59:59 403 2.6% 0.111.1 MB 2.2% 0.32
Mar 11 02:00:00 - 02:59:59 507 3.2% 0.141.7 MB 3.2% 0.47
Mar 11 03:00:00 - 03:59:59 605 3.9% 0.171.6 MB 3.1% 0.45
Mar 11 04:00:00 - 04:59:59 741 4.7% 0.211.8 MB 3.6% 0.53
Mar 11 05:00:00 - 05:59:59 689 4.4% 0.192.4 MB 4.6% 0.67
Mar 11 06:00:00 - 06:59:59 762 4.9% 0.211.9 MB 3.6% 0.53
Mar 11 07:00:00 - 07:59:59 880 5.6% 0.243.3 MB 6.4% 0.94
Mar 11 08:00:00 - 08:59:59 732 4.7% 0.201.9 MB 3.7% 0.55
Mar 11 09:00:00 - 09:59:59 985 6.3% 0.273.8 MB 7.3% 1.07
Mar 11 10:00:00 - 10:59:59 834 5.3% 0.232.2 MB 4.2% 0.62
Mar 11 11:00:00 - 11:59:59 1007 6.4% 0.283.2 MB 6.2% 0.91
Mar 11 12:00:00 - 12:59:59 883 5.6% 0.252.5 MB 4.9% 0.71
Mar 11 13:00:00 - 13:59:59 792 5.0% 0.222.4 MB 4.7% 0.70
Mar 11 14:00:00 - 14:59:59 734 4.7% 0.202.8 MB 5.4% 0.80
Mar 11 15:00:00 - 15:59:59 717 4.6% 0.202.2 MB 4.2% 0.62
Mar 11 16:00:00 - 16:59:59 851 5.4% 0.242.5 MB 4.8% 0.70
Mar 11 17:00:00 - 17:59:59 705 4.5% 0.203.0 MB 5.9% 0.86
Mar 11 18:00:00 - 18:59:59 690 4.4% 0.192.8 MB 5.5% 0.81
Mar 11 19:00:00 - 19:59:59 447 2.8% 0.122.2 MB 4.2% 0.62
Mar 11 20:00:00 - 20:59:59 461 2.9% 0.131.4 MB 2.7% 0.40
Mar 11 21:00:00 - 21:59:59 356 2.3% 0.10995.5 KB 1.9% 0.28
Mar 11 22:00:00 - 22:59:59 285 1.8% 0.081.1 MB 2.1% 0.31
Mar 11 23:00:00 - 23:57:11 284 1.8% 0.081.5 MB 2.8% 0.44
TOTAL: 23:56:10 15686 100.0% 0.1851.6 MB 100.0% 0.61
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1781 1278 0 0 5 0 0 0 498
2newsfeed.neva.ru 791 381 0 1 1 0 0 0 408
3news.snarked.org 516 399 0 0 1 0 0 0 116
4feeder3.feed-ams.uzoreto.com 488 292 0 1 4 0 0 0 191
5ripco-out.feeder.erje.net 384 373 0 0 0 0 0 0 11
6newsfeed.fu-berlin.de 188 0 0 0 0 0 0 0 188
7news.lightlink.com 138 0 0 1 0 0 0 0 137
8ripco-out.news.tnetconsulting.net 22 13 0 0 0 0 0 0 9
9news-in.rahul.net 12 7 0 0 0 0 0 0 5
10news.cmpublishers.com 5 3 0 0 0 0 0 0 2
TOTAL: 10 4325 2746 0 3 11 0 0 0 1565

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1865
alt.binaries.ftd 115
perl.cpan.uploads 115
it.tlc.cellulari.android 51
fido7.su.pol.news 49
alt.binaries.nl 36
alt.bestjobsusa.computer.jobs 28
free.ucp 25
it.comp.os.win.windows10 23
scot.general 23
alt.binaries.pictures.scenic 22
free.it.scienza.fisica 21
alt.jobs.jobsearch 15
alt.binaries.e-book 13
free.willey 12
aus.jobs 12
alt.my.job.sucks 11
alt.binaries.pictures.earlmiller 11
at.jobs 11
alt.binaries.3d.poser 11
TOTAL: 132 2746

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

GroupsCount
pl.praca.oferowana 9
alt.christnet.religion 1
bit.listserv.catholic 1
TOTAL: 3 11

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1276
Too many newsgroups 912
Binary in non-binary group 252
EMP (phl) 106
Scoring filter (8) 20
Scoring filter (10) 16
Scoring filter (9) 8
Scoring filter (13) 4
Scoring filter (11) 4
Scoring filter (15) 4
Scoring filter (16) 2
U2 violation - invalid distribution 2
Scoring filter (14) 2
TOTAL: 13 2608

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 30
ripco-out.feed.uzoreto.com 8
feeder3.feed-ams.uzoreto.com 4
TOTAL: 3 42
Huge articles
newsfeed.fu-berlin.de 4
TOTAL: 1 4
Including strange strings
newsfeed.fu-berlin.de 178
newsfeed.neva.ru 66
ripco-out.feed.uzoreto.com 8
news.snarked.org 3
feeder3.feed-ams.uzoreto.com 3
TOTAL: 5 258
No colon-space in header
ripco-out.feed.uzoreto.com 1
TOTAL: 1 1
TOTAL: 4 305

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 33790 1494 27522 218 0 2 4%47:42:00
2news.lightlink.com 10082 1478 5682 12 0 6 14%47:42:00
3rahul.net 23874 852 13000 22 0 10 3%47:42:00
4news.cmpublishers.com 43138 218 29052 1688 0 50 0%47:42:00
5news.uzoreto.com 13688 86 13128 148 0 0 0%47:42:00
6news.snarked.org 38676 44 23346 12 0 32 0%47:42:00
7newsfeed.neva.ru 26920 26 26142 14 0 0 0%47:42:00
8fu-berlin.de 28434 24 28410 0 0 0 0%47:42:00
9news.tnetconsulting.net 14134 16 8690 0 0 0 0%16:40:00
10TNet 52754 6 50602 0 0 18844 0%31:01:58
11remote6hme0.ripco.com 6 0 0 6 0 0 0%01:32:10
TOTAL: 11 285496 4244 225574 2120 0 18944 1%430:50:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net5.6 MB39.7 KB5.6 MB0.0 KB/s6.6 KB47:42:00
2news.lightlink.com5.3 MB76.7 KB5.3 MB0.0 KB/s3.7 KB47:42:00
3feeder.erje.net3.7 MB437.7 KB4.1 MB0.0 KB/s2.4 KB47:42:00
4news.cmpublishers.com543.3 KB4.0 MB4.5 MB0.0 KB/s2.4 KB47:42:00
5news.uzoreto.com281.3 KB562.2 KB843.5 KB0.0 KB/s3.6 KB47:42:00
6news.snarked.org141.8 KB28.9 KB170.8 KB0.0 KB/s3.0 KB47:42:00
7newsfeed.neva.ru86.4 KB39.1 KB125.5 KB0.0 KB/s3.1 KB47:42:00
8fu-berlin.de65.8 KB0.0 KB65.8 KB0.0 KB/s2.7 KB47:42:00
9news.tnetconsulting.net46.0 KB0.0 KB46.0 KB0.0 KB/s2.9 KB16:40:00
10TNet16.2 KB0.0 KB16.2 KB0.0 KB/s2.7 KB31:01:58
11remote6hme0.ripco.com0.0 KB20.5 KB20.5 KB0.0 KB/s3.4 KB01:32:10
TOTAL: 1115.6 MB5.2 MB20.8 MB0.0 KB/s3.3 KB430:50:08
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 11784.2 MB 418 8 000:07:59
2shell3 12 78296.6 KB 28 2 000:36:17
TOTAL: 2 298 12564.5 MB 446 10 000:46:09

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 11784.2 MB 418 8 000:07:59
2? 12 78296.6 KB 28 2 000:36:39
TOTAL: 2 298 12564.5 MB 446 10 000:44:39

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 2.526 1.130 0.00000:36:17
ftupet.com 46.622 20.444 0.00000:07:59
84-105-134-55.cable.dynamic.v4.ziggo.nl 16.168 4.234 0.00000:01:22
? 0.452 0.110 0.00000:00:22
scan-141.security.ipip.net 0.198 0.048 0.00000:00:05
185.100.87.191 0.252 0.072 0.00000:00:01
192.241.211.155 0.206 0.052 0.00000:00:00
TOTAL: 7 66.424 26.090 0.00000:46:09

NNRP no permission clients:

SystemConn
84-105-134-55.cable.dynamic.v4.ziggo.nl 160
scan-141.security.ipip.net 2
185.100.87.191 2
192.241.211.155 2
TOTAL: 4 166

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 1174 93.5%
2misc 30 2.4%
3alt 20 1.6%
4comp 16 1.3%
5sci 8 0.6%
6chi 4 0.3%
7ba 2 0.2%
8news 2 0.2%
TOTAL: 8 1256100.0%

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

NewsgroupCount
1rec.arts.tv 734
2rec.food.cooking 338
3rec.bicycles.tech 94
4misc.phone.mobile.iphone 26
5sci.electronics.repair 8
6alt.stupidity 8
7comp.protocols.dns.bind 6
8comp.sys.mac.system 6
9rec.radio.broadcasting 4
10comp.unix.bsd.freebsd.misc 4
11rec.radio.swap 4
12chi.weather 4
13alt.radio.pirate 4
14misc.consumers.frugal-living 4
15ba.internet 2
16news.admin.net-abuse.usenet 2
17alt.security.alarms 2
18alt.tasteless 2
19alt.free.newsservers 2
20alt.internet.wireless 2
TOTAL: 20 1256