Daily Usenet report for news.ripco.com

Oct 4 00:01:03 -- Oct 4 23:58:00

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Oct 4 01:32:18 remote5bge0 overchan[24081]: [ID 702911 news.error] input line too long, skipping
Oct 4 09:42:42 remote5bge0 overchan[24081]: [ID 702911 news.error] input line too long, skipping
Oct 4 13:14:45 remote5bge0 overchan[24081]: [ID 702911 news.error] input line too long, skipping
Oct 4 13:50:30 remote5bge0 overchan[24081]: [ID 702911 news.error] input line too long, skipping
Oct 4 17:03:31 remote5bge0 overchan[24081]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 20821 33.2%3.2 MB 34.2%
inn 20276 32.3%3.5 MB 37.6%
nnrpd 18034 28.7%1.9 MB 20.1%
innfeed 3660 5.8%769.9 KB 8.0%
controlchan 8 0.0%1.5 KB 0.0%
overchan 5 0.0%0.7 KB 0.0%
TOTAL: 6 62804 100.0%9.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 199160 57.4%
Cache misses 148064 42.6%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 347224 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%96 0.000 0.000 0.000
article cleanup00:00:00.384 0.0%40246 0.000 0.010 0.147
article logging00:00:00.712 0.0%40506 0.000 0.018 1.307
article parse00:00:01.564 0.0%92440 0.000 0.017 0.040
article write00:00:48.404 0.0%29656 0.352 1.632 81.882
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.214 0.0%340430 0.000 0.001 0.007
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.432 0.0%348340 0.001 0.007 0.019
history sync00:00:00.178 0.0%810 0.000 0.220 2.000
history write00:00:03.122 0.0%40242 0.000 0.078 1.356
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:39:47.440 99.9%383784 265.840 447.094 1184.108
nntp read00:00:02.208 0.0%381756 0.000 0.006 0.013
overview write00:00:00.192 0.0%29656 0.000 0.006 0.042
perl filter00:00:52.332 0.0%40240 1.061 1.300 1.986
python filter00:00:01.034 0.0%40242 0.000 0.026 0.089
site send00:00:01.586 0.0%88940 0.000 0.018 0.048
TOTAL: 47:42:18.17847:41:41.802100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.108 0.0%29686 0.000 0.004 0.023
article prepare00:00:00.002 0.0%1672 0.000 0.001 0.125
article read00:00:00.174 0.0%336 0.000 0.518 70.000
backlog stats00:00:00.172 0.0%333066 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.056 0.0%224332 0.002 0.009 0.022
data write00:00:03.084 0.0%195508 0.004 0.016 0.035
idle47:53:12.790100.0%333066 286.269 517.593 1456.459
status file00:00:02.116 0.0%354 0.000 5.977 23.000
TOTAL: 47:53:31.87247:53:20.502100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:18:46.624 98.6%18114 5.000 459.679 23943.515
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:05.038 0.1%558802 0.000 0.009 2.000
readart00:00:20.022 0.2%2494 2.250 8.028 35.500
TOTAL: 02:20:48.67402:19:11.684 98.9%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de002002
TOTAL002002

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 37552 13776 18060 5716 36%94:51:20
2newsfeed.neva.ru 586 26830 5816 18406 2608 21%277:42:34
3feeder3.feed-ams.uzoreto.com 574 13716 5220 7394 1102 38%47:19:12
4news.snarked.org 54 27566 2648 24760 158 9%53:59:06
5news.cmpublishers.com 52 8912 804 8048 60 9%47:58:26
6news-in.rahul.net 574 17592 660 16888 44 3%47:20:30
7newsfeed.fu-berlin.de 2 13352 456 12864 32 3%45:11:58
8news.lightlink.com 2 11254 160 10994 100 1%49:48:38
9ripco-out.feeder.erje.net 574 31464 44 30628 792 0%47:17:36
10localhost 148 2 2 0 0 100%00:00:00
TOTAL: 10 3714 188240 29586 148042 10612 15%711:29:20
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com35.6 MB6.2 KB15.1 MB50.7 MB 70%2.7 KB
2newsfeed.neva.ru16.0 MB0.0 KB8.4 MB24.5 MB 65%3.0 KB
3feeder3.feed-ams.uzoreto.com13.5 MB0.0 KB4.2 MB17.7 MB 76%2.9 KB
4news-in.rahul.net9.1 MB98.5 KB1.3 MB10.5 MB 86%15.2 KB
5news.snarked.org7.9 MB0.0 KB804.4 KB8.7 MB 90%3.2 KB
6newsfeed.fu-berlin.de2.5 MB0.0 KB558.2 KB3.0 MB 81%6.3 KB
7news.cmpublishers.com2.5 MB0.0 KB180.5 KB2.6 MB 93%3.1 KB
8news.lightlink.com1.1 MB0.0 KB5.1 MB6.2 MB 17%24.4 KB
9ripco-out.feeder.erje.net131.6 KB0.0 KB7.4 MB7.6 MB 1%9.3 KB
10localhost4.1 KB0.0 KB0.0 KB4.1 KB100%2.1 KB
TOTAL: 1088.3 MB104.6 KB43.0 MB131.5 MB 67%3.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 4 00:01:03 - 00:59:59 330 2.2% 0.09989.5 KB 2.2% 0.28
Oct 4 01:00:00 - 01:59:59 567 3.8% 0.161.4 MB 3.2% 0.41
Oct 4 02:00:00 - 02:59:59 618 4.2% 0.171.6 MB 3.5% 0.44
Oct 4 03:00:00 - 03:59:59 648 4.4% 0.181.7 MB 3.8% 0.48
Oct 4 04:00:00 - 04:59:59 747 5.0% 0.212.3 MB 5.0% 0.64
Oct 4 05:00:00 - 05:59:59 713 4.8% 0.202.1 MB 4.6% 0.59
Oct 4 06:00:00 - 06:59:59 768 5.2% 0.212.3 MB 5.1% 0.66
Oct 4 07:00:00 - 07:59:59 722 4.9% 0.201.8 MB 4.1% 0.52
Oct 4 08:00:00 - 08:59:59 765 5.2% 0.212.2 MB 4.9% 0.63
Oct 4 09:00:00 - 09:59:59 827 5.6% 0.232.2 MB 4.9% 0.62
Oct 4 10:00:00 - 10:59:59 839 5.7% 0.232.7 MB 6.0% 0.77
Oct 4 11:00:00 - 11:59:59 799 5.4% 0.222.1 MB 4.6% 0.59
Oct 4 12:00:00 - 12:59:59 883 5.9% 0.253.5 MB 7.9% 1.01
Oct 4 13:00:00 - 13:59:59 879 5.9% 0.242.5 MB 5.5% 0.70
Oct 4 14:00:00 - 14:59:59 724 4.9% 0.202.1 MB 4.7% 0.60
Oct 4 15:00:00 - 15:59:59 693 4.7% 0.192.3 MB 5.1% 0.65
Oct 4 16:00:00 - 16:59:59 677 4.6% 0.192.0 MB 4.5% 0.57
Oct 4 17:00:00 - 17:59:59 566 3.8% 0.161.8 MB 3.9% 0.50
Oct 4 18:00:00 - 18:59:59 484 3.3% 0.132.1 MB 4.7% 0.59
Oct 4 19:00:00 - 19:59:59 346 2.3% 0.10990.0 KB 2.2% 0.28
Oct 4 20:00:00 - 20:59:59 325 2.2% 0.091.0 MB 2.3% 0.29
Oct 4 21:00:00 - 21:59:59 360 2.4% 0.101.1 MB 2.5% 0.33
Oct 4 22:00:00 - 22:59:59 275 1.9% 0.08996.7 KB 2.2% 0.28
Oct 4 23:00:00 - 23:58:00 290 2.0% 0.081.2 MB 2.7% 0.36
TOTAL: 23:56:57 14845 100.0% 0.1744.9 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2870 1542 0 1 8 0 0 0 1319
2newsfeed.neva.ru 1347 474 0 0 5 0 0 0 868
3feeder3.feed-ams.uzoreto.com 555 122 0 0 0 0 0 0 433
4ripco-out.feeder.erje.net 396 394 0 0 0 0 0 0 2
5newsfeed.fu-berlin.de 84 0 0 0 0 0 0 0 84
6news.snarked.org 79 26 0 0 1 0 0 0 52
7news.lightlink.com 50 1 0 0 0 0 0 0 49
8news.cmpublishers.com 28 0 0 0 0 0 0 0 28
9news-in.rahul.net 22 1 0 1 0 0 0 0 20
TOTAL: 9 5431 2560 0 2 14 0 0 0 2855

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1777
alt.binaries.ftd 238
fido7.su.pol.news 47
it.tlc.cellulari.android 33
perl.cpan.uploads 30
alt.bestjobsusa.computer.jobs 29
scot.general 28
it.comp.os.win.windows10 22
alt.binaries.e-book 21
free.it.scienza.fisica 19
mozilla.dev.security.policy 13
alt.my.job.sucks 10
alt.jobs.jobsearch 10
aus.jobs 10
att.jobs 9
alt.tv.star-trek 7
free.willey 7
at.jobs 7
alt.binaries.pictures.erotica.vintage 7
linux.debian.maint.emacsen 6
TOTAL: 132 2560

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

GroupsCount
pl.praca.oferowana 8
christnet.bible 3
fr.comp.lang.php 1
fr.comp.securite 1
bit.listserv.catholic 1
TOTAL: 5 14

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3626
Too many newsgroups 1368
EMP (phl) 218
Binary in non-binary group 90
HTML post 56
Scoring filter (10) 32
Scoring filter (8) 30
Scoring filter (9) 22
Scoring filter (11) 2
Scoring filter (12) 2
U2 violation - invalid distribution 2
TOTAL: 11 5448

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 20
ripco-out.feed.uzoreto.com 2
TOTAL: 2 22
Including strange strings
newsfeed.fu-berlin.de 72
newsfeed.neva.ru 44
ripco-out.feed.uzoreto.com 11
feeder3.feed-ams.uzoreto.com 3
TOTAL: 4 130
TOTAL: 2 152

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 19800 160 12678 0 0 0 0%47:39:12
2news.lightlink.com 11880 62 6698 6 0 0 0%47:51:06
3news.snarked.org 39976 28 26690 2 0 18 0%47:40:02
4feeder.erje.net 25686 12 25644 12 0 4 0%47:36:48
5fu-berlin.de 27088 12 27076 0 0 0 0%47:41:44
6newsfeed.neva.ru 23900 8 23728 8 0 0 0%47:40:02
7news.uzoreto.com 10396 6 10376 6 0 0 0%47:33:04
8news.cmpublishers.com 36658 0 28518 94 0 6 0%47:42:48
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:02
TOTAL: 9 195384 288 161408 128 0 34 0%429:04:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net1006.1 KB0.0 KB1006.1 KB0.0 KB/s6.3 KB47:39:12
2news.lightlink.com186.5 KB18.1 KB204.6 KB0.0 KB/s3.0 KB47:51:06
3news.snarked.org114.3 KB4.0 KB118.3 KB0.0 KB/s3.9 KB47:40:02
4feeder.erje.net61.2 KB49.1 KB110.2 KB0.0 KB/s4.6 KB47:36:48
5fu-berlin.de61.2 KB0.0 KB61.2 KB0.0 KB/s5.1 KB47:41:44
6news.uzoreto.com36.1 KB25.0 KB61.2 KB0.0 KB/s5.1 KB47:33:04
7newsfeed.neva.ru28.9 KB39.9 KB68.8 KB0.0 KB/s4.3 KB47:40:02
8news.cmpublishers.com0.0 KB390.4 KB390.4 KB0.0 KB/s4.2 KB47:42:48
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
TOTAL: 91.5 MB526.5 KB2.0 MB0.0 KB/s4.9 KB429:04:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10422.8 MB 428 2 000:07:51
2shell3 14 4081.3 MB 28 0 002:11:58
TOTAL: 2 300 14504.1 MB 456 2 002:20:38

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10422.8 MB 428 2 000:07:51
2? 14 4081.3 MB 28 0 002:11:58
TOTAL: 2 300 14504.1 MB 456 2 002:19:50

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 3.266 1.542 0.00002:11:58
ftupet.com 45.730 7.284 0.00000:07:51
d54c176a7.access.telenet.be 13.478 2.822 0.00000:00:26
80.82.65.74 6.018 1.186 0.00000:00:14
124-169-29-35.dyn.iinet.net.au 0.400 0.076 0.00000:00:04
112.64.199.58 0.200 0.038 0.00000:00:01
TOTAL: 6 69.092 12.948 0.00002:20:38

NNRP no permission clients:

SystemConn
d54c176a7.access.telenet.be 134
80.82.65.74 60
124-169-29-35.dyn.iinet.net.au 4
112.64.199.58 2
TOTAL: 4 200

NNRP unrecognized commands (by host):

SystemConn
shell3 6
TOTAL: 1 6

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 6
TOTAL: 1 6

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1258 86.8%
2misc 126 8.7%
3comp 26 1.8%
4alt 18 1.2%
5chi 8 0.6%
6sci 8 0.6%
7news 6 0.4%
TOTAL: 7 1450100.0%

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

NewsgroupCount
1rec.arts.tv 834
2rec.food.cooking 334
3misc.phone.mobile.iphone 114
4rec.bicycles.tech 74
5comp.sys.mac.system 24
6misc.consumers.frugal-living 12
7sci.electronics.repair 8
8alt.stupidity 8
9rec.radio.broadcasting 6
10rec.radio.swap 6
11chi.weather 6
12alt.free.newsservers 6
13news.software.readers 4
14rec.gardens.edible 4
15comp.sys.mac.apps 2
16alt.tv.sopranos 2
17news.admin.net-abuse.email 2
18alt.satellite.gps.garmin 2
19chi.eats 2
TOTAL: 19 1450