Daily Usenet report for news.ripco.com

Jun 14 00:01:02 -- Jun 14 23:57:54

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Jun 14 10:30:50 remote5bge0 overchan[23265]: [ID 702911 news.error] input line too long, skipping
Jun 14 10:57:13 remote5bge0 overchan[23265]: [ID 702911 news.error] input line too long, skipping
Jun 14 11:18:22 remote5bge0 overchan[23265]: [ID 702911 news.error] input line too long, skipping
Jun 14 11:30:52 remote5bge0 overchan[23265]: [ID 702911 news.error] input line too long, skipping
Jun 14 11:36:06 remote5bge0 overchan[23265]: [ID 702911 news.error] input line too long, skipping
Jun 14 12:11:27 remote5bge0 overchan[23265]: [ID 702911 news.error] input line too long, skipping
Jun 14 13:48:54 remote5bge0 overchan[23265]: [ID 702911 news.error] input line too long, skipping
Jun 14 14:30:25 remote5bge0 overchan[23265]: [ID 702911 news.error] input line too long, skipping
Jun 14 14:35:19 remote5bge0 overchan[23265]: [ID 702911 news.error] input line too long, skipping
Jun 14 15:16:16 remote5bge0 overchan[23265]: [ID 702911 news.error] input line too long, skipping
Jun 14 21:56:40 remote5bge0 overchan[23265]: [ID 702911 news.error] input line too long, skipping
Jun 14 23:57:47.821 - ripco-out.feeder.

Log entries by program:

Program nameLines%LinesSize%Size
inn 19650 33.2%3.8 MB 41.1%
innd 18635 31.4%2.9 MB 30.9%
nnrpd 17315 29.2%1.8 MB 19.2%
innfeed 3660 6.2%828.5 KB 8.7%
overchan 11 0.0%1.4 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 59273 100.0%9.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 184448 50.8%
Cache misses 178950 49.2%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 363398 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%524 0.000 0.000 0.000
article cleanup00:00:00.494 0.0%38842 0.000 0.013 0.066
article logging00:00:00.738 0.0%39214 0.000 0.019 0.060
article parse00:00:01.522 0.0%97888 0.000 0.016 0.037
article write00:01:33.064 0.1%29526 1.701 3.152 15.391
artlog/artparse00:00:00.000 0.0%16 0.000 0.000 0.000
data move00:00:00.448 0.0%374244 0.000 0.001 0.011
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:03.228 0.0%363430 0.002 0.009 0.017
history sync00:00:00.302 0.0%794 0.000 0.380 2.333
history write00:00:05.754 0.0%38846 0.014 0.148 21.240
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:36:34.904 99.8%409588 216.462 418.457 1032.253
nntp read00:00:03.148 0.0%410240 0.002 0.008 0.017
overview write00:00:00.258 0.0%29526 0.000 0.009 0.075
perl filter00:01:01.832 0.0%38828 1.225 1.592 3.870
python filter00:00:01.452 0.0%38830 0.005 0.037 0.136
site send00:00:02.950 0.0%88566 0.008 0.033 0.062
TOTAL: 47:42:06.39247:39:30.094 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.116 0.0%29884 0.000 0.004 0.032
article prepare00:00:00.000 0.0%8632 0.000 0.000 0.000
article read00:00:00.342 0.0%1810 0.000 0.189 71.000
backlog stats00:00:00.260 0.0%431960 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.624 0.0%276918 0.001 0.006 0.013
data write00:00:04.336 0.0%247610 0.006 0.018 0.045
idle47:33:51.688100.0%431960 209.421 396.406 1215.281
status file00:00:01.756 0.0%348 0.750 5.046 41.000
TOTAL: 47:34:15.94047:34:00.122100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:58:56.998 99.0%18248 18.361 785.675 62182.100
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.420 0.1%919050 0.000 0.010 0.048
readart00:00:24.616 0.2%2618 0.000 9.403 143.833
TOTAL: 04:01:17.65603:59:31.034 99.3%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1152 32846 10826 17274 4746 32%94:58:56
2feeder3.feed-ams.uzoreto.com 576 17418 7182 8830 1406 41%47:29:18
3ripco-out.news.tnetconsulting.net 4 31556 5350 25810 396 16%47:39:06
4newsfeed.neva.ru 594 29286 5120 22582 1584 17%275:27:46
5newsfeed.fu-berlin.de 4 15108 470 14618 20 3%48:12:50
6news-in.rahul.net 576 15772 190 15430 152 1%47:34:20
7news.lightlink.com 2 8500 132 8194 174 1%47:38:32
8news.snarked.org 44 26972 108 26800 64 0%48:26:06
9ripco-out.feeder.erje.net 576 31940 16 31130 794 0%47:29:02
10news.cmpublishers.com 52 8210 16 8186 8 0%47:59:30
11localhost 148 2 2 0 0 100%00:00:00
TOTAL: 11 3728 217610 29412 178854 9344 13%752:55:26
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.news.tnetconsulting.net28.6 MB0.0 KB2.4 MB31.1 MB 92%5.5 KB
2ripco-out.feed.uzoreto.com28.4 MB0.0 KB10.3 MB38.7 MB 73%2.5 KB
3feeder3.feed-ams.uzoreto.com19.6 MB0.0 KB3.6 MB23.2 MB 84%2.8 KB
4newsfeed.neva.ru15.6 MB0.0 KB4.2 MB19.8 MB 78%3.0 KB
5news.lightlink.com4.6 MB526.6 KB7.8 MB12.9 MB 35%43.2 KB
6news-in.rahul.net4.1 MB0.0 KB6.0 MB10.1 MB 40%30.3 KB
7newsfeed.fu-berlin.de2.9 MB0.0 KB467.7 KB3.4 MB 86%7.1 KB
8news.snarked.org719.1 KB0.0 KB275.8 KB995.0 KB 72%5.8 KB
9ripco-out.feeder.erje.net80.4 KB0.0 KB4.3 MB4.4 MB 1%5.6 KB
10news.cmpublishers.com35.9 KB0.0 KB11.3 KB47.2 KB 76%2.0 KB
11localhost3.6 KB0.0 KB0.0 KB3.6 KB100%1.8 KB
TOTAL: 11104.7 MB526.6 KB39.4 MB144.7 MB 72%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 14 00:01:02 - 00:59:59 329 2.2% 0.091.1 MB 2.1% 0.32
Jun 14 01:00:00 - 01:59:59 386 2.6% 0.111.8 MB 3.4% 0.50
Jun 14 02:00:00 - 02:59:59 510 3.4% 0.141.8 MB 3.5% 0.52
Jun 14 03:00:00 - 03:59:59 576 3.9% 0.161.7 MB 3.3% 0.49
Jun 14 04:00:00 - 04:59:59 592 4.0% 0.161.9 MB 3.6% 0.53
Jun 14 05:00:00 - 05:59:59 686 4.6% 0.192.6 MB 4.9% 0.73
Jun 14 06:00:00 - 06:59:59 761 5.1% 0.212.4 MB 4.6% 0.68
Jun 14 07:00:00 - 07:59:59 792 5.4% 0.222.7 MB 5.3% 0.78
Jun 14 08:00:00 - 08:59:59 741 5.0% 0.212.5 MB 4.7% 0.70
Jun 14 09:00:00 - 09:59:59 776 5.2% 0.222.9 MB 5.5% 0.82
Jun 14 10:00:00 - 10:59:59 771 5.2% 0.213.2 MB 6.1% 0.90
Jun 14 11:00:00 - 11:59:59 960 6.5% 0.273.1 MB 6.0% 0.88
Jun 14 12:00:00 - 12:59:59 925 6.3% 0.262.9 MB 5.5% 0.82
Jun 14 13:00:00 - 13:59:59 809 5.5% 0.222.2 MB 4.2% 0.63
Jun 14 14:00:00 - 14:59:59 831 5.6% 0.232.4 MB 4.7% 0.69
Jun 14 15:00:00 - 15:59:59 668 4.5% 0.192.0 MB 3.8% 0.56
Jun 14 16:00:00 - 16:59:59 721 4.9% 0.202.7 MB 5.1% 0.76
Jun 14 17:00:00 - 17:59:59 564 3.8% 0.162.1 MB 4.1% 0.61
Jun 14 18:00:00 - 18:59:59 491 3.3% 0.141.9 MB 3.7% 0.54
Jun 14 19:00:00 - 19:59:59 468 3.2% 0.133.0 MB 5.7% 0.84
Jun 14 20:00:00 - 20:59:59 340 2.3% 0.091.2 MB 2.3% 0.33
Jun 14 21:00:00 - 21:59:59 354 2.4% 0.101006.9 KB 1.9% 0.28
Jun 14 22:00:00 - 22:59:59 320 2.2% 0.091.5 MB 2.9% 0.42
Jun 14 23:00:00 - 23:57:54 422 2.9% 0.121.6 MB 3.0% 0.46
TOTAL: 23:56:52 14793 100.0% 0.1751.9 MB 100.0% 0.62
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2375 1745 0 0 7 0 0 0 623
2newsfeed.neva.ru 840 495 0 0 3 0 0 0 342
3feeder3.feed-ams.uzoreto.com 703 408 0 0 0 0 0 0 295
4ripco-out.feeder.erje.net 395 393 0 0 0 0 0 0 2
5ripco-out.news.tnetconsulting.net 193 102 0 1 0 0 0 0 90
6newsfeed.fu-berlin.de 135 0 0 0 0 0 0 0 135
7news.lightlink.com 103 0 0 5 0 0 0 0 98
8news-in.rahul.net 76 0 0 0 0 0 0 0 76
9news.snarked.org 33 31 0 0 0 0 0 0 2
10news.cmpublishers.com 3 2 0 0 0 0 0 0 1
TOTAL: 10 4856 3176 0 6 10 0 0 0 1664

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2342
alt.binaries.ftd 136
de.soc.arbeitslos 61
perl.cpan.uploads 40
aioe.news.assistenza 39
free.it.scienza.fisica 31
scot.general 30
alt.binaries.3d.poser 25
scinet.stats 24
alt.binaries.pictures.scenic 23
fido7.su.pol.news 22
it.tlc.cellulari.android 22
alt.binaries.e-book 22
alt.binaries.nospam.female.bodyhair.pubes 17
wales.test 16
alt.binaries.pictures.purebeauty 13
alt.binaries.pictures.wallpaper 13
free.linux 13
panix.questions 12
muc.lists.netbsd.port.vax 11
TOTAL: 127 3176

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

GroupsCount
fr.bienvenue 9
bit.listserv.catholic 1
TOTAL: 2 10

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1742
Too many newsgroups 944
Binary in non-binary group 112
EMP (phl) 80
Scoring filter (8) 30
Scoring filter (9) 18
Scoring filter (11) 4
Scoring filter (10) 2
EMP (fsl) 2
U2 violation - invalid distribution 2
TOTAL: 10 2936

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 24
feeder3.feed-ams.uzoreto.com 4
ripco-out.feed.uzoreto.com 2
TOTAL: 3 30
Including strange strings
newsfeed.fu-berlin.de 130
newsfeed.neva.ru 52
ripco-out.feed.uzoreto.com 4
news.snarked.org 1
TOTAL: 4 187
No colon-space in header
ripco-out.feed.uzoreto.com 5
feeder3.feed-ams.uzoreto.com 3
TOTAL: 2 8
TOTAL: 3 225

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10278 602 6448 20 0 4 5%47:40:02
2rahul.net 23426 536 13548 24 0 16 2%47:40:02
3feeder.erje.net 34748 276 28094 198 0 24 0%48:12:30
4news.cmpublishers.com 40806 40 28770 336 0 198 0%47:40:02
5news.snarked.org 39494 32 24630 12 0 120 0%48:03:30
6news.tnetconsulting.net 36010 24 23974 0 0 68 0%47:40:02
7fu-berlin.de 26878 16 26862 0 0 0 0%47:40:02
8newsfeed.neva.ru 24900 12 24406 4 0 0 0%47:59:44
9news.uzoreto.com 11434 10 11184 8 0 0 0%47:38:48
10remote6hme0.ripco.com 8 2 0 6 0 0 25%01:32:04
TOTAL: 10 247982 1550 187916 608 0 430 0%431:46:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net3.4 MB244.7 KB3.7 MB0.0 KB/s6.7 KB47:40:02
2news.lightlink.com2.9 MB312.8 KB3.2 MB0.0 KB/s5.2 KB47:40:02
3feeder.erje.net1019.6 KB503.2 KB1.5 MB0.0 KB/s3.2 KB48:12:30
4news.snarked.org220.6 KB28.9 KB249.5 KB0.0 KB/s5.7 KB48:03:30
5news.tnetconsulting.net183.9 KB0.0 KB183.9 KB0.0 KB/s7.7 KB47:40:02
6newsfeed.neva.ru138.4 KB28.7 KB167.1 KB0.0 KB/s10.4 KB47:59:44
7news.cmpublishers.com110.9 KB1.0 MB1.1 MB0.0 KB/s3.1 KB47:40:02
8fu-berlin.de100.5 KB0.0 KB100.5 KB0.0 KB/s6.3 KB47:40:02
9news.uzoreto.com79.9 KB44.8 KB124.8 KB0.0 KB/s6.9 KB47:38:48
10remote6hme0.ripco.com2.7 KB20.5 KB23.1 KB0.0 KB/s2.9 KB01:32:04
TOTAL: 108.1 MB2.2 MB10.3 MB0.0 KB/s4.9 KB431:46:46
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10403.0 MB 436 2 000:07:19
2shell3 10 5361.5 MB 50 0 003:53:47
TOTAL: 2 296 15764.5 MB 486 2 004:01:08

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10403.0 MB 436 2 000:07:19
2? 10 5361.5 MB 50 0 003:53:47
TOTAL: 2 296 15764.5 MB 486 2 004:01:07

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 4.274 9.730 0.00003:53:47
ftupet.com 47.946 21.248 0.00000:07:19
33.20.97.83.ro.ovo.sc 0.200 0.048 0.00000:00:00
scan-141.security.ipip.net 0.200 0.046 0.00000:00:00
TOTAL: 4 52.620 31.072 0.00004:01:08

NNRP no permission clients:

SystemConn
33.20.97.83.ro.ovo.sc 2
scan-141.security.ipip.net 2
TOTAL: 2 4

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1448 91.9%
2alt 54 3.4%
3chi 34 2.2%
4comp 16 1.0%
5news 14 0.9%
6misc 6 0.4%
7sci 4 0.3%
TOTAL: 7 1576100.0%

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

NewsgroupCount
1rec.arts.tv 1006
2rec.food.cooking 322
3rec.bicycles.tech 80
4alt.comp.os.windows-10 54
5chi.general 26
6rec.bicycles.misc 16
7comp.sys.apple2 10
8rec.boats.building 8
9rec.radio.broadcasting 6
10chi.weather 6
11sci.electronics.repair 4
12rec.radio.swap 4
13news.groups 4
14news.software.nntp 4
15misc.consumers.frugal-living 4
16rec.scouting.usa 2
17rec.heraldry 2
18comp.sys.mac.apps 2
19news.admin.net-abuse.misc 2
20chi.forsale 2
21comp.unix.solaris 2
22news.admin.net-abuse.usenet 2
23misc.phone.mobile.iphone 2
24news.software.readers 2
25comp.mobile.android 2
26rec.boats.paddle 2
TOTAL: 26 1576