Daily Usenet report for news.ripco.com

Jul 27 00:01:01 -- Jul 27 23:57:55

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Jul 27 04:15:16 remote5bge0 overchan[13081]: [ID 702911 news.error] input line too long, skipping
Jul 27 08:51:49 remote5bge0 overchan[13081]: [ID 702911 news.error] input line too long, skipping
Jul 27 08:56:52 remote5bge0 overchan[13081]: [ID 702911 news.error] input line too long, skipping
Jul 27 09:21:44 remote5bge0 overchan[13081]: [ID 702911 news.error] input line too long, skipping
Jul 27 09:32:11 remote5bge0 overchan[13081]: [ID 702911 news.error] input line too long, skipping
Jul 27 09:38:38 remote5bge0 overchan[13081]: [ID 702911 news.error] input line too long, skipping
Jul 27 13:34:18 remote5bge0 overchan[13081]: [ID 702911 news.error] input line too long, skipping
Jul 27 17:59:39 remote5bge0 overchan[13081]: [ID 702911 news.error] input line too long, skipping
Jul 27 18:27:28 remote5bge0 overchan[13081]: [ID 702911 news.error] input line too long, skipping
Jul 27 23:37:42 remote5bge0 overchan[13081]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 18661 32.4%3.6 MB 40.4%
innd 17965 31.1%2.8 MB 31.1%
nnrpd 17252 29.9%1.8 MB 19.9%
innfeed 3794 6.6%793.4 KB 8.6%
overchan 10 0.0%1.2 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 57684 100.0%9.0 MB100.0%

History cache:

ReasonCount%Count
Cache misses 174878 51.7%
Do not exist 163296 48.3%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 338174 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%70 0.000 0.000 0.000
article cleanup00:00:00.430 0.0%36964 0.000 0.012 0.054
article logging00:00:00.952 0.0%37376 0.000 0.025 1.226
article parse00:00:01.374 0.0%92816 0.000 0.015 0.056
article write00:01:54.450 0.1%28662 1.237 3.993 30.738
artlog/artparse00:00:00.000 0.0%12 0.000 0.000 0.000
data move00:00:00.392 0.0%350304 0.000 0.001 0.005
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.412 0.0%339006 0.002 0.007 0.018
history sync00:00:00.246 0.0%808 0.000 0.304 17.000
history write00:00:04.742 0.0%36974 0.018 0.128 1.352
hiswrite/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
idle47:56:51.408 99.8%390000 270.133 442.593 1450.471
nntp read00:00:02.798 0.0%386844 0.002 0.007 0.016
overview write00:00:00.294 0.0%28662 0.000 0.010 0.058
perl filter00:00:54.676 0.0%36964 1.226 1.479 2.604
python filter00:00:01.362 0.0%36970 0.000 0.037 0.109
site send00:00:02.690 0.0%85972 0.000 0.031 0.095
TOTAL: 48:02:07.15447:59:58.226 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.004 0.0%420376 0.000 0.002 0.042
article prepare00:00:00.298 0.0%808836 0.000 0.000 0.036
article read00:21:47.252 0.8%202062 0.000 6.470 18.250
backlog stats00:00:00.462 0.0%607792 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.772 0.0%428484 0.000 0.006 0.018
data write00:00:07.614 0.0%397532 0.005 0.019 0.035
idle47:30:47.220 99.2%607792 5.842 281.424 1066.281
status file00:00:03.230 0.0%434 0.000 7.442 133.000
TOTAL: 47:53:29.48247:52:49.852100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:35:03.986 98.4%18328 18.111 704.059 52586.417
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:07.998 0.1%754576 0.000 0.011 1.000
readart00:00:23.334 0.2%2644 1.825 8.825 54.000
TOTAL: 03:38:38.90603:35:35.318 98.6%----

Control commands to INND:

CommandNumber
L 2
flush 2
go 4
logmode 2
mode 293
name 2
pause 2
paused 2
reserve 4
TOTAL: 9 313

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 32480 10676 17512 4292 32%94:29:50
2news.snarked.org 62 26528 7008 18950 570 26%48:48:38
3newsfeed.neva.ru 606 34770 5030 28490 1250 14%278:54:06
4feeder3.feed-ams.uzoreto.com 574 13524 4614 7738 1172 34%47:19:30
5newsfeed.fu-berlin.de 4 21646 762 20864 20 3%78:08:26
6ripco-out.news.tnetconsulting.net 4 28680 558 28074 48 1%43:34:30
7news.lightlink.com 2 7220 126 6982 112 1%43:52:52
8news-in.rahul.net 574 14044 42 13972 30 0%47:19:24
9ripco-out.feeder.erje.net 576 29940 22 29164 754 0%47:28:14
10localhost 152 6 6 0 0 100%00:00:02
11news.cmpublishers.com 52 7846 4 7834 8 0%47:59:58
TOTAL: 11 3754 216684 28848 179580 8256 13%777:55:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com25.9 MB0.0 KB8.1 MB33.9 MB 76%2.3 KB
2news.snarked.org19.2 MB0.0 KB1.4 MB20.6 MB 93%2.8 KB
3newsfeed.neva.ru14.8 MB0.0 KB3.2 MB18.0 MB 82%2.9 KB
4feeder3.feed-ams.uzoreto.com12.4 MB0.0 KB2.6 MB15.1 MB 82%2.7 KB
5ripco-out.news.tnetconsulting.net9.7 MB0.0 KB504.7 KB10.1 MB 95%17.1 KB
6newsfeed.fu-berlin.de6.7 MB0.0 KB935.3 KB7.6 MB 88%10.0 KB
7news.lightlink.com5.3 MB0.0 KB5.8 MB11.0 MB 47%47.5 KB
8news-in.rahul.net2.7 MB0.0 KB1.4 MB4.2 MB 65%59.1 KB
9ripco-out.feeder.erje.net45.1 KB0.0 KB5.0 MB5.0 MB 0%6.6 KB
10localhost15.9 KB0.0 KB0.0 KB15.9 KB100%2.6 KB
11news.cmpublishers.com10.6 KB0.0 KB11.7 KB22.3 KB 47%1.9 KB
TOTAL: 1196.7 MB0.0 KB28.9 MB125.7 MB 76%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 27 00:01:01 - 00:59:59 366 2.6% 0.10985.4 KB 2.1% 0.28
Jul 27 01:00:00 - 01:59:59 476 3.3% 0.132.1 MB 4.5% 0.59
Jul 27 02:00:00 - 02:59:59 524 3.7% 0.151.3 MB 2.7% 0.36
Jul 27 03:00:00 - 03:59:59 607 4.2% 0.171.6 MB 3.5% 0.45
Jul 27 04:00:00 - 04:59:59 626 4.4% 0.171.8 MB 3.9% 0.51
Jul 27 05:00:00 - 05:59:59 631 4.4% 0.182.1 MB 4.5% 0.59
Jul 27 06:00:00 - 06:59:59 671 4.7% 0.192.4 MB 5.3% 0.69
Jul 27 07:00:00 - 07:59:59 658 4.6% 0.181.9 MB 4.1% 0.54
Jul 27 08:00:00 - 08:59:59 801 5.6% 0.222.7 MB 5.8% 0.76
Jul 27 09:00:00 - 09:59:59 835 5.8% 0.232.8 MB 6.1% 0.80
Jul 27 10:00:00 - 10:59:59 841 5.9% 0.232.7 MB 5.8% 0.76
Jul 27 11:00:00 - 11:59:59 793 5.5% 0.222.7 MB 5.9% 0.77
Jul 27 12:00:00 - 12:59:59 719 5.0% 0.201.9 MB 4.2% 0.55
Jul 27 13:00:00 - 13:59:59 746 5.2% 0.212.4 MB 5.2% 0.68
Jul 27 14:00:00 - 14:59:59 690 4.8% 0.192.2 MB 4.7% 0.62
Jul 27 15:00:00 - 15:59:59 715 5.0% 0.202.0 MB 4.3% 0.56
Jul 27 16:00:00 - 16:59:59 670 4.7% 0.192.4 MB 5.2% 0.68
Jul 27 17:00:00 - 17:59:59 581 4.1% 0.161.7 MB 3.7% 0.49
Jul 27 18:00:00 - 18:59:59 568 4.0% 0.161.9 MB 4.1% 0.53
Jul 27 19:00:00 - 19:59:59 436 3.0% 0.121.4 MB 3.1% 0.41
Jul 27 20:00:00 - 20:59:59 398 2.8% 0.111.3 MB 2.7% 0.36
Jul 27 21:00:00 - 21:59:59 319 2.2% 0.091.2 MB 2.5% 0.33
Jul 27 22:00:00 - 22:59:59 275 1.9% 0.08934.2 KB 2.0% 0.26
Jul 27 23:00:00 - 23:57:55 355 2.5% 0.102.0 MB 4.3% 0.58
TOTAL: 23:56:54 14301 100.0% 0.1746.1 MB 100.0% 0.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2156 1669 0 0 1 0 0 0 486
2newsfeed.neva.ru 668 444 0 0 1 0 0 0 223
3feeder3.feed-ams.uzoreto.com 588 388 0 0 0 0 0 0 200
4ripco-out.feeder.erje.net 377 375 0 0 0 0 0 0 2
5news.snarked.org 282 184 0 0 1 0 0 0 97
6newsfeed.fu-berlin.de 158 0 0 0 0 0 0 0 158
7news.lightlink.com 68 0 0 0 0 0 0 0 68
8ripco-out.news.tnetconsulting.net 43 4 0 0 0 0 0 0 39
9news-in.rahul.net 15 0 0 0 0 0 0 0 15
10news.cmpublishers.com 5 3 0 0 0 0 0 0 2
TOTAL: 10 4360 3067 0 0 3 0 0 0 1290

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2319
alt.binaries.ftd 193
fido7.su.pol.news 51
alt.binaries.e-book 32
scinet.stats 31
it.tlc.cellulari.android 31
perl.cpan.uploads 31
free.willey 24
scot.general 22
alt.bestjobsusa.computer.jobs 12
linux.debian.maint.hams 11
alt.binaries.pictures.scenic 10
it.comp.os.win.windows10 10
alt.paranormal.spells 10
linux.debian.maint.emacsen 9
free.it.scienza.fisica 9
abg.test04 8
alt.binaries.test.yenc 7
alt.binaries.adan 6
alt.jobs.jobsearch 6
TOTAL: 146 3067

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

GroupsCount
pl.praca.oferowana 2
bit.listserv.catholic 1
TOTAL: 2 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1054
Too many newsgroups 790
Binary in non-binary group 138
EMP (phl) 128
Scoring filter (10) 18
Scoring filter (9) 12
Scoring filter (8) 8
Scoring filter (11) 6
Scoring filter (13) 2
TOTAL: 9 2156

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 22
feeder3.feed-ams.uzoreto.com 4
ripco-out.feed.uzoreto.com 2
TOTAL: 3 28
Huge articles
newsfeed.fu-berlin.de 2
TOTAL: 1 2
Including strange strings
newsfeed.fu-berlin.de 148
newsfeed.neva.ru 43
ripco-out.feed.uzoreto.com 11
news.snarked.org 2
feeder3.feed-ams.uzoreto.com 2
TOTAL: 5 206
No colon-space in header
feeder3.feed-ams.uzoreto.com 3
ripco-out.feed.uzoreto.com 1
TOTAL: 2 4
TOTAL: 4 240

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 24204 620 12594 40 0 16 2%47:41:42
2news.cmpublishers.com 43108 158 26702 1454 0 74 0%47:51:54
3feeder.erje.net 36250 112 25684 202 0 6 0%47:43:56
4news.tnetconsulting.net 45698 88 27762 2 0 20 0%47:35:02
5news.uzoreto.com 13342 52 12806 100 0 0 0%47:50:12
6news.snarked.org 36416 48 21344 36 0 102 0%47:40:04
7newsfeed.neva.ru 411342 14 211486199156 198 4244 0%47:47:08
8fu-berlin.de 25870 14 25856 0 0 0 0%47:40:04
9remote6hme0.ripco.com 8 2 0 6 0 0 25%01:32:12
10news.lightlink.com 0 0 0 0 0 6516 0%47:40:04
TOTAL: 10 636238 1108 364234200996 198 10978 0%431:02:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net3.0 MB74.2 KB3.0 MB0.0 KB/s4.7 KB47:41:42
2news.cmpublishers.com654.9 KB3.8 MB4.5 MB0.0 KB/s2.8 KB47:51:54
3news.tnetconsulting.net509.4 KB6.9 KB516.4 KB0.0 KB/s5.7 KB47:35:02
4news.snarked.org408.8 KB464.7 KB873.5 KB0.0 KB/s10.4 KB47:40:04
5feeder.erje.net374.0 KB486.7 KB860.7 KB0.0 KB/s2.7 KB47:43:56
6newsfeed.neva.ru328.0 KB684.2 MB684.5 MB4.1 KB/s3.5 KB47:47:08
7news.uzoreto.com258.9 KB310.2 KB569.1 KB0.0 KB/s3.7 KB47:50:12
8fu-berlin.de39.2 KB0.0 KB39.2 KB0.0 KB/s2.8 KB47:40:04
9remote6hme0.ripco.com2.7 KB22.2 KB24.9 KB0.0 KB/s3.1 KB01:32:12
10news.lightlink.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:04
TOTAL: 105.5 MB689.4 MB694.8 MB0.5 KB/s3.5 KB431:02:18
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 11243.2 MB 482 2 000:08:19
2shell3.ripco.com 14 3941.0 MB 36 4 003:30:08
TOTAL: 2 300 15184.2 MB 518 6 003:38:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 11243.2 MB 482 2 000:08:19
2*.ripco.com 14 3941.0 MB 36 4 003:30:08
TOTAL: 2 300 15184.2 MB 518 6 003:38:27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 4.154 6.862 0.00003:30:08
ftupet.com 48.130 21.584 0.00000:08:19
213.188.112.92 0.202 0.052 0.00000:00:01
? 0.226 0.054 0.00000:00:00
TOTAL: 4 52.712 28.552 0.00003:38:29

NNRP no permission clients:

SystemConn
213.188.112.92 2
TOTAL: 1 2

NNRP unrecognized commands (by host):

SystemConn
shell3.ripco.com 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 4
TOTAL: 1 4

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3.ripco.com 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1346 88.7%
2comp 98 6.5%
3misc 28 1.8%
4news 18 1.2%
5chi 14 0.9%
6alt 10 0.7%
7sci 2 0.1%
8houston 2 0.1%
TOTAL: 8 1518100.0%

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

NewsgroupCount
1rec.food.cooking 598
2rec.arts.tv 554
3rec.bicycles.tech 162
4comp.sys.mac.system 64
5comp.mobile.android 28
6rec.gardens.edible 24
7misc.phone.mobile.iphone 22
8news.groups 16
9alt.stupidity 8
10chi.general 8
11comp.sys.apple2 6
12rec.antiques.radio+phono 4
13chi.weather 4
14misc.consumers.frugal-living 4
15houston.general 2
16rec.radio.broadcasting 2
17misc.transport.rail.americas 2
18rec.radio.swap 2
19sci.electronics.repair 2
20news.admin.net-abuse.usenet 2
21alt.video.tape-trading 2
22chi.eats 2
TOTAL: 22 1518