Daily Usenet report for news.ripco.com

Jun 26 00:01:03 -- Jun 26 23:57:52

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Jun 26 05:18:12 remote5bge0 overchan[27017]: [ID 702911 news.error] input line too long, skipping
Jun 26 07:53:45 remote5bge0 overchan[27017]: [ID 702911 news.error] input line too long, skipping
Jun 26 08:24:07 remote5bge0 overchan[27017]: [ID 702911 news.error] input line too long, skipping
Jun 26 10:18:52 remote5bge0 overchan[27017]: [ID 702911 news.error] input line too long, skipping
Jun 26 13:10:15 remote5bge0 overchan[27017]: [ID 702911 news.error] input line too long, skipping
Jun 26 21:46:11 remote5bge0 overchan[27017]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 23679 34.9%2.6 MB 26.2%
inn 20728 30.6%3.6 MB 36.1%
innd 19971 29.5%3.1 MB 30.9%
innfeed 3426 5.1%694.9 KB 6.8%
overchan 6 0.0%0.9 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 67812 100.0%10.0 MB100.0%

History cache:

ReasonCount%Count
Cache misses 150988 50.0%
Do not exist 150932 50.0%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 301920 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%130 0.000 0.000 0.000
article cleanup00:00:00.456 0.0%41160 0.000 0.011 0.049
article logging00:00:00.778 0.0%41454 0.000 0.019 0.134
article parse00:00:01.516 0.0%92722 0.000 0.016 0.053
article write00:00:53.310 0.0%30630 0.358 1.740 108.755
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.338 0.0%303218 0.000 0.001 0.008
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:04.752 0.0%302904 0.000 0.016 2.815
history sync00:00:00.170 0.0%816 0.000 0.208 1.000
history write00:00:10.070 0.0%41162 0.014 0.245 50.817
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:56:12.066 99.8%344776 179.209 500.534 1383.331
nntp read00:00:02.324 0.0%338284 0.001 0.007 0.018
overview write00:00:00.232 0.0%30630 0.000 0.008 0.039
perl filter00:01:00.962 0.0%41138 1.209 1.482 4.017
python filter00:00:01.664 0.0%41154 0.000 0.040 0.085
site send00:00:02.342 0.0%91790 0.000 0.026 0.058
TOTAL: 48:02:10.29647:58:30.980 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.180 0.0%30982 0.000 0.006 0.037
article prepare00:00:00.004 0.0%16576 0.000 0.000 0.050
article read00:00:00.408 0.0%3374 0.000 0.121 17.750
backlog stats00:00:00.262 0.0%335576 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.008 0.0%216706 0.000 0.009 0.019
data write00:00:03.004 0.0%186644 0.006 0.016 0.032
idle47:48:30.664 99.9%335576 105.440 512.881 1051.231
status file00:00:02.048 0.0%356 0.000 5.753 30.000
TOTAL: 47:52:38.05047:48:38.578 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:20:41.892 95.3%17820 0.333 877.772121952.800
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.838 0.1%1133078 0.000 0.009 3.000
readart00:00:18.142 0.1%1662 0.000 10.916 43.000
TOTAL: 04:33:36.52204:21:09.872 95.5%----

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 1156 35592 10624 21858 3110 29%95:27:24
2news.snarked.org 52 29210 8546 20194 470 29%59:08:10
3newsfeed.neva.ru 400 30110 6690 20686 2734 22%186:30:04
4feeder3.feed-ams.uzoreto.com 578 17236 3242 10946 3048 18%47:38:58
5news-in.rahul.net 578 17102 280 16778 44 1%47:50:00
6news.cmpublishers.com 52 7534 276 7210 48 3%47:59:58
7newsfeed.fu-berlin.de 10 9422 272 9138 12 2%39:19:52
8ripco-out.feeder.erje.net 580 31728 114 30706 908 0%49:28:10
9localhost 162 16 16 0 0 100%00:00:02
10news.lightlink.com 2 910 2 854 54 0%07:47:40
TOTAL: 10 3570 178860 30062 138370 10428 16%581:10:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com26.5 MB0.0 KB8.4 MB34.9 MB 75%2.6 KB
2news.snarked.org25.6 MB0.0 KB1.9 MB27.5 MB 93%3.1 KB
3newsfeed.neva.ru17.7 MB0.0 KB8.7 MB26.4 MB 67%2.9 KB
4feeder3.feed-ams.uzoreto.com9.6 MB0.0 KB7.7 MB17.2 MB 55%2.8 KB
5news-in.rahul.net2.9 MB0.0 KB397.9 KB3.3 MB 88%10.4 KB
6newsfeed.fu-berlin.de1.4 MB0.0 KB136.8 KB1.5 MB 91%5.4 KB
7news.cmpublishers.com925.2 KB0.0 KB225.1 KB1.1 MB 80%3.6 KB
8ripco-out.feeder.erje.net331.4 KB0.0 KB8.6 MB8.9 MB 3%9.0 KB
9localhost39.8 KB0.0 KB0.0 KB39.8 KB100%2.5 KB
10news.lightlink.com14.5 KB0.0 KB4.0 MB4.0 MB 0%73.3 KB
TOTAL: 1084.9 MB0.0 KB40.0 MB124.9 MB 67%3.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 26 00:01:03 - 00:59:59 464 3.0% 0.131.3 MB 3.0% 0.38
Jun 26 01:00:00 - 01:59:59 483 3.2% 0.131.3 MB 2.9% 0.36
Jun 26 02:00:00 - 02:59:59 554 3.6% 0.151.4 MB 3.3% 0.41
Jun 26 03:00:00 - 03:59:59 570 3.7% 0.161.4 MB 3.3% 0.41
Jun 26 04:00:00 - 04:59:59 636 4.2% 0.181.7 MB 4.0% 0.50
Jun 26 05:00:00 - 05:59:59 1365 8.9% 0.383.1 MB 7.2% 0.88
Jun 26 06:00:00 - 06:59:59 698 4.6% 0.192.2 MB 5.0% 0.62
Jun 26 07:00:00 - 07:59:59 742 4.8% 0.211.9 MB 4.5% 0.55
Jun 26 08:00:00 - 08:59:59 782 5.1% 0.221.8 MB 4.2% 0.52
Jun 26 09:00:00 - 09:59:59 743 4.9% 0.211.9 MB 4.3% 0.53
Jun 26 10:00:00 - 10:59:59 820 5.4% 0.232.4 MB 5.5% 0.67
Jun 26 11:00:00 - 11:59:59 848 5.5% 0.242.4 MB 5.6% 0.69
Jun 26 12:00:00 - 12:59:59 740 4.8% 0.212.3 MB 5.3% 0.65
Jun 26 13:00:00 - 13:59:59 748 4.9% 0.212.1 MB 4.9% 0.61
Jun 26 14:00:00 - 14:59:59 756 4.9% 0.212.2 MB 5.0% 0.62
Jun 26 15:00:00 - 15:59:59 745 4.9% 0.212.7 MB 6.1% 0.76
Jun 26 16:00:00 - 16:59:59 719 4.7% 0.202.0 MB 4.7% 0.57
Jun 26 17:00:00 - 17:59:59 503 3.3% 0.141.6 MB 3.7% 0.45
Jun 26 18:00:00 - 18:59:59 525 3.4% 0.151.6 MB 3.7% 0.45
Jun 26 19:00:00 - 19:59:59 444 2.9% 0.121.3 MB 3.0% 0.37
Jun 26 20:00:00 - 20:59:59 374 2.4% 0.101.4 MB 3.1% 0.38
Jun 26 21:00:00 - 21:59:59 383 2.5% 0.111.1 MB 2.5% 0.31
Jun 26 22:00:00 - 22:59:59 311 2.0% 0.091.0 MB 2.3% 0.29
Jun 26 23:00:00 - 23:57:52 362 2.4% 0.101.2 MB 2.7% 0.35
TOTAL: 23:56:49 15315 100.0% 0.1843.2 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1557 579 0 0 1 0 0 0 977
2feeder3.feed-ams.uzoreto.com 1523 1153 0 0 0 0 0 0 370
3newsfeed.neva.ru 1409 430 0 0 3 0 0 0 976
4ripco-out.feeder.erje.net 454 449 0 0 0 0 0 0 5
5news.snarked.org 238 106 0 0 1 0 0 0 131
6newsfeed.fu-berlin.de 121 0 0 0 0 0 0 0 121
7news.lightlink.com 58 0 0 0 0 0 0 0 58
8news.cmpublishers.com 31 2 0 0 0 0 0 0 29
9news-in.rahul.net 22 0 0 0 0 0 0 0 22
TOTAL: 9 5413 2719 0 0 5 0 0 0 2689

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1856
alt.binaries.ftd 230
fido7.su.pol.news 49
scot.general 48
perl.cpan.uploads 40
alt.bestjobsusa.computer.jobs 37
alt.binaries.nl 35
it.comp.os.win.windows10 30
alt.my.job.sucks 22
free.it.scienza.fisica 20
alt.jobs.jobsearch 18
it.tlc.cellulari.android 17
alt.binaries.3d.poser 15
free.willey 13
att.jobs 13
alt.binaries.e-book 13
at.jobs 12
alt.binaries.movies.xvid 10
alt.binaries.pictures.earlmiller 10
mozilla.dev.ui-alerts 10
TOTAL: 117 2719

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

GroupsCount
pl.praca.oferowana 3
christnet.theology 1
bit.listserv.catholic 1
TOTAL: 3 5

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3710
Too many newsgroups 882
Binary in non-binary group 320
EMP (phl) 62
Scoring filter (8) 44
Scoring filter (9) 26
Scoring filter (10) 8
Scoring filter (11) 6
Scoring filter (13) 2
Scoring filter (16) 2
TOTAL: 10 5062

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 100
newsfeed.neva.ru 39
ripco-out.feed.uzoreto.com 7
feeder3.feed-ams.uzoreto.com 1
TOTAL: 4 147
No colon-space in header
ripco-out.feed.uzoreto.com 1
TOTAL: 1 1
TOTAL: 3 166

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 12224 2312 5132 16 0 0 18%47:40:00
2rahul.net 20736 740 12914 18 0 20 3%47:40:00
3news.uzoreto.com 16722 90 16250 128 0 48 0%47:37:30
4feeder.erje.net 29616 84 28722 36 0 40 0%47:40:02
5news.cmpublishers.com 40918 46 29432 566 0 44 0%47:40:00
6news.snarked.org 34720 44 21464 12 0 76 0%47:46:56
7fu-berlin.de 28240 42 28156 0 0 228 0%47:32:06
8newsfeed.neva.ru 0 0 0 0 0 23702 0%47:40:00
9remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:14
TOTAL: 9 183182 3358 142070 782 0 24158 1%382:28:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com6.6 MB20.5 KB6.6 MB0.0 KB/s2.9 KB47:40:00
2rahul.net2.8 MB43.9 KB2.8 MB0.0 KB/s3.8 KB47:40:00
3feeder.erje.net311.7 KB95.1 KB406.8 KB0.0 KB/s3.4 KB47:40:02
4news.uzoreto.com300.0 KB619.6 KB919.6 KB0.0 KB/s4.2 KB47:37:30
5news.cmpublishers.com252.5 KB1.9 MB2.2 MB0.0 KB/s3.7 KB47:40:00
6news.snarked.org152.7 KB28.8 KB181.6 KB0.0 KB/s3.2 KB47:46:56
7fu-berlin.de128.3 KB0.0 KB128.3 KB0.0 KB/s3.1 KB47:32:06
8newsfeed.neva.ru0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
9remote6hme0.ripco.com0.0 KB33.2 KB33.2 KB0.0 KB/s5.5 KB01:12:14
TOTAL: 910.5 MB2.8 MB13.2 MB0.0 KB/s3.3 KB382:28:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 6881.8 MB 344 4 000:07:54
2shell3 46 282841.8 KB 38 12 004:14:47
TOTAL: 2 332 9702.6 MB 382 16 004:32:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 6881.8 MB 344 4 000:07:54
2? 46 282841.8 KB 38 12 004:14:47
TOTAL: 2 332 9702.6 MB 382 16 004:22:41

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 8.922 3.328 0.00004:14:47
ftupet.com 45.520 23.052 0.00000:07:54
d54c176a7.access.telenet.be 76.038 21.754 0.00000:04:47
84-106-232-24.cable.dynamic.v4.ziggo.nl 57.276 15.386 0.00000:02:33
84-105-134-55.cable.dynamic.v4.ziggo.nl 25.904 7.322 0.00000:02:24
ppp118-211-201-42.bras1.syd2.internode.on.net 0.200 0.054 0.00000:00:00
board.census.shodan.io 0.200 0.052 0.00000:00:00
TOTAL: 7 214.060 70.948 0.00004:32:28

NNRP no permission clients:

SystemConn
d54c176a7.access.telenet.be 752
84-106-232-24.cable.dynamic.v4.ziggo.nl 570
84-105-134-55.cable.dynamic.v4.ziggo.nl 256
board.census.shodan.io 2
ppp118-211-201-42.bras1.syd2.internode.on.net 2
TOTAL: 5 1582

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 16 0
TOTAL: 1 16 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 826 85.2%
2comp 86 8.9%
3alt 28 2.9%
4sci 14 1.4%
5chi 8 0.8%
6ba 6 0.6%
7soc 2 0.2%
TOTAL: 7 970100.0%

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

NewsgroupCount
1rec.arts.tv 496
2rec.food.cooking 282
3comp.sys.mac.system 80
4rec.bicycles.tech 36
5alt.stupidity 20
6sci.electronics.repair 14
7alt.dss.hack 8
8chi.weather 8
9comp.protocols.dns.bind 6
10rec.radio.swap 6
11rec.radio.broadcasting 4
12ba.food 4
13soc.history.what-if 2
14ba.internet 2
15rec.puzzles 2
TOTAL: 15 970