Daily Usenet report for news.ripco.com

Jul 11 00:01:02 -- Jul 11 23:58:02

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Jul 11 01:15:49 remote5bge0 overchan[28481]: [ID 702911 news.error] input line too long, skipping
Jul 11 04:04:59 remote5bge0 overchan[28481]: [ID 702911 news.error] input line too long, skipping
Jul 11 05:06:40 remote5bge0 overchan[28481]: [ID 702911 news.error] input line too long, skipping
Jul 11 08:40:07 remote5bge0 overchan[28481]: [ID 702911 news.error] input line too long, skipping
Jul 11 08:41:58 remote5bge0 overchan[28481]: [ID 702911 news.error] input line too long, skipping
Jul 11 10:52:22 remote5bge0 overchan[28481]: [ID 702911 news.error] input line too long, skipping
Jul 11 13:11:04 remote5bge0 overchan[28481]: [ID 702911 news.error] input line too long, skipping
Jul 11 13:25:10 remote5bge0 overchan[28481]: [ID 702911 news.error] input line too long, skipping
Jul 11 13:51:13 remote5bge0 overchan[28481]: [ID 702911 news.error] input line too long, skipping
Jul 11 16:00:42 remote5bge0 overchan[28481]: [ID 702911 news.error] input line too long, skipping
Jul 11 16:04:16 remote5bge0 overchan[28481]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 18312 31.6%3.6 MB 39.9%
innd 17915 30.9%2.8 MB 31.2%
nnrpd 17802 30.7%1.9 MB 20.8%
innfeed 3910 6.7%733.4 KB 8.0%
overchan 11 0.0%1.5 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 57952 100.0%8.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 162912 50.2%
Cache misses 161632 49.8%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 324544 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%166 0.000 0.000 0.000
article cleanup00:00:00.432 0.0%36096 0.000 0.012 0.041
article logging00:00:00.636 0.0%36546 0.000 0.017 0.068
article parse00:00:01.334 0.0%92920 0.000 0.014 0.041
article write00:01:49.516 0.1%26592 1.700 4.118 63.394
artlog/artparse00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:00.278 0.0%316310 0.000 0.001 0.007
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:01.682 0.0%324944 0.000 0.005 0.013
history sync00:00:00.378 0.0%790 0.000 0.478 14.667
history write00:00:03.820 0.0%36102 0.010 0.106 3.476
hiswrite/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
idle47:37:04.018 99.8%353950 149.038 484.317 1332.458
nntp read00:00:02.480 0.0%350094 0.001 0.007 0.019
overview write00:00:00.232 0.0%26592 0.000 0.009 0.049
perl filter00:00:53.728 0.0%36094 1.176 1.489 2.920
python filter00:00:01.238 0.0%36096 0.000 0.034 0.096
site send00:00:02.566 0.0%79756 0.008 0.032 0.075
TOTAL: 47:42:08.17447:40:02.338 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.200 0.0%48344 0.000 0.004 0.036
article prepare00:00:00.002 0.0%5280 0.000 0.000 0.005
article read00:00:00.318 0.0%1206 0.000 0.264 23.667
backlog stats00:00:00.252 0.0%299310 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.424 0.0%186318 0.000 0.008 0.028
data write00:00:03.206 0.0%159756 0.003 0.020 0.041
idle47:53:20.298100.0%299310 139.642 575.992 1624.965
status file00:00:09.726 0.0%496 0.000 19.609 397.143
TOTAL: 47:53:55.10047:53:35.426100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:40:41.556 89.7%17868 17.571 136.644 8100.977
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:05.412 0.2%418984 0.000 0.013 1.000
readart00:00:19.780 0.7%2534 2.059 7.806 44.500
TOTAL: 00:45:22.14600:41:06.748 90.6%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 33898 13560 15600 4738 40%94:39:46
2newsfeed.neva.ru 604 28322 4310 22412 1600 15%277:57:26
3ripco-out.news.tnetconsulting.net 4 43778 4100 39378 300 9%36:40:14
4feeder3.feed-ams.uzoreto.com 574 12304 3784 7142 1378 30%47:19:24
5newsfeed.fu-berlin.de 2 13156 580 12554 22 4%47:43:20
6news-in.rahul.net 574 14468 130 14122 216 0%47:19:42
7ripco-out.feeder.erje.net 574 29034 32 28016 986 0%47:07:22
8news.cmpublishers.com 52 10514 16 10496 2 0%50:39:32
9localhost 148 2 2 0 0 100%00:00:00
10news.lightlink.com 2 0 0 0 0 0%00:00:00
TOTAL: 10 3682 185476 26514 149720 9242 14%649:26:46
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com34.7 MB0.0 KB8.8 MB43.6 MB 79%2.4 KB
2ripco-out.news.tnetconsulting.net22.7 MB0.0 KB5.0 MB27.7 MB 82%6.4 KB
3newsfeed.neva.ru13.1 MB2.1 KB4.0 MB17.1 MB 76%3.0 KB
4feeder3.feed-ams.uzoreto.com9.6 MB0.0 KB2.7 MB12.3 MB 78%2.4 KB
5newsfeed.fu-berlin.de8.0 MB0.0 KB2.1 MB10.1 MB 78%17.2 KB
6news-in.rahul.net5.1 MB0.0 KB10.8 MB15.9 MB 32%47.2 KB
7ripco-out.feeder.erje.net178.6 KB0.0 KB7.6 MB7.8 MB 2%7.9 KB
8news.cmpublishers.com55.1 KB0.0 KB5.0 KB60.2 KB 91%3.3 KB
9localhost4.6 KB0.0 KB0.0 KB4.6 KB100%2.3 KB
10news.lightlink.com0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1093.5 MB2.1 KB41.1 MB134.6 MB 69%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 11 00:01:02 - 00:59:59 273 2.0% 0.08933.6 KB 2.0% 0.26
Jul 11 01:00:00 - 01:59:59 348 2.6% 0.101.1 MB 2.4% 0.31
Jul 11 02:00:00 - 02:59:59 407 3.1% 0.111.1 MB 2.4% 0.32
Jul 11 03:00:00 - 03:59:59 484 3.6% 0.131.4 MB 3.1% 0.41
Jul 11 04:00:00 - 04:59:59 579 4.3% 0.162.7 MB 5.7% 0.76
Jul 11 05:00:00 - 05:59:59 571 4.3% 0.161.5 MB 3.3% 0.43
Jul 11 06:00:00 - 06:59:59 566 4.2% 0.161.7 MB 3.6% 0.48
Jul 11 07:00:00 - 07:59:59 702 5.3% 0.204.3 MB 9.3% 1.23
Jul 11 08:00:00 - 08:59:59 662 5.0% 0.181.9 MB 4.1% 0.54
Jul 11 09:00:00 - 09:59:59 610 4.6% 0.171.7 MB 3.6% 0.47
Jul 11 10:00:00 - 10:59:59 680 5.1% 0.192.1 MB 4.5% 0.60
Jul 11 11:00:00 - 11:59:59 721 5.4% 0.204.0 MB 8.7% 1.15
Jul 11 12:00:00 - 12:59:59 806 6.0% 0.222.1 MB 4.6% 0.60
Jul 11 13:00:00 - 13:59:59 780 5.8% 0.223.4 MB 7.4% 0.97
Jul 11 14:00:00 - 14:59:59 736 5.5% 0.202.3 MB 5.0% 0.65
Jul 11 15:00:00 - 15:59:59 742 5.6% 0.212.3 MB 4.9% 0.65
Jul 11 16:00:00 - 16:59:59 602 4.5% 0.171.8 MB 3.8% 0.50
Jul 11 17:00:00 - 17:59:59 559 4.2% 0.161.7 MB 3.7% 0.49
Jul 11 18:00:00 - 18:59:59 522 3.9% 0.141.3 MB 2.9% 0.38
Jul 11 19:00:00 - 19:59:59 464 3.5% 0.131.3 MB 2.7% 0.36
Jul 11 20:00:00 - 20:59:59 372 2.8% 0.101.8 MB 3.9% 0.52
Jul 11 21:00:00 - 21:59:59 404 3.0% 0.111.1 MB 2.3% 0.31
Jul 11 22:00:00 - 22:59:59 404 3.0% 0.112.0 MB 4.3% 0.57
Jul 11 23:00:00 - 23:58:02 342 2.6% 0.10925.0 KB 1.9% 0.27
TOTAL: 23:57:00 13336 100.0% 0.1546.4 MB 100.0% 0.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2396 1894 0 0 4 0 0 0 498
2newsfeed.neva.ru 843 566 0 1 1 0 0 0 275
3feeder3.feed-ams.uzoreto.com 694 548 0 0 2 0 0 0 144
4ripco-out.feeder.erje.net 491 488 0 0 0 0 0 0 3
5newsfeed.fu-berlin.de 158 0 0 0 0 0 0 0 158
6ripco-out.news.tnetconsulting.net 153 45 0 0 0 0 0 0 108
7news.lightlink.com 133 0 0 0 0 0 0 0 133
8news-in.rahul.net 108 0 0 0 0 0 0 0 108
TOTAL: 8 4976 3541 0 1 7 0 0 0 1427

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2707
alt.binaries.ftd 279
scot.general 38
free.willey 32
scinet.stats 31
fido7.su.pol.news 25
perl.cpan.uploads 22
alt.paranormal.spells 21
linux.debian.changes 20
it.tlc.cellulari.android 16
alt.binaries.e-book 15
uk.net.news.moderation 14
alt.binaries.pictures.purebeauty 13
alt.binaries.pictures.scenic 13
alt.binaries.pictures.rail 13
free.it.scienza.fisica 12
it.comp.os.win.windows10 10
alt.binaries.pictures.wallpaper 9
alt.binaries.pictures.nude 7
fr.comp.os.android 7
TOTAL: 132 3541

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

GroupsCount
pl.praca.oferowana 3
christnet.bible 3
bit.listserv.catholic 1
TOTAL: 3 7

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1322
Too many newsgroups 770
Binary in non-binary group 116
EMP (phl) 114
Scoring filter (8) 32
Scoring filter (10) 18
HTML post 10
Scoring filter (9) 8
Scoring filter (15) 2
Scoring filter (14) 2
TOTAL: 10 2394

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 24
feeder3.feed-ams.uzoreto.com 10
ripco-out.feed.uzoreto.com 6
TOTAL: 3 40
Huge articles
newsfeed.fu-berlin.de 2
TOTAL: 1 2
Including strange strings
newsfeed.fu-berlin.de 147
newsfeed.neva.ru 47
ripco-out.feed.uzoreto.com 26
feeder3.feed-ams.uzoreto.com 5
TOTAL: 4 225
No colon-space in header
ripco-out.feed.uzoreto.com 2
feeder3.feed-ams.uzoreto.com 1
TOTAL: 2 3
TOTAL: 4 270

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 23306 582 13096 14 0 0 2%47:52:38
2feeder.erje.net 29478 188 25754 162 0 0 0%47:40:46
3news.uzoreto.com 9938 100 9414 6 0 0 1%47:54:28
4news.tnetconsulting.net 49698 28 37256 8 0 2162 0%47:47:10
5fu-berlin.de 24714 22 24692 0 0 0 0%47:40:04
6news.cmpublishers.com 37068 6 26778 190 0 2056 0%47:34:46
7remote6hme0.ripco.com 8 2 0 6 0 0 25%01:32:12
8news.snarked.org 0 0 0 0 0 23224 0%47:44:48
9news.lightlink.com 0 0 0 0 0 7144 0%47:40:00
10newsfeed.neva.ru 0 0 0 0 0 22198 0%47:44:48
TOTAL: 10 174210 928 136990 386 0 56784 0%431:11:40
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net5.0 MB33.5 KB5.1 MB0.0 KB/s8.7 KB47:52:38
2feeder.erje.net466.4 KB412.3 KB878.6 KB0.0 KB/s2.5 KB47:40:46
3news.uzoreto.com400.4 KB18.1 KB418.5 KB0.0 KB/s3.9 KB47:54:28
4news.tnetconsulting.net118.4 KB39.9 KB158.3 KB0.0 KB/s4.4 KB47:47:10
5fu-berlin.de86.6 KB0.0 KB86.6 KB0.0 KB/s3.9 KB47:40:04
6news.cmpublishers.com9.5 KB599.7 KB609.2 KB0.0 KB/s3.1 KB47:34:46
7remote6hme0.ripco.com2.8 KB35.1 KB37.9 KB0.0 KB/s4.7 KB01:32:12
8news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s047:44:48
9news.lightlink.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
10newsfeed.neva.ru0.0 KB0.0 KB0.0 KB0.0 KB/s047:44:48
TOTAL: 106.1 MB1.1 MB7.2 MB0.0 KB/s5.6 KB431:11:40
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 11603.0 MB 420 2 000:08:08
2shell3 4 212613.8 KB 24 0 000:35:33
TOTAL: 2 290 13723.6 MB 444 2 000:45:07

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 11603.0 MB 420 2 000:08:08
2? 4 212613.8 KB 24 0 000:35:33
TOTAL: 2 290 13723.6 MB 444 2 000:43:42

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 1.900 1.708 0.00000:35:33
ftupet.com 47.348 20.550 0.00000:08:08
84-105-134-55.cable.dynamic.v4.ziggo.nl 16.170 4.166 0.00000:01:24
45.229.210.69 0.204 0.050 0.00000:00:00
223.71.167.164 0.200 0.050 0.00000:00:00
TOTAL: 5 65.822 26.524 0.00000:45:07

NNRP no permission clients:

SystemConn
84-105-134-55.cable.dynamic.v4.ziggo.nl 160
223.71.167.164 2
45.229.210.69 2
TOTAL: 3 164

Newsgroup request counts (by category):

CategoryCountPct
1rec 1316 95.9%
2comp 18 1.3%
3sci 16 1.2%
4chi 12 0.9%
5alt 6 0.4%
6news 4 0.3%
TOTAL: 6 1372100.0%

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

NewsgroupCount
1rec.food.cooking 660
2rec.arts.tv 632
3rec.bicycles.tech 20
4sci.electronics.repair 16
5comp.sys.mac.system 16
6chi.weather 6
7chi.general 6
8rec.radio.swap 4
9alt.dss.hack 2
10comp.unix.solaris 2
11news.software.readers 2
12alt.video.tape-trading 2
13alt.free.newsservers 2
14news.software.nntp 2
TOTAL: 14 1372