Daily Usenet report for news.ripco.com

Nov 21 00:01:01 -- Nov 21 23:58:04

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Nov 21 00:18:23 remote5bge0 overchan[18207]: [ID 702911 news.error] input line too long, skipping
Nov 21 09:51:07 remote5bge0 overchan[18207]: [ID 702911 news.error] input line too long, skipping
Nov 21 09:55:04 remote5bge0 overchan[18207]: [ID 702911 news.error] input line too long, skipping
Nov 21 10:34:47 remote5bge0 overchan[18207]: [ID 702911 news.error] input line too long, skipping
Nov 21 10:55:21 remote5bge0 overchan[18207]: [ID 702911 news.error] input line too long, skipping
Nov 21 13:12:37 remote5bge0 overchan[18207]: [ID 702911 news.error] input line too long, skipping
Nov 21 13:23:49 remote5bge0 overchan[18207]: [ID 702911 news.error] input line too long, skipping
Nov 21 14:42:59 remote5bge0 overchan[18207]: [ID 702911 news.error] input line too long, skipping
Nov 21 15:06:48 remote5bge0 overchan[18207]: [ID 702911 news.error] input line too long, skipping
Nov 21 23:32:17 remote5bge0 overchan[18207]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 18009 31.8%2.8 MB 32.1%
inn 17809 31.4%3.4 MB 38.6%
nnrpd 17148 30.3%1.8 MB 20.2%
innfeed 3709 6.5%817.0 KB 9.1%
overchan 10 0.0%1.7 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 56687 100.0%8.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 170498 51.8%
Cache misses 158652 48.2%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 329150 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%126 0.000 0.000 0.000
article cleanup00:00:00.452 0.0%35306 0.000 0.013 0.051
article logging00:00:00.974 0.0%35668 0.000 0.027 1.273
article parse00:00:01.392 0.0%92760 0.000 0.015 0.040
article write00:01:17.186 0.0%25292 0.727 3.052 46.917
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.356 0.0%339136 0.000 0.001 0.006
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:02.928 0.0%329844 0.004 0.009 0.020
history sync00:00:00.374 0.0%816 0.000 0.458 21.250
history write00:00:04.080 0.0%35308 0.000 0.116 5.850
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:57:19.404 99.8%375882 254.465 459.291 1680.076
nntp read00:00:03.118 0.0%375858 0.003 0.008 0.019
overview write00:00:00.274 0.0%25292 0.000 0.011 0.068
perl filter00:00:53.666 0.0%35304 1.214 1.520 2.667
python filter00:00:01.332 0.0%35306 0.000 0.038 0.121
site send00:00:01.808 0.0%75852 0.000 0.024 0.062
TOTAL: 48:02:18.18447:59:47.344 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.350 0.0%25624 0.000 0.014 0.049
article prepare00:00:00.004 0.0%9240 0.000 0.000 0.018
article read00:00:00.356 0.0%1590 0.000 0.224 4.867
backlog stats00:00:00.298 0.0%398702 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.574 0.0%247604 0.000 0.010 0.020
data write00:00:04.098 0.0%222360 0.007 0.018 0.034
idle47:35:34.418100.0%398702 246.658 429.731 1278.474
status file00:00:02.048 0.0%386 0.000 5.306 25.000
TOTAL: 47:36:06.29447:35:44.146100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:46:19.972 97.9%17870 18.079 558.476 49448.438
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.816 0.1%923062 0.000 0.011 0.051
readart00:00:19.564 0.2%1894 0.000 10.329 36.000
TOTAL: 02:49:54.13002:46:49.352 98.2%----

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 35490 11782 17786 5922 33%94:38:26
2newsfeed.neva.ru 580 24358 4522 18244 1592 18%273:55:22
3news.snarked.org 70 26738 4418 22108 212 16%67:25:06
4feeder3.feed-ams.uzoreto.com 574 11120 3140 7054 926 28%47:17:58
5newsfeed.fu-berlin.de 2 12236 500 11724 12 4%50:32:06
6ripco-out.news.tnetconsulting.net 4 23814 446 23342 26 1%34:52:02
7news.lightlink.com 2 8598 176 8372 50 2%52:29:26
8news-in.rahul.net 574 12450 60 12348 42 0%47:20:52
9ripco-out.feeder.erje.net 574 27826 28 26638 1160 0%47:16:10
10news.cmpublishers.com 52 7592 24 7560 8 0%47:59:52
11localhost 148 2 2 0 0 100%00:00:04
TOTAL: 11 3728 190224 25098 155176 9950 13%763:47:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com30.0 MB0.0 KB11.6 MB41.6 MB 72%2.4 KB
2newsfeed.neva.ru14.9 MB0.0 KB4.3 MB19.1 MB 77%3.2 KB
3news.snarked.org12.6 MB0.0 KB900.1 KB13.4 MB 93%3.0 KB
4ripco-out.news.tnetconsulting.net12.0 MB0.0 KB960.4 KB13.0 MB 92%28.1 KB
5feeder3.feed-ams.uzoreto.com8.3 MB0.0 KB1.9 MB10.2 MB 81%2.6 KB
6newsfeed.fu-berlin.de6.9 MB0.0 KB266.3 KB7.2 MB 96%14.3 KB
7news.lightlink.com5.1 MB110.5 KB3.2 MB8.4 MB 60%38.0 KB
8news-in.rahul.net1.4 MB0.0 KB1.8 MB3.3 MB 43%32.6 KB
9news.cmpublishers.com49.5 KB0.0 KB24.9 KB74.3 KB 66%2.3 KB
10ripco-out.feeder.erje.net48.0 KB0.0 KB9.8 MB9.8 MB 0%8.5 KB
11localhost3.8 KB0.0 KB0.0 KB3.8 KB100%1.9 KB
TOTAL: 1191.2 MB110.5 KB34.8 MB126.1 MB 72%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 21 00:01:01 - 00:59:59 257 2.0% 0.07766.9 KB 1.6% 0.22
Nov 21 01:00:00 - 01:59:59 424 3.4% 0.122.6 MB 5.5% 0.74
Nov 21 02:00:00 - 02:59:59 466 3.7% 0.132.0 MB 4.2% 0.56
Nov 21 03:00:00 - 03:59:59 643 5.1% 0.182.2 MB 4.8% 0.64
Nov 21 04:00:00 - 04:59:59 589 4.7% 0.161.9 MB 4.0% 0.54
Nov 21 05:00:00 - 05:59:59 655 5.2% 0.182.1 MB 4.5% 0.61
Nov 21 06:00:00 - 06:59:59 529 4.2% 0.151.6 MB 3.4% 0.46
Nov 21 07:00:00 - 07:59:59 563 4.5% 0.161.7 MB 3.6% 0.49
Nov 21 08:00:00 - 08:59:59 707 5.6% 0.201.8 MB 3.8% 0.52
Nov 21 09:00:00 - 09:59:59 787 6.2% 0.223.7 MB 7.7% 1.04
Nov 21 10:00:00 - 10:59:59 679 5.4% 0.191.6 MB 3.4% 0.46
Nov 21 11:00:00 - 11:59:59 801 6.3% 0.224.0 MB 8.4% 1.13
Nov 21 12:00:00 - 12:59:59 680 5.4% 0.192.1 MB 4.4% 0.59
Nov 21 13:00:00 - 13:59:59 636 5.0% 0.183.0 MB 6.3% 0.85
Nov 21 14:00:00 - 14:59:59 660 5.2% 0.182.0 MB 4.3% 0.57
Nov 21 15:00:00 - 15:59:59 609 4.8% 0.171.9 MB 4.0% 0.54
Nov 21 16:00:00 - 16:59:59 634 5.0% 0.182.6 MB 5.5% 0.74
Nov 21 17:00:00 - 17:59:59 470 3.7% 0.131.8 MB 3.8% 0.51
Nov 21 18:00:00 - 18:59:59 433 3.4% 0.122.2 MB 4.7% 0.63
Nov 21 19:00:00 - 19:59:59 388 3.1% 0.112.0 MB 4.1% 0.56
Nov 21 20:00:00 - 20:59:59 264 2.1% 0.07820.9 KB 1.7% 0.23
Nov 21 21:00:00 - 21:59:59 251 2.0% 0.07925.0 KB 1.9% 0.26
Nov 21 22:00:00 - 22:59:59 262 2.1% 0.071.2 MB 2.5% 0.34
Nov 21 23:00:00 - 23:58:04 238 1.9% 0.07826.8 KB 1.7% 0.24
TOTAL: 23:57:03 12625 100.0% 0.1547.3 MB 100.0% 0.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2973 2327 0 0 8 0 0 0 638
2newsfeed.neva.ru 853 456 0 0 5 0 0 0 392
3ripco-out.feeder.erje.net 580 577 0 0 0 0 0 0 3
4feeder3.feed-ams.uzoreto.com 465 311 0 0 2 0 0 0 152
5newsfeed.fu-berlin.de 117 0 0 0 0 0 0 0 117
6news.snarked.org 113 43 0 0 0 0 0 0 70
7ripco-out.news.tnetconsulting.net 36 27 0 0 0 0 0 0 9
8news.lightlink.com 22 0 0 1 0 0 0 0 21
9news-in.rahul.net 21 0 0 0 0 0 0 0 21
10news.cmpublishers.com 4 0 0 0 0 0 0 0 4
TOTAL: 10 5184 3741 0 1 15 0 0 0 1427

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2858
alt.binaries.ftd 359
alt.bestjobsusa.computer.jobs 38
it.comp.os.win.windows10 26
alt.binaries.pictures.purebeauty 24
scinet.stats 23
it.tlc.cellulari.android 22
alt.binaries.pictures.rail 21
free.it.scienza.fisica 20
alt.my.job.sucks 18
alt.binaries.e-book 16
free.willey 15
alt.binaries.pictures.earlmiller 15
alt.jobs.jobsearch 13
att.jobs 13
fido7.su.pol.news 12
alt.binaries.test.yenc 11
alt.binaries.mp3.audiobooks 9
alt.binaries.pictures.wallpaper 9
alt.binaries.nospam.breasts.natural 9
TOTAL: 118 3741

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

GroupsCount
pl.praca.oferowana 12
christnet.bible 2
bit.listserv.catholic 1
TOTAL: 3 15

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1050
EMP (md5) 976
EMP (phl) 230
Binary in non-binary group 130
Scoring filter (9) 34
Scoring filter (8) 28
Scoring filter (10) 8
HTML post 6
Scoring filter (16) 6
Scoring filter (15) 6
Scoring filter (11) 4
Scoring filter (13) 4
Scoring filter (18) 2
Scoring filter (12) 2
Scoring filter (14) 2
TOTAL: 15 2488

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 20
feeder3.feed-ams.uzoreto.com 2
ripco-out.feed.uzoreto.com 2
TOTAL: 3 24
Including strange strings
newsfeed.fu-berlin.de 111
newsfeed.neva.ru 58
ripco-out.feed.uzoreto.com 11
news.snarked.org 1
TOTAL: 4 181
No colon-space in header
feeder3.feed-ams.uzoreto.com 2
TOTAL: 1 2
TOTAL: 3 207

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 19746 950 10574 2 0 0 4%47:42:44
2news.lightlink.com 9792 548 5732 26 0 0 5%47:42:18
3feeder.erje.net 26980 378 22916 210 0 0 1%47:45:28
4news.snarked.org 34618 20 20488 6 0 186 0%47:50:36
5news.tnetconsulting.net 37622 18 24494 0 0 46 0%47:46:58
6fu-berlin.de 22394 16 22378 0 0 0 0%47:51:16
7news.uzoreto.com 10200 4 9866 8 0 0 0%47:43:30
8newsfeed.neva.ru 21018 4 20638 4 0 0 0%47:40:02
9news.cmpublishers.com 39194 2 24724 108 0 206 0%47:40:46
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:06
TOTAL: 10 221570 1940 161810 370 0 438 0%430:55:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net5.5 MB3.3 KB5.5 MB0.0 KB/s5.9 KB47:42:44
2news.lightlink.com3.0 MB252.6 KB3.2 MB0.0 KB/s5.7 KB47:42:18
3feeder.erje.net1.0 MB750.6 KB1.8 MB0.0 KB/s3.1 KB47:45:28
4news.snarked.org330.7 KB10.7 KB341.4 KB0.0 KB/s13.1 KB47:50:36
5news.tnetconsulting.net328.3 KB0.0 KB328.3 KB0.0 KB/s18.2 KB47:46:58
6fu-berlin.de145.6 KB0.0 KB145.6 KB0.0 KB/s9.1 KB47:51:16
7news.uzoreto.com39.9 KB38.5 KB78.5 KB0.0 KB/s6.5 KB47:43:30
8newsfeed.neva.ru20.6 KB49.9 KB70.6 KB0.0 KB/s8.8 KB47:40:02
9news.cmpublishers.com5.3 KB354.1 KB359.4 KB0.0 KB/s3.3 KB47:40:46
10remote6hme0.ripco.com0.0 KB25.5 KB25.5 KB0.0 KB/s4.2 KB01:12:06
TOTAL: 1010.4 MB1.5 MB11.8 MB0.0 KB/s5.2 KB430:55:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 7042.0 MB 380 2 000:08:39
2shell3.ripco.com 10 4841.5 MB 48 0 002:40:57
TOTAL: 2 296 11883.4 MB 428 2 002:49:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 7042.0 MB 380 2 000:08:39
2*.ripco.com 10 4841.5 MB 48 0 002:40:57
TOTAL: 2 296 11883.4 MB 428 2 002:49:37

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 4.124 2.816 0.00002:40:57
ftupet.com 44.882 21.302 0.00000:08:39
33.20.97.83.ro.ovo.sc 0.206 0.050 0.00000:00:06
scan-141.security.ipip.net 0.206 0.052 0.00000:00:00
TOTAL: 4 49.418 24.220 0.00002:49:44

NNRP no permission clients:

SystemConn
33.20.97.83.ro.ovo.sc 2
scan-141.security.ipip.net 2
TOTAL: 2 4

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 884 74.4%
2comp 124 10.4%
3misc 88 7.4%
4alt 42 3.5%
5chi 26 2.2%
6news 18 1.5%
7sci 4 0.3%
8rocksolid 2 0.2%
TOTAL: 8 1188100.0%

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

NewsgroupCount
1rec.arts.tv 442
2rec.food.cooking 304
3rec.bicycles.tech 96
4comp.sys.mac.system 86
5misc.phone.mobile.iphone 76
6alt.comp.os.windows-10 40
7rec.outdoors.rv-travel 30
8comp.mobile.android 26
9chi.general 22
10misc.consumers.frugal-living 12
11news.admin.hierarchies 6
12comp.sys.apple2 6
13news.groups 6
14comp.mail.pine 6
15rec.radio.broadcasting 4
16sci.electronics.repair 4
17rec.radio.shortwave 4
18chi.weather 4
19rec.radio.swap 2
20news.software.nntp 2
21rocksolid.nodes.announce 2
22news.admin.peering 2
23rec.puzzles 2
24alt.free.newsservers 2
25news.lists.misc 2
TOTAL: 25 1188