Daily Usenet report for news.ripco.com

Nov 3 00:01:02 -- Nov 3 23:57:52

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Nov 3 00:39:30 remote5bge0 overchan[2174]: [ID 702911 news.error] input line too long, skipping
Nov 3 02:29:44 remote5bge0 overchan[2174]: [ID 702911 news.error] input line too long, skipping
Nov 3 09:14:03 remote5bge0 overchan[2174]: [ID 702911 news.error] input line too long, skipping
Nov 3 10:48:29 remote5bge0 overchan[2174]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 39952 37.7%4.8 MB 31.9%
innd 31589 29.8%4.8 MB 31.7%
inn 30627 28.9%4.7 MB 31.1%
innfeed 3792 3.6%822.8 KB 5.3%
overchan 4 0.0%0.6 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 105966 100.0%15.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 246350 60.3%
Cache misses 161882 39.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 408232 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%126 0.000 0.000 0.000
article cleanup00:00:00.568 0.0%60586 0.000 0.009 0.037
article logging00:00:00.852 0.0%60972 0.000 0.014 0.168
article parse00:00:02.312 0.0%149152 0.002 0.016 0.028
article write00:00:41.008 0.0%27240 0.359 1.505 38.711
artlog/artparse00:00:00.000 0.0%24 0.000 0.000 0.000
data move00:00:00.410 0.0%434242 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.550 0.0%409878 0.002 0.009 0.016
history sync00:00:00.580 0.0%828 0.000 0.700 20.500
history write00:00:07.774 0.0%60610 0.028 0.128 7.115
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle49:33:13.908 99.7%492668 220.141 362.098 893.318
nntp read00:00:02.936 0.0%486152 0.002 0.006 0.012
overview write00:00:00.198 0.0%27240 0.000 0.007 0.053
perl filter00:01:22.738 0.0%60586 1.072 1.366 2.596
python filter00:00:01.790 0.0%60592 0.006 0.030 0.212
site send00:00:02.078 0.0%81700 0.000 0.025 0.065
TOTAL: 49:42:08.71449:35:40.702 99.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.102 0.0%27236 0.000 0.004 0.034
article prepare00:00:00.010 0.0%22096 0.000 0.000 0.031
article read00:00:00.550 0.0%4586 0.000 0.120 14.000
backlog stats00:00:00.202 0.0%340666 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.674 0.0%221044 0.000 0.008 0.020
data write00:00:03.340 0.0%194154 0.004 0.017 0.055
idle49:37:34.958100.0%340666 297.248 524.428 1482.405
status file00:00:01.682 0.0%358 0.000 4.698 34.000
TOTAL: 49:37:52.92449:37:42.518100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:58:03.642 85.5%18784 9.000 760.415 30825.791
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.196 0.0%820888 0.000 0.010 90.000
readart00:00:21.178 0.1%2302 2.571 9.200 36.000
TOTAL: 04:38:34.48403:58:33.016 85.6%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1194 36298 10250 20238 5810 28%98:47:36
2news.snarked.org 44 26668 7588 18452 628 28%49:58:34
3newsfeed.neva.ru 612 67708 4458 39820 23430 6%295:03:42
4feeder3.feed-ams.uzoreto.com 598 15574 3704 9820 2050 23%49:20:30
5newsfeed.fu-berlin.de 2 13088 542 12534 12 4%48:18:52
6news.lightlink.com 2 7650 238 7194 218 3%49:11:52
7news-in.rahul.net 598 15680 222 15396 62 1%49:20:06
8news.cmpublishers.com 54 8076 46 8022 8 0%47:59:52
9ripco-out.feeder.erje.net 598 30866 30 29714 1122 0%49:17:22
10localhost 158 6 6 0 0 100%00:00:00
TOTAL: 10 3860 221614 27084 161190 33340 12%737:18:26
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com26.9 MB0.0 KB12.9 MB39.8 MB 67%2.5 KB
2news.snarked.org24.1 MB0.0 KB2.3 MB26.4 MB 91%3.3 KB
3newsfeed.neva.ru16.1 MB0.0 KB100.2 MB116.2 MB 13%4.3 KB
4feeder3.feed-ams.uzoreto.com10.6 MB0.0 KB5.4 MB16.0 MB 66%2.9 KB
5newsfeed.fu-berlin.de2.6 MB0.0 KB257.0 KB2.9 MB 91%5.4 KB
6news-in.rahul.net2.6 MB0.0 KB1.9 MB4.4 MB 57%16.0 KB
7news.lightlink.com797.4 KB0.0 KB8.3 MB9.0 MB 8%20.3 KB
8news.cmpublishers.com137.0 KB0.0 KB27.2 KB164.2 KB 83%3.0 KB
9ripco-out.feeder.erje.net47.2 KB0.0 KB12.6 MB12.6 MB 0%11.2 KB
10localhost13.7 KB0.0 KB0.0 KB13.7 KB100%2.3 KB
TOTAL: 1083.9 MB0.0 KB143.8 MB227.6 MB 36%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 3 00:01:02 - 00:59:59 226 1.7% 0.06899.8 KB 2.1% 0.25
Nov 3 01:00:00 - 01:59:59 622 4.6% 0.172.0 MB 4.8% 0.57
Nov 3 02:00:00 - 02:59:59 397 2.9% 0.111.3 MB 3.0% 0.36
Nov 3 03:00:00 - 03:59:59 568 4.2% 0.161.7 MB 4.0% 0.48
Nov 3 04:00:00 - 04:59:59 570 4.2% 0.161.7 MB 3.9% 0.47
Nov 3 05:00:00 - 05:59:59 534 3.9% 0.151.7 MB 4.1% 0.49
Nov 3 06:00:00 - 06:59:59 530 3.9% 0.151.5 MB 3.5% 0.42
Nov 3 07:00:00 - 07:59:59 688 5.0% 0.191.8 MB 4.4% 0.52
Nov 3 08:00:00 - 08:59:59 781 5.7% 0.222.4 MB 5.7% 0.69
Nov 3 09:00:00 - 09:59:59 639 4.7% 0.181.8 MB 4.2% 0.50
Nov 3 10:00:00 - 10:59:59 786 5.8% 0.222.5 MB 6.1% 0.73
Nov 3 11:00:00 - 11:59:59 752 5.5% 0.212.5 MB 5.9% 0.70
Nov 3 12:00:00 - 12:59:59 773 5.7% 0.212.2 MB 5.3% 0.63
Nov 3 13:00:00 - 13:59:59 816 6.0% 0.232.5 MB 5.8% 0.70
Nov 3 14:00:00 - 14:59:59 700 5.1% 0.192.0 MB 4.8% 0.58
Nov 3 15:00:00 - 15:59:59 802 5.9% 0.222.7 MB 6.5% 0.77
Nov 3 16:00:00 - 16:59:59 711 5.2% 0.202.2 MB 5.3% 0.64
Nov 3 17:00:00 - 17:59:59 534 3.9% 0.151.5 MB 3.6% 0.43
Nov 3 18:00:00 - 18:59:59 461 3.4% 0.131.4 MB 3.4% 0.41
Nov 3 19:00:00 - 19:59:59 413 3.0% 0.111.2 MB 2.8% 0.33
Nov 3 20:00:00 - 20:59:59 334 2.4% 0.091.2 MB 2.8% 0.34
Nov 3 21:00:00 - 21:59:59 363 2.7% 0.101.2 MB 2.8% 0.34
Nov 3 22:00:00 - 22:59:59 287 2.1% 0.08943.4 KB 2.2% 0.26
Nov 3 23:00:00 - 23:57:52 382 2.8% 0.111.3 MB 3.0% 0.37
TOTAL: 23:56:50 13669 100.0% 0.1642.1 MB 100.0% 0.50
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 11816 5593 0 0 0 0 0 0 6223
2ripco-out.feed.uzoreto.com 2914 2040 0 0 5 0 0 0 869
3feeder3.feed-ams.uzoreto.com 1026 591 0 0 1 0 0 0 434
4ripco-out.feeder.erje.net 569 566 0 0 0 0 0 0 3
5news.snarked.org 312 145 0 0 1 0 0 0 166
6newsfeed.fu-berlin.de 146 0 0 0 0 0 0 0 146
7news.lightlink.com 143 4 0 0 0 0 0 0 139
8news-in.rahul.net 31 0 0 0 0 0 0 0 31
9news.cmpublishers.com 1 1 0 0 0 0 0 0 0
TOTAL: 9 16958 8940 0 0 7 0 0 0 8011

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.boneless 5191
free.usenet 2839
alt.binaries.ftd 306
scot.general 101
free.it.scienza.fisica 58
alt.binaries.nl 41
it.tlc.cellulari.android 27
alt.binaries.e-book 27
alt.binaries.pictures.rail 25
alt.binaries.pictures.wallpaper 20
fido7.su.pol.news 16
alt.binaries.pictures.scenic 16
grisbi.bugsreports 16
it.comp.os.win.windows10 15
alt.binaries.sounds.lossless 10
alt.binaries.mma 9
alt.slack.goathead 9
alt.binaries.nospam.female.bodyhair.pubes 8
free.willey 7
alt.binaries.test.yenc 7
TOTAL: 126 8940

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

GroupsCount
christnet.bible 3
fr.comp.securite 2
christnet.theology 1
bit.listserv.catholic 1
TOTAL: 4 7

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 11126
EMP (md5) 2980
Too many newsgroups 1018
EMP (phl) 272
Scoring filter (8) 92
Scoring filter (9) 56
Scoring filter (12) 16
Scoring filter (18) 12
Scoring filter (11) 12
Scoring filter (16) 10
HTML post 10
Scoring filter (10) 8
Scoring filter (13) 2
Scoring filter (15) 2
Scoring filter (14) 2
TOTAL: 15 15618

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 138
newsfeed.neva.ru 51
ripco-out.feed.uzoreto.com 2
feeder3.feed-ams.uzoreto.com 2
TOTAL: 4 193
No colon-space in header
ripco-out.feed.uzoreto.com 6
feeder3.feed-ams.uzoreto.com 5
TOTAL: 2 11
TOTAL: 3 222

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9826 1634 5162 28 0 0 16%49:40:00
2rahul.net 21220 734 12106 26 0 0 3%49:39:22
3news.cmpublishers.com 38766 310 24800 1912 0 16 0%49:44:12
4feeder.erje.net 25700 162 24826 310 0 0 0%49:53:02
5news.uzoreto.com 13278 102 12756 166 0 0 0%49:34:20
6news.snarked.org 32108 36 19138 22 0 42 0%49:40:00
7fu-berlin.de 24810 26 24784 0 0 0 0%49:37:22
8newsfeed.neva.ru 23814 24 22686 32 0 0 0%49:40:00
9remote6hme0.ripco.com 0 0 0 0 0 6 0%49:40:00
TOTAL: 9 189522 3028 146258 2496 0 64 1%447:08:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com4.8 MB263.7 KB5.1 MB0.0 KB/s3.1 KB49:40:00
2rahul.net4.1 MB328.8 KB4.4 MB0.0 KB/s5.9 KB49:39:22
3news.cmpublishers.com1.1 MB5.2 MB6.3 MB0.0 KB/s2.9 KB49:44:12
4feeder.erje.net526.8 KB941.2 KB1.4 MB0.0 KB/s3.1 KB49:53:02
5news.uzoreto.com343.4 KB649.4 KB992.9 KB0.0 KB/s3.7 KB49:34:20
6fu-berlin.de204.2 KB0.0 KB204.2 KB0.0 KB/s7.9 KB49:37:22
7news.snarked.org184.9 KB87.8 KB272.8 KB0.0 KB/s4.7 KB49:40:00
8newsfeed.neva.ru90.3 KB66.5 KB156.8 KB0.0 KB/s2.8 KB49:40:00
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s049:40:00
TOTAL: 911.3 MB7.5 MB18.8 MB0.0 KB/s3.5 KB447:08:18
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 298 9302.7 MB 438 4 000:07:32
2shell3 16 4381.2 MB 40 2 003:51:46
TOTAL: 2 314 13684.0 MB 478 6 004:36:18

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 298 9302.7 MB 438 4 000:07:32
2? 16 4381.2 MB 40 2 003:51:46
TOTAL: 2 314 13684.0 MB 478 6 003:59:18

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 4.624 2.156 0.00003:51:46
84-105-134-55.cable.dynamic.v4.ziggo.nl 547.934 124.570 0.00000:36:34
ftupet.com 47.920 8.158 0.00000:07:32
d54c176a7.access.telenet.be 4.832 1.092 0.00000:00:12
124-169-1-165.dyn.iinet.net.au 0.404 0.084 0.00000:00:11
46.33.201.24 0.204 0.044 0.00000:00:00
80.80.195.45 0.600 0.130 0.00000:00:00
23.229.103.117 0.200 0.042 0.00000:00:00
TOTAL: 8 606.718 136.276 0.00004:36:18

NNRP no permission clients:

SystemConn
84-105-134-55.cable.dynamic.v4.ziggo.nl 5440
d54c176a7.access.telenet.be 48
80.80.195.45 6
124-169-1-165.dyn.iinet.net.au 4
23.229.103.117 2
46.33.201.24 2
TOTAL: 6 5502

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 8 0
TOTAL: 1 8 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1158 84.6%
2comp 96 7.0%
3misc 64 4.7%
4alt 34 2.5%
5sci 10 0.7%
6chi 4 0.3%
7news 2 0.1%
TOTAL: 7 1368100.0%

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

NewsgroupCount
1rec.arts.tv 632
2rec.food.cooking 392
3rec.bicycles.tech 90
4comp.sys.mac.system 68
5misc.phone.mobile.iphone 62
6alt.comp.os.windows-10 30
7rec.outdoors.rv-travel 24
8comp.mobile.android 22
9sci.electronics.repair 10
10rec.bicycles.misc 8
11comp.sys.mac.apps 6
12rec.radio.broadcasting 4
13rec.radio.swap 4
14chi.weather 4
15rec.video.satellite.tvro 2
16news.admin.net-abuse.misc 2
17alt.hvac 2
18rec.antiques.radio+phono 2
19misc.consumers.frugal-living 2
20alt.internet.wireless 2
TOTAL: 20 1368