Daily Usenet report for news.ripco.com

Dec 18 00:01:02 -- Dec 18 23:57:40

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Dec 18 02:15:18 remote5bge0 overchan[20005]: [ID 702911 news.error] input line too long, skipping
Dec 18 02:59:54 remote5bge0 overchan[20005]: [ID 702911 news.error] input line too long, skipping
Dec 18 05:47:29 remote5bge0 overchan[20005]: [ID 702911 news.error] input line too long, skipping
Dec 18 09:19:00 remote5bge0 overchan[20005]: [ID 702911 news.error] input line too long, skipping
Dec 18 09:28:07 remote5bge0 overchan[20005]: [ID 702911 news.error] input line too long, skipping
Dec 18 09:50:32 remote5bge0 overchan[20005]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 25255 38.3%4.6 MB 44.8%
innd 19171 29.1%3.0 MB 29.3%
nnrpd 17952 27.2%1.9 MB 18.5%
innfeed 3588 5.4%764.7 KB 7.3%
overchan 6 0.0%0.9 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 65974 100.0%10.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 206256 52.3%
Cache misses 188390 47.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 394646 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%210 0.000 0.000 0.000
article cleanup00:00:00.430 0.0%50240 0.000 0.009 0.030
article logging00:00:00.802 0.0%50578 0.000 0.016 0.135
article parse00:00:01.976 0.0%138788 0.002 0.014 0.029
article write00:01:20.104 0.0%41068 1.098 1.951 23.454
artlog/artparse00:00:00.000 0.0%6 0.000 0.000 0.000
data move00:00:00.340 0.0%417726 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.350 0.0%397048 0.001 0.008 0.019
history sync00:00:00.314 0.0%790 0.000 0.397 9.500
history write00:00:03.684 0.0%50246 0.000 0.073 0.355
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:58:27.660 99.9%470262 217.057 367.258 1101.308
nntp read00:00:02.506 0.0%470262 0.001 0.005 0.011
overview write00:00:00.218 0.0%41068 0.000 0.005 0.034
perl filter00:01:15.708 0.0%50240 1.188 1.507 2.216
python filter00:00:01.280 0.0%50248 0.000 0.025 0.064
site send00:00:03.454 0.0%123148 0.007 0.028 0.061
TOTAL: 48:02:08.20048:01:21.826100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.108 0.0%41088 0.000 0.003 0.029
article prepare00:00:00.010 0.0%25824 0.000 0.000 0.018
article read00:00:00.618 0.0%5686 0.000 0.109 2.958
backlog stats00:00:00.402 0.0%482326 0.000 0.001 0.038
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.758 0.0%319920 0.000 0.005 0.014
data write00:00:04.906 0.0%279660 0.008 0.018 0.033
idle47:48:50.954100.0%482326 214.988 356.877 1049.563
status file00:00:02.482 0.0%332 0.000 7.476 74.000
TOTAL: 47:49:11.06647:49:01.238100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:14:40.926 99.0%18262 18.786 639.630 61603.778
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:07.144 0.1%741574 0.000 0.010 1.000
readart00:00:20.676 0.2%2562 0.000 8.070 70.000
TOTAL: 03:16:42.85403:15:08.746 99.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
1feeder3.feed-ams.uzoreto.com 574 30632 14854 13410 2368 48%47:20:02
2ripco-out.feed.uzoreto.com 1148 34196 9830 22024 2342 28%94:39:08
3news.snarked.org 60 33670 9060 23470 1140 26%57:37:02
4newsfeed.neva.ru 588 57388 6314 49184 1890 11%279:24:58
5newsfeed.fu-berlin.de 2 13486 534 12932 20 3%44:30:14
6news.lightlink.com 2 6456 228 5830 398 3%45:17:10
7news-in.rahul.net 574 14640 158 14454 28 1%47:19:52
8ripco-out.feeder.erje.net 574 38790 72 37732 986 0%47:17:32
9news.cmpublishers.com 50 8062 60 7982 20 0%48:00:02
10localhost 154 8 8 0 0 100%00:00:00
TOTAL: 10 3726 237328 41118 187018 9192 17%711:26:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder3.feed-ams.uzoreto.com70.4 MB0.0 KB5.3 MB75.7 MB 93%4.5 KB
2ripco-out.feed.uzoreto.com30.6 MB0.0 KB6.9 MB37.5 MB 81%3.2 KB
3news.snarked.org25.3 MB0.0 KB3.6 MB28.9 MB 87%2.9 KB
4newsfeed.neva.ru24.3 MB0.0 KB7.0 MB31.3 MB 77%3.9 KB
5news-in.rahul.net4.8 MB0.0 KB757.2 KB5.5 MB 86%30.5 KB
6newsfeed.fu-berlin.de4.4 MB0.0 KB213.8 KB4.6 MB 95%8.5 KB
7news.lightlink.com2.0 MB0.0 KB15.1 MB17.1 MB 11%27.9 KB
8ripco-out.feeder.erje.net225.4 KB0.0 KB9.7 MB9.9 MB 2%9.6 KB
9news.cmpublishers.com144.2 KB0.0 KB55.6 KB199.8 KB 72%2.5 KB
10localhost13.4 KB0.0 KB0.0 KB13.4 KB100%1.7 KB
TOTAL: 10162.1 MB0.0 KB48.6 MB210.7 MB 76%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 18 00:01:02 - 00:59:59 370 1.8% 0.101.1 MB 1.3% 0.31
Dec 18 01:00:00 - 01:59:59 472 2.3% 0.131.4 MB 1.8% 0.40
Dec 18 02:00:00 - 02:59:59 503 2.5% 0.141.3 MB 1.6% 0.37
Dec 18 03:00:00 - 03:59:59 661 3.2% 0.181.8 MB 2.3% 0.52
Dec 18 04:00:00 - 04:59:59 936 4.6% 0.263.7 MB 4.6% 1.05
Dec 18 05:00:00 - 05:59:59 931 4.5% 0.263.7 MB 4.6% 1.05
Dec 18 06:00:00 - 06:59:59 979 4.8% 0.273.9 MB 4.9% 1.11
Dec 18 07:00:00 - 07:59:59 874 4.3% 0.243.5 MB 4.3% 0.98
Dec 18 08:00:00 - 08:59:59 1121 5.5% 0.314.7 MB 5.8% 1.33
Dec 18 09:00:00 - 09:59:59 1139 5.6% 0.324.8 MB 6.0% 1.36
Dec 18 10:00:00 - 10:59:59 1188 5.8% 0.334.3 MB 5.4% 1.23
Dec 18 11:00:00 - 11:59:59 1059 5.2% 0.294.1 MB 5.1% 1.15
Dec 18 12:00:00 - 12:59:59 1141 5.6% 0.323.9 MB 4.9% 1.12
Dec 18 13:00:00 - 13:59:59 1100 5.4% 0.314.1 MB 5.1% 1.17
Dec 18 14:00:00 - 14:59:59 1153 5.6% 0.324.3 MB 5.4% 1.23
Dec 18 15:00:00 - 15:59:59 1077 5.3% 0.304.2 MB 5.2% 1.19
Dec 18 16:00:00 - 16:59:59 954 4.7% 0.274.1 MB 5.1% 1.15
Dec 18 17:00:00 - 17:59:59 823 4.0% 0.233.6 MB 4.5% 1.02
Dec 18 18:00:00 - 18:59:59 807 3.9% 0.223.6 MB 4.5% 1.03
Dec 18 19:00:00 - 19:59:59 757 3.7% 0.213.2 MB 4.0% 0.92
Dec 18 20:00:00 - 20:59:59 715 3.5% 0.203.2 MB 3.9% 0.90
Dec 18 21:00:00 - 21:59:59 616 3.0% 0.172.8 MB 3.5% 0.79
Dec 18 22:00:00 - 22:59:59 571 2.8% 0.162.5 MB 3.1% 0.70
Dec 18 23:00:00 - 23:57:40 563 2.7% 0.162.5 MB 3.1% 0.73
TOTAL: 23:56:38 20510 100.0% 0.2480.1 MB 100.0% 0.95
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feeder3.feed-ams.uzoreto.com 1187 875 0 0 0 0 0 0 312
2ripco-out.feed.uzoreto.com 1186 524 0 0 3 0 0 0 659
3newsfeed.neva.ru 966 408 0 0 1 0 0 0 557
4news.snarked.org 562 398 0 0 1 0 0 0 163
5ripco-out.feeder.erje.net 494 492 0 0 0 0 0 0 2
6news.lightlink.com 196 0 0 0 0 0 0 0 196
7newsfeed.fu-berlin.de 129 0 0 0 0 0 0 0 129
8news-in.rahul.net 14 4 0 0 0 0 0 0 10
9news.cmpublishers.com 11 2 0 0 0 0 0 0 9
TOTAL: 9 4745 2703 0 0 5 0 0 0 2037

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1695
alt.binaries.ftd 243
alt.binaries.boneless 125
de.soc.arbeitslos 51
fido7.su.pol.news 48
perl.cpan.uploads 48
alt.binaries.nl 42
it.comp.os.win.windows10 30
wales.test 29
free.it.scienza.fisica 22
it.tlc.cellulari.android 21
alt.binaries.humor.skewed 19
scot.general 18
alt.binaries.pictures.purebeauty 17
linux.debian.maint.hams 13
alt.binaries.font 13
alt.binaries.ebooks 12
alt.binaries.nospam.breasts.natural 11
alt.binaries.multimedia.vintage-film 10
alt.binaries.adan 9
TOTAL: 124 2703

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

GroupsCount
alt.penthouse.sex.masterbation 2
alt.christnet.christnews 1
rec.travel.resorts.all-inclusive 1
bit.listserv.catholic 1
TOTAL: 4 5

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1650
Too many newsgroups 1172
Binary in non-binary group 622
EMP (phl) 148
Scoring filter (8) 40
Excessive Supersedes (82.224.103.103) 34
Scoring filter (9) 30
Scoring filter (10) 12
Scoring filter (12) 8
Scoring filter (11) 6
Scoring filter (16) 4
Scoring filter (14) 4
Scoring filter (15) 2
TOTAL: 13 3732

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 121
newsfeed.neva.ru 36
ripco-out.feed.uzoreto.com 9
feeder3.feed-ams.uzoreto.com 3
TOTAL: 4 169
No colon-space in header
ripco-out.feeder.erje.net 2
ripco-out.feed.uzoreto.com 1
TOTAL: 2 3
TOTAL: 3 190

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9568 2036 5230 16 0 0 21%47:46:10
2rahul.net 22918 1056 12506 34 0 0 4%47:40:02
3news.cmpublishers.com 57610 322 37906 2372 0 106 0%47:40:02
4feeder.erje.net 38964 110 38324 278 0 0 0%47:40:02
5fu-berlin.de 38774 62 38712 0 0 0 0%47:40:02
6news.snarked.org 53880 30 31574 8 0 46 0%47:40:02
7news.uzoreto.com 16592 24 15906 72 0 0 0%47:40:02
8newsfeed.neva.ru 35400 16 34486 16 0 0 0%47:37:22
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:02
TOTAL: 9 273706 3656 214644 2796 0 158 1%429:03:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com5.3 MB70.5 KB5.4 MB0.0 KB/s2.7 KB47:46:10
2rahul.net3.0 MB70.8 KB3.0 MB0.0 KB/s2.8 KB47:40:02
3news.cmpublishers.com1.0 MB6.3 MB7.4 MB0.0 KB/s2.8 KB47:40:02
4fu-berlin.de911.1 KB0.0 KB911.1 KB0.0 KB/s14.7 KB47:40:02
5feeder.erje.net492.5 KB706.3 KB1.2 MB0.0 KB/s3.1 KB47:40:02
6news.snarked.org262.2 KB20.9 KB283.1 KB0.0 KB/s7.4 KB47:40:02
7newsfeed.neva.ru216.3 KB51.8 KB268.1 KB0.0 KB/s8.4 KB47:37:22
8news.uzoreto.com48.9 KB217.0 KB265.9 KB0.0 KB/s2.8 KB47:40:02
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
TOTAL: 911.2 MB7.5 MB18.7 MB0.0 KB/s3.0 KB429:03:46
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10642.9 MB 432 6 000:07:56
2shell3 20 4281.3 MB 52 2 003:07:56
TOTAL: 2 306 14924.2 MB 484 8 003:16:33

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10642.9 MB 432 6 000:07:56
2? 20 4281.3 MB 52 2 003:07:56
TOTAL: 2 306 14924.2 MB 484 8 003:15:53

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 5.112 2.790 0.00003:07:56
ftupet.com 46.080 7.766 0.00000:07:56
84-105-134-55.cable.dynamic.v4.ziggo.nl 16.110 3.548 0.00000:00:37
86.120.43.147 0.200 0.042 0.00000:00:01
122.228.19.80 0.200 0.040 0.00000:00:00
37.120.137.153 0.198 0.040 0.00000:00:00
TOTAL: 6 67.900 14.226 0.00003:16:33

NNRP no permission clients:

SystemConn
84-105-134-55.cable.dynamic.v4.ziggo.nl 160
86.120.43.147 2
37.120.137.153 2
122.228.19.80 2
TOTAL: 4 166

NNRP unrecognized commands (by host):

SystemConn
shell3 6
TOTAL: 1 6

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 6
TOTAL: 1 6

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 6 0
TOTAL: 1 6 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1272 85.3%
2alt 70 4.7%
3comp 66 4.4%
4sci 32 2.1%
5misc 20 1.3%
6news 12 0.8%
7rocksolid 10 0.7%
8soc 6 0.4%
9chi 4 0.3%
TOTAL: 9 1492100.0%

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

NewsgroupCount
1rec.arts.tv 630
2rec.food.cooking 516
3rec.bicycles.tech 82
4alt.comp.os.windows-10 40
5rec.outdoors.rv-travel 34
6sci.electronics.repair 32
7comp.mobile.android 32
8comp.sys.mac.system 24
9misc.phone.mobile.iphone 20
10alt.stupidity 16
11alt.online-service.comcast 12
12soc.history.what-if 6
13rec.radio.broadcasting 6
14rocksolid.nodes.announce 6
15comp.mail.sendmail 6
16rec.radio.swap 4
17news.admin.net-abuse.usenet 4
18news.admin.net-abuse.email 4
19chi.weather 4
20alt.video.digital-tv 2
21comp.risks 2
22rocksolid.shared.news 2
23rocksolid.shared.general 2
24news.admin.hierarchies 2
25comp.protocols.dns.bind 2
26news.groups 2
TOTAL: 26 1492