Daily Usenet report for news.ripco.com

Nov 25 00:01:02 -- Nov 25 23:57:32

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Nov 25 05:24:30 remote5bge0 overchan[16849]: [ID 702911 news.error] input line too long, skipping
Nov 25 06:00:23 remote5bge0 overchan[16849]: [ID 702911 news.error] input line too long, skipping
Nov 25 06:04:31 remote5bge0 overchan[16849]: [ID 702911 news.error] input line too long, skipping
Nov 25 06:04:31 remote5bge0 overchan[16849]: [ID 702911 news.error] input line too long, skipping
Nov 25 06:04:31 remote5bge0 overchan[16849]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 21849 34.8%3.7 MB 39.6%
innd 19755 31.4%3.1 MB 33.1%
nnrpd 17482 27.8%1.8 MB 19.5%
innfeed 3726 5.9%741.3 KB 7.8%
overchan 5 0.0%0.6 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 62819 100.0%9.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 151572 51.9%
Cache misses 140754 48.1%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 292326 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%106 0.000 0.000 0.000
article cleanup00:00:00.430 0.0%43560 0.000 0.010 0.035
article logging00:00:00.640 0.0%43808 0.000 0.015 0.066
article parse00:00:01.414 0.0%102092 0.000 0.014 0.046
article write00:00:42.198 0.0%29014 0.312 1.454 33.155
artlog/artparse00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:00.268 0.0%306750 0.000 0.001 0.005
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.800 0.0%293808 0.002 0.010 0.019
history sync00:00:00.274 0.0%798 0.000 0.343 11.000
history write00:00:04.324 0.0%43568 0.014 0.099 6.247
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:59:49.974 99.9%345000 300.184 500.841 1172.885
nntp read00:00:01.998 0.0%342492 0.001 0.006 0.014
overview write00:00:00.172 0.0%29014 0.000 0.006 0.029
perl filter00:00:59.364 0.0%43558 1.000 1.363 2.301
python filter00:00:01.082 0.0%43572 0.000 0.025 0.068
site send00:00:01.584 0.0%87014 0.000 0.018 0.041
TOTAL: 48:02:15.03248:01:46.522100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.128 0.0%28972 0.000 0.004 0.031
article prepare00:00:00.000 0.0%20944 0.000 0.000 0.000
article read00:00:00.500 0.0%4712 0.000 0.106 14.200
backlog stats00:00:00.164 0.0%326920 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.962 0.0%206050 0.000 0.010 0.019
data write00:00:02.872 0.0%177570 0.005 0.016 0.047
idle47:35:17.066100.0%326920 285.840 524.034 1384.395
status file00:00:01.944 0.0%398 0.000 4.884 45.000
TOTAL: 47:35:35.44647:35:24.636100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:37:21.742 99.3%20254 19.983 643.909100303.833
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:12.852 0.1%1495050 0.000 0.009 0.035
readart00:00:27.636 0.2%4404 1.542 6.275 49.000
TOTAL: 03:38:58.64203:38:02.230 99.6%----

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 33598 10880 19292 3426 32%94:38:36
2news.snarked.org 50 30430 8720 21238 472 28%49:07:00
3newsfeed.neva.ru 392 33468 5126 21730 6612 15%186:59:04
4feeder3.feed-ams.uzoreto.com 574 15366 3464 8918 2984 22%47:20:00
5newsfeed.fu-berlin.de 2 13206 378 12814 14 2%44:30:16
6news-in.rahul.net 574 13442 194 13220 28 1%47:20:44
7news.cmpublishers.com 50 7828 84 7734 10 1%47:59:56
8news.lightlink.com 2 2756 48 2662 46 1%22:41:06
9ripco-out.feeder.erje.net 574 30740 42 29804 894 0%47:16:48
10localhost 160 14 14 0 0 100%00:00:00
TOTAL: 10 3526 180848 28950 137412 14486 16%587:53:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com27.3 MB5.1 KB8.4 MB35.7 MB 76%2.6 KB
2news.snarked.org24.8 MB0.0 KB2.1 MB26.9 MB 92%3.0 KB
3newsfeed.neva.ru15.9 MB0.0 KB27.6 MB43.5 MB 36%3.8 KB
4feeder3.feed-ams.uzoreto.com9.8 MB0.0 KB6.7 MB16.5 MB 59%2.6 KB
5news-in.rahul.net7.3 MB0.0 KB891.3 KB8.1 MB 89%37.5 KB
6newsfeed.fu-berlin.de3.0 MB0.0 KB165.4 KB3.1 MB 94%8.2 KB
7news.lightlink.com624.2 KB0.0 KB3.2 MB3.8 MB 16%41.1 KB
8ripco-out.feeder.erje.net179.5 KB0.0 KB9.4 MB9.6 MB 1%10.5 KB
9news.cmpublishers.com174.0 KB0.0 KB15.8 KB189.9 KB 91%2.0 KB
10localhost31.1 KB0.0 KB0.0 KB31.1 KB100%2.2 KB
TOTAL: 1089.1 MB5.1 KB58.5 MB147.6 MB 60%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 25 00:01:02 - 00:59:59 363 2.5% 0.101.0 MB 2.2% 0.29
Nov 25 01:00:00 - 01:59:59 434 3.0% 0.121.7 MB 3.8% 0.48
Nov 25 02:00:00 - 02:59:59 536 3.7% 0.151.5 MB 3.3% 0.42
Nov 25 03:00:00 - 03:59:59 607 4.2% 0.171.7 MB 3.7% 0.47
Nov 25 04:00:00 - 04:59:59 645 4.5% 0.182.2 MB 4.8% 0.61
Nov 25 05:00:00 - 05:59:59 715 4.9% 0.202.2 MB 4.9% 0.62
Nov 25 06:00:00 - 06:59:59 664 4.6% 0.182.2 MB 5.0% 0.63
Nov 25 07:00:00 - 07:59:59 814 5.6% 0.232.1 MB 4.7% 0.60
Nov 25 08:00:00 - 08:59:59 759 5.2% 0.212.2 MB 4.8% 0.62
Nov 25 09:00:00 - 09:59:59 828 5.7% 0.232.2 MB 5.0% 0.63
Nov 25 10:00:00 - 10:59:59 852 5.9% 0.242.5 MB 5.5% 0.70
Nov 25 11:00:00 - 11:59:59 928 6.4% 0.262.8 MB 6.3% 0.80
Nov 25 12:00:00 - 12:59:59 792 5.5% 0.222.3 MB 5.1% 0.66
Nov 25 13:00:00 - 13:59:59 740 5.1% 0.212.1 MB 4.7% 0.60
Nov 25 14:00:00 - 14:59:59 730 5.0% 0.202.1 MB 4.7% 0.60
Nov 25 15:00:00 - 15:59:59 697 4.8% 0.192.4 MB 5.3% 0.67
Nov 25 16:00:00 - 16:59:59 631 4.4% 0.182.4 MB 5.4% 0.68
Nov 25 17:00:00 - 17:59:59 586 4.1% 0.161.8 MB 4.1% 0.52
Nov 25 18:00:00 - 18:59:59 499 3.5% 0.141.4 MB 3.1% 0.40
Nov 25 19:00:00 - 19:59:59 369 2.6% 0.101.4 MB 3.1% 0.40
Nov 25 20:00:00 - 20:59:59 368 2.5% 0.101.5 MB 3.2% 0.41
Nov 25 21:00:00 - 21:59:59 394 2.7% 0.111.2 MB 2.6% 0.34
Nov 25 22:00:00 - 22:59:59 271 1.9% 0.08939.9 KB 2.0% 0.26
Nov 25 23:00:00 - 23:57:32 239 1.7% 0.071.2 MB 2.6% 0.34
TOTAL: 23:56:30 14461 100.0% 0.1744.8 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 3324 1713 0 0 1 0 0 0 1610
2ripco-out.feed.uzoreto.com 1720 1198 0 1 2 0 0 0 519
3feeder3.feed-ams.uzoreto.com 1493 1234 0 0 1 0 0 0 258
4ripco-out.feeder.erje.net 450 442 0 0 0 0 0 0 8
5news.snarked.org 236 77 0 0 0 0 0 0 159
6newsfeed.fu-berlin.de 75 0 0 0 0 0 0 0 75
7news.lightlink.com 60 1 0 0 0 0 0 0 59
8news.cmpublishers.com 16 1 0 0 0 0 0 0 15
9news-in.rahul.net 14 5 0 0 0 0 0 0 9
TOTAL: 9 7388 4671 0 1 4 0 0 0 2712

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2548
alt.binaries.boneless 1308
alt.binaries.ftd 210
fido7.su.pol.news 53
it.tlc.cellulari.android 52
alt.binaries.nl 41
perl.cpan.uploads 29
de.soc.arbeitslos 23
free.it.scienza.fisica 20
alt.bestjobsusa.computer.jobs 20
it.comp.os.win.windows10 16
free.willey 13
alt.binaries.pictures.wallpaper 13
alt.binaries.pictures.scenic 13
alt.binaries.mac.osx.apps 11
alt.binaries.ebooks 11
alt.binaries.nospam.female.bodyhair.pubes 10
mozilla.test 10
linux.debian.ports.alpha 10
alt.tv.star-trek 9
TOTAL: 124 4671

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

GroupsCount
christnet.bible 3
pl.praca.oferowana 1
TOTAL: 2 4

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 2946
EMP (md5) 1142
Too many newsgroups 888
EMP (phl) 58
Scoring filter (8) 44
Scoring filter (10) 30
HTML post 20
Scoring filter (9) 20
Scoring filter (11) 12
Scoring filter (12) 8
Scoring filter (13) 2
TOTAL: 11 5170

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 68
newsfeed.neva.ru 47
ripco-out.feed.uzoreto.com 7
feeder3.feed-ams.uzoreto.com 1
TOTAL: 4 123
No colon-space in header
ripco-out.feed.uzoreto.com 2
feeder3.feed-ams.uzoreto.com 1
TOTAL: 2 3
TOTAL: 3 144

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 8856 1750 4872 20 0 0 19%47:38:12
2rahul.net 22142 784 11706 22 0 4 3%47:51:04
3news.cmpublishers.com 40610 286 26104 2126 0 28 0%47:35:40
4news.uzoreto.com 14506 52 14056 84 0 0 0%47:36:30
5news.snarked.org 33524 34 19780 10 0 100 0%47:39:32
6fu-berlin.de 26690 34 26652 0 0 0 0%47:36:40
7feeder.erje.net 26924 20 26444 16 0 0 0%47:40:04
8newsfeed.neva.ru 0 0 0 0 0 23730 0%47:40:04
9remote6hme0.ripco.com 0 0 0 0 0 8 0%47:40:04
TOTAL: 9 173252 2960 129614 2278 0 23870 1%428:57:50
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com4.7 MB227.7 KB4.9 MB0.0 KB/s2.9 KB47:38:12
2rahul.net2.3 MB69.3 KB2.3 MB0.0 KB/s3.0 KB47:51:04
3news.cmpublishers.com912.0 KB5.7 MB6.6 MB0.0 KB/s2.8 KB47:35:40
4fu-berlin.de243.5 KB0.0 KB243.5 KB0.0 KB/s7.2 KB47:36:40
5news.snarked.org166.3 KB30.4 KB196.7 KB0.0 KB/s4.5 KB47:39:32
6news.uzoreto.com130.7 KB405.8 KB536.5 KB0.0 KB/s3.9 KB47:36:30
7feeder.erje.net56.8 KB59.2 KB116.0 KB0.0 KB/s3.2 KB47:40:04
8newsfeed.neva.ru0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:04
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:04
TOTAL: 98.5 MB6.5 MB15.0 MB0.0 KB/s2.9 KB428:57:50
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1c-73-246-79-215.hsd1.il.comcast.net 2 18184.9 MB 8 0 000:01:59
2ftupet.com 286 10543.3 MB 452 10 000:07:39
3shell3 26 4681.3 MB 50 4 003:29:09
TOTAL: 3 314 33409.5 MB 510 14 003:38:52

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.hsd1.il.comcast.net 2 18184.9 MB 8 0 000:01:59
2*.com 286 10543.3 MB 452 10 000:07:39
3? 26 4681.3 MB 50 4 003:29:09
TOTAL: 3 314 33409.5 MB 510 14 003:38:48

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 7.272 3.578 0.00003:29:09
ftupet.com 45.620 8.012 0.00000:07:39
c-73-246-79-215.hsd1.il.comcast.net 0.428 0.182 0.00000:01:59
60.190.248.13 0.208 0.044 0.00000:00:02
91ec8adc.dsl.pool.telekom.hu 0.200 0.040 0.00000:00:01
198.20.87.98 0.200 0.044 0.00000:00:00
worker-18.sfj.corp.censys.io 0.200 0.042 0.00000:00:00
TOTAL: 7 54.128 11.942 0.00003:38:52

NNRP no permission clients:

SystemConn
60.190.248.13 2
91ec8adc.dsl.pool.telekom.hu 2
198.20.87.98 2
worker-18.sfj.corp.censys.io 2
TOTAL: 4 8

NNRP unrecognized commands (by host):

SystemConn
shell3 8
TOTAL: 1 8

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 8
TOTAL: 1 8

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 4 0
TOTAL: 1 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1252 37.5%
2misc 1208 36.2%
3sci 726 21.7%
4comp 64 1.9%
5alt 44 1.3%
6news 24 0.7%
7soc 8 0.2%
8chi 6 0.2%
9seattle 6 0.2%
10houston 2 0.1%
TOTAL: 10 3340100.0%

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

NewsgroupCount
1misc.phone.mobile.iphone 1072
2rec.arts.tv 830
3sci.electronics.repair 726
4rec.food.cooking 234
5rec.bicycles.tech 146
6misc.consumers.frugal-living 136
7alt.comp.os.windows-10 36
8rec.gardens.edible 30
9comp.mobile.android 28
10comp.sys.mac.system 18
11news.software.nntp 16
12soc.history.what-if 8
13alt.stupidity 8
14comp.unix.solaris 6
15news.admin.peering 6
16seattle.general 6
17chi.weather 6
18comp.mail.pine 4
19rec.radio.broadcasting 4
20rec.radio.swap 4
21comp.protocols.dns.bind 4
22rec.food.drink.tea 2
23comp.risks 2
24houston.forsale 2
25news.software.readers 2
26comp.security.ssh 2
27rec.puzzles 2
TOTAL: 27 3340