Daily Usenet report for news.ripco.com

Jun 24 00:01:01 -- Jun 24 23:57:27

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Jun 24 06:14:57 remote5bge0 overchan[7812]: [ID 702911 news.error] input line too long, skipping
Jun 24 07:10:34 remote5bge0 overchan[7812]: [ID 702911 news.error] input line too long, skipping
Jun 24 09:07:53 remote5bge0 overchan[7812]: [ID 702911 news.error] input line too long, skipping
Jun 24 09:16:16 remote5bge0 overchan[7812]: [ID 702911 news.error] input line too long, skipping
Jun 24 09:32:33 remote5bge0 overchan[7812]: [ID 702911 news.error] input line too long, skipping
Jun 24 09:48:19 remote5bge0 overchan[7812]: [ID 702911 news.error] input line too long, skipping
Jun 24 13:32:11 remote5bge0 overchan[7812]: [ID 702911 news.error] input line too long, skipping
Jun 24 13:40:51 remote5bge0 overchan[7812]: [ID 702911 news.error] input line too long, skipping
Jun 24 16:48:18 remote5bge0 overchan[7812]: [ID 702911 news.error] input line too long, skipping
Jun 24 23:31:05 remote5bge0 overchan[7812]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 18829 32.2%2.9 MB 31.7%
inn 18511 31.7%3.7 MB 39.9%
nnrpd 17416 29.8%1.8 MB 19.7%
innfeed 3712 6.3%821.8 KB 8.7%
overchan 10 0.0%1.4 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 58480 100.0%9.2 MB100.0%

History cache:

ReasonCount%Count
Cache misses 176746 51.1%
Do not exist 169222 48.9%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 345968 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.004 0.0%232 0.000 0.017 0.500
article cleanup00:00:00.486 0.0%36566 0.000 0.013 0.039
article logging00:00:00.900 0.0%36928 0.000 0.024 0.504
article parse00:00:01.346 0.0%91912 0.000 0.015 0.029
article write00:01:22.918 0.0%29076 1.845 2.852 13.494
artlog/artparse00:00:00.000 0.0%12 0.000 0.000 0.000
data move00:00:00.372 0.0%356454 0.000 0.001 0.004
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:02.698 0.0%348030 0.001 0.008 0.017
history sync00:00:00.290 0.0%796 0.000 0.364 8.500
history write00:00:03.804 0.0%36570 0.009 0.104 3.787
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:36:47.836 99.8%392370 265.921 436.853 1300.711
nntp read00:00:03.050 0.0%391924 0.003 0.008 0.017
overview write00:00:00.256 0.0%29076 0.000 0.009 0.045
perl filter00:00:57.768 0.0%36558 1.298 1.580 2.449
python filter00:00:01.294 0.0%36572 0.000 0.035 0.090
site send00:00:02.022 0.0%87192 0.000 0.023 0.064
TOTAL: 47:42:02.88047:39:25.044 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.502 0.0%29488 0.000 0.017 0.054
article prepare00:00:00.000 0.0%9664 0.000 0.000 0.000
article read00:00:00.394 0.0%1882 0.000 0.209 4.111
backlog stats00:00:00.222 0.0%424630 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.970 0.0%276208 0.002 0.011 0.022
data write00:00:04.508 0.0%247266 0.009 0.018 0.048
idle47:51:02.416100.0%424630 239.744 405.677 1013.819
status file00:00:02.106 0.0%384 0.000 5.484 42.000
TOTAL: 47:51:31.57647:51:13.118100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:07:53.876 98.8%18430 0.333 611.713 43153.643
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:06.518 0.1%586802 0.000 0.011 0.047
readart00:00:23.212 0.2%2564 2.607 9.053 87.000
TOTAL: 03:10:13.35603:08:23.606 99.0%----

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 1148 30906 9646 18022 3238 31%94:49:08
2news.snarked.org 68 26410 7240 18466 704 27%62:46:28
3feeder3.feed-ams.uzoreto.com 574 15232 6086 8026 1120 39%47:18:46
4newsfeed.neva.ru 600 35094 4472 29032 1590 12%284:16:20
5ripco-out.news.tnetconsulting.net 4 30280 1002 29152 126 3%47:14:18
6newsfeed.fu-berlin.de 8 7250 332 6912 6 4%29:58:14
7news.lightlink.com 2 7812 182 7542 88 2%43:52:52
8news-in.rahul.net 574 15348 82 15262 4 0%47:29:28
9ripco-out.feeder.erje.net 574 30012 44 29334 634 0%47:18:26
10localhost 160 14 14 0 0 100%00:00:04
11news.cmpublishers.com 50 7452 4 7448 0 0%48:00:06
TOTAL: 11 3762 205810 29104 169196 7510 14%753:04:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com24.0 MB0.0 KB8.3 MB32.4 MB 74%2.6 KB
2news.snarked.org20.1 MB0.0 KB2.0 MB22.1 MB 90%2.8 KB
3ripco-out.news.tnetconsulting.net18.3 MB199.9 KB3.0 MB21.5 MB 85%19.5 KB
4feeder3.feed-ams.uzoreto.com15.4 MB0.0 KB3.8 MB19.1 MB 80%2.7 KB
5newsfeed.neva.ru13.3 MB3.1 KB5.7 MB19.0 MB 69%3.2 KB
6news.lightlink.com3.0 MB199.9 KB5.8 MB9.0 MB 33%34.1 KB
7news-in.rahul.net1.5 MB200.0 KB207.0 KB1.8 MB 78%22.0 KB
8newsfeed.fu-berlin.de1.3 MB0.0 KB154.9 KB1.4 MB 89%4.3 KB
9ripco-out.feeder.erje.net206.8 KB0.0 KB3.8 MB4.0 MB 5%6.0 KB
10localhost36.1 KB0.0 KB0.0 KB36.1 KB100%2.6 KB
11news.cmpublishers.com6.8 KB0.0 KB0.0 KB6.8 KB100%1.7 KB
TOTAL: 1197.0 MB602.9 KB32.8 MB130.4 MB 74%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 24 00:01:01 - 00:59:59 444 3.0% 0.131.3 MB 2.6% 0.37
Jun 24 01:00:00 - 01:59:59 458 3.1% 0.131.1 MB 2.3% 0.32
Jun 24 02:00:00 - 02:59:59 563 3.9% 0.161.6 MB 3.4% 0.46
Jun 24 03:00:00 - 03:59:59 624 4.3% 0.172.2 MB 4.6% 0.63
Jun 24 04:00:00 - 04:59:59 635 4.4% 0.181.9 MB 3.9% 0.53
Jun 24 05:00:00 - 05:59:59 756 5.2% 0.212.3 MB 4.6% 0.64
Jun 24 06:00:00 - 06:59:59 567 3.9% 0.162.0 MB 4.1% 0.57
Jun 24 07:00:00 - 07:59:59 540 3.7% 0.151.4 MB 2.8% 0.39
Jun 24 08:00:00 - 08:59:59 765 5.3% 0.212.5 MB 5.3% 0.73
Jun 24 09:00:00 - 09:59:59 901 6.2% 0.252.6 MB 5.4% 0.75
Jun 24 10:00:00 - 10:59:59 772 5.3% 0.212.8 MB 5.8% 0.81
Jun 24 11:00:00 - 11:59:59 743 5.1% 0.212.4 MB 4.9% 0.67
Jun 24 12:00:00 - 12:59:59 837 5.7% 0.233.7 MB 7.7% 1.07
Jun 24 13:00:00 - 13:59:59 766 5.3% 0.212.7 MB 5.5% 0.75
Jun 24 14:00:00 - 14:59:59 747 5.1% 0.212.1 MB 4.3% 0.59
Jun 24 15:00:00 - 15:59:59 669 4.6% 0.192.6 MB 5.4% 0.74
Jun 24 16:00:00 - 16:59:59 724 5.0% 0.203.1 MB 6.4% 0.89
Jun 24 17:00:00 - 17:59:59 588 4.0% 0.162.3 MB 4.7% 0.65
Jun 24 18:00:00 - 18:59:59 451 3.1% 0.131.5 MB 3.1% 0.42
Jun 24 19:00:00 - 19:59:59 479 3.3% 0.131.4 MB 2.9% 0.41
Jun 24 20:00:00 - 20:59:59 433 3.0% 0.121.1 MB 2.2% 0.31
Jun 24 21:00:00 - 21:59:59 285 2.0% 0.08816.0 KB 1.6% 0.23
Jun 24 22:00:00 - 22:59:59 432 3.0% 0.121.7 MB 3.6% 0.50
Jun 24 23:00:00 - 23:57:27 387 2.7% 0.111.4 MB 2.8% 0.41
TOTAL: 23:56:26 14566 100.0% 0.1748.6 MB 100.0% 0.58
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1630 1100 0 0 14 0 0 0 516
2newsfeed.neva.ru 844 327 0 1 5 0 0 0 511
3feeder3.feed-ams.uzoreto.com 563 278 0 0 5 0 0 0 280
4news.snarked.org 346 249 0 0 0 0 0 0 97
5ripco-out.feeder.erje.net 317 312 0 0 0 0 0 0 5
6newsfeed.fu-berlin.de 126 0 0 0 0 0 0 0 126
7ripco-out.news.tnetconsulting.net 72 36 0 1 0 0 0 0 35
8news.lightlink.com 44 0 0 1 0 0 0 0 43
9news-in.rahul.net 2 0 0 1 0 0 0 0 1
10news.cmpublishers.com 1 0 0 0 0 0 0 0 1
TOTAL: 10 3945 2302 0 4 24 0 0 0 1615

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1574
alt.binaries.ftd 120
scot.general 54
fido7.su.pol.news 42
perl.cpan.uploads 41
scinet.stats 30
aioe.news.assistenza 25
alt.binaries.e-book 24
alt.internet.research 20
wales.test 19
it.comp.os.win.windows10 17
it.tlc.cellulari.android 17
alt.binaries.3d.poser 15
free.it.scienza.fisica 14
alt.bestjobsusa.computer.jobs 13
free.willey 11
alt.binaries.pictures.earlmiller 11
alt.binaries.pictures.scenic 11
mozilla.dev.platform 8
alt.paranormal.spells 8
TOTAL: 126 2302

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

GroupsCount
fr.comp.securite 14
rec.travel.resorts.all-inclusive 7
fr.bienvenue 2
bit.listserv.catholic 1
TOTAL: 4 24

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 984
Too many newsgroups 922
Binary in non-binary group 624
EMP (phl) 222
Scoring filter (8) 54
HTML post 16
Scoring filter (10) 12
Scoring filter (9) 8
Scoring filter (11) 6
Scoring filter (18) 4
Scoring filter (13) 2
Scoring filter (16) 2
TOTAL: 12 2856

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 24
ripco-out.feed.uzoreto.com 6
TOTAL: 2 30
Including strange strings
newsfeed.fu-berlin.de 121
newsfeed.neva.ru 48
ripco-out.feed.uzoreto.com 10
news.snarked.org 1
feeder3.feed-ams.uzoreto.com 1
TOTAL: 5 181
No colon-space in header
ripco-out.feed.uzoreto.com 3
feeder3.feed-ams.uzoreto.com 3
TOTAL: 2 6
TOTAL: 3 217

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 24098 868 13546 54 0 0 3%47:51:02
2news.lightlink.com 10988 714 6584 26 0 0 6%47:45:08
3news.tnetconsulting.net 39690 70 27976 0 0 14 0%47:40:02
4news.snarked.org 36036 52 21604 14 0 96 0%47:40:06
5news.cmpublishers.com 41748 36 28400 298 0 26 0%47:38:34
6feeder.erje.net 28124 32 27838 124 0 0 0%47:40:04
7fu-berlin.de 26254 30 26184 0 0 206 0%47:49:58
8newsfeed.neva.ru 25226 26 24472 8 0 46 0%47:34:34
9news.uzoreto.com 13336 24 13008 22 0 0 0%47:46:02
10remote6hme0.ripco.com 14 8 0 6 0 0 57%02:15:56
TOTAL: 10 245514 1860 189612 552 0 388 0%431:41:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net10.9 MB117.7 KB11.0 MB0.1 KB/s12.2 KB47:51:02
2news.lightlink.com4.6 MB184.5 KB4.8 MB0.0 KB/s6.7 KB47:45:08
3news.tnetconsulting.net245.0 KB0.0 KB245.0 KB0.0 KB/s3.5 KB47:40:02
4news.snarked.org237.0 KB28.9 KB265.9 KB0.0 KB/s4.0 KB47:40:06
5feeder.erje.net200.2 KB411.8 KB611.9 KB0.0 KB/s3.9 KB47:40:04
6fu-berlin.de153.2 KB0.0 KB153.2 KB0.0 KB/s5.1 KB47:49:58
7news.cmpublishers.com148.3 KB861.7 KB1010.0 KB0.0 KB/s3.0 KB47:38:34
8newsfeed.neva.ru136.6 KB12.7 KB149.3 KB0.0 KB/s4.4 KB47:34:34
9news.uzoreto.com121.7 KB88.4 KB210.1 KB0.0 KB/s4.6 KB47:46:02
10remote6hme0.ripco.com22.1 KB28.1 KB50.2 KB0.0 KB/s3.6 KB02:15:56
TOTAL: 1016.8 MB1.7 MB18.5 MB0.0 KB/s7.8 KB431:41:26
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10562.9 MB 436 2 000:07:11
2shell3 30 4501.1 MB 54 12 003:02:50
TOTAL: 2 316 15064.1 MB 490 14 003:10:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10562.9 MB 436 2 000:07:11
2? 30 4501.1 MB 54 12 003:02:50
TOTAL: 2 316 15064.1 MB 490 14 003:10:02

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 5.936 9.186 0.00003:02:50
ftupet.com 47.324 21.144 0.00000:07:11
33.20.97.83.ro.ovo.sc 0.200 0.048 0.00000:00:00
192.241.220.59 0.200 0.052 0.00000:00:00
TOTAL: 4 53.660 30.430 0.00003:10:03

NNRP no permission clients:

SystemConn
33.20.97.83.ro.ovo.sc 2
192.241.220.59 2
TOTAL: 2 4

NNRP unrecognized commands (by host):

SystemConn
shell3 6
TOTAL: 1 6

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 6
TOTAL: 1 6

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 6 0
TOTAL: 1 6 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1342 89.1%
2chi 68 4.5%
3comp 54 3.6%
4alt 18 1.2%
5misc 16 1.1%
6sci 4 0.3%
7news 2 0.1%
8control 2 0.1%
TOTAL: 8 1506100.0%

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

NewsgroupCount
1rec.arts.tv 796
2rec.food.cooking 442
3rec.bicycles.tech 82
4chi.general 64
5comp.mail.sendmail 24
6alt.stupidity 12
7comp.sys.mac.system 12
8rec.bicycles.misc 10
9misc.phone.mobile.iphone 10
10rec.radio.broadcasting 6
11misc.consumers.frugal-living 6
12comp.sys.mac.apps 4
13comp.sys.mac.vintage 4
14sci.electronics.repair 4
15chi.weather 4
16comp.protocols.dns.bind 4
17rec.gardens.edible 4
18alt.test.test.test.test 2
19comp.unix.bsd.freebsd.misc 2
20rec.radio.swap 2
21control 2
22comp.mobile.android 2
23alt.radio.pirate 2
24alt.autos.porsche.944 2
25comp.internet.services.video.youtube 2
26news.groups.questions 2
TOTAL: 26 1506