Daily Usenet report for news.ripco.com

Aug 26 00:01:01 -- Aug 26 23:57:59

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Aug 26 00:16:37 remote5bge0 overchan[7841]: [ID 702911 news.error] input line too long, skipping
Aug 26 05:33:12 remote5bge0 overchan[7841]: [ID 702911 news.error] input line too long, skipping
Aug 26 06:00:51 remote5bge0 overchan[7841]: [ID 702911 news.error] input line too long, skipping
Aug 26 11:37:10 remote5bge0 overchan[7841]: [ID 702911 news.error] input line too long, skipping
Aug 26 11:40:08 remote5bge0 overchan[7841]: [ID 702911 news.error] input line too long, skipping
Aug 26 11:59:02 remote5bge0 overchan[7841]: [ID 702911 news.error] input line too long, skipping
Aug 26 12:02:56 remote5bge0 overchan[7841]: [ID 702911 news.error] input line too long, skipping
Aug 26 14:38:39 remote5bge0 overchan[7841]: [ID 702911 news.error] input line too long, skipping
Aug 26 14:46:25 remote5bge0 overchan[7841]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 21056 32.3%2.3 MB 23.5%
innd 20543 31.5%3.2 MB 32.6%
inn 20107 30.8%3.5 MB 36.2%
innfeed 3572 5.5%753.0 KB 7.6%
overchan 9 0.0%1.1 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 65289 100.0%9.7 MB100.0%

History cache:

ReasonCount%Count
Cache misses 188126 52.5%
Do not exist 170162 47.5%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 358288 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%160 0.000 0.000 0.000
article cleanup00:00:00.352 0.0%39860 0.000 0.009 0.043
article logging00:00:00.578 0.0%40160 0.000 0.014 0.155
article parse00:00:01.536 0.0%97922 0.000 0.016 0.050
article write00:00:41.136 0.0%29352 0.442 1.401 38.256
artlog/artparse00:00:00.000 0.0%12 0.000 0.000 0.000
data move00:00:00.250 0.0%344340 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.882 0.0%359356 0.002 0.008 0.018
history sync00:00:00.158 0.0%782 0.000 0.202 1.667
history write00:00:02.866 0.0%39872 0.008 0.072 0.531
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:39:18.876 99.9%381188 116.865 450.064 1769.336
nntp read00:00:02.338 0.0%378892 0.003 0.006 0.015
overview write00:00:00.168 0.0%29352 0.000 0.006 0.032
perl filter00:00:53.136 0.0%39860 1.040 1.333 2.728
python filter00:00:00.996 0.0%39864 0.000 0.025 0.090
site send00:00:02.094 0.0%88018 0.004 0.024 0.064
TOTAL: 47:42:12.64047:41:07.366100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.118 0.0%29336 0.000 0.004 0.032
article prepare00:00:00.002 0.0%14616 0.000 0.000 0.013
article read00:00:00.492 0.0%3058 0.000 0.161 3.944
backlog stats00:00:00.144 0.0%335394 0.000 0.000 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.478 0.0%226372 0.000 0.007 0.016
data write00:00:03.388 0.0%197666 0.003 0.017 0.035
idle47:38:01.686100.0%335394 301.154 511.284 1847.330
status file00:00:01.522 0.0%316 1.000 4.816 29.000
TOTAL: 47:38:18.03847:38:08.830100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:08:19.196 95.5%18342 20.033 419.758 13310.121
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:05.786 0.1%571862 0.000 0.010 1.000
readart00:00:19.486 0.2%2246 0.000 8.676 35.500
TOTAL: 02:14:24.33002:08:44.468 95.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 46 26628 8012 18170 446 30%49:40:58
2ripco-out.feed.uzoreto.com 1148 61876 8002 51042 2832 12%94:35:30
3newsfeed.neva.ru 566 43356 5894 34680 2782 13%279:53:54
4feeder3.feed-ams.uzoreto.com 574 20278 5884 11428 2966 29%47:27:58
5newsfeed.fu-berlin.de 4 18484 794 17648 42 4%63:31:06
6news.cmpublishers.com 52 8562 470 8030 62 5%47:59:06
7news.lightlink.com 2 7284 168 6794 322 2%38:11:06
8news-in.rahul.net 574 15484 124 15326 34 0%47:30:22
9ripco-out.feeder.erje.net 574 30738 64 29698 976 0%47:17:24
10localhost 150 4 4 0 0 100%00:00:02
TOTAL: 10 3690 232694 29416 192816 10462 12%716:07:26
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org22.3 MB0.0 KB1.5 MB23.8 MB 93%2.9 KB
2ripco-out.feed.uzoreto.com20.2 MB0.0 KB7.5 MB27.7 MB 73%2.6 KB
3newsfeed.neva.ru17.8 MB0.0 KB12.4 MB30.2 MB 58%3.6 KB
4feeder3.feed-ams.uzoreto.com14.4 MB0.0 KB5.9 MB20.3 MB 71%2.3 KB
5newsfeed.fu-berlin.de9.0 MB0.0 KB870.0 KB9.9 MB 91%12.1 KB
6news.lightlink.com2.8 MB0.0 KB11.8 MB14.5 MB 18%30.4 KB
7news-in.rahul.net2.1 MB0.0 KB1.2 MB3.4 MB 63%21.7 KB
8news.cmpublishers.com1.4 MB0.0 KB154.6 KB1.5 MB 90%3.0 KB
9ripco-out.feeder.erje.net185.3 KB0.0 KB9.4 MB9.5 MB 1%9.4 KB
10localhost10.4 KB0.0 KB0.0 KB10.4 KB100%2.6 KB
TOTAL: 1090.2 MB0.0 KB50.6 MB140.9 MB 64%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 26 00:01:01 - 00:59:59 394 2.7% 0.111.1 MB 2.4% 0.32
Aug 26 01:00:00 - 01:59:59 420 2.9% 0.121.2 MB 2.5% 0.33
Aug 26 02:00:00 - 02:59:59 521 3.5% 0.141.7 MB 3.7% 0.48
Aug 26 03:00:00 - 03:59:59 629 4.3% 0.171.7 MB 3.6% 0.47
Aug 26 04:00:00 - 04:59:59 679 4.6% 0.192.1 MB 4.7% 0.61
Aug 26 05:00:00 - 05:59:59 653 4.4% 0.181.6 MB 3.5% 0.45
Aug 26 06:00:00 - 06:59:59 626 4.3% 0.172.2 MB 4.9% 0.64
Aug 26 07:00:00 - 07:59:59 759 5.2% 0.211.8 MB 4.0% 0.52
Aug 26 08:00:00 - 08:59:59 854 5.8% 0.243.1 MB 6.9% 0.89
Aug 26 09:00:00 - 09:59:59 789 5.4% 0.222.0 MB 4.3% 0.55
Aug 26 10:00:00 - 10:59:59 860 5.9% 0.243.0 MB 6.7% 0.86
Aug 26 11:00:00 - 11:59:59 802 5.5% 0.222.7 MB 6.0% 0.77
Aug 26 12:00:00 - 12:59:59 846 5.8% 0.232.2 MB 4.9% 0.63
Aug 26 13:00:00 - 13:59:59 870 5.9% 0.242.9 MB 6.4% 0.83
Aug 26 14:00:00 - 14:59:59 907 6.2% 0.252.6 MB 5.7% 0.74
Aug 26 15:00:00 - 15:59:59 853 5.8% 0.242.6 MB 5.7% 0.74
Aug 26 16:00:00 - 16:59:59 663 4.5% 0.181.9 MB 4.1% 0.53
Aug 26 17:00:00 - 17:59:59 554 3.8% 0.151.6 MB 3.5% 0.45
Aug 26 18:00:00 - 18:59:59 444 3.0% 0.121.3 MB 2.8% 0.36
Aug 26 19:00:00 - 19:59:59 342 2.3% 0.101.0 MB 2.2% 0.29
Aug 26 20:00:00 - 20:59:59 379 2.6% 0.112.3 MB 5.1% 0.66
Aug 26 21:00:00 - 21:59:59 276 1.9% 0.08876.7 KB 1.9% 0.24
Aug 26 22:00:00 - 22:59:59 340 2.3% 0.091.3 MB 3.0% 0.38
Aug 26 23:00:00 - 23:57:59 236 1.6% 0.07710.2 KB 1.5% 0.20
TOTAL: 23:56:58 14696 100.0% 0.1745.4 MB 100.0% 0.54
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feeder3.feed-ams.uzoreto.com 1484 1085 0 0 4 0 0 0 395
2newsfeed.neva.ru 1429 426 0 0 4 0 0 0 999
3ripco-out.feed.uzoreto.com 1414 640 0 0 3 0 0 0 771
4ripco-out.feeder.erje.net 488 483 0 0 0 0 0 0 5
5news.snarked.org 229 105 0 0 3 0 0 0 121
6news.lightlink.com 204 2 0 0 0 0 0 0 202
7newsfeed.fu-berlin.de 121 0 0 0 0 0 0 0 121
8news.cmpublishers.com 25 0 0 0 0 0 0 0 25
9news-in.rahul.net 17 0 0 0 0 0 0 0 17
TOTAL: 9 5411 2741 0 0 14 0 0 0 2656

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1751
alt.binaries.ftd 261
it.tlc.cellulari.android 67
perl.cpan.uploads 56
scot.general 55
linux.debian.maint.emacsen 50
fido7.su.pol.news 49
free.it.scienza.fisica 32
alt.binaries.nl 30
muc.lists.netbsd.port.vax 22
alt.binaries.pictures.scenic 17
aioe.news.assistenza 17
alt.binaries.pictures.purebeauty 12
mozilla.dev.platform 12
fr.comp.os.android 11
linux.debian.changes 11
mozilla.dev.security.policy 10
alt.binaries.pictures.earlmiller 9
alt.binaries.pictures.rail 9
free.willey 8
TOTAL: 147 2741

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

GroupsCount
alt.penthouse.sex.sissy.slut 3
fr.comp.securite 3
bit.listserv.catholic 2
christnet.bible 2
christnet.theology 1
alt.christnet.religion 1
alt.penthouse.sex.wanted.escorts.ads 1
alt.christnet.christnews 1
TOTAL: 8 14

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2894
Too many newsgroups 1138
Binary in non-binary group 766
EMP (phl) 106
Scoring filter (8) 48
Scoring filter (9) 22
Scoring filter (10) 8
Scoring filter (11) 6
Scoring filter (12) 4
HTML post 2
Scoring filter (14) 2
TOTAL: 11 4996

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
TOTAL: 1 18
Including strange strings
newsfeed.fu-berlin.de 95
newsfeed.neva.ru 45
ripco-out.feed.uzoreto.com 5
feeder3.feed-ams.uzoreto.com 5
news.snarked.org 2
TOTAL: 5 152
TOTAL: 2 170

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10574 1854 5058 12 0 0 17%47:40:02
2rahul.net 20966 740 12284 20 0 0 3%47:40:02
3news.cmpublishers.com 36086 86 27898 700 0 10 0%47:40:02
4news.uzoreto.com 15518 24 15088 36 0 0 0%47:40:02
5news.snarked.org 33198 20 20860 16 0 36 0%47:40:02
6feeder.erje.net 28070 14 27470 92 0 0 0%47:40:02
7newsfeed.neva.ru 23926 14 23420 16 0 0 0%47:47:56
8fu-berlin.de 26542 12 26530 0 0 0 0%47:37:22
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:02
TOTAL: 9 194880 2764 158608 892 0 52 1%429:05:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com5.5 MB110.8 KB5.6 MB0.0 KB/s3.1 KB47:40:02
2rahul.net4.9 MB35.7 KB4.9 MB0.0 KB/s6.7 KB47:40:02
3news.cmpublishers.com273.7 KB1.8 MB2.1 MB0.0 KB/s2.7 KB47:40:02
4news.uzoreto.com123.4 KB212.2 KB335.6 KB0.0 KB/s5.6 KB47:40:02
5news.snarked.org104.8 KB46.5 KB151.3 KB0.0 KB/s4.2 KB47:40:02
6feeder.erje.net56.8 KB150.1 KB206.9 KB0.0 KB/s2.0 KB47:40:02
7fu-berlin.de52.5 KB0.0 KB52.5 KB0.0 KB/s4.4 KB47:37:22
8newsfeed.neva.ru42.8 KB38.2 KB81.0 KB0.0 KB/s2.7 KB47:47:56
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
TOTAL: 911.0 MB2.4 MB13.4 MB0.0 KB/s3.8 KB429:05:32
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 288 8722.3 MB 414 2 000:07:56
2shell3 18 5001.3 MB 60 2 002:01:32
TOTAL: 2 306 13723.6 MB 474 4 002:13:58

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 288 8722.3 MB 414 2 000:07:56
2? 18 5001.3 MB 60 2 002:01:32
TOTAL: 2 306 13723.6 MB 474 4 002:09:29

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 4.050 1.864 0.00002:01:32
ftupet.com 45.424 7.532 0.00000:07:56
197.185.111.134 74.100 16.124 0.00000:02:22
89.248.168.176 0.210 0.054 0.00000:02:01
124-169-136-153.dyn.iinet.net.au 0.200 0.042 0.00000:00:02
78-22-194-73.access.telenet.be 0.806 0.158 0.00000:00:02
TOTAL: 6 124.790 25.774 0.00002:13:58

NNRP no permission clients:

SystemConn
197.185.111.134 736
78-22-194-73.access.telenet.be 8
124-169-136-153.dyn.iinet.net.au 2
89.248.168.176 2
TOTAL: 4 748

NNRP unrecognized commands (by host):

SystemConn
shell3 10
TOTAL: 1 10

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 10
TOTAL: 1 10

Newsgroup request counts (by category):

CategoryCountPct
1rec 990 72.2%
2alt 150 10.9%
3comp 106 7.7%
4rocksolid 42 3.1%
5sci 30 2.2%
6misc 28 2.0%
7chi 10 0.7%
8news 8 0.6%
9ba 4 0.3%
10soc 4 0.3%
TOTAL: 10 1372100.0%

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

NewsgroupCount
1rec.arts.tv 490
2rec.food.cooking 286
3rec.bicycles.tech 168
4alt.comp.os.windows-10 110
5comp.sys.mac.system 42
6comp.sys.apple2 30
7sci.electronics.repair 30
8misc.phone.mobile.iphone 28
9alt.home.repair 24
10rocksolid.shared.offtopic 16
11comp.mobile.android 16
12rec.gardens.edible 16
13rec.outdoors.rv-travel 12
14alt.stupidity 10
15chi.weather 10
16rocksolid.shared.rocksolid 10
17comp.mail.sendmail 8
18rocksolid.shared.entertainment 6
19rec.audio.tubes 6
20comp.mail.pine 6
21rec.radio.broadcasting 6
22rec.radio.swap 6
23soc.history.what-if 4
24rocksolid.shared.test 4
25comp.protocols.dns.bind 4
26ba.internet 4
27rocksolid.shared.linux 4
28news.software.readers 4
29news.admin.net-abuse.email 4
30alt.games.warcraft 4
31rocksolid.nodes 2
32alt.apache.configuration 2
TOTAL: 32 1372