Daily Usenet report for news.ripco.com

Oct 25 00:01:03 -- Oct 25 23:57:13

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Oct 25 00:13:16 remote5bge0 overchan[22926]: [ID 702911 news.error] input line too long, skipping
Oct 25 00:21:32 remote5bge0 overchan[22926]: [ID 702911 news.error] input line too long, skipping
Oct 25 00:28:13 remote5bge0 overchan[22926]: [ID 702911 news.error] input line too long, skipping
Oct 25 01:54:48 remote5bge0 overchan[22926]: [ID 702911 news.error] input line too long, skipping
Oct 25 03:42:05 remote5bge0 overchan[22926]: [ID 702911 news.error] input line too long, skipping
Oct 25 11:10:04 remote5bge0 overchan[22926]: [ID 702911 news.error] input line too long, skipping
Oct 25 12:50:11 remote5bge0 overchan[22926]: [ID 702911 news.error] input line too long, skipping
Oct 25 14:10:29 remote5bge0 overchan[22926]: [ID 702911 news.error] input line too long, skipping
Oct 25 15:37:14 remote5bge0 overchan[22926]: [ID 702911 news.error] input line too long, skipping
Oct 25 23:43:06 remote5bge0 overchan[22926]: [ID 702911 news.error] input line too long, skipping
Oct 25 23:51:19 remote5bge0 overchan[22926]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 33446 41.6%4.2 MB 34.4%
inn 22531 28.0%3.9 MB 32.7%
innd 20861 25.9%3.2 MB 26.7%
innfeed 3604 4.5%767.2 KB 6.2%
overchan 11 0.0%1.8 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 80455 100.0%12.1 MB100.0%

History cache:

ReasonCount%Count
Cache misses 211142 54.4%
Do not exist 177040 45.6%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 388182 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%370 0.000 0.000 0.000
article cleanup00:00:00.434 0.0%44766 0.000 0.010 0.034
article logging00:00:00.880 0.0%45150 0.000 0.019 0.459
article parse00:00:01.678 0.0%104788 0.000 0.016 0.038
article write00:00:42.982 0.0%34190 0.374 1.257 34.453
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.256 0.0%398460 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:04.312 0.0%389088 0.001 0.011 0.574
history sync00:00:00.394 0.0%790 0.000 0.499 2.500
history write00:00:07.362 0.0%44754 0.013 0.164 5.753
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:59:43.374 99.9%433780 185.950 398.320 1261.588
nntp read00:00:02.610 0.0%430512 0.000 0.006 0.014
overview write00:00:00.264 0.0%34190 0.000 0.008 0.037
perl filter00:00:58.386 0.0%44738 0.906 1.305 2.395
python filter00:00:01.148 0.0%44742 0.000 0.026 0.078
site send00:00:01.950 0.0%102526 0.000 0.019 0.040
TOTAL: 48:02:21.62848:01:46.030100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.130 0.0%34194 0.000 0.004 0.019
article prepare00:00:00.012 0.0%26912 0.000 0.000 0.014
article read00:00:00.562 0.0%5540 0.000 0.101 15.000
backlog stats00:00:00.208 0.0%406950 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.238 0.0%271568 0.000 0.008 0.019
data write00:00:03.642 0.0%237786 0.004 0.015 0.044
idle47:51:43.096100.0%406950 249.933 423.401 1359.655
status file00:00:05.300 0.0%342 0.000 15.497 159.000
TOTAL: 47:52:13.55247:51:55.188100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.720 0.0%37898 0.000 0.019 0.133
idle101:42:25.372100.0%72126 18.354 5076.469328514.444
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:07.806 0.0%770524 0.000 0.010 0.032
readart00:00:20.000 0.0%3104 1.000 6.443 39.500
TOTAL: 101:44:23.260101:42:53.898100.0%----

Control commands to INND:

CommandNumber
L 2
flush 2
go 4
logmode 2
mode 9
name 2
pause 2
paused 2
reserve 4
TOTAL: 9 29

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 40760 12560 24438 3762 30%94:38:28
2news.snarked.org 40 41208 10804 27418 2986 26%49:27:12
3newsfeed.neva.ru 566 62736 6156 54902 1678 9%280:50:26
4feeder3.feed-ams.uzoreto.com 574 19152 3204 15244 704 16%47:18:44
5newsfeed.fu-berlin.de 2 17758 818 16898 42 4%50:42:28
6news-in.rahul.net 574 18814 248 18560 6 1%47:20:26
7news.lightlink.com 2 8802 224 8194 384 2%45:01:30
8ripco-out.feeder.erje.net 574 36736 48 35692 996 0%47:17:44
9news.cmpublishers.com 50 9798 22 9774 2 0%47:59:58
10localhost 148 4 4 0 0 100%00:00:00
TOTAL: 10 3678 255768 34088 211120 10560 13%710:36:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org30.5 MB0.0 KB10.5 MB41.0 MB 74%3.0 KB
2ripco-out.feed.uzoreto.com29.7 MB0.0 KB7.9 MB37.6 MB 79%2.4 KB
3newsfeed.neva.ru16.7 MB22.5 KB5.7 MB22.4 MB 74%2.9 KB
4news-in.rahul.net12.1 MB0.0 KB347.2 KB12.5 MB 97%50.2 KB
5feeder3.feed-ams.uzoreto.com8.4 MB0.0 KB1.6 MB10.0 MB 83%2.6 KB
6newsfeed.fu-berlin.de4.3 MB0.0 KB1.3 MB5.6 MB 76%6.7 KB
7news.lightlink.com4.0 MB0.0 KB13.5 MB17.6 MB 22%29.6 KB
8ripco-out.feeder.erje.net178.3 KB0.0 KB8.8 MB9.0 MB 1%8.8 KB
9news.cmpublishers.com59.7 KB0.0 KB2.9 KB62.6 KB 95%2.6 KB
10localhost11.5 KB0.0 KB0.0 KB11.5 KB100%2.9 KB
TOTAL: 10106.1 MB22.5 KB49.7 MB155.8 MB 68%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 25 00:01:03 - 00:59:59 376 2.2% 0.111.6 MB 3.1% 0.47
Oct 25 01:00:00 - 01:59:59 480 2.8% 0.131.2 MB 2.3% 0.35
Oct 25 02:00:00 - 02:59:59 699 4.1% 0.191.6 MB 3.1% 0.46
Oct 25 03:00:00 - 03:59:59 746 4.4% 0.212.2 MB 4.2% 0.62
Oct 25 04:00:00 - 04:59:59 878 5.1% 0.242.7 MB 5.1% 0.76
Oct 25 05:00:00 - 05:59:59 909 5.3% 0.252.7 MB 5.1% 0.77
Oct 25 06:00:00 - 06:59:59 818 4.8% 0.232.7 MB 5.2% 0.78
Oct 25 07:00:00 - 07:59:59 783 4.6% 0.221.8 MB 3.5% 0.52
Oct 25 08:00:00 - 08:59:59 970 5.7% 0.272.7 MB 5.0% 0.76
Oct 25 09:00:00 - 09:59:59 954 5.6% 0.272.4 MB 4.5% 0.68
Oct 25 10:00:00 - 10:59:59 992 5.8% 0.283.1 MB 5.9% 0.88
Oct 25 11:00:00 - 11:59:59 929 5.4% 0.263.0 MB 5.7% 0.86
Oct 25 12:00:00 - 12:59:59 937 5.5% 0.262.6 MB 4.8% 0.73
Oct 25 13:00:00 - 13:59:59 997 5.8% 0.283.1 MB 5.8% 0.87
Oct 25 14:00:00 - 14:59:59 951 5.6% 0.263.2 MB 6.1% 0.91
Oct 25 15:00:00 - 15:59:59 859 5.0% 0.242.8 MB 5.3% 0.79
Oct 25 16:00:00 - 16:59:59 789 4.6% 0.222.3 MB 4.3% 0.65
Oct 25 17:00:00 - 17:59:59 674 3.9% 0.193.5 MB 6.7% 1.01
Oct 25 18:00:00 - 18:59:59 510 3.0% 0.141.8 MB 3.4% 0.51
Oct 25 19:00:00 - 19:59:59 388 2.3% 0.111.3 MB 2.5% 0.38
Oct 25 20:00:00 - 20:59:59 388 2.3% 0.111.3 MB 2.5% 0.38
Oct 25 21:00:00 - 21:59:59 373 2.2% 0.101.1 MB 2.1% 0.32
Oct 25 22:00:00 - 22:59:59 302 1.8% 0.081.0 MB 1.9% 0.29
Oct 25 23:00:00 - 23:57:13 365 2.1% 0.111.0 MB 2.0% 0.31
TOTAL: 23:56:10 17067 100.0% 0.2052.9 MB 100.0% 0.63
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1888 1288 0 0 1 0 0 0 599
2news.snarked.org 1512 65 0 0 2 0 0 0 1445
3newsfeed.neva.ru 879 426 0 6 1 0 0 0 446
4ripco-out.feeder.erje.net 498 493 0 0 0 0 0 0 5
5feeder3.feed-ams.uzoreto.com 357 177 0 0 0 0 0 0 180
6news.lightlink.com 186 2 0 0 0 0 0 0 184
7newsfeed.fu-berlin.de 139 0 0 0 0 0 0 0 139
8news-in.rahul.net 3 0 0 0 0 0 0 0 3
9news.cmpublishers.com 2 0 0 0 0 0 0 0 2
TOTAL: 9 5464 2451 0 6 4 0 0 0 3003

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1593
alt.binaries.ftd 229
perl.cpan.uploads 44
fido7.su.pol.news 43
it.comp.os.win.windows10 42
alt.astrology.pro 33
alt.binaries.e-book 23
free.uk.astrology 20
alt.binaries.nl 18
alt.music.pink-floyd.publius 17
free.it.scienza.fisica 15
alt.binaries.pictures.rail 15
alt.binaries.drwho 13
alt.binaries.pictures.vladmodels 13
free.willey 12
it.tlc.cellulari.android 12
free.ucp 12
alt.binaries.pictures.scenic 11
alt.binaries.mac.games 9
alt.binaries.test.yenc 9
TOTAL: 143 2451

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

GroupsCount
fr.comp.securite 1
pl.praca.oferowana 1
christnet.theology 1
rec.travel.resorts.all-inclusive 1
TOTAL: 4 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3556
Too many newsgroups 1342
Binary in non-binary group 260
EMP (phl) 190
Attached HTML file 90
Scoring filter (16) 44
Scoring filter (8) 44
Scoring filter (9) 42
Scoring filter (10) 10
HTML post 10
Scoring filter (18) 8
Scoring filter (13) 4
Scoring filter (12) 4
Malformed article 2
TOTAL: 14 5606

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 26
ripco-out.feed.uzoreto.com 4
feeder3.feed-ams.uzoreto.com 4
TOTAL: 3 34
Including strange strings
newsfeed.fu-berlin.de 118
newsfeed.neva.ru 48
news.snarked.org 13
ripco-out.feed.uzoreto.com 9
feeder3.feed-ams.uzoreto.com 4
TOTAL: 5 192
TOTAL: 3 227

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 11042 3188 5378 6 0 0 28%47:44:12
2rahul.net 26656 1272 14482 26 0 2 4%47:48:06
3feeder.erje.net 32346 166 31202 202 0 0 0%47:40:00
4news.cmpublishers.com 44170 82 32388 1214 0 12 0%47:40:00
5news.snarked.org 38514 70 22856 4 0 82 0%47:47:06
6news.uzoreto.com 19350 52 17576 296 0 0 0%47:40:10
7fu-berlin.de 30936 32 30904 0 0 0 0%47:40:00
8newsfeed.neva.ru 28808 16 27696 96 0 0 0%47:40:02
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:00
TOTAL: 9 231822 4878 182482 1844 0 102 2%429:19:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com8.9 MB20.7 KB9.0 MB0.1 KB/s2.9 KB47:44:12
2rahul.net3.9 MB60.9 KB3.9 MB0.0 KB/s3.1 KB47:48:06
3feeder.erje.net537.8 KB598.2 KB1.1 MB0.0 KB/s3.1 KB47:40:00
4news.cmpublishers.com297.6 KB3.0 MB3.2 MB0.0 KB/s2.6 KB47:40:00
5news.snarked.org290.6 KB7.4 KB297.9 KB0.0 KB/s4.0 KB47:47:06
6news.uzoreto.com181.9 KB834.8 KB1016.7 KB0.0 KB/s2.9 KB47:40:10
7fu-berlin.de127.6 KB0.0 KB127.6 KB0.0 KB/s4.0 KB47:40:00
8newsfeed.neva.ru69.2 KB351.8 KB421.1 KB0.0 KB/s3.8 KB47:40:02
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 914.3 MB4.8 MB19.1 MB0.0 KB/s2.9 KB429:19:36
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 13683.7 MB 504 2 000:06:57
2shell3 12 362976.5 KB 52 2 001:28:28
375-151-74-61-independence.hfc.comcastbusiness.net 8 44.0 KB 4 0 000:14:51
TOTAL: 3 306 17344.7 MB 560 4 0101:44:15

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 13683.7 MB 504 2 000:06:57
2? 12 362976.5 KB 52 2 001:28:28
3*.hfc.comcastbusiness.net 8 44.0 KB 4 0 000:14:51
4unresolved 128 00.0 KB 0 0 099:49:41
5*.cpe.metrocast.net 8 00.0 KB 0 0 000:04:15
TOTAL: 5 442 17344.7 MB 560 4 0101:44:15

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.11.163.217 1.650 0.460 0.00093:21:02
212.117.188.68 12.116 3.858 0.00006:28:39
shell3 3.358 1.940 0.00001:28:28
75-151-74-61-independence.hfc.comcastbusiness.net 1.690 1.352 0.00000:14:51
ftupet.com 46.960 7.438 0.00000:06:57
d-72-9-26-236.cpe.metrocast.net 0.802 0.194 0.00000:04:15
TOTAL: 6 66.576 15.242 0.000101:44:15

Curious NNRP server explorers [Top 20]:

SystemConn
212.117.188.68 112
66.11.163.217 16
d-72-9-26-236.cpe.metrocast.net 8
TOTAL: 3 136

NNRP unrecognized commands (by host):

SystemConn
shell3 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
66.11.163.217 16 0
shell3 2 0
TOTAL: 2 18 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1500 86.5%
2misc 82 4.7%
3comp 72 4.2%
4alt 42 2.4%
5news 18 1.0%
6ba 10 0.6%
7chi 4 0.2%
8microsoft 2 0.1%
9sci 2 0.1%
10at 2 0.1%
TOTAL: 10 1734100.0%

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

NewsgroupCount
1rec.arts.tv 896
2rec.food.cooking 508
3rec.bicycles.tech 78
4misc.consumers.frugal-living 46
5misc.phone.mobile.iphone 36
6comp.mobile.android 36
7alt.www.webmaster 16
8comp.mobile.ipad 12
9news.groups.questions 12
10ba.food 10
11comp.sys.mac.system 10
12alt.stupidity 8
13rec.puzzles 6
14rec.radio.swap 6
15alt.hvac 4
16comp.mail.sendmail 4
17alt.bittorrent 4
18comp.unix.solaris 4
19alt.security.alarms 4
20news.admin.net-abuse.email 4
21chi.weather 4
22rec.gardens.edible 4
23at.usenet.gruppen 2
24alt.tv.sopranos 2
25microsoft.public.test.here 2
26comp.mail.misc 2
27comp.protocols.dns.bind 2
28comp.sys.mac.apps 2
29rec.radio.broadcasting 2
30alt.tv.iron-chef 2
31alt.usenet.news-server-comparison 2
32sci.electronics.repair 2
33news.groups 2
TOTAL: 33 1734