Daily Usenet report for news.ripco.com

Jun 8 00:01:01 -- Jun 8 23:57:17

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Jun 8 07:00:39 remote5bge0 overchan[7204]: [ID 702911 news.error] input line too long, skipping
Jun 8 08:53:15 remote5bge0 overchan[7204]: [ID 702911 news.error] input line too long, skipping
Jun 8 08:56:10 remote5bge0 overchan[7204]: [ID 702911 news.error] input line too long, skipping
Jun 8 09:20:28 remote5bge0 overchan[7204]: [ID 702911 news.error] input line too long, skipping
Jun 8 12:54:11 remote5bge0 overchan[7204]: [ID 702911 news.error] input line too long, skipping
Jun 8 12:55:50 remote5bge0 overchan[7204]: [ID 702911 news.error] input line too long, skipping
Jun 8 20:17:05 remote5bge0 overchan[7204]: [ID 702911 news.error] input line too long, skipping
Jun 8 20:59:11 remote5bge0 overchan[7204]: [ID 702911 news.error] input line too long, skipping
Jun

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 35496 44.9%4.4 MB 35.9%
inn 21158 26.8%4.2 MB 33.9%
innd 18789 23.8%2.9 MB 23.8%
innfeed 3578 4.5%797.5 KB 6.4%
overchan 8 0.0%1.1 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 79031 100.0%12.3 MB100.0%

History cache:

ReasonCount%Count
Cache misses 205400 53.1%
Do not exist 181344 46.9%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 386744 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%124 0.000 0.000 0.000
article cleanup00:00:00.510 0.0%42098 0.000 0.012 0.047
article logging00:00:00.946 0.0%42434 0.000 0.022 0.500
article parse00:00:01.470 0.0%104032 0.000 0.014 0.044
article write00:01:27.708 0.1%32740 1.292 2.679 15.491
artlog/artparse00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:00.338 0.0%397390 0.000 0.001 0.003
hishave/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.612 0.0%389324 0.004 0.009 0.017
history sync00:00:00.352 0.0%792 0.000 0.444 2.000
history write00:00:04.456 0.0%42100 0.013 0.106 5.000
hiswrite/artparse00:00:00.002 0.0%2 1.000 1.000 1.000
idle47:52:32.874 99.7%445704 223.497 386.698 843.100
nntp read00:00:03.492 0.0%438420 0.001 0.008 0.015
overview write00:00:00.322 0.0%32740 0.000 0.010 0.050
perl filter00:01:06.096 0.0%42092 1.306 1.570 2.423
python filter00:00:01.598 0.0%42096 0.000 0.038 0.164
site send00:00:02.490 0.0%98202 0.006 0.025 0.055
TOTAL: 48:02:01.04247:55:26.266 99.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.574 0.0%32730 0.000 0.018 0.060
article prepare00:00:00.014 0.0%38720 0.000 0.000 0.016
article read00:00:00.682 0.0%6108 0.000 0.112 10.286
backlog stats00:00:00.288 0.0%530302 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.352 0.0%330726 0.002 0.010 0.018
data write00:00:05.000 0.0%297916 0.009 0.017 0.030
idle47:33:42.346100.0%530302 192.271 322.877 756.808
status file00:00:02.156 0.0%342 1.000 6.304 34.000
TOTAL: 47:34:13.87647:33:54.412100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:29:28.406 89.1%18748 17.824 862.407121294.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:07.750 0.0%754200 0.000 0.010 3.000
readart00:00:24.950 0.1%3204 1.423 7.787 48.500
TOTAL: 05:02:32.88804:30:01.106 89.2%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 34750 10590 20144 4016 30%94:48:22
2news.snarked.org 42 29824 7762 21194 868 26%47:29:38
3feeder3.feed-ams.uzoreto.com 574 18914 6704 10778 1432 35%47:19:16
4newsfeed.neva.ru 592 43602 5868 35810 1924 13%278:49:28
5ripco-out.news.tnetconsulting.net 2 39578 1022 38352 204 2%52:24:52
6newsfeed.fu-berlin.de 2 16128 560 15530 38 3%45:38:12
7news.lightlink.com 2 7796 162 7596 38 2%47:38:32
8news-in.rahul.net 574 16692 64 16626 2 0%47:19:16
9ripco-out.feeder.erje.net 574 34752 22 33930 800 0%47:17:10
10news.cmpublishers.com 50 9462 20 9428 14 0%48:00:00
11localhost 150 4 4 0 0 100%00:00:00
TOTAL: 11 3710 251502 32778 209388 9336 13%756:44:46
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com27.6 MB0.0 KB7.6 MB35.2 MB 78%2.5 KB
2news.snarked.org21.7 MB0.0 KB2.2 MB23.9 MB 90%2.8 KB
3ripco-out.news.tnetconsulting.net18.1 MB474.2 KB3.3 MB21.8 MB 82%18.2 KB
4feeder3.feed-ams.uzoreto.com17.0 MB0.0 KB3.8 MB20.7 MB 81%2.6 KB
5newsfeed.neva.ru16.5 MB0.0 KB6.3 MB22.8 MB 72%3.0 KB
6newsfeed.fu-berlin.de5.6 MB0.0 KB1.9 MB7.5 MB 74%12.9 KB
7news.lightlink.com3.1 MB0.0 KB2.6 MB5.7 MB 54%29.1 KB
8news-in.rahul.net1.3 MB0.0 KB4.5 KB1.4 MB 99%21.0 KB
9ripco-out.feeder.erje.net104.1 KB0.0 KB5.7 MB5.8 MB 1%7.2 KB
10news.cmpublishers.com35.0 KB0.0 KB29.1 KB64.1 KB 54%1.9 KB
11localhost10.7 KB0.0 KB0.0 KB10.7 KB100%2.7 KB
TOTAL: 11111.1 MB474.2 KB33.3 MB144.9 MB 76%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 8 00:01:01 - 00:59:59 382 2.3% 0.111.5 MB 2.8% 0.44
Jun 8 01:00:00 - 01:59:59 479 2.9% 0.131.5 MB 2.7% 0.42
Jun 8 02:00:00 - 02:59:59 584 3.6% 0.161.9 MB 3.6% 0.55
Jun 8 03:00:00 - 03:59:59 652 4.0% 0.182.2 MB 4.0% 0.62
Jun 8 04:00:00 - 04:59:59 700 4.3% 0.192.1 MB 3.9% 0.60
Jun 8 05:00:00 - 05:59:59 695 4.3% 0.192.1 MB 3.8% 0.59
Jun 8 06:00:00 - 06:59:59 703 4.3% 0.202.0 MB 3.6% 0.56
Jun 8 07:00:00 - 07:59:59 863 5.3% 0.242.7 MB 5.0% 0.78
Jun 8 08:00:00 - 08:59:59 841 5.2% 0.232.7 MB 4.9% 0.76
Jun 8 09:00:00 - 09:59:59 837 5.1% 0.233.2 MB 5.8% 0.90
Jun 8 10:00:00 - 10:59:59 1004 6.2% 0.283.3 MB 6.0% 0.93
Jun 8 11:00:00 - 11:59:59 1029 6.3% 0.294.2 MB 7.8% 1.20
Jun 8 12:00:00 - 12:59:59 862 5.3% 0.242.8 MB 5.1% 0.79
Jun 8 13:00:00 - 13:59:59 857 5.2% 0.242.6 MB 4.8% 0.74
Jun 8 14:00:00 - 14:59:59 849 5.2% 0.243.1 MB 5.7% 0.89
Jun 8 15:00:00 - 15:59:59 925 5.7% 0.262.8 MB 5.2% 0.80
Jun 8 16:00:00 - 16:59:59 775 4.7% 0.222.3 MB 4.3% 0.66
Jun 8 17:00:00 - 17:59:59 779 4.8% 0.222.7 MB 4.9% 0.76
Jun 8 18:00:00 - 18:59:59 520 3.2% 0.141.8 MB 3.3% 0.50
Jun 8 19:00:00 - 19:59:59 528 3.2% 0.151.6 MB 2.9% 0.45
Jun 8 20:00:00 - 20:59:59 437 2.7% 0.121.5 MB 2.8% 0.43
Jun 8 21:00:00 - 21:59:59 325 2.0% 0.091.0 MB 1.9% 0.29
Jun 8 22:00:00 - 22:59:59 341 2.1% 0.091.7 MB 3.1% 0.48
Jun 8 23:00:00 - 23:57:17 358 2.2% 0.101.1 MB 2.1% 0.34
TOTAL: 23:56:16 16325 100.0% 0.1954.3 MB 100.0% 0.64
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2017 1546 0 0 1 0 0 0 470
2newsfeed.neva.ru 1007 414 0 0 0 0 0 0 593
3feeder3.feed-ams.uzoreto.com 719 358 0 0 1 0 0 0 360
4news.snarked.org 432 331 0 0 0 0 0 0 101
5ripco-out.feeder.erje.net 400 395 0 0 3 0 0 0 2
6newsfeed.fu-berlin.de 126 0 0 0 0 0 0 0 126
7ripco-out.news.tnetconsulting.net 95 31 0 3 0 0 0 0 61
8news.lightlink.com 27 0 0 0 0 0 0 0 27
9news.cmpublishers.com 9 2 0 0 0 0 0 0 7
10news-in.rahul.net 1 1 0 0 0 0 0 0 0
TOTAL: 10 4833 3078 0 3 5 0 0 0 1747

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2230
alt.binaries.ftd 190
perl.cpan.uploads 61
aioe.news.assistenza 57
scot.general 40
fido7.su.pol.news 39
scinet.stats 30
it.tlc.cellulari.android 30
alt.binaries.e-book 23
alt.paranormal.spells 22
perl.perl6.users 20
it.comp.os.win.windows10 16
uk.net.news.moderation 16
alt.binaries.pictures.scenic 13
alt.binaries.3d.poser 9
alt.binaries.pictures.purebeauty 8
alt.binaries.pictures.earlmiller 8
alt.bestjobsusa.computer.jobs 8
alt.binaries.nospam.female.bodyhair.pubes 8
alt.binaries.mma 8
TOTAL: 136 3078

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

GroupsCount
misc.taxes.moderated 3
alt.christnet.religion 1
bit.listserv.catholic 1
TOTAL: 3 5

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1398
EMP (md5) 1074
Binary in non-binary group 358
EMP (phl) 240
Scoring filter (8) 38
Scoring filter (9) 16
Scoring filter (11) 10
Scoring filter (10) 10
Scoring filter (13) 4
Scoring filter (16) 4
TOTAL: 10 3152

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 28
ripco-out.feed.uzoreto.com 8
feeder3.feed-ams.uzoreto.com 4
TOTAL: 3 40
Including strange strings
newsfeed.fu-berlin.de 106
newsfeed.neva.ru 51
ripco-out.feed.uzoreto.com 7
feeder3.feed-ams.uzoreto.com 2
news.snarked.org 1
TOTAL: 5 167
No colon-space in header
ripco-out.feed.uzoreto.com 2
feeder3.feed-ams.uzoreto.com 2
TOTAL: 2 4
TOTAL: 3 211

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 38118 3464 27214 958 0 18 9%47:41:50
2news.lightlink.com 10468 1916 5558 22 0 0 18%47:40:02
3rahul.net 28230 948 14518 20 0 0 3%47:40:10
4news.cmpublishers.com 48994 222 30142 1888 0 60 0%47:40:08
5news.uzoreto.com 15478 46 14872 84 0 0 0%47:40:10
6newsfeed.neva.ru 27358 32 26658 10 0 0 0%47:40:10
7news.snarked.org 41338 22 24560 6 0 50 0%47:49:00
8news.tnetconsulting.net 51554 22 31670 0 0 56 0%47:40:04
9fu-berlin.de 29608 20 29588 0 0 0 0%47:40:10
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:08
TOTAL: 10 291152 6692 204780 2994 0 184 2%430:23:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1feeder.erje.net9.5 MB2.7 MB12.1 MB0.1 KB/s2.8 KB47:41:50
2news.lightlink.com7.3 MB426.6 KB7.7 MB0.0 KB/s4.1 KB47:40:02
3rahul.net6.4 MB37.9 KB6.4 MB0.0 KB/s6.8 KB47:40:10
4news.cmpublishers.com742.0 KB5.1 MB5.8 MB0.0 KB/s2.8 KB47:40:08
5news.tnetconsulting.net343.9 KB0.0 KB343.9 KB0.0 KB/s15.6 KB47:40:04
6newsfeed.neva.ru326.8 KB25.5 KB352.4 KB0.0 KB/s8.4 KB47:40:10
7news.snarked.org324.4 KB14.3 KB338.7 KB0.0 KB/s12.1 KB47:49:00
8news.uzoreto.com249.6 KB394.9 KB644.5 KB0.0 KB/s5.0 KB47:40:10
9fu-berlin.de98.6 KB0.0 KB98.6 KB0.0 KB/s4.9 KB47:40:10
10remote6hme0.ripco.com0.0 KB30.4 KB30.4 KB0.0 KB/s5.1 KB01:12:08
TOTAL: 1025.2 MB8.6 MB33.8 MB0.0 KB/s3.6 KB430:23:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 12543.9 MB 484 2 000:07:40
2shell3 24 6941.8 MB 46 2 004:24:01
TOTAL: 2 310 19485.6 MB 530 4 004:59:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 12543.9 MB 484 2 000:07:40
2? 24 6941.8 MB 46 2 004:24:01
TOTAL: 2 310 19485.6 MB 530 4 004:31:42

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 5.502 3.520 0.00004:24:01
host81-129-173-246.range81-129.btcentralplus.com 421.956 116.164 0.00000:26:07
ftupet.com 48.160 21.994 0.00000:07:40
84-105-134-55.cable.dynamic.v4.ziggo.nl 36.916 9.166 0.00000:01:46
45.79.172.148.li.binaryedge.ninja 0.200 0.048 0.00000:00:00
192.35.169.48 0.200 0.050 0.00000:00:00
TOTAL: 6 512.934 150.942 0.00004:59:36

NNRP no permission clients:

SystemConn
host81-129-173-246.range81-129.btcentralplus.com 4176
84-105-134-55.cable.dynamic.v4.ziggo.nl 368
45.79.172.148.li.binaryedge.ninja 2
192.35.169.48 2
TOTAL: 4 4548

NNRP unrecognized commands (by host):

SystemConn
shell3 8
TOTAL: 1 8

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 8
TOTAL: 1 8

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 6 0
TOTAL: 1 6 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1598 82.0%
2alt 174 8.9%
3comp 114 5.9%
4chi 40 2.1%
5misc 12 0.6%
6news 6 0.3%
7sci 2 0.1%
8seattle 2 0.1%
TOTAL: 8 1948100.0%

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

NewsgroupCount
1rec.arts.tv 968
2rec.food.cooking 474
3alt.comp.os.windows-10 162
4rec.bicycles.tech 148
5comp.sys.mac.system 44
6comp.mobile.android 42
7chi.general 36
8comp.sys.mac.apps 18
9misc.phone.mobile.iphone 12
10alt.stupidity 8
11rec.radio.broadcasting 6
12comp.mail.sendmail 6
13chi.weather 4
14alt.cellular.verizon 2
15rec.radio.swap 2
16sci.electronics.repair 2
17alt.smokers 2
18news.admin.net-abuse.usenet 2
19news.software.readers 2
20seattle.general 2
21comp.protocols.dns.bind 2
22comp.mail.elm 2
23news.groups.questions 2
TOTAL: 23 1948