Daily Usenet report for news.ripco.com

Nov 1 00:01:02 -- Nov 1 23:58:03

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Nov 1 04:42:37 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping
Nov 1 04:54:42 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping
Nov 1 08:33:02 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping
Nov 1 08:46:11 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping
Nov 1 08:47:48 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping
Nov 1 09:12:11 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping
Nov 1 15:11:12 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping
Nov 1 15:40:14 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping
Nov 1 19:45:32 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping
Nov 1 20:57:37 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping
Nov 1 21:00:43 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping
Nov 1 21:00:43 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping
Nov 1 21:00:43 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping
Nov 1 22:27:38 remote5bge0 overchan[13432]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 48840 52.0%6.4 MB 46.0%
inn 21130 22.5%3.6 MB 26.2%
innd 20182 21.5%3.1 MB 22.4%
innfeed 3671 3.9%773.8 KB 5.4%
overchan 14 0.0%2.3 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 93839 100.0%13.9 MB100.0%

History cache:

ReasonCount%Count
Cache misses 186560 52.3%
Do not exist 169910 47.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 356470 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%178 0.000 0.000 0.000
article cleanup00:00:00.488 0.0%42164 0.000 0.012 0.065
article logging00:00:00.621 0.0%42604 0.000 0.015 0.197
article parse00:00:01.686 0.0%98968 0.000 0.017 0.057
article write00:00:38.935 0.0%30239 0.301 1.288 13.116
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.329 0.0%363937 0.000 0.001 0.004
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.395 0.0%359884 0.001 0.007 0.018
history sync00:00:00.579 0.0%818 0.000 0.708 12.750
history write00:00:03.986 0.0%42164 0.018 0.095 3.182
hiswrite/artparse00:00:00.002 0.0%2 1.000 1.000 1.000
idle48:29:56.809 99.9%402744 215.698 433.518 1343.076
nntp read00:00:02.331 0.0%399178 0.002 0.006 0.016
overview write00:00:00.166 0.0%30239 0.000 0.005 0.029
perl filter00:00:56.966 0.0%42160 1.007 1.351 4.345
python filter00:00:01.102 0.0%42176 0.000 0.026 0.070
site send00:00:01.711 0.0%90653 0.000 0.019 0.046
TOTAL: 48:32:22.05848:31:48.106100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.440 0.0%29998 0.000 0.015 0.061
article prepare00:00:00.004 0.0%18896 0.000 0.000 0.062
article read00:00:00.446 0.0%3900 0.000 0.114 5.769
backlog stats00:00:00.222 0.0%363898 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.588 0.0%238346 0.000 0.011 0.021
data write00:00:03.244 0.0%208680 0.004 0.016 0.034
idle47:53:32.440100.0%363898 263.506 473.793 1512.214
status file00:00:06.382 0.0%362 0.000 17.630 48.000
TOTAL: 47:53:56.54047:53:45.766100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:16.030 0.0%1152770 0.000 0.014 0.087
idle216:36:48.752100.0%1204572 0.052 647.374300118.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:04:01.094 0.0%3260328 0.000 0.074 1.765
readart00:00:18.134 0.0%1936 0.000 9.367 42.000
TOTAL: 216:43:04.636216:41:24.010100.0%----

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 1146 36404 11266 20474 4664 30%94:47:34
2news.snarked.org 54 37828 7848 27602 2378 20%55:53:50
3newsfeed.neva.ru 592 52776 6082 44774 1920 11%279:06:30
4feeder3.feed-ams.uzoreto.com 574 16560 3222 11912 1426 19%47:19:04
5newsfeed.fu-berlin.de 2 15136 868 14230 38 5%47:25:28
6news.lightlink.com 2 8800 224 8428 148 2%45:01:30
7news-in.rahul.net 574 17196 172 17014 10 1%47:19:36
8ripco-out.feeder.erje.net 574 33950 74 32646 1230 0%47:17:18
9news.cmpublishers.com 50 10594 16 10564 14 0%52:55:12
10localhost 160 16 16 0 0 100%00:00:00
TOTAL: 10 3728 229260 29788 187644 11828 12%717:06:02
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com28.7 MB0.0 KB8.9 MB37.6 MB 76%2.4 KB
2news.snarked.org24.5 MB0.0 KB8.0 MB32.5 MB 75%3.3 KB
3newsfeed.neva.ru18.5 MB2.5 KB6.6 MB25.1 MB 73%3.2 KB
4feeder3.feed-ams.uzoreto.com9.0 MB0.0 KB2.9 MB12.0 MB 75%2.6 KB
5news-in.rahul.net8.8 MB0.0 KB422.6 KB9.2 MB 95%52.0 KB
6newsfeed.fu-berlin.de3.9 MB0.0 KB3.0 MB6.9 MB 56%7.8 KB
7news.lightlink.com2.8 MB0.0 KB6.8 MB9.6 MB 29%26.5 KB
8localhost910.9 KB0.0 KB0.0 KB910.9 KB100%56.9 KB
9ripco-out.feeder.erje.net218.4 KB0.0 KB11.3 MB11.5 MB 1%9.0 KB
10news.cmpublishers.com30.7 KB0.0 KB20.0 KB50.7 KB 60%1.7 KB
TOTAL: 1097.3 MB2.5 KB48.0 MB145.3 MB 66%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 1 00:01:02 - 00:59:59 304 2.0% 0.091.1 MB 2.3% 0.33
Nov 1 01:00:00 - 01:59:59 260 1.7% 0.071.2 MB 2.5% 0.35
Nov 1 02:00:00 - 02:59:59 444 3.0% 0.121.3 MB 2.7% 0.38
Nov 1 03:00:00 - 03:59:59 527 3.5% 0.151.4 MB 2.8% 0.39
Nov 1 04:00:00 - 04:59:59 651 4.3% 0.181.8 MB 3.6% 0.50
Nov 1 05:00:00 - 05:59:59 712 4.8% 0.201.8 MB 3.7% 0.51
Nov 1 06:00:00 - 06:59:59 720 4.8% 0.201.8 MB 3.7% 0.52
Nov 1 07:00:00 - 07:59:59 749 5.0% 0.212.5 MB 5.0% 0.70
Nov 1 08:00:00 - 08:59:59 727 4.9% 0.201.9 MB 3.9% 0.55
Nov 1 09:00:00 - 09:59:59 817 5.5% 0.232.1 MB 4.3% 0.60
Nov 1 10:00:00 - 10:59:59 760 5.1% 0.212.3 MB 4.7% 0.66
Nov 1 11:00:00 - 11:59:59 905 6.0% 0.253.6 MB 7.4% 1.04
Nov 1 12:00:00 - 12:59:59 866 5.8% 0.243.5 MB 7.1% 1.00
Nov 1 13:00:00 - 13:59:59 919 6.1% 0.262.7 MB 5.5% 0.77
Nov 1 14:00:00 - 14:59:59 866 5.8% 0.243.4 MB 7.0% 0.98
Nov 1 15:00:00 - 15:59:59 894 6.0% 0.253.1 MB 6.3% 0.88
Nov 1 16:00:00 - 16:59:59 826 5.5% 0.232.3 MB 4.7% 0.66
Nov 1 17:00:00 - 17:59:59 715 4.8% 0.202.4 MB 5.0% 0.69
Nov 1 18:00:00 - 18:59:59 591 3.9% 0.161.9 MB 3.9% 0.54
Nov 1 19:00:00 - 19:59:59 441 2.9% 0.121.8 MB 3.7% 0.51
Nov 1 20:00:00 - 20:59:59 334 2.2% 0.091.1 MB 2.2% 0.31
Nov 1 21:00:00 - 21:59:59 393 2.6% 0.111.7 MB 3.4% 0.48
Nov 1 22:00:00 - 22:59:59 286 1.9% 0.081.5 MB 3.1% 0.43
Nov 1 23:00:00 - 23:58:03 270 1.8% 0.08881.5 KB 1.7% 0.25
TOTAL: 23:57:01 14977 100.0% 0.1749.3 MB 100.0% 0.59
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2339 1746 0 0 1 0 0 0 592
2news.snarked.org 1209 84 0 0 5 0 0 0 1120
3newsfeed.neva.ru 1002 603 0 1 5 0 0 0 393
4feeder3.feed-ams.uzoreto.com 716 509 0 0 0 0 0 0 207
5ripco-out.feeder.erje.net 616 614 0 0 0 0 0 0 2
6newsfeed.fu-berlin.de 181 0 0 0 0 0 0 0 181
7news.lightlink.com 78 1 0 0 0 0 0 0 77
8news.cmpublishers.com 7 2 0 0 0 0 0 0 5
9news-in.rahul.net 5 0 0 0 0 0 0 0 5
TOTAL: 9 6153 3559 0 1 11 0 0 0 2582

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2172
alt.binaries.ftd 329
alt.astrology.pro 129
alt.music.pink-floyd.publius 103
free.willey 68
it.tlc.cellulari.android 57
perl.cpan.uploads 49
fido7.su.pol.news 40
free.it.scienza.fisica 30
alt.bestjobsusa.computer.jobs 28
it.comp.os.win.windows10 25
alt.binaries.pictures.rail 24
alt.binaries.pictures.wallpaper 23
alt.binaries.nl 18
alt.jobs.jobsearch 18
alt.binaries.e-book 17
alt.binaries.pictures.aviation 15
gmane.linux.alsa.devel 13
alt.my.job.sucks 12
free.uk.astrology 12
TOTAL: 165 3559

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

GroupsCount
pl.praca.oferowana 5
christnet.bible 3
alt.penthouse.sex.masterbation 2
alt.christnet.christnews 1
TOTAL: 4 11

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3068
Too many newsgroups 1032
Binary in non-binary group 324
EMP (phl) 78
Scoring filter (8) 72
Scoring filter (16) 48
Attached HTML file 40
Scoring filter (9) 20
HTML post 14
Scoring filter (18) 10
Scoring filter (17) 8
Scoring filter (10) 4
Scoring filter (11) 2
Scoring filter (12) 2
TOTAL: 14 4722

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 12
TOTAL: 1 12
Huge articles
newsfeed.fu-berlin.de 2
TOTAL: 1 2
Including strange strings
newsfeed.fu-berlin.de 162
newsfeed.neva.ru 43
ripco-out.feed.uzoreto.com 7
feeder3.feed-ams.uzoreto.com 4
news.snarked.org 3
ripco-out.feeder.erje.net 1
TOTAL: 6 220
TOTAL: 3 234

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10298 1928 5640 4 0 0 18%47:41:38
2rahul.net 24362 846 13266 24 0 2 3%47:40:04
3news.cmpublishers.com 37930 88 26816 1124 0 1614 0%47:53:22
4news.snarked.org 36538 82 21568 6 0 74 0%47:44:04
5feeder.erje.net 28472 68 27146 128 0 0 0%47:48:42
6news.uzoreto.com 15876 66 14794 196 0 0 0%47:43:48
7fu-berlin.de 26734 56 26676 0 0 0 0%47:43:36
8newsfeed.neva.ru 24546 20 23646 84 0 0 0%47:40:04
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:02
TOTAL: 9 204756 3154 159552 1566 0 1696 1%429:35:20
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com7.1 MB15.8 KB7.1 MB0.0 KB/s3.8 KB47:41:38
2rahul.net3.7 MB54.7 KB3.8 MB0.0 KB/s4.4 KB47:40:04
3news.cmpublishers.com404.7 KB3.3 MB3.7 MB0.0 KB/s3.1 KB47:53:22
4fu-berlin.de295.1 KB0.0 KB295.1 KB0.0 KB/s5.3 KB47:43:36
5news.snarked.org285.9 KB18.4 KB304.3 KB0.0 KB/s3.5 KB47:44:04
6feeder.erje.net269.3 KB522.8 KB792.2 KB0.0 KB/s4.0 KB47:48:42
7news.uzoreto.com255.2 KB882.0 KB1.1 MB0.0 KB/s4.3 KB47:43:48
8newsfeed.neva.ru164.4 KB182.5 KB347.0 KB0.0 KB/s3.3 KB47:40:04
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
TOTAL: 912.5 MB4.9 MB17.4 MB0.0 KB/s3.8 KB429:35:20
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 8502.3 MB 380 2 000:06:43
2shell3 34 216593.6 KB 34 14 002:09:21
3a85-139-63-33.cpe.netcabo.pt 2 1046.3 KB 4 0 006:33:11
475-151-74-61-independence.hfc.comcastbusiness.net 16 811.4 KB 8 0 000:25:42
5209.58.147.245 6 00.0 KB 0 0 400:24:58
TOTAL: 5 344 10842.9 MB 426 16 4216:42:57

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 8502.3 MB 380 2 000:06:43
2? 34 216593.6 KB 34 14 002:09:21
3*.cpe.netcabo.pt 2 1046.3 KB 4 0 006:33:11
4*.hfc.comcastbusiness.net 16 811.4 KB 8 0 000:25:42
5*.cm-12-2c.dynamic.ziggo.nl 32 00.0 KB 0 0 075:27:43
6*.chello.nl 2 00.0 KB 0 0 000:00:45
7*.binaryedge.ninja 2 00.0 KB 0 0 000:00:03
8*.7-3.cable.virginm.net 2 00.0 KB 0 0 000:18:14
9unresolved 18 00.0 KB 0 0 4131:41:11
TOTAL: 9 394 10842.9 MB 426 16 4216:42:57

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.11.163.217 1.266 0.424 0.000130:36:11
5469a4b0.cm-12-2c.dynamic.ziggo.nl 25.716 34.472 0.00075:27:43
a85-139-63-33.cpe.netcabo.pt 0.366 0.084 0.00006:33:11
shell3 5.676 2.066 0.00002:09:21
212.117.188.59 0.396 0.082 0.00000:40:01
75-151-74-61-independence.hfc.comcastbusiness.net 3.212 2.588 0.00000:25:42
209.58.147.245 0.798 0.352 0.00000:24:58
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 0.260 0.164 0.00000:18:14
ftupet.com 45.194 7.424 0.00000:06:43
dhcp-077-249-121-101.chello.nl 0.198 0.042 0.00000:00:45
min-do-uk-10-04-6011-d-prod.binaryedge.ninja 0.198 0.042 0.00000:00:03
TOTAL: 11 83.280 47.740 0.000216:42:57

Curious NNRP server explorers [Top 20]:

SystemConn
5469a4b0.cm-12-2c.dynamic.ziggo.nl 32
66.11.163.217 8
212.117.188.59 4
dhcp-077-249-121-101.chello.nl 2
min-do-uk-10-04-6011-d-prod.binaryedge.ninja 2
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 2
TOTAL: 6 50

NNRP unrecognized commands (by host):

SystemConn
shell3 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 4
TOTAL: 1 4

NNRP client timeouts [Top 20]:

SystemConnPeer
66.11.163.217 12 0
shell3 6 0
212.117.188.59 4 0
209.58.147.245 2 0
TOTAL: 4 24 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 992 91.5%
2sci 30 2.8%
3comp 28 2.6%
4alt 12 1.1%
5chi 8 0.7%
6news 8 0.7%
7tw 2 0.2%
8linux 2 0.2%
9soc 2 0.2%
TOTAL: 9 1084100.0%

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

NewsgroupCount
1rec.arts.tv 522
2rec.food.cooking 394
3rec.bicycles.tech 60
4comp.sys.mac.system 20
5sci.electronics.repair 18
6alt.stupidity 8
7sci.math 8
8rec.radio.broadcasting 6
9rec.bicycles.misc 6
10chi.weather 6
11rec.radio.swap 4
12news.software.readers 4
13comp.protocols.dns.bind 4
14linux.debian.maint.boot 2
15soc.history.what-if 2
16alt.current-events.clinton.whitewater 2
17comp.risks 2
18comp.sys.mac.apps 2
19sci.research 2
20tw.bbs.forsale 2
21alt.tv.sopranos 2
22news.admin.hierarchies 2
23news.admin.net-abuse.email 2
24sci.astro.seti 2
25chi.general 2
TOTAL: 25 1084