Daily Usenet report for news.ripco.com

Jul 22 00:01:02 -- Jul 22 23:57:31

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Jul 22 02:47:36 remote5bge0 overchan[5994]: [ID 702911 news.error] input line too long, skipping
Jul 22 04:17:56 remote5bge0 overchan[5994]: [ID 702911 news.error] input line too long, skipping
Jul 22 09:57:26 remote5bge0 overchan[5994]: [ID 702911 news.error] input line too long, skipping
Jul 22 10:59:42 remote5bge0 overchan[5994]: [ID 702911 news.error] input line too long, skipping
Jul 22 11:20:00 remote5bge0 overchan[5994]: [ID 702911 news.error] input line too long, skipping
Jul 22 23:11:59 remote5bge0 overchan[5994]: [ID 702911 news.error] input line too long, skipping
Jul 22 23:33:08 remote5bge0 overchan[5994]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 19124 32.8%3.8 MB 41.3%
innd 18245 31.3%2.8 MB 30.9%
nnrpd 17234 29.5%1.8 MB 19.6%
innfeed 3730 6.4%764.6 KB 8.2%
overchan 7 0.0%1.0 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 58342 100.0%9.1 MB100.0%

History cache:

ReasonCount%Count
Cache misses 181140 52.1%
Do not exist 166668 47.9%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 347808 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%134 0.000 0.000 0.000
article cleanup00:00:00.482 0.0%37738 0.000 0.013 0.038
article logging00:00:04.022 0.0%38202 0.000 0.105 22.387
article parse00:00:01.414 0.0%97476 0.000 0.015 0.036
article write00:01:43.942 0.1%29796 1.124 3.488 270.357
artlog/artparse00:00:00.000 0.0%8 0.000 0.000 0.000
data move00:00:00.346 0.0%363036 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:46.804 0.0%348710 0.004 0.134 1.044
history sync00:00:00.246 0.0%804 0.000 0.306 7.667
history write00:00:04.590 0.0%37746 0.015 0.122 8.526
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:36:01.968 99.8%401190 271.044 427.134 1040.450
nntp read00:00:02.560 0.0%398394 0.001 0.006 0.013
overview write00:00:00.272 0.0%29796 0.000 0.009 0.036
perl filter00:00:56.288 0.0%37738 1.185 1.492 2.450
python filter00:00:01.350 0.0%37744 0.000 0.036 0.092
site send00:00:02.026 0.0%89370 0.004 0.023 0.058
TOTAL: 47:41:59.51847:39:46.310 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.254 0.0%30084 0.000 0.008 0.031
article prepare00:00:00.016 0.0%29512 0.000 0.001 0.028
article read00:00:00.656 0.0%5782 0.000 0.113 24.333
backlog stats00:00:00.332 0.0%434724 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.638 0.0%263488 0.002 0.010 0.021
data write00:00:04.160 0.0%233632 0.008 0.018 0.031
idle47:52:11.408100.0%434724 240.054 396.416 1026.617
status file00:00:02.368 0.0%404 0.000 5.861 29.000
TOTAL: 47:52:42.18647:52:21.832100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:25:54.520 97.7%18038 18.088 485.338 16501.346
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.514 0.1%763792 0.000 0.011 0.048
readart00:00:20.452 0.2%2350 1.500 8.703 40.000
TOTAL: 02:29:22.28402:26:23.486 98.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 30590 8282 19314 2994 27%94:38:34
2news.snarked.org 50 27500 7712 19188 600 28%56:03:44
3feeder3.feed-ams.uzoreto.com 574 17584 6678 8804 2102 37%47:20:00
4newsfeed.neva.ru 558 37482 5538 30566 1378 14%276:22:12
5ripco-out.news.tnetconsulting.net 4 38078 1116 36888 74 2%58:32:54
6newsfeed.fu-berlin.de 2 14696 594 14082 20 4%47:43:22
7news.lightlink.com 2 9006 108 8816 82 1%43:52:52
8news-in.rahul.net 574 15032 94 14928 10 0%47:18:50
9ripco-out.feeder.erje.net 574 29736 22 28932 782 0%47:44:18
10localhost 152 6 6 0 0 100%00:00:02
11news.cmpublishers.com 50 7122 4 7112 6 0%48:00:02
TOTAL: 11 3688 226832 30154 188630 8048 13%767:36:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org21.2 MB0.0 KB1.5 MB22.7 MB 93%2.8 KB
2ripco-out.feed.uzoreto.com21.0 MB0.0 KB6.8 MB27.8 MB 75%2.5 KB
3ripco-out.news.tnetconsulting.net19.8 MB0.0 KB1.1 MB20.9 MB 94%18.0 KB
4newsfeed.neva.ru16.5 MB0.0 KB6.2 MB22.7 MB 72%3.4 KB
5feeder3.feed-ams.uzoreto.com16.1 MB0.0 KB3.6 MB19.7 MB 81%2.3 KB
6news.lightlink.com5.5 MB0.0 KB5.8 MB11.2 MB 48%60.6 KB
7newsfeed.fu-berlin.de4.2 MB0.0 KB455.8 KB4.6 MB 90%7.7 KB
8news-in.rahul.net4.0 MB0.0 KB877.3 KB4.9 MB 82%48.0 KB
9ripco-out.feeder.erje.net42.3 KB0.0 KB5.6 MB5.7 MB 0%7.2 KB
10localhost16.5 KB0.0 KB0.0 KB16.5 KB100%2.7 KB
11news.cmpublishers.com16.1 KB0.0 KB7.1 KB23.2 KB 69%2.3 KB
TOTAL: 11108.4 MB0.0 KB31.9 MB140.2 MB 77%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 22 00:01:02 - 00:59:59 360 2.4% 0.101.1 MB 2.1% 0.32
Jul 22 01:00:00 - 01:59:59 496 3.3% 0.142.8 MB 5.3% 0.80
Jul 22 02:00:00 - 02:59:59 548 3.7% 0.151.4 MB 2.6% 0.39
Jul 22 03:00:00 - 03:59:59 679 4.6% 0.192.1 MB 4.0% 0.60
Jul 22 04:00:00 - 04:59:59 708 4.7% 0.202.8 MB 5.3% 0.80
Jul 22 05:00:00 - 05:59:59 683 4.6% 0.192.2 MB 4.1% 0.61
Jul 22 06:00:00 - 06:59:59 703 4.7% 0.202.8 MB 5.4% 0.81
Jul 22 07:00:00 - 07:59:59 726 4.9% 0.202.4 MB 4.5% 0.68
Jul 22 08:00:00 - 08:59:59 802 5.4% 0.223.2 MB 6.1% 0.92
Jul 22 09:00:00 - 09:59:59 890 6.0% 0.252.8 MB 5.3% 0.80
Jul 22 10:00:00 - 10:59:59 799 5.4% 0.223.4 MB 6.4% 0.96
Jul 22 11:00:00 - 11:59:59 773 5.2% 0.212.6 MB 5.0% 0.75
Jul 22 12:00:00 - 12:59:59 763 5.1% 0.212.2 MB 4.2% 0.64
Jul 22 13:00:00 - 13:59:59 719 4.8% 0.202.1 MB 4.0% 0.60
Jul 22 14:00:00 - 14:59:59 843 5.7% 0.233.9 MB 7.3% 1.10
Jul 22 15:00:00 - 15:59:59 713 4.8% 0.201.9 MB 3.6% 0.54
Jul 22 16:00:00 - 16:59:59 738 5.0% 0.202.0 MB 3.7% 0.56
Jul 22 17:00:00 - 17:59:59 630 4.2% 0.172.0 MB 3.8% 0.56
Jul 22 18:00:00 - 18:59:59 446 3.0% 0.121.3 MB 2.5% 0.37
Jul 22 19:00:00 - 19:59:59 465 3.1% 0.132.4 MB 4.6% 0.69
Jul 22 20:00:00 - 20:59:59 389 2.6% 0.111.1 MB 2.0% 0.31
Jul 22 21:00:00 - 21:59:59 367 2.5% 0.101.0 MB 1.9% 0.28
Jul 22 22:00:00 - 22:59:59 366 2.5% 0.102.0 MB 3.7% 0.56
Jul 22 23:00:00 - 23:57:31 301 2.0% 0.091.4 MB 2.7% 0.42
TOTAL: 23:56:29 14907 100.0% 0.1752.9 MB 100.0% 0.63
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1498 827 0 0 3 0 0 0 668
2feeder3.feed-ams.uzoreto.com 1053 832 0 0 0 0 0 0 221
3newsfeed.neva.ru 743 367 0 0 2 0 0 0 374
4ripco-out.feeder.erje.net 391 389 0 0 0 0 0 0 2
5news.snarked.org 297 206 0 0 0 0 0 0 91
6newsfeed.fu-berlin.de 183 0 0 0 0 0 0 0 183
7news.lightlink.com 23 2 0 0 0 0 0 0 21
8ripco-out.news.tnetconsulting.net 22 9 0 0 0 0 0 0 13
9news-in.rahul.net 5 0 0 0 0 0 0 0 5
10news.cmpublishers.com 2 1 0 0 0 0 0 0 1
TOTAL: 10 4217 2633 0 0 5 0 0 0 1579

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1835
alt.binaries.ftd 178
fido7.su.pol.news 47
it.comp.os.win.windows10 39
scot.general 39
scinet.stats 31
perl.cpan.uploads 27
alt.bestjobsusa.computer.jobs 23
alt.binaries.e-book 17
free.willey 15
free.it.scienza.fisica 13
alt.binaries.pictures.earlmiller 12
free.linux 12
alt.binaries.comics.dcp 11
mozilla.dev.l10n 10
alt.binaries.humor.skewed 10
alt.binaries.pictures.scenic 10
trollnet.cinema 10
alt.paranormal.spells 10
alt.binaries.nospam.breasts.natural 9
TOTAL: 154 2633

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

GroupsCount
pl.praca.oferowana 4
bit.listserv.catholic 1
TOTAL: 2 5

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1514
Too many newsgroups 752
EMP (phl) 198
Binary in non-binary group 116
Scoring filter (10) 30
Scoring filter (8) 28
Scoring filter (9) 26
Scoring filter (13) 10
Scoring filter (18) 6
Scoring filter (11) 6
Poison newsgroup 6
Scoring filter (16) 4
TOTAL: 12 2696

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 20
ripco-out.feed.uzoreto.com 2
TOTAL: 2 22
Including strange strings
newsfeed.fu-berlin.de 176
newsfeed.neva.ru 51
feeder3.feed-ams.uzoreto.com 3
ripco-out.feed.uzoreto.com 2
TOTAL: 4 232
No colon-space in header
ripco-out.feed.uzoreto.com 3
feeder3.feed-ams.uzoreto.com 1
TOTAL: 2 4
TOTAL: 3 258

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 35116 3560 23604 756 0 18 10%47:40:02
2rahul.net 25298 972 13200 36 0 0 3%47:50:32
3news.cmpublishers.com 43000 188 27656 1506 0 74 0%47:40:02
4news.tnetconsulting.net 46166 126 28666 8 0 94 0%47:40:02
5news.snarked.org 37126 64 21966 28 0 86 0%47:40:02
6news.uzoreto.com 14814 22 14272 72 0 0 0%47:36:36
7fu-berlin.de 26918 14 26904 0 0 0 0%47:40:04
8news.lightlink.com 0 0 0 0 0 7790 0%47:40:02
9newsfeed.neva.ru 0 0 0 0 0 24220 0%47:40:04
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:06
TOTAL: 10 228444 4946 156268 2412 0 32282 2%430:19:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1feeder.erje.net9.5 MB2.0 MB11.5 MB0.1 KB/s2.7 KB47:40:02
2rahul.net5.8 MB71.0 KB5.9 MB0.0 KB/s6.0 KB47:50:32
3news.cmpublishers.com572.7 KB3.8 MB4.3 MB0.0 KB/s2.6 KB47:40:02
4news.tnetconsulting.net467.5 KB28.5 KB496.0 KB0.0 KB/s3.7 KB47:40:02
5news.snarked.org340.2 KB844.5 KB1.2 MB0.0 KB/s12.9 KB47:40:02
6news.uzoreto.com90.8 KB289.1 KB379.9 KB0.0 KB/s4.0 KB47:36:36
7fu-berlin.de45.7 KB0.0 KB45.7 KB0.0 KB/s3.3 KB47:40:04
8news.lightlink.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
9newsfeed.neva.ru0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:04
10remote6hme0.ripco.com0.0 KB26.7 KB26.7 KB0.0 KB/s4.4 KB01:12:06
TOTAL: 1016.8 MB7.0 MB23.8 MB0.0 KB/s3.3 KB430:19:32
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9362.4 MB 386 2 000:08:09
2shell3.ripco.com 14 4761.3 MB 46 4 002:21:02
TOTAL: 2 300 14123.7 MB 432 6 002:29:12

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9362.4 MB 386 2 000:08:09
2*.ripco.com 14 4761.3 MB 46 4 002:21:02
TOTAL: 2 300 14123.7 MB 432 6 002:29:11

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 4.602 6.596 0.00002:21:02
ftupet.com 46.062 21.042 0.00000:08:09
scan-141.security.ipip.net 0.198 0.048 0.00000:00:00
183.136.225.45 0.200 0.050 0.00000:00:00
223.71.167.164 0.198 0.050 0.00000:00:00
TOTAL: 5 51.260 27.786 0.00002:29:12

NNRP no permission clients:

SystemConn
183.136.225.45 2
scan-141.security.ipip.net 2
223.71.167.164 2
TOTAL: 3 6

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

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 1150 81.4%
2alt 166 11.8%
3comp 66 4.7%
4misc 16 1.1%
5news 8 0.6%
6chi 6 0.4%
TOTAL: 6 1412100.0%

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

NewsgroupCount
1rec.arts.tv 786
2rec.food.cooking 254
3alt.comp.os.windows-10 150
4rec.bicycles.tech 98
5comp.sys.mac.system 28
6comp.sys.apple2 18
7misc.phone.mobile.iphone 12
8comp.mail.pine 8
9alt.stupidity 8
10rec.radio.broadcasting 6
11comp.mobile.ipad 6
12alt.security.alarms 6
13rec.radio.swap 4
14news.admin.net-abuse.usenet 4
15chi.weather 4
16comp.protocols.dns.bind 4
17misc.consumers.frugal-living 4
18alt.autos.ford 2
19rec.bicycles.misc 2
20comp.mobile.android 2
21news.announce.newgroups 2
22chi.general 2
23news.groups.questions 2
TOTAL: 23 1412