Daily Usenet report for news.ripco.com

Nov 7 00:01:01 -- Nov 7 23:57:55

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Nov 7 10:03:29 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 15:29:02 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 15:42:50 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 17:15:23 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 17:17:43 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 17:56:19 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 18:09:11 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 20:21:24 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 20:28:03 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 20:31:58 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 20:36:45 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 20:44:45 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 20:52:04 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 21:32:44 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 21:41:14 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping
Nov 7 22:27:04 remote5bge0 overchan[23858]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 18669 32.6%3.7 MB 40.6%
innd 17775 31.0%2.8 MB 30.8%
nnrpd 17154 29.9%1.8 MB 19.7%
innfeed 3678 6.4%818.0 KB 8.8%
overchan 16 0.0%2.7 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 57294 100.0%9.0 MB100.0%

History cache:

ReasonCount%Count
Cache misses 175890 51.7%
Do not exist 164340 48.3%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 340230 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%70 0.000 0.000 0.000
article cleanup00:00:00.428 0.0%36888 0.000 0.012 0.041
article logging00:00:00.850 0.0%37398 0.000 0.023 0.400
article parse00:00:01.366 0.0%92170 0.000 0.015 0.040
article write00:01:35.996 0.1%28388 1.824 3.382 142.475
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.358 0.0%350484 0.000 0.001 0.005
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.344 0.0%341740 0.002 0.007 0.016
history sync00:00:00.214 0.0%814 0.000 0.263 4.000
history write00:00:03.424 0.0%36888 0.000 0.093 1.600
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:57:00.960 99.8%387650 223.440 445.301 1199.882
nntp read00:00:03.098 0.0%387144 0.001 0.008 0.017
overview write00:00:00.284 0.0%28388 0.000 0.010 0.040
perl filter00:00:53.816 0.0%36886 1.157 1.459 2.409
python filter00:00:01.392 0.0%36888 0.000 0.038 0.128
site send00:00:02.094 0.0%85118 0.007 0.025 0.092
TOTAL: 48:02:18.20247:59:46.624 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.130 0.0%28244 0.000 0.005 0.053
article prepare00:00:00.006 0.0%21592 0.000 0.000 0.042
article read00:00:00.672 0.0%4688 0.000 0.143 23.667
backlog stats00:00:00.326 0.0%457792 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.840 0.0%285276 0.003 0.010 0.020
data write00:00:04.990 0.0%257372 0.010 0.019 0.034
idle47:33:41.110100.0%457792 195.872 374.015 1240.963
status file00:00:02.870 0.0%372 0.500 7.715 111.000
TOTAL: 47:34:14.12047:33:52.944100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:29:28.240 96.5%18206 18.536 294.861 9894.761
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:05.770 0.1%502904 0.000 0.011 0.046
readart00:00:20.254 0.4%2646 2.769 7.655 35.500
TOTAL: 01:32:40.24201:29:54.264 97.0%----

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 1164 32800 9708 18512 4580 29%94:45:28
2feeder3.feed-ams.uzoreto.com 580 17722 6822 9784 1116 38%47:19:34
3news.snarked.org 48 25864 6210 19336 318 24%57:53:00
4newsfeed.neva.ru 584 30712 4220 25242 1250 13%276:56:04
5ripco-out.news.tnetconsulting.net 2 29168 692 28358 118 2%45:39:48
6newsfeed.fu-berlin.de 2 13284 602 12674 8 4%42:14:10
7news-in.rahul.net 574 15256 60 15134 62 0%47:27:32
8ripco-out.feeder.erje.net 574 30220 48 29224 948 0%47:16:52
9news.cmpublishers.com 48 8226 42 8178 6 0%48:00:06
10news.lightlink.com 2 4804 6 4664 134 0%31:06:08
11localhost 148 2 2 0 0 100%00:00:02
TOTAL: 11 3726 208058 28412 171106 8540 13%738:38:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com24.0 MB0.0 KB8.4 MB32.3 MB 74%2.3 KB
2news.snarked.org16.8 MB0.0 KB1.2 MB18.0 MB 93%2.8 KB
3feeder3.feed-ams.uzoreto.com16.3 MB0.0 KB2.5 MB18.8 MB 86%2.4 KB
4ripco-out.news.tnetconsulting.net12.9 MB0.0 KB2.7 MB15.6 MB 82%19.7 KB
5newsfeed.neva.ru12.3 MB8.6 KB3.4 MB15.7 MB 78%2.9 KB
6newsfeed.fu-berlin.de5.5 MB0.0 KB173.4 KB5.7 MB 97%9.6 KB
7news-in.rahul.net310.8 KB0.0 KB4.0 MB4.4 MB 6%36.5 KB
8news.cmpublishers.com125.4 KB0.0 KB8.7 KB134.1 KB 93%2.8 KB
9news.lightlink.com93.8 KB0.0 KB5.8 MB5.9 MB 1%42.8 KB
10ripco-out.feeder.erje.net76.3 KB0.0 KB8.1 MB8.2 MB 0%8.4 KB
11localhost3.5 KB0.0 KB0.0 KB3.5 KB100%1.7 KB
TOTAL: 1188.3 MB8.6 KB36.4 MB124.7 MB 70%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 7 00:01:01 - 00:59:59 225 1.6% 0.06748.4 KB 1.7% 0.21
Nov 7 01:00:00 - 01:59:59 387 2.7% 0.111.2 MB 2.7% 0.34
Nov 7 02:00:00 - 02:59:59 489 3.5% 0.141.6 MB 3.7% 0.46
Nov 7 03:00:00 - 03:59:59 620 4.4% 0.171.6 MB 3.7% 0.45
Nov 7 04:00:00 - 04:59:59 614 4.3% 0.172.9 MB 6.6% 0.81
Nov 7 05:00:00 - 05:59:59 597 4.2% 0.171.7 MB 3.9% 0.48
Nov 7 06:00:00 - 06:59:59 653 4.6% 0.182.3 MB 5.2% 0.64
Nov 7 07:00:00 - 07:59:59 613 4.3% 0.171.8 MB 4.2% 0.52
Nov 7 08:00:00 - 08:59:59 798 5.6% 0.222.4 MB 5.6% 0.69
Nov 7 09:00:00 - 09:59:59 754 5.3% 0.212.8 MB 6.5% 0.81
Nov 7 10:00:00 - 10:59:59 788 5.6% 0.222.7 MB 6.2% 0.77
Nov 7 11:00:00 - 11:59:59 901 6.4% 0.253.3 MB 7.5% 0.93
Nov 7 12:00:00 - 12:59:59 1000 7.1% 0.282.6 MB 6.0% 0.75
Nov 7 13:00:00 - 13:59:59 842 5.9% 0.232.1 MB 4.8% 0.60
Nov 7 14:00:00 - 14:59:59 692 4.9% 0.191.6 MB 3.7% 0.45
Nov 7 15:00:00 - 15:59:59 779 5.5% 0.221.9 MB 4.3% 0.53
Nov 7 16:00:00 - 16:59:59 689 4.9% 0.191.9 MB 4.5% 0.55
Nov 7 17:00:00 - 17:59:59 633 4.5% 0.181.6 MB 3.7% 0.46
Nov 7 18:00:00 - 18:59:59 437 3.1% 0.122.3 MB 5.3% 0.66
Nov 7 19:00:00 - 19:59:59 388 2.7% 0.111.0 MB 2.4% 0.30
Nov 7 20:00:00 - 20:59:59 390 2.8% 0.111.0 MB 2.3% 0.29
Nov 7 21:00:00 - 21:59:59 336 2.4% 0.09874.4 KB 2.0% 0.24
Nov 7 22:00:00 - 22:59:59 320 2.3% 0.09924.1 KB 2.1% 0.26
Nov 7 23:00:00 - 23:57:55 224 1.6% 0.06751.6 KB 1.7% 0.22
TOTAL: 23:56:54 14169 100.0% 0.1643.7 MB 100.0% 0.52
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2344 1819 0 0 6 0 0 0 519
2newsfeed.neva.ru 675 394 0 1 7 0 0 0 273
3feeder3.feed-ams.uzoreto.com 561 310 0 0 1 0 0 0 250
4ripco-out.feeder.erje.net 474 473 0 0 0 0 0 0 1
5news.snarked.org 160 58 0 0 2 0 0 0 100
6newsfeed.fu-berlin.de 158 0 0 0 0 0 0 0 158
7ripco-out.news.tnetconsulting.net 59 30 0 0 0 0 0 0 29
8news.lightlink.com 36 0 0 0 0 0 0 0 36
9news-in.rahul.net 31 0 0 0 0 0 0 0 31
10news.cmpublishers.com 2 2 0 0 0 0 0 0 0
TOTAL: 10 4500 3086 0 1 16 0 0 0 1397

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2238
alt.binaries.ftd 266
de.soc.arbeitslos 39
alt.bestjobsusa.computer.jobs 38
nntp4net.test 35
scinet.stats 31
it.tlc.cellulari.android 25
fido7.su.pol.news 23
alt.binaries.nospam.breasts.natural 17
free.it.scienza.fisica 17
alt.my.job.sucks 16
alt.binaries.pictures.earlmiller 15
alt.jobs.jobsearch 15
alt.binaries.pictures.purebeauty 13
alt.binaries.pictures.scenic 13
linux.debian.maint.emacsen 12
alt.binaries.e-book 12
cn.bbs.sci.mechanics 12
aus.jobs 11
alt.binaries.pictures.erotica.vintage 10
TOTAL: 123 3086

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

GroupsCount
pl.praca.oferowana 10
rec.travel.resorts.all-inclusive 2
fr.comp.securite 2
bit.listserv.catholic 1
alt.christnet.religion 1
TOTAL: 5 16

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 906
Too many newsgroups 866
Binary in non-binary group 228
EMP (phl) 226
Scoring filter (9) 34
Scoring filter (8) 18
HTML post 4
Scoring filter (11) 2
Scoring filter (13) 2
Scoring filter (10) 2
TOTAL: 10 2288

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 32
ripco-out.feed.uzoreto.com 14
TOTAL: 2 46
Including strange strings
newsfeed.fu-berlin.de 151
ripco-out.feed.uzoreto.com 52
newsfeed.neva.ru 49
feeder3.feed-ams.uzoreto.com 1
TOTAL: 4 253
TOTAL: 2 299

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 12802 1954 5496 250 0 0 15%47:40:00
2rahul.net 25970 846 13614 8 0 0 3%47:34:18
3news.cmpublishers.com 41858 132 25870 1762 0 296 0%47:52:04
4feeder.erje.net 28498 84 27482 120 0 0 0%47:40:04
5news.uzoreto.com 11840 50 11346 70 0 0 0%47:34:26
6news.snarked.org 38176 30 21818 2 0 12 0%47:40:02
7fu-berlin.de 25354 26 25328 0 0 0 0%47:51:10
8news.tnetconsulting.net 43994 24 27686 0 0 0 0%47:40:00
9newsfeed.neva.ru 24484 18 23982 8 0 0 0%47:40:04
10remote6hme0.ripco.com 14 8 0 6 0 0 57%02:32:06
TOTAL: 10 252990 3172 182622 2226 0 308 1%431:44:14
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net10.9 MB75.4 KB11.0 MB0.1 KB/s13.2 KB47:34:18
2news.lightlink.com8.8 MB1.3 MB10.1 MB0.1 KB/s4.7 KB47:40:00
3news.cmpublishers.com429.5 KB4.6 MB5.0 MB0.0 KB/s2.7 KB47:52:04
4feeder.erje.net231.5 KB422.3 KB653.8 KB0.0 KB/s3.2 KB47:40:04
5news.snarked.org168.0 KB6.2 KB174.2 KB0.0 KB/s5.4 KB47:40:02
6news.uzoreto.com163.6 KB193.2 KB356.8 KB0.0 KB/s3.0 KB47:34:26
7news.tnetconsulting.net128.9 KB0.0 KB128.9 KB0.0 KB/s5.4 KB47:40:00
8newsfeed.neva.ru118.5 KB21.0 KB139.5 KB0.0 KB/s5.4 KB47:40:04
9fu-berlin.de81.3 KB0.0 KB81.3 KB0.0 KB/s3.1 KB47:51:10
10remote6hme0.ripco.com13.7 KB25.8 KB39.5 KB0.0 KB/s2.8 KB02:32:06
TOTAL: 1021.1 MB6.6 MB27.6 MB0.0 KB/s5.2 KB431:44:14
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 11143.0 MB 478 2 000:08:54
2shell3.ripco.com 4 4161.1 MB 36 0 001:23:35
TOTAL: 2 290 15304.1 MB 514 2 001:32:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 11143.0 MB 478 2 000:08:54
2*.ripco.com 4 4161.1 MB 36 0 001:23:35
TOTAL: 2 290 15304.1 MB 514 2 001:32:29

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 2.180 4.224 0.00001:23:35
ftupet.com 46.528 21.512 0.00000:08:54
87.123.200.216 0.200 0.050 0.00000:00:00
192.241.211.215 0.200 0.050 0.00000:00:00
TOTAL: 4 49.108 25.836 0.00001:32:31

NNRP no permission clients:

SystemConn
192.241.211.215 2
87.123.200.216 2
TOTAL: 2 4

Newsgroup request counts (by category):

CategoryCountPct
1rec 1238 80.9%
2alt 182 11.9%
3comp 40 2.6%
4misc 40 2.6%
5chi 18 1.2%
6sci 8 0.5%
7news 4 0.3%
TOTAL: 7 1530100.0%

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

NewsgroupCount
1rec.food.cooking 552
2rec.arts.tv 528
3alt.comp.os.windows-10 172
4rec.bicycles.tech 142
5misc.phone.mobile.iphone 36
6comp.mobile.android 28
7chi.eats 8
8sci.electronics.repair 8
9rec.radio.broadcasting 6
10chi.general 6
11rec.radio.shortwave 6
12comp.sys.mac.system 6
13comp.mail.sendmail 6
14alt.games.warcraft 6
15alt.video.dvd 4
16misc.consumers.frugal-living 4
17chi.weather 4
18rec.radio.swap 4
19news.admin.net-abuse.usenet 2
20news.software.nntp 2
TOTAL: 20 1530