Daily Usenet report for news.ripco.com

Oct 28 00:01:03 -- Oct 28 23:57:47

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Oct 28 00:55:25 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 01:09:26 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 01:10:24 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 01:12:06 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 03:16:29 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 03:19:14 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 05:23:14 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 09:40:32 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 12:25:40 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 15:54:06 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 15:56:31 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 19:08:28 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 19:17:00 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 19:41:36 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 20:02:36 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping
Oct 28 20:04:36 remote5bge0 overchan[2296]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 42038 48.6%5.3 MB 41.8%
inn 20534 23.7%3.5 MB 27.7%
innd 20353 23.5%3.2 MB 24.6%
innfeed 3618 4.2%766.9 KB 5.9%
overchan 16 0.0%2.4 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 86561 100.0%12.8 MB100.0%

History cache:

ReasonCount%Count
Cache misses 187748 54.0%
Do not exist 159772 46.0%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 347520 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%94 0.000 0.000 0.000
article cleanup00:00:00.434 0.0%40638 0.000 0.011 0.040
article logging00:00:00.594 0.0%41002 0.000 0.014 0.175
article parse00:00:01.428 0.0%92564 0.000 0.015 0.045
article write00:00:38.258 0.0%29010 0.382 1.319 40.900
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.248 0.0%350678 0.000 0.001 0.003
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.168 0.0%348600 0.001 0.006 0.026
history sync00:00:00.378 0.0%762 0.000 0.496 7.333
history write00:00:03.808 0.0%40628 0.011 0.094 3.211
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:39:50.480 99.9%387690 270.417 442.597 1204.661
nntp read00:00:02.356 0.0%383884 0.000 0.006 0.016
overview write00:00:00.174 0.0%29010 0.000 0.006 0.040
perl filter00:00:51.070 0.0%40624 1.078 1.257 2.273
python filter00:00:01.046 0.0%40630 0.000 0.026 0.075
site send00:00:01.636 0.0%86884 0.000 0.019 0.044
TOTAL: 47:42:06.77047:41:34.078100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.454 0.0%28980 0.000 0.016 0.042
article prepare00:00:00.010 0.0%23608 0.000 0.000 0.016
article read00:00:00.510 0.0%4806 0.000 0.106 9.000
backlog stats00:00:00.182 0.0%342806 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.542 0.0%228298 0.002 0.011 0.022
data write00:00:03.150 0.0%199912 0.003 0.016 0.032
idle47:52:00.632100.0%342806 287.756 502.677 1196.183
status file00:00:05.814 0.0%346 0.000 16.803 75.571
TOTAL: 47:52:24.93247:52:13.294100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:17.588 0.0%303568 0.000 0.058 1.000
idle247:54:19.468100.0%345292 0.000 2584.651399056.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:46.982 0.0%2080908 0.000 0.023 1.000
readart00:00:18.316 0.0%2118 0.000 8.648 43.000
TOTAL: 247:57:42.462247:55:42.354100.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
1news.snarked.org 50 37946 9444 25444 3058 24%52:30:40
2ripco-out.feed.uzoreto.com 1162 35488 8518 22590 4380 24%93:27:30
3newsfeed.neva.ru 568 56278 5242 49422 1614 9%278:56:18
4feeder3.feed-ams.uzoreto.com 572 17424 4558 11618 1248 26%46:50:14
5newsfeed.fu-berlin.de 4 15462 602 14830 30 3%51:00:38
6news.lightlink.com 2 7342 212 7014 116 2%45:01:30
7news-in.rahul.net 572 16568 178 16366 24 1%47:30:12
8ripco-out.feeder.erje.net 574 33130 162 31858 1110 0%47:28:26
9news.cmpublishers.com 50 9322 40 9272 10 0%48:00:00
10localhost 150 6 6 0 0 100%00:00:00
TOTAL: 10 3704 228966 28962 188414 11590 12%710:45:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org27.3 MB0.0 KB9.5 MB36.8 MB 74%3.0 KB
2ripco-out.feed.uzoreto.com21.3 MB0.0 KB7.8 MB29.1 MB 73%2.3 KB
3newsfeed.neva.ru15.2 MB22.9 KB4.6 MB19.9 MB 76%3.0 KB
4feeder3.feed-ams.uzoreto.com11.6 MB0.0 KB3.2 MB14.8 MB 78%2.6 KB
5news-in.rahul.net7.3 MB0.0 KB1.8 MB9.1 MB 79%46.2 KB
6news.lightlink.com2.9 MB0.0 KB2.2 MB5.1 MB 56%15.8 KB
7newsfeed.fu-berlin.de2.7 MB0.0 KB324.6 KB3.0 MB 89%4.8 KB
8ripco-out.feeder.erje.net316.3 KB0.0 KB10.6 MB10.9 MB 2%8.8 KB
9news.cmpublishers.com106.8 KB0.0 KB25.5 KB132.3 KB 80%2.6 KB
10localhost18.5 KB0.0 KB0.0 KB18.5 KB100%3.1 KB
TOTAL: 1088.7 MB22.9 KB40.1 MB128.8 MB 68%3.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 28 00:01:03 - 00:59:59 243 1.7% 0.07850.2 KB 1.9% 0.24
Oct 28 01:00:00 - 01:59:59 335 2.3% 0.091.1 MB 2.4% 0.30
Oct 28 02:00:00 - 02:59:59 462 3.2% 0.131.3 MB 3.1% 0.38
Oct 28 03:00:00 - 03:59:59 562 3.9% 0.161.3 MB 2.9% 0.37
Oct 28 04:00:00 - 04:59:59 583 4.0% 0.161.6 MB 3.6% 0.45
Oct 28 05:00:00 - 05:59:59 626 4.3% 0.172.0 MB 4.6% 0.58
Oct 28 06:00:00 - 06:59:59 526 3.6% 0.151.5 MB 3.4% 0.43
Oct 28 07:00:00 - 07:59:59 624 4.3% 0.172.1 MB 4.7% 0.59
Oct 28 08:00:00 - 08:59:59 654 4.5% 0.181.8 MB 4.1% 0.52
Oct 28 09:00:00 - 09:59:59 774 5.3% 0.212.7 MB 6.1% 0.77
Oct 28 10:00:00 - 10:59:59 725 5.0% 0.202.0 MB 4.6% 0.58
Oct 28 11:00:00 - 11:59:59 805 5.5% 0.222.2 MB 5.0% 0.62
Oct 28 12:00:00 - 12:59:59 809 5.6% 0.221.9 MB 4.4% 0.55
Oct 28 13:00:00 - 13:59:59 855 5.9% 0.242.1 MB 4.9% 0.61
Oct 28 14:00:00 - 14:59:59 951 6.5% 0.263.1 MB 7.1% 0.89
Oct 28 15:00:00 - 15:59:59 900 6.2% 0.253.2 MB 7.2% 0.90
Oct 28 16:00:00 - 16:59:59 782 5.4% 0.222.2 MB 5.0% 0.63
Oct 28 17:00:00 - 17:59:59 680 4.7% 0.192.2 MB 5.0% 0.63
Oct 28 18:00:00 - 18:59:59 544 3.7% 0.151.5 MB 3.4% 0.42
Oct 28 19:00:00 - 19:59:59 553 3.8% 0.151.9 MB 4.4% 0.55
Oct 28 20:00:00 - 20:59:59 455 3.1% 0.131.5 MB 3.3% 0.41
Oct 28 21:00:00 - 21:59:59 399 2.7% 0.111.7 MB 3.8% 0.47
Oct 28 22:00:00 - 22:59:59 353 2.4% 0.101.0 MB 2.3% 0.29
Oct 28 23:00:00 - 23:57:47 320 2.2% 0.091.3 MB 2.9% 0.38
TOTAL: 23:56:44 14520 100.0% 0.1744.1 MB 100.0% 0.52
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2199 1892 0 0 0 0 0 0 307
2news.snarked.org 1558 56 0 0 1 0 0 0 1501
3newsfeed.neva.ru 836 458 0 5 1 0 0 0 372
4feeder3.feed-ams.uzoreto.com 624 361 0 0 0 0 0 0 263
5ripco-out.feeder.erje.net 555 551 0 0 0 0 0 0 4
6newsfeed.fu-berlin.de 149 1 0 0 0 0 0 0 148
7news.lightlink.com 76 0 0 0 0 0 0 0 76
8news-in.rahul.net 12 0 0 0 0 0 0 0 12
9news.cmpublishers.com 5 0 0 0 0 0 0 0 5
TOTAL: 9 6014 3319 0 5 2 0 0 0 2688

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2539
alt.binaries.ftd 296
perl.cpan.uploads 33
free.willey 32
fido7.su.pol.news 25
alt.binaries.pictures.wallpaper 22
free.it.scienza.fisica 21
alt.binaries.pictures.rail 19
alt.binaries.nl 18
alt.binaries.pictures.earlmiller 14
alt.binaries.e-book 13
free.ucp 12
alt.binaries.pictures.scenic 10
alt.binaries.pictures.aviation 9
it.comp.os.win.windows10 9
it.tlc.cellulari.android 8
alt.binaries.humor.skewed 7
alt.binaries.test.yenc 7
fr.rec.loisirs-creatifs 7
alt.binaries.multimedia.cooking 6
TOTAL: 142 3319

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

GroupsCount
alt.christnet.christnews 1
bit.listserv.catholic 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3162
Too many newsgroups 1378
EMP (phl) 214
Binary in non-binary group 104
Attached HTML file 58
Scoring filter (16) 40
Scoring filter (10) 14
Scoring filter (9) 14
Scoring filter (8) 12
Scoring filter (11) 4
Scoring filter (18) 2
HTML post 2
TOTAL: 12 5004

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
ripco-out.feed.uzoreto.com 1
TOTAL: 1 1
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
TOTAL: 1 18
Including strange strings
newsfeed.fu-berlin.de 134
newsfeed.neva.ru 29
news.snarked.org 12
ripco-out.feed.uzoreto.com 9
ripco-out.feeder.erje.net 1
TOTAL: 5 185
TOTAL: 3 204

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9008 2772 4240 2 0 4 30%47:40:06
2rahul.net 21652 942 12314 32 0 0 4%47:41:30
3feeder.erje.net 28134 146 26438 380 0 0 0%47:40:06
4news.uzoreto.com 16064 70 15118 326 0 0 0%47:51:54
5news.cmpublishers.com 36660 64 27602 982 0 48 0%47:50:34
6news.snarked.org 32670 60 19050 8 0 20 0%47:41:44
7fu-berlin.de 26074 22 26050 0 0 0 0%47:41:26
8newsfeed.neva.ru 24152 20 23414 62 0 0 0%47:40:04
9remote6hme0.ripco.com 0 0 0 0 0 14 0%47:40:06
TOTAL: 9 194414 4096 154226 1792 0 86 2%429:27:30
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com7.8 MB4.9 KB7.8 MB0.0 KB/s2.9 KB47:40:06
2rahul.net3.0 MB114.1 KB3.1 MB0.0 KB/s3.3 KB47:41:30
3feeder.erje.net491.0 KB1.3 MB1.7 MB0.0 KB/s3.4 KB47:40:06
4news.snarked.org405.1 KB30.6 KB435.7 KB0.0 KB/s6.4 KB47:41:44
5newsfeed.neva.ru323.1 KB156.5 KB479.6 KB0.0 KB/s5.8 KB47:40:04
6news.uzoreto.com271.6 KB997.0 KB1.2 MB0.0 KB/s3.2 KB47:51:54
7news.cmpublishers.com199.7 KB2.5 MB2.7 MB0.0 KB/s2.6 KB47:50:34
8fu-berlin.de74.9 KB0.0 KB74.9 KB0.0 KB/s3.4 KB47:41:26
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:06
TOTAL: 912.5 MB5.0 MB17.6 MB0.0 KB/s3.1 KB429:27:30
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 8802.4 MB 404 2 000:06:57
2shell3 12 350852.0 KB 22 4 001:43:30
375-151-74-61-independence.hfc.comcastbusiness.net 12 66.8 KB 6 0 000:20:22
TOTAL: 3 310 12363.2 MB 432 6 0247:57:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 8802.4 MB 404 2 000:06:57
2? 12 350852.0 KB 22 4 001:43:31
3*.hfc.comcastbusiness.net 12 66.8 KB 6 0 000:20:22
4*.security.ipip.net 2 00.0 KB 0 0 000:00:04
5*.7-3.cable.virginm.net 6 00.0 KB 0 0 043:03:05
6unresolved 270 00.0 KB 0 0 0202:43:29
TOTAL: 6 588 12363.2 MB 432 6 0247:57:31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.11.163.217 18.672 3.982 0.000155:34:09
212.117.188.73 9.930 5.774 0.00046:38:14
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 5.872 8.556 0.00043:03:05
shell3 7.812 3.114 0.00001:43:30
185.196.32.180 1.796 0.410 0.00000:31:05
75-151-74-61-independence.hfc.comcastbusiness.net 2.480 1.908 0.00000:20:22
ftupet.com 45.368 7.420 0.00000:06:57
scan-141.security.ipip.net 0.198 0.040 0.00000:00:04
? 0.464 0.118 0.00000:00:00
TOTAL: 9 92.592 31.322 0.000247:57:31

Curious NNRP server explorers [Top 20]:

SystemConn
66.11.163.217 186
212.117.188.73 72
185.196.32.180 12
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 6
scan-141.security.ipip.net 2
TOTAL: 5 278

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 8
shell3 2
TOTAL: 2 10

NNRP unrecognized commands (by command):

CommandCount
Connection: close 2
GET / HTTP/1.1 2
User-Agent: HTTP Banner Detection (https... 2
Host: 66.251.253.167:119 2
XTHREAD DBINIT 2
TOTAL: 5 10

NNRP client timeouts [Top 20]:

SystemConnPeer
66.11.163.217 184 0
212.117.188.73 52 0
185.196.32.180 2 0
shell3 2 0
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 2 0
TOTAL: 5 242 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1110 89.8%
2comp 42 3.4%
3chi 28 2.3%
4alt 22 1.8%
5ba 14 1.1%
6misc 8 0.6%
7sci 6 0.5%
8esp 2 0.2%
9de 2 0.2%
10news 2 0.2%
TOTAL: 10 1236100.0%

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

NewsgroupCount
1rec.arts.tv 730
2rec.food.cooking 324
3comp.sys.mac.apps 40
4rec.bicycles.tech 40
5alt.stupidity 22
6chi.general 20
7ba.food 14
8misc.consumers.frugal-living 8
9sci.electronics.repair 6
10rec.bicycles.misc 4
11rec.radio.swap 4
12chi.weather 4
13chi.eats 4
14rec.gardens.edible 4
15rec.music.celtic 2
16rec.radio.broadcasting 2
17news.admin.net-abuse.misc 2
18esp.charla.sexo 2
19comp.unix.solaris 2
20de.soc.zensur 2
TOTAL: 20 1236