Daily Usenet report for news.ripco.com

Oct 17 00:01:03 -- Oct 17 23:58:02

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Oct 17 07:57:29 remote5bge0 overchan[27154]: [ID 702911 news.error] input line too long, skipping
Oct 17 08:41:33 remote5bge0 overchan[27154]: [ID 702911 news.error] input line too long, skipping
Oct 17 09:14:01 remote5bge0 overchan[27154]: [ID 702911 news.error] input line too long, skipping
Oct 17 09:15:55 remote5bge0 overchan[27154]: [ID 702911 news.error] input line too long, skipping
Oct 17 09:20:29 remote5bge0 overchan[27154]: [ID 702911 news.error] input line too long, skipping
Oct 17 11:53:49 remote5bge0 overchan[27154]: [ID 702911 news.error] input line too long, skipping
Oct 17 13:54:54 remote5bge0 overchan[27154]: [ID 702911 news.error] input line too long, skipping
Oct 17 14:03:05 remote5bge0 overchan[27154]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 38109 46.6%4.8 MB 39.5%
inn 21821 26.7%3.8 MB 31.2%
innd 18129 22.2%2.8 MB 23.1%
innfeed 3620 4.4%763.2 KB 6.2%
overchan 8 0.0%1.0 KB 0.0%
controlchan 8 0.0%1.2 KB 0.0%
TOTAL: 6 81695 100.0%12.1 MB100.0%

History cache:

ReasonCount%Count
Cache misses 185950 52.3%
Do not exist 169420 47.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 355370 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%120 0.000 0.000 0.000
article cleanup00:00:00.386 0.0%43258 0.000 0.009 0.028
article logging00:00:00.702 0.0%43626 0.000 0.016 0.114
article parse00:00:01.662 0.0%102324 0.000 0.016 0.041
article write00:00:45.044 0.0%31966 0.377 1.409 45.522
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.304 0.0%367022 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:04.278 0.0%355934 0.001 0.012 0.737
history sync00:00:00.324 0.0%794 0.000 0.408 8.333
history write00:00:06.998 0.0%43252 0.011 0.162 7.127
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:39:19.356 99.9%402668 216.858 426.057 1340.493
nntp read00:00:02.098 0.0%399376 0.000 0.005 0.012
overview write00:00:00.214 0.0%31966 0.000 0.007 0.041
perl filter00:00:55.888 0.0%43252 0.994 1.292 4.187
python filter00:00:01.118 0.0%43258 0.000 0.026 0.145
site send00:00:01.880 0.0%95860 0.000 0.020 0.049
TOTAL: 47:42:06.35647:41:20.252100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.128 0.0%32304 0.000 0.004 0.029
article prepare00:00:00.012 0.0%18640 0.000 0.001 0.021
article read00:00:00.476 0.0%4020 0.000 0.118 8.875
backlog stats00:00:00.166 0.0%373750 0.000 0.000 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.924 0.0%249478 0.000 0.008 0.019
data write00:00:03.464 0.0%217844 0.004 0.016 0.034
idle47:52:39.472100.0%373750 238.970 461.162 1636.688
status file00:00:03.848 0.0%366 0.000 10.514 64.000
TOTAL: 47:53:00.23247:52:49.490100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:06.636 0.0%421222 0.000 0.016 0.333
idle174:07:04.700 99.6%446280 7.667 1404.555284019.800
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:13.790 0.0%2658676 0.000 0.028 0.500
readart00:00:22.278 0.0%2672 1.000 8.338 68.000
TOTAL: 174:52:27.100174:08:47.404 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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newsmaster@carnet.hr002002
TOTAL002002

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1188 48266 13792 29176 5298 28%94:41:28
2news.snarked.org 48 39870 10058 27346 2466 25%52:47:46
3newsfeed.neva.ru 580 58438 6968 49036 2434 11%280:08:22
4newsfeed.fu-berlin.de 6 17840 740 17062 38 4%53:40:48
5news.lightlink.com 2 7070 208 6740 122 2%45:01:30
6news-in.rahul.net 574 16914 176 16724 14 1%47:21:22
7ripco-out.feeder.erje.net 574 34906 42 34022 842 0%47:18:34
8news.cmpublishers.com 52 9822 26 9794 2 0%52:17:50
9localhost 150 6 6 0 0 100%00:00:00
TOTAL: 9 3174 233132 32016 189900 11216 13%673:17:40
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com35.3 MB0.0 KB9.9 MB45.2 MB 78%2.4 KB
2news.snarked.org30.2 MB0.0 KB8.4 MB38.6 MB 78%3.2 KB
3newsfeed.neva.ru19.0 MB10.4 KB18.6 MB37.6 MB 50%4.1 KB
4news-in.rahul.net8.7 MB0.0 KB1.0 MB9.7 MB 89%52.4 KB
5news.lightlink.com4.4 MB0.0 KB6.6 MB11.0 MB 39%34.3 KB
6newsfeed.fu-berlin.de3.1 MB0.0 KB623.3 KB3.7 MB 83%4.9 KB
7ripco-out.feeder.erje.net92.6 KB0.0 KB7.6 MB7.7 MB 1%8.9 KB
8news.cmpublishers.com73.6 KB0.0 KB2.7 KB76.3 KB 96%2.7 KB
9localhost15.6 KB0.0 KB0.0 KB15.6 KB100%2.6 KB
TOTAL: 9101.0 MB10.4 KB52.7 MB153.7 MB 65%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 17 00:01:03 - 00:59:59 358 2.2% 0.101.1 MB 2.3% 0.33
Oct 17 01:00:00 - 01:59:59 457 2.9% 0.131.4 MB 2.7% 0.39
Oct 17 02:00:00 - 02:59:59 541 3.4% 0.151.4 MB 2.7% 0.39
Oct 17 03:00:00 - 03:59:59 745 4.7% 0.212.1 MB 4.1% 0.58
Oct 17 04:00:00 - 04:59:59 749 4.7% 0.212.2 MB 4.3% 0.61
Oct 17 05:00:00 - 05:59:59 843 5.3% 0.232.5 MB 5.0% 0.71
Oct 17 06:00:00 - 06:59:59 774 4.8% 0.212.4 MB 4.8% 0.69
Oct 17 07:00:00 - 07:59:59 849 5.3% 0.242.2 MB 4.4% 0.64
Oct 17 08:00:00 - 08:59:59 851 5.3% 0.242.5 MB 5.0% 0.72
Oct 17 09:00:00 - 09:59:59 838 5.2% 0.232.2 MB 4.4% 0.63
Oct 17 10:00:00 - 10:59:59 897 5.6% 0.252.8 MB 5.5% 0.79
Oct 17 11:00:00 - 11:59:59 951 5.9% 0.263.9 MB 7.7% 1.10
Oct 17 12:00:00 - 12:59:59 1000 6.3% 0.282.9 MB 5.8% 0.82
Oct 17 13:00:00 - 13:59:59 863 5.4% 0.242.9 MB 5.8% 0.83
Oct 17 14:00:00 - 14:59:59 892 5.6% 0.252.8 MB 5.6% 0.81
Oct 17 15:00:00 - 15:59:59 919 5.7% 0.263.0 MB 5.9% 0.84
Oct 17 16:00:00 - 16:59:59 795 5.0% 0.222.3 MB 4.5% 0.65
Oct 17 17:00:00 - 17:59:59 568 3.6% 0.162.0 MB 4.0% 0.57
Oct 17 18:00:00 - 18:59:59 469 2.9% 0.132.1 MB 4.2% 0.60
Oct 17 19:00:00 - 19:59:59 376 2.4% 0.101.2 MB 2.5% 0.35
Oct 17 20:00:00 - 20:59:59 357 2.2% 0.101.3 MB 2.5% 0.36
Oct 17 21:00:00 - 21:59:59 375 2.3% 0.101.3 MB 2.5% 0.36
Oct 17 22:00:00 - 22:59:59 259 1.6% 0.07958.5 KB 1.9% 0.27
Oct 17 23:00:00 - 23:58:02 268 1.7% 0.08919.5 KB 1.8% 0.26
TOTAL: 23:56:59 15994 100.0% 0.1950.2 MB 100.0% 0.60
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2660 2050 0 0 0 0 0 0 610
2newsfeed.neva.ru 1277 654 0 3 2 0 0 0 618
3news.snarked.org 1249 67 0 0 1 0 0 0 1181
4ripco-out.feeder.erje.net 419 418 0 0 0 0 0 0 1
5newsfeed.fu-berlin.de 128 0 0 0 0 0 0 0 128
6news.lightlink.com 86 6 0 0 0 0 0 0 80
7news-in.rahul.net 7 0 0 0 0 0 0 0 7
8news.cmpublishers.com 1 1 0 0 0 0 0 0 0
TOTAL: 8 5827 3196 0 3 3 0 0 0 2625

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2322
alt.binaries.ftd 208
it.comp.os.win.windows10 53
perl.cpan.uploads 52
fido7.su.pol.news 45
gmane.linux.alsa.devel 33
uk.radio.amateur.moderated 26
alt.binaries.e-book 20
alt.astrology.pro 18
mozilla.dev.platform 15
uk.net.news.moderation 14
it.tlc.cellulari.android 13
alt.binaries.nl 12
free.ucp 12
mi.jobs 11
free.willey 10
lada.fishing 10
alt.binaries.test.yenc 9
alt.binaries.pictures.wallpaper 9
alt.alan.c.sanderson.looks.like.a.dork 8
TOTAL: 150 3196

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2676
Too many newsgroups 1102
Binary in non-binary group 766
EMP (phl) 160
Scoring filter (8) 54
Scoring filter (16) 44
Attached HTML file 32
Scoring filter (9) 28
Scoring filter (11) 6
Scoring filter (10) 6
Scoring filter (18) 4
Scoring filter (15) 2
Scoring filter (14) 2
TOTAL: 13 4882

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 24
ripco-out.feed.uzoreto.com 6
TOTAL: 2 30
Including strange strings
newsfeed.fu-berlin.de 110
newsfeed.neva.ru 63
ripco-out.feed.uzoreto.com 11
news.snarked.org 1
TOTAL: 4 185
TOTAL: 2 215

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 8666 2478 4260 4 0 52 28%47:39:04
2rahul.net 23036 742 13396 16 0 88 3%47:40:08
3news.snarked.org 37060 106 21520 6 0 122 0%47:51:04
4news.uzoreto.com 19120 70 17602 112 0 0 0%47:41:50
5news.cmpublishers.com 39988 62 29012 776 0 1806 0%47:37:14
6fu-berlin.de 29160 40 29120 0 0 0 0%47:41:34
7feeder.erje.net 31528 32 30252 90 0 0 0%47:36:12
8newsfeed.neva.ru 25834 22 24796 82 0 0 0%47:40:06
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:02
TOTAL: 9 214392 3552 169958 1086 0 2074 1%429:07:14
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com7.3 MB11.5 KB7.3 MB0.0 KB/s3.0 KB47:39:04
2rahul.net2.6 MB40.3 KB2.7 MB0.0 KB/s3.6 KB47:40:08
3news.snarked.org385.3 KB9.3 KB394.6 KB0.0 KB/s3.5 KB47:51:04
4news.uzoreto.com349.4 KB387.7 KB737.1 KB0.0 KB/s4.1 KB47:41:50
5newsfeed.neva.ru207.0 KB182.2 KB389.2 KB0.0 KB/s3.7 KB47:40:06
6feeder.erje.net181.6 KB443.4 KB625.0 KB0.0 KB/s5.1 KB47:36:12
7news.cmpublishers.com162.4 KB2.3 MB2.4 MB0.0 KB/s3.0 KB47:37:14
8fu-berlin.de148.0 KB0.0 KB148.0 KB0.0 KB/s3.7 KB47:41:34
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
TOTAL: 911.3 MB3.3 MB14.6 MB0.0 KB/s3.2 KB429:07:14
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9702.7 MB 412 4 000:06:42
2shell3 18 7221.8 MB 56 2 002:26:50
375-151-74-61-independence.hfc.comcastbusiness.net 8 44.0 KB 4 0 000:09:58
TOTAL: 3 312 16964.5 MB 472 6 0175:12:47

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9702.7 MB 412 4 000:06:42
2? 18 7221.8 MB 56 2 002:26:50
3*.hfc.comcastbusiness.net 8 44.0 KB 4 0 000:09:58
4*.7-3.cable.virginm.net 2 00.0 KB 0 0 001:39:07
5unresolved 798 00.0 KB 0 0 0138:10:23
6*.211.168.217.static-nl.twistednetworks.net 64 00.0 KB 0 0 014:41:11
7*.res.spectrum.com 366 00.0 KB 0 0 017:58:32
8*.dhcp.chtrptr.net 6 00.0 KB 0 0 000:00:02
TOTAL: 81548 16964.5 MB 472 6 0175:12:47

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.11.163.217 1.086 0.400 0.000137:41:11
047-225-153-009.res.spectrum.com 54.985 23.119 0.00017:58:32
95.211.168.217.static-nl.twistednetworks.net 6.926 2.136 0.00014:41:11
shell3 9.028 3.912 0.00002:26:50
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 1.056 1.440 0.00001:39:07
75-151-74-61-independence.hfc.comcastbusiness.net 1.526 1.244 0.00000:09:58
173.245.203.183 2.846 0.602 0.00000:08:52
136.62.40.45 0.478 0.230 0.00000:06:58
173.245.203.182 1.548 0.294 0.00000:06:43
ftupet.com 46.496 7.376 0.00000:06:42
1.251.94.143 76.702 15.630 0.00000:06:36
174-082-087-237.dhcp.chtrptr.net 0.598 0.120 0.00000:00:02
TOTAL: 12 203.275 56.503 0.000175:12:47

Curious NNRP server explorers [Top 20]:

SystemConn
1.251.94.143 768
047-225-153-009.res.spectrum.com 366
95.211.168.217.static-nl.twistednetworks.net 64
173.245.203.183 14
66.11.163.217 10
174-082-087-237.dhcp.chtrptr.net 6
173.245.203.182 4
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 2
136.62.40.45 2
TOTAL: 9 1236

NNRP unrecognized commands (by host):

SystemConn
174-082-087-237.dhcp.chtrptr.net 4
shell3 2
TOTAL: 2 6

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 2
Cé†Û A,A«àpjß\x119\x15`©\x04³z3 ®0[Ý` 1
\x16\x03\x01\x01O\x01 1
^V^C^A^AO^A 1
C\351\206\333^MA,A\253\340pj\337^Q9^U`\251^D\263z3 \2560[\335` 1
TOTAL: 5 6

NNRP client timeouts [Top 20]:

SystemConnPeer
047-225-153-009.res.spectrum.com 162 162
95.211.168.217.static-nl.twistednetworks.net 64 0
66.11.163.217 8 0
174-082-087-237.dhcp.chtrptr.net 2 2
shell3 2 0
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 2 0
TOTAL: 6 240 164

Newsgroup request counts (by category):

CategoryCountPct
1rec 1244 73.3%
2comp 206 12.1%
3alt 178 10.5%
4misc 26 1.5%
5chi 20 1.2%
6sci 8 0.5%
7ba 6 0.4%
8news 6 0.4%
9de 2 0.1%
TOTAL: 9 1696100.0%

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

NewsgroupCount
1rec.arts.tv 838
2rec.food.cooking 296
3alt.comp.os.windows-10 152
4comp.sys.apple2 78
5comp.mobile.android 74
6rec.radio.shortwave 64
7comp.sys.mac.system 34
8rec.bicycles.tech 28
9misc.phone.mobile.iphone 26
10chi.general 10
11chi.weather 10
12sci.electronics.repair 8
13alt.stupidity 8
14comp.mail.pine 6
15comp.mobile.ipad 6
16rec.radio.swap 6
17ba.food 6
18alt.dbs.echostar 4
19rec.puzzles 4
20rec.radio.broadcasting 4
21comp.unix.solaris 4
22alt.security.alarms 4
23news.admin.net-abuse.email 4
24rec.gardens.edible 4
25comp.mail.eudora.ms-windows 2
26alt.hvac 2
27alt.tasteless 2
28de.comm.software.forte-agent 2
29alt.games.warcraft 2
30comp.sys.ibm.pc.games.rpg 2
31alt.free.newsservers 2
32alt.satellite.gps.garmin 2
33news.groups.questions 2
TOTAL: 33 1696