Daily Usenet report for news.ripco.com

Jun 3 00:01:01 -- Jun 3 23:58:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Jun 3 10:06:28 remote5bge0 overchan[7509]: [ID 702911 news.error] input line too long, skipping
Jun 3 10:26:15 remote5bge0 overchan[7509]: [ID 702911 news.error] input line too long, skipping
Jun 3 10:44:59 remote5bge0 overchan[7509]: [ID 702911 news.error] input line too long, skipping
Jun 3 10:57:55 remote5bge0 overchan[7509]: [ID 702911 news.error] input line too long, skipping
Jun 3 11:23:39 remote5bge0 overchan[7509]: [ID 702911 news.error] input line too long, skipping
Jun 3 13:04:06 remote5bge0 overchan[7509]: [ID 702911 news.error] input line too long, skipping
Jun 3 15:18:50 remote5bge0 overchan[7509]: [ID 702911 news.error] input line too long, skipping
Jun 3 16:17:51 remote5bge0 overchan[7509]: [ID 702911 news.error] input line too long, skipping
Jun 3 17:01:03 remote5bge0 overchan[7509]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 35844 45.1%4.5 MB 36.0%
inn 21130 26.6%4.2 MB 33.8%
innd 18856 23.7%2.9 MB 23.6%
innfeed 3704 4.7%830.0 KB 6.6%
overchan 9 0.0%1.2 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 79545 100.0%12.4 MB100.0%

History cache:

ReasonCount%Count
Cache misses 206304 53.3%
Do not exist 180896 46.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 387200 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%282 0.000 0.000 0.000
article cleanup00:00:00.530 0.0%41766 0.000 0.013 0.042
article logging00:00:00.790 0.0%42188 0.000 0.019 0.080
article parse00:00:01.512 0.0%105764 0.000 0.014 0.038
article write00:01:45.804 0.1%33494 1.755 3.159 59.067
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.448 0.0%402870 0.000 0.001 0.006
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.650 0.0%388004 0.002 0.009 0.020
history sync00:00:00.272 0.0%792 0.000 0.343 2.500
history write00:00:05.076 0.0%41766 0.011 0.122 8.449
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:31:49.948 99.6%447118 231.272 382.695 1003.459
nntp read00:00:03.436 0.0%439828 0.002 0.008 0.020
overview write00:00:00.290 0.0%33494 0.000 0.009 0.030
perl filter00:01:08.028 0.0%41760 1.323 1.629 3.944
python filter00:00:01.638 0.0%41770 0.007 0.039 0.144
site send00:00:03.770 0.0%100472 0.004 0.038 0.429
TOTAL: 47:42:07.36647:35:05.192 99.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.112 0.0%33594 0.000 0.003 0.022
article prepare00:00:00.006 0.0%26352 0.000 0.000 0.010
article read00:00:00.644 0.0%5256 0.000 0.123 14.600
backlog stats00:00:00.252 0.0%495112 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.836 0.0%321616 0.001 0.006 0.017
data write00:00:04.926 0.0%288284 0.007 0.017 0.030
idle47:33:48.546100.0%495112 195.206 345.838 779.330
status file00:00:02.348 0.0%376 0.667 6.245 62.000
TOTAL: 47:34:15.92847:33:58.670100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:38:13.426 89.0%18664 0.333 894.418 68555.222
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:10.670 0.1%961402 0.000 0.011 1.000
readart00:00:22.840 0.1%3348 0.000 6.822 48.000
TOTAL: 05:12:42.52004:38:46.936 89.2%----

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
1ripco-out.feed.uzoreto.com 1146 30862 9012 19372 2478 29%94:45:00
2news.snarked.org 60 30756 8420 21654 682 27%59:20:50
3feeder3.feed-ams.uzoreto.com 576 21588 8100 11370 2118 37%47:09:48
4newsfeed.neva.ru 572 44054 5890 36660 1504 13%279:06:56
5ripco-out.news.tnetconsulting.net 2 35606 994 34448 164 2%47:51:04
6newsfeed.fu-berlin.de 4 16520 636 15868 16 3%45:56:22
7news-in.rahul.net 574 16906 148 16744 14 0%47:18:56
8news.lightlink.com 2 8030 120 7462 448 1%47:38:32
9news.cmpublishers.com 50 8360 40 8310 10 0%48:00:06
10ripco-out.feeder.erje.net 574 34868 22 34020 826 0%47:28:06
11localhost 156 10 10 0 0 100%00:00:00
TOTAL: 11 3716 247560 33392 205908 8260 13%764:35:40
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org23.0 MB0.0 KB2.0 MB24.9 MB 92%2.8 KB
2ripco-out.feed.uzoreto.com22.1 MB0.0 KB5.6 MB27.7 MB 79%2.5 KB
3feeder3.feed-ams.uzoreto.com20.4 MB0.0 KB4.2 MB24.6 MB 82%2.5 KB
4newsfeed.neva.ru16.8 MB5.1 KB4.8 MB21.6 MB 77%3.0 KB
5ripco-out.news.tnetconsulting.net9.0 MB0.0 KB2.8 MB11.8 MB 76%10.4 KB
6news-in.rahul.net5.4 MB0.0 KB784.9 KB6.2 MB 87%39.2 KB
7news.lightlink.com5.2 MB0.0 KB18.1 MB23.3 MB 22%41.9 KB
8newsfeed.fu-berlin.de4.7 MB0.0 KB246.2 KB4.9 MB 95%7.8 KB
9ripco-out.feeder.erje.net270.9 KB0.0 KB5.4 MB5.7 MB 4%6.8 KB
10news.cmpublishers.com202.5 KB0.0 KB14.9 KB217.4 KB 93%4.3 KB
11localhost26.2 KB0.0 KB0.0 KB26.2 KB100%2.6 KB
TOTAL: 11107.0 MB5.1 KB43.8 MB150.9 MB 70%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 3 00:01:01 - 00:59:59 448 2.7% 0.131.3 MB 2.3% 0.37
Jun 3 01:00:00 - 01:59:59 484 2.9% 0.132.3 MB 4.1% 0.65
Jun 3 02:00:00 - 02:59:59 555 3.3% 0.151.5 MB 2.8% 0.44
Jun 3 03:00:00 - 03:59:59 712 4.2% 0.201.7 MB 3.1% 0.49
Jun 3 04:00:00 - 04:59:59 743 4.4% 0.213.1 MB 5.5% 0.87
Jun 3 05:00:00 - 05:59:59 811 4.8% 0.232.6 MB 4.7% 0.73
Jun 3 06:00:00 - 06:59:59 684 4.1% 0.192.4 MB 4.3% 0.68
Jun 3 07:00:00 - 07:59:59 876 5.2% 0.242.4 MB 4.3% 0.67
Jun 3 08:00:00 - 08:59:59 929 5.5% 0.262.7 MB 4.9% 0.76
Jun 3 09:00:00 - 09:59:59 1016 6.1% 0.282.7 MB 4.9% 0.76
Jun 3 10:00:00 - 10:59:59 956 5.7% 0.273.2 MB 5.9% 0.92
Jun 3 11:00:00 - 11:59:59 1068 6.4% 0.303.0 MB 5.5% 0.85
Jun 3 12:00:00 - 12:59:59 835 5.0% 0.232.3 MB 4.3% 0.67
Jun 3 13:00:00 - 13:59:59 833 5.0% 0.232.5 MB 4.6% 0.72
Jun 3 14:00:00 - 14:59:59 838 5.0% 0.232.3 MB 4.1% 0.65
Jun 3 15:00:00 - 15:59:59 834 5.0% 0.232.8 MB 5.0% 0.79
Jun 3 16:00:00 - 16:59:59 797 4.8% 0.222.6 MB 4.7% 0.74
Jun 3 17:00:00 - 17:59:59 712 4.2% 0.202.6 MB 4.7% 0.73
Jun 3 18:00:00 - 18:59:59 682 4.1% 0.194.0 MB 7.3% 1.15
Jun 3 19:00:00 - 19:59:59 500 3.0% 0.142.0 MB 3.6% 0.57
Jun 3 20:00:00 - 20:59:59 368 2.2% 0.101.4 MB 2.6% 0.40
Jun 3 21:00:00 - 21:59:59 380 2.3% 0.111.1 MB 2.0% 0.32
Jun 3 22:00:00 - 22:59:59 307 1.8% 0.091.1 MB 2.0% 0.31
Jun 3 23:00:00 - 23:58:02 398 2.4% 0.111.5 MB 2.8% 0.45
TOTAL: 23:57:01 16766 100.0% 0.1955.1 MB 100.0% 0.65
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1239 761 0 0 3 0 0 0 475
2feeder3.feed-ams.uzoreto.com 1069 794 0 0 1 0 0 0 274
3newsfeed.neva.ru 823 355 0 1 2 0 0 0 465
4ripco-out.feeder.erje.net 414 413 0 0 0 0 0 0 1
5news.snarked.org 346 218 0 0 0 0 0 0 128
6news.lightlink.com 224 0 0 0 0 0 0 0 224
7newsfeed.fu-berlin.de 147 0 0 0 0 0 0 0 147
8ripco-out.news.tnetconsulting.net 87 25 0 0 0 0 0 0 62
9news.cmpublishers.com 8 4 0 0 0 0 0 0 4
10news-in.rahul.net 7 0 0 0 0 0 0 0 7
TOTAL: 10 4364 2570 0 1 6 0 0 0 1787

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1775
alt.binaries.ftd 176
fido7.su.pol.news 50
perl.cpan.uploads 47
scot.general 32
scinet.stats 30
it.tlc.cellulari.android 28
alt.binaries.pictures.scenic 19
free.it.scienza.fisica 19
alt.binaries.e-book 16
oesterreich.test 14
alt.binaries.3d.poser 14
alt.binaries.pictures.purebeauty 13
alt.binaries.nospam.female.bodyhair.pubes 12
wales.test 11
alt.binaries.pictures.earlmiller 10
aioe.news.assistenza 10
alt.binaries.pictures.rail 9
rocksolid.programming 8
alt.binaries.howard-stern 7
TOTAL: 140 2570

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

GroupsCount
pl.praca.oferowana 3
christnet.bible 1
rec.travel.resorts.all-inclusive 1
bit.listserv.catholic 1
TOTAL: 4 6

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1460
EMP (md5) 1022
Binary in non-binary group 434
EMP (phl) 150
Scoring filter (8) 42
Scoring filter (9) 14
Scoring filter (10) 8
Scoring filter (13) 4
Scoring filter (11) 4
HTML post 4
Scoring filter (15) 2
TOTAL: 11 3144

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
ripco-out.feed.uzoreto.com 1
TOTAL: 1 1
Bad Message-ID's offered
ripco-out.feeder.erje.net 22
feeder3.feed-ams.uzoreto.com 4
ripco-out.feed.uzoreto.com 2
TOTAL: 3 28
Including strange strings
newsfeed.fu-berlin.de 136
newsfeed.neva.ru 68
feeder3.feed-ams.uzoreto.com 8
news.snarked.org 1
TOTAL: 4 213
No colon-space in header
ripco-out.feed.uzoreto.com 1
TOTAL: 1 1
TOTAL: 4 243

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10990 2118 5874 6 0 0 19%47:39:06
2rahul.net 28106 1068 14926 14 0 4 3%47:47:56
3news.cmpublishers.com 46944 308 30726 2092 0 60 0%47:53:10
4feeder.erje.net 32820 190 31718 490 0 0 0%47:40:04
5news.uzoreto.com 16892 50 15860 102 0 0 0%47:39:46
6news.snarked.org 41378 36 24700 16 0 78 0%47:34:30
7news.tnetconsulting.net 48280 30 32274 2 0 48 0%47:40:00
8fu-berlin.de 30428 28 30400 0 0 0 0%47:51:18
9newsfeed.neva.ru 28482 24 27532 16 0 0 0%47:40:04
10remote6hme0.ripco.com 10 4 0 6 0 0 40%01:52:10
TOTAL: 10 284330 3856 214010 2744 0 190 1%431:18:04
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com7.4 MB43.6 KB7.4 MB0.0 KB/s3.6 KB47:39:06
2rahul.net5.4 MB76.5 KB5.5 MB0.0 KB/s5.2 KB47:47:56
3news.cmpublishers.com930.5 KB5.3 MB6.3 MB0.0 KB/s2.7 KB47:53:10
4feeder.erje.net728.0 KB1.4 MB2.1 MB0.0 KB/s3.2 KB47:40:04
5news.snarked.org203.0 KB36.6 KB239.6 KB0.0 KB/s4.6 KB47:34:30
6news.tnetconsulting.net185.0 KB8.0 KB193.0 KB0.0 KB/s6.0 KB47:40:00
7newsfeed.neva.ru170.6 KB39.5 KB210.1 KB0.0 KB/s5.3 KB47:40:04
8news.uzoreto.com166.0 KB426.5 KB592.6 KB0.0 KB/s3.9 KB47:39:46
9fu-berlin.de75.1 KB0.0 KB75.1 KB0.0 KB/s2.7 KB47:51:18
10remote6hme0.ripco.com14.1 KB32.7 KB46.8 KB0.0 KB/s4.7 KB01:52:10
TOTAL: 1015.2 MB7.4 MB22.6 MB0.0 KB/s3.5 KB431:18:04
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 14464.6 MB 474 2 000:07:28
2shell3 30 4541.1 MB 60 8 004:33:08
TOTAL: 2 316 19005.8 MB 534 10 005:09:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 14464.6 MB 474 2 000:07:28
2? 30 4541.1 MB 60 8 004:33:08
TOTAL: 2 316 19005.8 MB 534 10 004:40:37

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 7.410 13.910 0.00004:33:08
host81-129-173-246.range81-129.btcentralplus.com 462.568 129.506 0.00000:29:02
ftupet.com 48.572 22.036 0.00000:07:28
162.243.139.214 0.200 0.052 0.00000:00:00
183.136.225.45 0.200 0.052 0.00000:00:00
TOTAL: 5 518.950 165.556 0.00005:09:40

NNRP no permission clients:

SystemConn
host81-129-173-246.range81-129.btcentralplus.com 4576
162.243.139.214 2
183.136.225.45 2
TOTAL: 3 4580

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 1626 85.6%
2comp 130 6.8%
3chi 60 3.2%
4misc 42 2.2%
5alt 22 1.2%
6sci 12 0.6%
7news 8 0.4%
TOTAL: 7 1900100.0%

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

NewsgroupCount
1rec.arts.tv 1182
2rec.food.cooking 316
3rec.bicycles.tech 106
4comp.sys.mac.system 72
5chi.general 54
6comp.mobile.android 34
7misc.phone.mobile.iphone 28
8sci.electronics.repair 12
9rec.gardens.edible 12
10misc.consumers.frugal-living 12
11comp.sys.mac.apps 8
12alt.stupidity 8
13comp.protocols.dns.bind 8
14news.software.nntp 8
15rec.radio.broadcasting 6
16alt.coronavirus 6
17rec.radio.swap 4
18alt.security.alarms 4
19chi.weather 4
20alt.online-service.comcast 2
21comp.mail.pine 2
22comp.risks 2
23chi.forsale 2
24comp.mail.misc 2
25alt.dss.hack 2
26comp.sys.ibm.pc.games.strategic 2
27misc.transport.urban-transit 2
TOTAL: 27 1900