Daily Usenet report for news.ripco.com

Oct 16 00:01:01 -- Oct 16 23:58:01

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Oct 16 01:53:39 remote5bge0 overchan[25318]: [ID 702911 news.error] input line too long, skipping
Oct 16 02:19:27 remote5bge0 overchan[25318]: [ID 702911 news.error] input line too long, skipping
Oct 16 02:31:37 remote5bge0 overchan[25318]: [ID 702911 news.error] input line too long, skipping
Oct 16 03:09:44 remote5bge0 overchan[25318]: [ID 702911 news.error] input line too long, skipping
Oct 16 11:38:43 remote5bge0 overchan[25318]: [ID 702911 news.error] input line too long, skipping
Oct 16 14:02:59 remote5bge0 overchan[25318]: [ID 702911 news.error] input line too long, skipping
Oct 16 16:10:18 remote5bge0 overchan[25318]: [ID 702911 news.error] input line too long, skipping
Oct 16 16:23:47 remote5bge0 overchan[25318]: [ID 702911 news.error] input line too long, skipping
Oct 16 23:27:52 remote5bge0 overchan[25318]: [ID 702911 news.error] input line too long, skipping
Oct 16 23:33:24 remote5bge0 overchan[25318]: [ID 702911 news.error] input line too long, skipping
Oct 16 23:44:42 remote5bge0 overchan[25318]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 18659 32.6%3.6 MB 40.4%
innd 17853 31.2%2.8 MB 31.2%
nnrpd 17138 29.9%1.8 MB 19.7%
innfeed 3592 6.3%801.1 KB 8.7%
overchan 11 0.0%1.9 KB 0.0%
controlchan 6 0.0%1.1 KB 0.0%
TOTAL: 6 57259 100.0%9.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 178392 51.1%
Cache misses 170800 48.9%
Positive hits 0 0.0%
Negative hits 0 0.0%
TOTAL: 4 349192 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%90 0.000 0.000 0.000
article cleanup00:00:00.502 0.0%36984 0.000 0.014 0.056
article logging00:00:00.722 0.0%37308 0.000 0.019 0.214
article parse00:00:01.274 0.0%94128 0.000 0.014 0.031
article write00:01:20.756 0.0%27586 1.391 2.927 40.180
artlog/artparse00:00:00.000 0.0%16 0.000 0.000 0.000
data move00:00:00.416 0.0%356492 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:02.936 0.0%350728 0.000 0.008 0.020
history sync00:00:00.228 0.0%786 0.000 0.290 1.667
history write00:00:03.700 0.0%36998 0.000 0.100 1.615
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:36:54.486 99.8%395044 254.254 433.912 1127.064
nntp read00:00:02.918 0.0%395144 0.001 0.007 0.017
overview write00:00:00.330 0.0%27586 0.000 0.012 0.053
perl filter00:00:55.992 0.0%36982 1.212 1.514 2.800
python filter00:00:01.378 0.0%36986 0.000 0.037 0.117
site send00:00:02.738 0.0%82738 0.007 0.033 0.071
TOTAL: 47:41:57.42047:39:28.376 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.130 0.0%27928 0.000 0.005 0.047
article prepare00:00:00.000 0.0%7344 0.000 0.000 0.000
article read00:00:00.316 0.0%1436 0.000 0.220 72.000
backlog stats00:00:00.300 0.0%416594 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.222 0.0%266594 0.000 0.008 0.017
data write00:00:05.066 0.0%239154 0.010 0.021 0.038
idle47:51:56.744100.0%416594 217.132 413.632 1109.896
status file00:00:01.716 0.0%348 1.000 4.931 45.000
TOTAL: 47:52:26.21847:52:06.494100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:21:09.714 87.8%17362 4.667 73.132 12606.938
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.440 0.2%211080 0.000 0.012 0.143
readart00:00:15.486 1.1%1488 1.750 10.407 36.000
TOTAL: 00:24:06.07800:21:27.640 89.0%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
news@sfere.anjou.terraraq.org.uk002002
TOTAL002002

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 27624 9022 16478 2124 32%94:38:44
2feeder3.feed-ams.uzoreto.com 574 20720 6542 9730 4448 31%47:19:30
3newsfeed.neva.ru 600 27176 5426 20468 1282 19%277:45:20
4news.snarked.org 38 28072 4788 22914 370 17%49:16:08
5ripco-out.news.tnetconsulting.net 4 30142 888 29150 104 2%43:28:10
6newsfeed.fu-berlin.de 2 13342 590 12736 16 4%47:28:50
7news.lightlink.com 2 7778 154 7516 108 1%52:29:26
8news-in.rahul.net 574 14306 46 14200 60 0%47:20:04
9ripco-out.feeder.erje.net 574 29294 28 28332 934 0%47:17:50
10news.cmpublishers.com 52 7846 12 7824 10 0%47:59:56
11localhost 150 4 4 0 0 100%00:00:00
TOTAL: 11 3718 206304 27500 169348 9456 13%755:03:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com23.4 MB0.0 KB5.0 MB28.4 MB 82%2.6 KB
2feeder3.feed-ams.uzoreto.com16.8 MB0.0 KB7.9 MB24.7 MB 68%2.3 KB
3newsfeed.neva.ru15.8 MB2.8 KB3.5 MB19.2 MB 82%2.9 KB
4news.snarked.org13.9 MB0.0 KB1.4 MB15.2 MB 91%3.0 KB
5ripco-out.news.tnetconsulting.net13.6 MB0.0 KB1.7 MB15.4 MB 88%15.9 KB
6newsfeed.fu-berlin.de5.0 MB0.0 KB294.7 KB5.3 MB 94%8.9 KB
7news.lightlink.com1.9 MB0.0 KB6.7 MB8.7 MB 22%34.0 KB
8news-in.rahul.net1019.7 KB0.0 KB2.5 MB3.5 MB 28%34.0 KB
9ripco-out.feeder.erje.net59.8 KB0.0 KB6.1 MB6.2 MB 0%6.6 KB
10news.cmpublishers.com40.4 KB0.0 KB55.3 KB95.7 KB 42%4.4 KB
11localhost16.1 KB0.0 KB0.0 KB16.1 KB100%4.0 KB
TOTAL: 1191.5 MB2.8 KB35.2 MB126.7 MB 72%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 16 00:01:01 - 00:59:59 329 2.4% 0.091.0 MB 2.2% 0.29
Oct 16 01:00:00 - 01:59:59 413 3.0% 0.111.1 MB 2.4% 0.32
Oct 16 02:00:00 - 02:59:59 588 4.3% 0.161.9 MB 4.0% 0.53
Oct 16 03:00:00 - 03:59:59 642 4.7% 0.181.6 MB 3.5% 0.45
Oct 16 04:00:00 - 04:59:59 677 4.9% 0.192.0 MB 4.4% 0.58
Oct 16 05:00:00 - 05:59:59 673 4.9% 0.192.3 MB 5.0% 0.66
Oct 16 06:00:00 - 06:59:59 620 4.5% 0.172.1 MB 4.6% 0.61
Oct 16 07:00:00 - 07:59:59 680 4.9% 0.193.6 MB 7.8% 1.02
Oct 16 08:00:00 - 08:59:59 707 5.1% 0.202.4 MB 5.2% 0.68
Oct 16 09:00:00 - 09:59:59 757 5.5% 0.212.2 MB 4.8% 0.63
Oct 16 10:00:00 - 10:59:59 900 6.5% 0.252.6 MB 5.6% 0.73
Oct 16 11:00:00 - 11:59:59 831 6.0% 0.232.8 MB 6.0% 0.79
Oct 16 12:00:00 - 12:59:59 857 6.2% 0.243.3 MB 7.2% 0.94
Oct 16 13:00:00 - 13:59:59 754 5.5% 0.212.2 MB 4.8% 0.64
Oct 16 14:00:00 - 14:59:59 653 4.7% 0.181.9 MB 4.2% 0.54
Oct 16 15:00:00 - 15:59:59 573 4.2% 0.161.6 MB 3.5% 0.46
Oct 16 16:00:00 - 16:59:59 543 3.9% 0.151.6 MB 3.4% 0.45
Oct 16 17:00:00 - 17:59:59 539 3.9% 0.151.8 MB 4.0% 0.52
Oct 16 18:00:00 - 18:59:59 513 3.7% 0.143.2 MB 6.9% 0.91
Oct 16 19:00:00 - 19:59:59 322 2.3% 0.091.1 MB 2.3% 0.30
Oct 16 20:00:00 - 20:59:59 300 2.2% 0.081023.6 KB 2.2% 0.28
Oct 16 21:00:00 - 21:59:59 323 2.3% 0.09935.6 KB 2.0% 0.26
Oct 16 22:00:00 - 22:59:59 292 2.1% 0.081015.8 KB 2.2% 0.28
Oct 16 23:00:00 - 23:58:01 308 2.2% 0.09879.4 KB 1.9% 0.25
TOTAL: 23:57:00 13794 100.0% 0.1646.1 MB 100.0% 0.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feeder3.feed-ams.uzoreto.com 2240 1866 0 0 2 0 0 0 372
2ripco-out.feed.uzoreto.com 1075 603 0 0 15 0 0 0 457
3newsfeed.neva.ru 678 420 0 1 2 0 0 0 255
4ripco-out.feeder.erje.net 467 463 0 0 0 0 0 0 4
5news.snarked.org 180 62 0 0 0 0 0 0 118
6newsfeed.fu-berlin.de 101 0 0 0 0 0 0 0 101
7ripco-out.news.tnetconsulting.net 51 32 0 0 0 0 0 0 19
8news.lightlink.com 38 1 0 0 0 0 0 0 37
9news-in.rahul.net 30 0 0 0 0 0 0 0 30
10news.cmpublishers.com 5 0 0 0 0 0 0 0 5
TOTAL: 10 4865 3447 0 1 19 0 0 0 1398

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2647
alt.binaries.ftd 202
alt.bestjobsusa.computer.jobs 39
scot.general 37
alt.binaries.pictures.purebeauty 36
scinet.stats 30
alt.binaries.pictures.erotica.vintage 30
alt.binaries.nospam.breasts.natural 26
alt.binaries.e-book 19
it.tlc.cellulari.android 18
it.comp.os.win.windows10 18
alt.my.job.sucks 15
linux.debian.changes 15
free.willey 15
alt.binaries.adan 14
mozilla.dev.security.policy 12
alt.binaries.3d.poser 11
alt.binaries.pictures.earlmiller 11
alt.binaries.test.yenc 10
free.it.scienza.fisica 10
TOTAL: 116 3447

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

GroupsCount
fr.sci.geosciences 14
pl.praca.oferowana 3
bit.listserv.catholic 1
alt.christnet.christnews 1
TOTAL: 4 19

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1052
EMP (md5) 800
EMP (phl) 336
Binary in non-binary group 166
HTML post 40
Scoring filter (8) 30
Scoring filter (10) 16
Scoring filter (9) 10
Scoring filter (11) 8
Scoring filter (13) 2
Scoring filter (12) 2
TOTAL: 11 2462

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 34
ripco-out.feed.uzoreto.com 10
feeder3.feed-ams.uzoreto.com 8
TOTAL: 3 52
Including strange strings
newsfeed.fu-berlin.de 95
newsfeed.neva.ru 38
feeder3.feed-ams.uzoreto.com 16
ripco-out.feed.uzoreto.com 13
TOTAL: 4 162
No colon-space in header
ripco-out.feed.uzoreto.com 4
ripco-out.feeder.erje.net 2
TOTAL: 2 6
TOTAL: 3 220

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 22492 792 12460 18 0 0 3%47:42:36
2news.lightlink.com 11038 446 6886 26 0 0 4%47:40:02
3feeder.erje.net 27108 110 26440 110 0 18 0%47:40:46
4news.cmpublishers.com 40348 26 27034 198 0 142 0%47:40:04
5news.snarked.org 37294 22 22406 4 0 98 0%47:40:04
6newsfeed.neva.ru 22952 20 22090 12 0 0 0%47:36:40
7fu-berlin.de 25062 16 25046 0 0 0 0%47:51:40
8news.tnetconsulting.net 40510 12 26562 2 0 80 0%47:40:02
9news.uzoreto.com 11966 6 11598 10 0 0 0%47:40:10
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:14
TOTAL: 10 238776 1450 180522 386 0 338 0%430:24:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net3.7 MB38.8 KB3.8 MB0.0 KB/s4.8 KB47:42:36
2news.lightlink.com1.7 MB262.9 KB1.9 MB0.0 KB/s4.2 KB47:40:02
3feeder.erje.net424.5 KB316.1 KB740.6 KB0.0 KB/s3.4 KB47:40:46
4news.snarked.org140.2 KB8.5 KB148.7 KB0.0 KB/s5.7 KB47:40:04
5newsfeed.neva.ru139.9 KB33.0 KB172.9 KB0.0 KB/s5.4 KB47:36:40
6fu-berlin.de127.9 KB0.0 KB127.9 KB0.0 KB/s8.0 KB47:51:40
7news.tnetconsulting.net114.7 KB4.6 KB119.3 KB0.0 KB/s8.5 KB47:40:02
8news.cmpublishers.com110.2 KB559.6 KB669.8 KB0.0 KB/s3.0 KB47:40:04
9news.uzoreto.com26.8 KB110.2 KB137.0 KB0.0 KB/s8.6 KB47:40:10
10remote6hme0.ripco.com0.0 KB38.6 KB38.6 KB0.0 KB/s6.4 KB01:12:14
TOTAL: 106.5 MB1.3 MB7.8 MB0.0 KB/s4.4 KB430:24:18
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 7242.0 MB 388 2 000:08:12
2shell3.ripco.com 8 38187.8 KB 10 2 000:15:42
TOTAL: 2 294 7622.2 MB 398 4 000:23:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 7242.0 MB 388 2 000:08:12
2*.ripco.com 8 38187.8 KB 10 2 000:15:42
TOTAL: 2 294 7622.2 MB 398 4 000:23:55

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 1.502 0.610 0.00000:15:42
ftupet.com 45.100 21.166 0.00000:08:12
185.220.101.2 0.402 0.110 0.00000:00:00
62.102.148.68 0.400 0.112 0.00000:00:00
ninja.census.shodan.io 0.200 0.048 0.00000:00:00
TOTAL: 5 47.604 22.046 0.00000:23:56

NNRP no permission clients:

SystemConn
62.102.148.68 4
185.220.101.2 4
ninja.census.shodan.io 2
TOTAL: 3 10

NNRP unrecognized commands (by host):

SystemConn
shell3.ripco.com 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 2
TOTAL: 1 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 722 94.8%
2sci 16 2.1%
3alt 8 1.0%
4chi 6 0.8%
5comp 6 0.8%
6misc 4 0.5%
TOTAL: 6 762100.0%

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

NewsgroupCount
1rec.food.cooking 306
2rec.arts.tv 286
3rec.bicycles.tech 124
4sci.electronics.repair 16
5alt.stupidity 8
6rec.radio.broadcasting 6
7comp.unix.solaris 6
8misc.consumers.frugal-living 4
9chi.weather 4
10chi.general 2
TOTAL: 10 762