Daily Usenet report for news.ripco.com

Sep 20 00:01:01 -- Sep 20 23:57:57

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Sep 20 07:46:51 remote5bge0 overchan[4337]: [ID 702911 news.error] input line too long, skipping
Sep 20 07:48:09 remote5bge0 overchan[4337]: [ID 702911 news.error] input line too long, skipping
Sep 20 07:52:23 remote5bge0 overchan[4337]: [ID 702911 news.error] input line too long, skipping
Sep 20 08:13:05 remote5bge0 overchan[4337]: [ID 702911 news.error] input line too long, skipping
Sep 20 09:38:38 remote5bge0 overchan[4337]: [ID 702911 news.error] input line too long, skipping
Sep 20 14:10:14 remote5bge0 overchan[4337]: [ID 702911 news.error] input line too long, skipping
Sep 20 14:28:59 remote5bge0 overchan[4337]: [ID 702911 news.error] input line too long, skipping
Sep 20 14:59:08 remote5bge0 overchan[4337]: [ID 702911 news.error] input line too long, skipping
Sep 20 15:11:37 remote5bge0 overchan[4337]: [ID 702911 news.error] input line too long, skipping
Sep 20 15:25:08 remote5bge0 overchan[4337]: [ID 702911 news.error] input line too long, skipping
Sep 20 16:43:11 remote5bge0 overchan[4337]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 18143 32.9%2.8 MB 33.5%
nnrpd 17496 31.7%1.8 MB 21.5%
inn 15791 28.6%3.1 MB 36.1%
innfeed 3682 6.7%762.1 KB 8.8%
overchan 11 0.0%1.7 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 55125 100.0%8.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 153680 57.9%
Cache misses 111840 42.1%
Positive hits 0 0.0%
Negative hits 0 0.0%
TOTAL: 4 265520 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%100 0.000 0.000 0.000
article cleanup00:00:00.382 0.0%31326 0.000 0.012 0.070
article logging00:00:00.682 0.0%31620 0.000 0.022 0.179
article parse00:00:01.234 0.0%86982 0.000 0.014 0.053
article write00:01:11.196 0.0%23180 1.247 3.071 81.844
artlog/artparse00:00:00.000 0.0%6 0.000 0.000 0.000
data move00:00:00.296 0.0%282934 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.526 0.0%266662 0.000 0.009 0.020
history sync00:00:00.218 0.0%810 0.000 0.269 1.500
history write00:00:02.814 0.0%31330 0.007 0.090 1.345
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:57:30.784 99.8%316668 295.953 545.211 1843.702
nntp read00:00:02.550 0.0%314820 0.002 0.008 0.020
overview write00:00:00.216 0.0%23180 0.000 0.009 0.059
perl filter00:00:49.344 0.0%31324 1.208 1.575 4.056
python filter00:00:01.296 0.0%31328 0.000 0.041 0.145
site send00:00:02.272 0.0%69500 0.000 0.033 0.064
TOTAL: 48:02:14.11047:59:45.810 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.142 0.0%23932 0.000 0.006 0.050
article prepare00:00:00.008 0.0%7720 0.000 0.001 0.062
article read00:00:00.404 0.0%1666 0.000 0.242 72.000
backlog stats00:00:00.310 0.0%302236 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.672 0.0%190312 0.000 0.009 0.023
data write00:00:03.746 0.0%167340 0.009 0.022 0.045
idle47:34:55.462100.0%302236 291.989 566.761 2001.347
status file00:00:01.898 0.0%362 1.000 5.243 36.000
TOTAL: 47:35:22.96447:35:03.642100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:04:39.286 96.4%18288 18.317 605.823131531.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:13.748 0.1%1350200 0.000 0.010 0.287
readart00:00:22.174 0.2%2662 0.000 8.330 70.000
TOTAL: 03:11:38.47003:05:15.208 96.7%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 30760 13068 12920 4772 42%94:28:58
2newsfeed.neva.ru 640 13392 4910 7182 1300 36%273:42:48
3feeder3.feed-ams.uzoreto.com 574 8644 3050 4820 774 35%47:18:58
4ripco-out.news.tnetconsulting.net 6 28236 992 27128 116 3%52:46:22
5newsfeed.fu-berlin.de 2 9834 444 9362 28 4%41:35:10
6news-in.rahul.net 574 13002 406 12488 108 3%47:27:04
7news.lightlink.com 2 7802 306 7210 286 3%52:29:26
8ripco-out.feeder.erje.net 576 25266 50 24452 764 0%47:16:00
9news.cmpublishers.com 52 7380 16 7352 12 0%46:00:44
10localhost 150 4 4 0 0 100%00:00:02
TOTAL: 10 3724 144320 23246 112914 8160 16%703:05:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com34.4 MB0.0 KB9.3 MB43.7 MB 78%2.5 KB
2ripco-out.news.tnetconsulting.net20.0 MB0.0 KB2.8 MB22.8 MB 87%21.1 KB
3newsfeed.neva.ru14.9 MB0.0 KB3.9 MB18.8 MB 79%3.1 KB
4feeder3.feed-ams.uzoreto.com8.8 MB0.0 KB1.7 MB10.5 MB 84%2.8 KB
5newsfeed.fu-berlin.de3.6 MB0.0 KB920.1 KB4.5 MB 80%9.8 KB
6news-in.rahul.net3.4 MB0.0 KB3.5 MB6.9 MB 49%13.7 KB
7news.lightlink.com2.3 MB0.0 KB10.8 MB13.0 MB 17%22.6 KB
8ripco-out.feeder.erje.net273.6 KB29.7 KB4.4 MB4.7 MB 5%5.9 KB
9news.cmpublishers.com36.4 KB0.0 KB39.5 KB75.9 KB 47%2.7 KB
10localhost7.6 KB0.0 KB0.0 KB7.6 KB100%1.9 KB
TOTAL: 1087.8 MB29.7 KB37.3 MB125.1 MB 70%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 20 00:01:01 - 00:59:59 249 2.2% 0.07703.2 KB 1.5% 0.20
Sep 20 01:00:00 - 01:59:59 367 3.2% 0.101.5 MB 3.3% 0.43
Sep 20 02:00:00 - 02:59:59 377 3.3% 0.101.7 MB 3.9% 0.50
Sep 20 03:00:00 - 03:59:59 419 3.6% 0.121.3 MB 2.9% 0.37
Sep 20 04:00:00 - 04:59:59 473 4.1% 0.131.8 MB 3.9% 0.50
Sep 20 05:00:00 - 05:59:59 485 4.2% 0.131.8 MB 4.0% 0.51
Sep 20 06:00:00 - 06:59:59 522 4.5% 0.141.9 MB 4.1% 0.53
Sep 20 07:00:00 - 07:59:59 637 5.5% 0.181.8 MB 3.9% 0.50
Sep 20 08:00:00 - 08:59:59 612 5.3% 0.172.2 MB 4.8% 0.61
Sep 20 09:00:00 - 09:59:59 646 5.6% 0.183.1 MB 6.8% 0.87
Sep 20 10:00:00 - 10:59:59 670 5.8% 0.192.2 MB 4.9% 0.62
Sep 20 11:00:00 - 11:59:59 687 5.9% 0.192.8 MB 6.3% 0.80
Sep 20 12:00:00 - 12:59:59 714 6.2% 0.202.3 MB 5.0% 0.64
Sep 20 13:00:00 - 13:59:59 690 6.0% 0.191.8 MB 3.9% 0.50
Sep 20 14:00:00 - 14:59:59 596 5.2% 0.172.4 MB 5.4% 0.69
Sep 20 15:00:00 - 15:59:59 564 4.9% 0.161.4 MB 3.2% 0.41
Sep 20 16:00:00 - 16:59:59 613 5.3% 0.171.8 MB 4.0% 0.51
Sep 20 17:00:00 - 17:59:59 422 3.6% 0.121.8 MB 4.1% 0.52
Sep 20 18:00:00 - 18:59:59 357 3.1% 0.104.4 MB 9.8% 1.26
Sep 20 19:00:00 - 19:59:59 328 2.8% 0.092.6 MB 5.7% 0.73
Sep 20 20:00:00 - 20:59:59 320 2.8% 0.09904.1 KB 2.0% 0.25
Sep 20 21:00:00 - 21:59:59 280 2.4% 0.08817.0 KB 1.8% 0.23
Sep 20 22:00:00 - 22:59:59 261 2.3% 0.07981.0 KB 2.1% 0.27
Sep 20 23:00:00 - 23:57:57 277 2.4% 0.081.3 MB 2.9% 0.38
TOTAL: 23:56:56 11566 100.0% 0.1345.1 MB 100.0% 0.54
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2387 1763 0 0 1 0 0 0 623
2newsfeed.neva.ru 679 345 0 0 0 0 0 0 334
3feeder3.feed-ams.uzoreto.com 388 181 0 0 0 0 0 0 207
4ripco-out.feeder.erje.net 382 378 0 1 0 0 0 0 3
5newsfeed.fu-berlin.de 136 1 0 0 0 0 0 0 135
6news.lightlink.com 133 1 0 0 0 0 0 0 132
7ripco-out.news.tnetconsulting.net 57 16 0 0 0 0 0 0 41
8news-in.rahul.net 54 0 0 0 0 0 0 0 54
9news.cmpublishers.com 9 0 0 0 0 0 0 0 9
TOTAL: 9 4225 2685 0 1 1 0 0 0 1538

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2061
alt.binaries.ftd 135
scot.general 33
alt.binaries.3d.poser 32
scinet.stats 29
fr.usenet.documents 25
fido7.su.pol.news 19
alt.binaries.pictures.wallpaper 18
alt.binaries.pictures.earlmiller 18
alt.binaries.e-book 14
alt.binaries.test.yenc 13
free.it.scienza.fisica 12
alt.binaries.pictures.scenic 12
alt.binaries.multimedia.erotica.amateur 11
it.comp.os.win.windows10 11
free.software 11
fr.usenet.abus.nocem 10
it.tlc.cellulari.android 9
linux.debian.changes 8
alt.binaries.nospam.breasts.natural 8
TOTAL: 137 2685

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1348
EMP (md5) 992
EMP (phl) 224
Binary in non-binary group 138
Scoring filter (9) 18
Scoring filter (8) 18
Scoring filter (15) 10
Scoring filter (10) 6
Scoring filter (13) 6
EMP (fsl) 6
Scoring filter (16) 2
Scoring filter (11) 2
Scoring filter (14) 2
HTML post 2
Scoring filter (17) 2
TOTAL: 15 2776

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 112
newsfeed.neva.ru 30
ripco-out.feed.uzoreto.com 2
ripco-out.news.tnetconsulting.net 2
feeder3.feed-ams.uzoreto.com 1
TOTAL: 5 147
No colon-space in header
feeder3.feed-ams.uzoreto.com 2
ripco-out.feeder.erje.net 1
TOTAL: 2 3
TOTAL: 3 168

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 25018 466 21416 240 0 2 1%47:53:30
2rahul.net 18346 416 10520 28 0 0 2%47:40:10
3news.lightlink.com 8564 130 5514 18 0 0 1%47:40:10
4news.cmpublishers.com 30914 98 22144 402 0 890 0%47:47:50
5news.tnetconsulting.net 37878 46 22114 6 0 8 0%47:42:40
6fu-berlin.de 20852 28 20824 0 0 0 0%47:40:10
7newsfeed.neva.ru 18708 20 18114 2 0 0 0%47:49:30
8news.uzoreto.com 6608 10 6422 16 0 0 0%47:40:00
9remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:04
10news.snarked.org 0 0 0 0 0 22914 0%47:40:10
TOTAL: 10 166894 1214 127068 718 0 23814 0%430:46:14
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net8.5 MB2.7 MB11.2 MB0.1 KB/s25.8 KB47:40:10
2feeder.erje.net1.3 MB610.6 KB1.9 MB0.0 KB/s2.8 KB47:53:30
3news.lightlink.com366.4 KB162.0 KB528.3 KB0.0 KB/s3.6 KB47:40:10
4news.cmpublishers.com245.9 KB1.1 MB1.3 MB0.0 KB/s2.7 KB47:47:50
5news.tnetconsulting.net155.3 KB11.8 KB167.1 KB0.0 KB/s3.2 KB47:42:40
6fu-berlin.de110.7 KB0.0 KB110.7 KB0.0 KB/s4.0 KB47:40:10
7newsfeed.neva.ru83.3 KB6.9 KB90.1 KB0.0 KB/s4.1 KB47:49:30
8news.uzoreto.com66.4 KB40.7 KB107.1 KB0.0 KB/s4.1 KB47:40:00
9remote6hme0.ripco.com0.0 KB13.9 KB13.9 KB0.0 KB/s2.3 KB01:12:04
10news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:10
TOTAL: 1010.8 MB4.6 MB15.4 MB0.0 KB/s8.2 KB430:46:14
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10663.9 MB 434 2 000:11:42
2shell3.ripco.com 20 5281.3 MB 50 2 002:59:16
TOTAL: 2 306 15945.2 MB 484 4 003:11:26

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10663.9 MB 434 2 000:11:42
2*.ripco.com 20 5281.3 MB 50 2 002:59:16
TOTAL: 2 306 15945.2 MB 484 4 003:10:59

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 6.572 3.822 0.00002:59:16
ftupet.com 47.502 21.292 0.00000:11:42
84-105-134-55.cable.dynamic.v4.ziggo.nl 3.240 0.920 0.00000:00:24
i5c741edc.versanet.de 0.622 0.158 0.00000:00:03
TOTAL: 4 57.936 26.192 0.00003:11:26

NNRP no permission clients:

SystemConn
84-105-134-55.cable.dynamic.v4.ziggo.nl 32
i5c741edc.versanet.de 6
TOTAL: 2 38

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3.ripco.com 6 0
TOTAL: 1 6 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1344 84.3%
2misc 126 7.9%
3alt 70 4.4%
4comp 34 2.1%
5chi 16 1.0%
6sci 2 0.1%
7news 2 0.1%
TOTAL: 7 1594100.0%

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

NewsgroupCount
1rec.food.cooking 676
2rec.arts.tv 586
3misc.phone.mobile.iphone 118
4alt.comp.os.windows-10 68
5rec.bicycles.tech 60
6rec.gardens.edible 14
7chi.general 12
8comp.mobile.android 12
9comp.sys.apple2 8
10misc.consumers.frugal-living 8
11comp.sys.mac.system 6
12comp.mail.sendmail 4
13chi.weather 4
14rec.radio.broadcasting 4
15rec.heraldry 2
16comp.sys.mac.apps 2
17news.admin.net-abuse.misc 2
18sci.electronics.repair 2
19comp.security.ssh 2
20rec.radio.swap 2
21alt.bbs.searchlight 2
TOTAL: 21 1594