Daily Usenet report for news.ripco.com

Jun 5 00:01:01 -- Jun 5 23:56:54

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Jun 5 06:09:06 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 06:55:43 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 07:47:18 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 10:03:22 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 10:05:01 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 10:14:21 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 10:35:22 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 11:19:25 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 11:29:22 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 11:53:49 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 12:23:16 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 13:23:24 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 13:36:35 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 13:41:28 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 16:16:18 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping
Jun 5 23:17:25 remote5bge0 overchan[19052]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 36126 45.9%4.5 MB 36.9%
inn 20629 26.2%4.1 MB 33.3%
innd 18142 23.1%2.8 MB 23.2%
innfeed 3706 4.7%822.4 KB 6.6%
overchan 16 0.0%2.5 KB 0.0%
controlchan 8 0.0%1.2 KB 0.0%
TOTAL: 6 78627 100.0%12.2 MB100.0%

History cache:

ReasonCount%Count
Cache misses 197054 52.5%
Do not exist 177948 47.5%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 375002 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%196 0.000 0.000 0.000
article cleanup00:00:00.506 0.0%40834 0.000 0.012 0.048
article logging00:00:00.744 0.0%41346 0.000 0.018 0.121
article parse00:00:01.446 0.0%101094 0.000 0.014 0.040
article write00:01:31.170 0.1%32088 1.536 2.841 47.837
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.466 0.0%386170 0.000 0.001 0.005
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.530 0.0%377452 0.002 0.009 0.021
history sync00:00:00.332 0.0%796 0.000 0.417 5.400
history write00:00:04.058 0.0%40824 0.016 0.099 4.778
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:52:07.898 99.7%433126 260.426 397.870 1087.256
nntp read00:00:03.268 0.0%424962 0.002 0.008 0.017
overview write00:00:00.310 0.0%32088 0.000 0.010 0.073
perl filter00:01:04.442 0.0%40820 1.249 1.579 2.787
python filter00:00:01.692 0.0%40828 0.000 0.041 0.607
site send00:00:03.268 0.0%96246 0.012 0.034 0.060
TOTAL: 48:01:56.04247:55:03.130 99.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.128 0.0%32142 0.000 0.004 0.035
article prepare00:00:00.008 0.0%32864 0.000 0.000 0.014
article read00:00:00.678 0.0%5418 0.000 0.125 10.286
backlog stats00:00:00.284 0.0%510108 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.690 0.0%320144 0.000 0.005 0.013
data write00:00:05.046 0.0%288232 0.010 0.018 0.040
idle47:33:59.622100.0%510108 199.574 335.693 923.721
status file00:00:02.566 0.0%384 0.667 6.682 27.000
TOTAL: 47:34:28.27847:34:10.022100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:10:21.652 87.4%18442 7.333 814.535 53269.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:12.428 0.1%1251912 0.000 0.010 4.000
readart00:00:20.564 0.1%2762 0.000 7.445 36.000
TOTAL: 04:46:27.56804:10:54.644 87.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de002002
TOTAL002002

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 38438 14098 20184 4156 36%94:47:12
2news.snarked.org 42 29640 6844 21912 884 23%49:45:22
3newsfeed.neva.ru 578 41348 6208 33602 1538 15%278:26:28
4feeder3.feed-ams.uzoreto.com 576 12072 2842 8456 774 23%47:18:48
5ripco-out.news.tnetconsulting.net 4 29334 802 28426 106 2%35:50:02
6newsfeed.fu-berlin.de 2 14950 710 14206 34 4%45:38:12
7news.lightlink.com 2 8360 150 8018 192 1%47:38:32
8news-in.rahul.net 574 15544 96 15416 32 0%47:20:48
9news.cmpublishers.com 50 8670 58 8566 46 0%48:00:08
10ripco-out.feeder.erje.net 574 33790 30 32888 872 0%47:18:02
11localhost 154 8 8 0 0 100%00:00:00
TOTAL: 11 3704 232154 31846 191674 8634 13%742:03:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com35.0 MB2.4 KB8.1 MB43.1 MB 81%2.4 KB
2news.snarked.org19.7 MB16.6 KB1.8 MB21.5 MB 91%2.9 KB
3newsfeed.neva.ru17.2 MB14.0 KB5.6 MB22.9 MB 75%3.0 KB
4ripco-out.news.tnetconsulting.net11.2 MB0.0 KB1.6 MB12.8 MB 87%14.4 KB
5feeder3.feed-ams.uzoreto.com7.0 MB6.1 KB1.5 MB8.5 MB 82%2.4 KB
6newsfeed.fu-berlin.de4.4 MB0.0 KB117.8 KB4.5 MB 97%6.2 KB
7news-in.rahul.net3.9 MB0.0 KB2.1 MB6.0 MB 65%47.9 KB
8news.lightlink.com3.3 MB0.0 KB8.8 MB12.0 MB 27%36.0 KB
9news.cmpublishers.com209.0 KB0.0 KB191.6 KB400.6 KB 52%3.9 KB
10ripco-out.feeder.erje.net170.5 KB0.0 KB4.6 MB4.7 MB 3%5.4 KB
11localhost15.6 KB0.0 KB0.0 KB15.6 KB100%1.9 KB
TOTAL: 11102.0 MB39.1 KB34.3 MB136.4 MB 74%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 5 00:01:01 - 00:59:59 399 2.5% 0.112.3 MB 4.3% 0.66
Jun 5 01:00:00 - 01:59:59 485 3.0% 0.131.4 MB 2.7% 0.41
Jun 5 02:00:00 - 02:59:59 674 4.2% 0.191.7 MB 3.2% 0.48
Jun 5 03:00:00 - 03:59:59 735 4.6% 0.202.3 MB 4.3% 0.66
Jun 5 04:00:00 - 04:59:59 657 4.1% 0.181.7 MB 3.2% 0.48
Jun 5 05:00:00 - 05:59:59 760 4.7% 0.212.5 MB 4.7% 0.71
Jun 5 06:00:00 - 06:59:59 776 4.8% 0.222.3 MB 4.3% 0.65
Jun 5 07:00:00 - 07:59:59 809 5.1% 0.222.5 MB 4.6% 0.70
Jun 5 08:00:00 - 08:59:59 803 5.0% 0.222.9 MB 5.5% 0.83
Jun 5 09:00:00 - 09:59:59 899 5.6% 0.252.6 MB 5.0% 0.75
Jun 5 10:00:00 - 10:59:59 889 5.6% 0.253.6 MB 6.8% 1.02
Jun 5 11:00:00 - 11:59:59 912 5.7% 0.252.9 MB 5.5% 0.83
Jun 5 12:00:00 - 12:59:59 851 5.3% 0.242.5 MB 4.7% 0.71
Jun 5 13:00:00 - 13:59:59 838 5.2% 0.232.7 MB 5.1% 0.77
Jun 5 14:00:00 - 14:59:59 879 5.5% 0.243.4 MB 6.3% 0.96
Jun 5 15:00:00 - 15:59:59 754 4.7% 0.211.9 MB 3.7% 0.55
Jun 5 16:00:00 - 16:59:59 778 4.9% 0.222.5 MB 4.7% 0.70
Jun 5 17:00:00 - 17:59:59 602 3.8% 0.171.9 MB 3.6% 0.54
Jun 5 18:00:00 - 18:59:59 587 3.7% 0.161.9 MB 3.7% 0.55
Jun 5 19:00:00 - 19:59:59 601 3.8% 0.172.1 MB 3.9% 0.58
Jun 5 20:00:00 - 20:59:59 413 2.6% 0.112.2 MB 4.2% 0.64
Jun 5 21:00:00 - 21:59:59 376 2.3% 0.101.2 MB 2.3% 0.35
Jun 5 22:00:00 - 22:59:59 284 1.8% 0.08925.2 KB 1.7% 0.26
Jun 5 23:00:00 - 23:56:54 254 1.6% 0.071.1 MB 2.1% 0.33
TOTAL: 23:55:53 16015 100.0% 0.1953.1 MB 100.0% 0.63
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2090 1575 0 1 3 0 0 0 511
2newsfeed.neva.ru 828 465 0 2 0 0 0 0 361
3news.snarked.org 447 326 0 2 1 0 0 0 118
4ripco-out.feeder.erje.net 436 435 0 0 0 0 0 0 1
5feeder3.feed-ams.uzoreto.com 389 252 0 1 2 0 0 0 134
6newsfeed.fu-berlin.de 191 0 0 0 0 0 0 0 191
7ripco-out.news.tnetconsulting.net 101 27 0 0 0 0 0 0 74
8news.lightlink.com 94 1 0 1 0 0 0 0 92
9news.cmpublishers.com 22 0 0 0 0 0 0 0 22
10news-in.rahul.net 16 0 0 0 0 0 0 0 16
TOTAL: 10 4614 3081 0 7 6 0 0 0 1520

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2263
alt.binaries.ftd 156
perl.cpan.uploads 42
fido7.su.pol.news 41
scinet.stats 31
it.tlc.cellulari.android 30
free.willey 29
free.it.scienza.fisica 28
alt.binaries.pictures.erotica.vintage 27
scot.general 26
alt.binaries.pictures.scenic 20
alt.binaries.3d.poser 18
alt.binaries.e-book 15
aioe.news.assistenza 14
alt.binaries.pictures.purebeauty 12
alt.binaries.mac.osx.apps 11
alt.binaries.test.yenc 11
alt.binaries.nospam.female.bodyhair.pubes 11
alt.binaries.classic.tv.shows 11
it.comp.os.win.windows10 10
TOTAL: 140 3081

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

GroupsCount
pl.praca.oferowana 3
fr.comp.lang.php 2
bit.listserv.catholic 1
TOTAL: 3 6

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1314
EMP (md5) 502
Binary in non-binary group 420
EMP (phl) 204
Scoring filter (8) 44
Scoring filter (9) 18
Scoring filter (10) 10
Scoring filter (11) 8
Scoring filter (13) 2
Scoring filter (16) 2
HTML post 2
U2 violation - invalid distribution 2
TOTAL: 12 2528

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 28
feeder3.feed-ams.uzoreto.com 12
ripco-out.feed.uzoreto.com 10
TOTAL: 3 50
Including strange strings
newsfeed.fu-berlin.de 174
newsfeed.neva.ru 63
ripco-out.feed.uzoreto.com 12
news.snarked.org 3
feeder3.feed-ams.uzoreto.com 2
TOTAL: 5 254
No colon-space in header
ripco-out.feed.uzoreto.com 2
TOTAL: 1 2
TOTAL: 3 306

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 37244 2996 26934 750 0 8 8%47:46:18
2news.lightlink.com 11718 1386 6544 26 0 0 11%47:46:02
3rahul.net 26336 948 13810 92 0 0 3%47:48:52
4news.cmpublishers.com 45940 130 29974 1494 0 70 0%47:40:08
5news.snarked.org 41592 68 24888 12 0 50 0%47:51:36
6news.uzoreto.com 15218 58 14498 158 0 0 0%47:50:58
7news.tnetconsulting.net 49672 40 30898 6 0 56 0%47:47:48
8fu-berlin.de 28964 24 28940 0 0 0 0%47:42:22
9newsfeed.neva.ru 26328 18 25702 14 0 18 0%47:35:42
10remote6hme0.ripco.com 10 4 0 6 0 0 40%01:52:10
TOTAL: 10 283022 5672 202188 2558 0 202 2%431:41:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1feeder.erje.net8.5 MB1.8 MB10.4 MB0.1 KB/s2.8 KB47:46:18
2rahul.net5.2 MB262.3 KB5.4 MB0.0 KB/s5.3 KB47:48:52
3news.lightlink.com4.7 MB96.8 KB4.8 MB0.0 KB/s3.4 KB47:46:02
4news.cmpublishers.com384.7 KB4.1 MB4.5 MB0.0 KB/s2.8 KB47:40:08
5news.snarked.org237.9 KB17.3 KB255.2 KB0.0 KB/s3.2 KB47:51:36
6news.uzoreto.com218.1 KB854.2 KB1.0 MB0.0 KB/s5.0 KB47:50:58
7news.tnetconsulting.net162.2 KB10.0 KB172.2 KB0.0 KB/s3.7 KB47:47:48
8fu-berlin.de125.1 KB0.0 KB125.1 KB0.0 KB/s5.2 KB47:42:22
9newsfeed.neva.ru61.0 KB92.6 KB153.6 KB0.0 KB/s4.8 KB47:35:42
10remote6hme0.ripco.com8.1 KB34.1 KB42.1 KB0.0 KB/s4.2 KB01:52:10
TOTAL: 1019.5 MB7.3 MB26.8 MB0.0 KB/s3.3 KB431:41:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 11323.3 MB 438 2 000:07:30
2shell3 28 4961.7 MB 62 6 004:05:02
TOTAL: 2 314 16285.0 MB 500 8 004:43:23

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 11323.3 MB 438 2 000:07:30
2? 28 4961.7 MB 62 6 004:05:02
TOTAL: 2 314 16285.0 MB 500 8 004:12:33

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 7.366 4.100 0.00004:05:02
host81-129-173-246.range81-129.btcentralplus.com 462.752 129.100 0.00000:28:55
ftupet.com 45.926 21.986 0.00000:07:30
84-105-134-55.cable.dynamic.v4.ziggo.nl 9.680 2.638 0.00000:01:54
scan-141.security.ipip.net 0.198 0.052 0.00000:00:00
TOTAL: 5 525.922 157.876 0.00004:43:23

NNRP no permission clients:

SystemConn
host81-129-173-246.range81-129.btcentralplus.com 4576
84-105-134-55.cable.dynamic.v4.ziggo.nl 96
scan-141.security.ipip.net 2
TOTAL: 3 4674

NNRP unrecognized commands (by host):

SystemConn
shell3 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 4
TOTAL: 1 4

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 8 0
TOTAL: 1 8 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1408 86.5%
2comp 78 4.8%
3misc 68 4.2%
4alt 24 1.5%
5chi 20 1.2%
6news 10 0.6%
7sci 8 0.5%
8rocksolid 6 0.4%
9seattle 4 0.2%
10houston 2 0.1%
TOTAL: 10 1628100.0%

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

NewsgroupCount
1rec.arts.tv 832
2rec.food.cooking 408
3rec.bicycles.tech 152
4misc.phone.mobile.iphone 64
5comp.mobile.android 48
6alt.stupidity 12
7chi.general 10
8comp.sys.mac.system 10
9comp.sys.ibm.pc.games.strategic 8
10sci.electronics.repair 8
11rocksolid.shared.general 6
12chi.forsale 6
13comp.protocols.dns.bind 6
14rec.radio.broadcasting 6
15alt.tv.twin-peaks 4
16alt.dss.hack 4
17seattle.general 4
18news.software.nntp 4
19rec.radio.swap 4
20chi.weather 4
21misc.consumers.frugal-living 4
22comp.mail.uucp 2
23news.admin.net-abuse.usenet 2
24rec.boats.paddle 2
25alt.bitcoins 2
26rec.video.cable-tv 2
27comp.risks 2
28houston.eats 2
29alt.smokers 2
30rec.scouting.misc 2
31news.software.readers 2
32news.admin.net-abuse.email 2
33comp.sys.sun.hardware 2
TOTAL: 33 1628