Daily Usenet report for news.ripco.com

Nov 23 00:01:02 -- Nov 23 23:57:31

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Nov 23 09:08:20 remote5bge0 overchan[5235]: [ID 702911 news.error] input line too long, skipping
Nov 23 09:21:54 remote5bge0 overchan[5235]: [ID 702911 news.error] input line too long, skipping
Nov 23 09:24:15 remote5bge0 overchan[5235]: [ID 702911 news.error] input line too long, skipping
Nov 23 09:54:09 remote5bge0 overchan[5235]: [ID 702911 news.error] input line too long, skipping
Nov 23 10:37:39 remote5bge0 overchan[5235]: [ID 702911 news.error] input line too long, skipping
Nov 23 10:37:39 remote5bge0 overchan[5235]: [ID 702911 news.error] input line too long, skipping
Nov 23 10:37:39 remote5bge0 overchan[5235]: [ID 702911 news.error] input line too long, skipping
Nov 23 10:48:26 remote5bge0 overchan[5235]: [ID 702911 news.error] input line too long, skipping
Nov 23 10:56:34 remote5bge0 overchan[5235]: [ID 702911 news.error] input line too long, skipping
Nov 23 11:42:03 remote5bge0 overchan[5235]: [ID 702911 news.error] input line too long, skipping
Nov 23 21:38:18 remote5bge0 overchan[5235]: [ID 702911 news.error] input line too long, skipping
Nov 23 23:40:59 remote5bge0 overchan[5235]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 18552 32.6%3.6 MB 40.3%
innd 17573 30.8%2.8 MB 30.9%
nnrpd 17216 30.2%1.8 MB 20.0%
innfeed 3626 6.4%799.3 KB 8.7%
overchan 12 0.0%1.7 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 56981 100.0%8.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 171110 51.8%
Cache misses 159074 48.2%
Positive hits 0 0.0%
Negative hits 0 0.0%
TOTAL: 4 330184 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%64 0.000 0.000 0.000
article cleanup00:00:00.448 0.0%36728 0.000 0.012 0.044
article logging00:00:01.000 0.0%37078 0.000 0.027 0.796
article parse00:00:01.438 0.0%99492 0.000 0.014 0.039
article write00:01:20.810 0.0%28180 1.322 2.868 40.410
artlog/artparse00:00:00.000 0.0%6 0.000 0.000 0.000
data move00:00:00.448 0.0%346734 0.000 0.001 0.006
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:03.166 0.0%332110 0.004 0.010 0.019
history sync00:00:00.280 0.0%782 0.000 0.358 3.000
history write00:00:04.030 0.0%36728 0.000 0.110 2.500
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:37:04.430 99.8%384898 245.739 445.376 1352.086
nntp read00:00:02.848 0.0%385292 0.000 0.007 0.017
overview write00:00:00.278 0.0%28180 0.000 0.010 0.051
perl filter00:00:59.266 0.0%36722 1.205 1.614 2.888
python filter00:00:01.434 0.0%36726 0.000 0.039 0.109
site send00:00:02.198 0.0%84516 0.000 0.026 0.052
TOTAL: 47:42:09.49047:39:42.074 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.140 0.0%28386 0.000 0.005 0.043
article prepare00:00:00.006 0.0%14624 0.000 0.000 0.019
article read00:00:00.492 0.0%2898 0.000 0.170 35.000
backlog stats00:00:00.302 0.0%445594 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.924 0.0%276820 0.003 0.011 0.018
data write00:00:04.684 0.0%248830 0.010 0.019 0.037
idle47:36:59.414100.0%445594 204.307 384.699 1117.250
status file00:00:01.592 0.0%354 0.667 4.497 36.000
TOTAL: 47:37:29.44447:37:09.554100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:36:40.350 97.6%17966 7.667 523.230 37199.800
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.314 0.1%770100 0.000 0.011 0.143
readart00:00:21.014 0.2%2116 0.000 9.931 37.000
TOTAL: 02:40:30.37802:37:09.678 97.9%----

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 27652 9968 14534 3150 36%94:49:00
2feeder3.feed-ams.uzoreto.com 574 18010 6986 8308 2716 38%47:19:46
3newsfeed.neva.ru 594 24506 6138 17106 1262 25%274:54:36
4news.snarked.org 52 27674 3732 23742 200 13%56:11:04
5ripco-out.news.tnetconsulting.net 2 25280 592 24652 36 2%36:43:28
6newsfeed.fu-berlin.de 2 12248 446 11790 12 3%47:28:50
7news.lightlink.com 2 7984 146 7760 78 1%52:29:30
8news-in.rahul.net 574 12502 40 12414 48 0%47:18:42
9ripco-out.feeder.erje.net 574 28940 32 27920 988 0%47:17:10
10news.cmpublishers.com 52 7098 18 7072 8 0%47:59:50
11localhost 150 4 4 0 0 100%00:00:02
TOTAL: 11 3724 191898 28102 155298 8498 14%752:31:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com26.5 MB0.0 KB7.2 MB33.7 MB 78%2.6 KB
2newsfeed.neva.ru20.3 MB7.0 KB3.9 MB24.1 MB 83%3.3 KB
3feeder3.feed-ams.uzoreto.com17.3 MB3.4 KB6.4 MB23.7 MB 73%2.5 KB
4ripco-out.news.tnetconsulting.net14.9 MB0.0 KB1.8 MB16.7 MB 89%27.3 KB
5news.snarked.org10.6 MB0.0 KB925.5 KB11.5 MB 92%3.0 KB
6newsfeed.fu-berlin.de7.1 MB0.0 KB348.3 KB7.5 MB 95%16.7 KB
7news.lightlink.com4.9 MB0.0 KB5.7 MB10.6 MB 46%48.3 KB
8news-in.rahul.net1.6 MB0.0 KB2.5 MB4.1 MB 38%47.9 KB
9ripco-out.feeder.erje.net73.3 KB0.0 KB8.7 MB8.8 MB 0%8.8 KB
10news.cmpublishers.com45.9 KB0.0 KB28.5 KB74.4 KB 61%2.9 KB
11localhost6.6 KB0.0 KB0.0 KB6.6 KB100%1.6 KB
TOTAL: 11103.4 MB10.3 KB37.4 MB140.9 MB 73%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 23 00:01:02 - 00:59:59 358 2.5% 0.102.3 MB 4.3% 0.67
Nov 23 01:00:00 - 01:59:59 415 2.9% 0.121.3 MB 2.5% 0.38
Nov 23 02:00:00 - 02:59:59 566 4.0% 0.161.6 MB 3.0% 0.45
Nov 23 03:00:00 - 03:59:59 773 5.5% 0.212.5 MB 4.6% 0.71
Nov 23 04:00:00 - 04:59:59 793 5.6% 0.223.3 MB 6.1% 0.93
Nov 23 05:00:00 - 05:59:59 673 4.8% 0.191.9 MB 3.6% 0.55
Nov 23 06:00:00 - 06:59:59 557 4.0% 0.152.0 MB 3.7% 0.57
Nov 23 07:00:00 - 07:59:59 752 5.3% 0.212.6 MB 4.8% 0.73
Nov 23 08:00:00 - 08:59:59 837 5.9% 0.232.7 MB 5.0% 0.76
Nov 23 09:00:00 - 09:59:59 792 5.6% 0.222.5 MB 4.8% 0.72
Nov 23 10:00:00 - 10:59:59 842 6.0% 0.233.9 MB 7.3% 1.11
Nov 23 11:00:00 - 11:59:59 908 6.4% 0.252.7 MB 5.1% 0.78
Nov 23 12:00:00 - 12:59:59 717 5.1% 0.203.2 MB 6.0% 0.92
Nov 23 13:00:00 - 13:59:59 815 5.8% 0.232.6 MB 4.8% 0.73
Nov 23 14:00:00 - 14:59:59 618 4.4% 0.171.9 MB 3.5% 0.54
Nov 23 15:00:00 - 15:59:59 690 4.9% 0.192.9 MB 5.4% 0.83
Nov 23 16:00:00 - 16:59:59 582 4.1% 0.162.9 MB 5.3% 0.81
Nov 23 17:00:00 - 17:59:59 480 3.4% 0.131.6 MB 2.9% 0.44
Nov 23 18:00:00 - 18:59:59 443 3.1% 0.122.1 MB 3.9% 0.59
Nov 23 19:00:00 - 19:59:59 387 2.7% 0.111.2 MB 2.2% 0.34
Nov 23 20:00:00 - 20:59:59 265 1.9% 0.071.0 MB 1.9% 0.29
Nov 23 21:00:00 - 21:59:59 299 2.1% 0.082.4 MB 4.4% 0.67
Nov 23 22:00:00 - 22:59:59 227 1.6% 0.06753.4 KB 1.4% 0.21
Nov 23 23:00:00 - 23:57:31 310 2.2% 0.091.8 MB 3.3% 0.53
TOTAL: 23:56:29 14099 100.0% 0.1653.5 MB 100.0% 0.64
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1587 1126 0 0 6 0 0 0 455
2feeder3.feed-ams.uzoreto.com 1360 1038 0 1 6 0 0 0 315
3newsfeed.neva.ru 691 430 0 2 4 0 0 0 255
4ripco-out.feeder.erje.net 494 492 0 0 0 0 0 0 2
5newsfeed.fu-berlin.de 110 0 0 0 0 0 0 0 110
6news.snarked.org 105 46 0 0 0 0 0 0 59
7ripco-out.news.tnetconsulting.net 40 30 0 0 0 0 0 0 10
8news.lightlink.com 38 4 0 0 0 0 0 0 34
9news-in.rahul.net 24 0 0 0 0 0 0 0 24
10news.cmpublishers.com 4 1 0 0 0 0 0 0 3
TOTAL: 10 4453 3167 0 3 16 0 0 0 1267

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2292
alt.binaries.ftd 278
fido7.su.pol.news 40
alt.bestjobsusa.computer.jobs 39
it.tlc.cellulari.android 34
scinet.stats 32
alt.binaries.e-book 29
alt.binaries.pictures.purebeauty 26
free.it.scienza.fisica 25
it.comp.os.win.windows10 25
alt.binaries.pictures.earlmiller 24
alt.jobs.jobsearch 19
at.jobs 14
free.willey 14
att.jobs 14
alt.binaries.test.yenc 12
alt.binaries.pictures.scenic 12
cn.bbs.sci.mechanics 10
scot.general 10
alt.my.job.sucks 9
TOTAL: 114 3167

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

GroupsCount
pl.praca.oferowana 10
christnet.bible 3
rec.travel.resorts.all-inclusive 2
bit.listserv.catholic 1
TOTAL: 4 16

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1064
Too many newsgroups 822
EMP (phl) 134
Binary in non-binary group 78
Scoring filter (9) 32
Scoring filter (8) 24
HTML post 14
Scoring filter (10) 8
Scoring filter (11) 2
TOTAL: 9 2178

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 99
newsfeed.neva.ru 59
ripco-out.feed.uzoreto.com 11
news.snarked.org 4
feeder3.feed-ams.uzoreto.com 2
TOTAL: 5 175
No colon-space in header
ripco-out.feed.uzoreto.com 3
TOTAL: 1 3
TOTAL: 3 196

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 8916 970 5332 24 0 0 10%47:36:54
2rahul.net 21338 778 10852 8 0 0 3%47:40:08
3feeder.erje.net 33422 146 26868 60 0 0 0%47:40:08
4fu-berlin.de 25222 118 25104 0 0 0 0%47:40:08
5news.cmpublishers.com 41518 90 26412 1138 0 96 0%47:40:08
6news.uzoreto.com 11112 54 10450 144 0 0 0%47:40:08
7news.snarked.org 40178 26 23860 12 0 128 0%47:39:28
8news.tnetconsulting.net 43330 20 27276 0 0 54 0%47:34:02
9newsfeed.neva.ru 22414 16 22010 16 0 0 0%47:49:46
10remote6hme0.ripco.com 8 2 0 6 0 0 25%01:32:08
TOTAL: 10 247458 2220 178164 1408 0 278 0%430:32:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net6.9 MB70.9 KB7.0 MB0.0 KB/s9.1 KB47:40:08
2news.lightlink.com5.6 MB112.5 KB5.7 MB0.0 KB/s5.9 KB47:36:54
3fu-berlin.de1.6 MB0.0 KB1.6 MB0.0 KB/s13.5 KB47:40:08
4feeder.erje.net560.0 KB205.4 KB765.4 KB0.0 KB/s3.7 KB47:40:08
5news.uzoreto.com310.0 KB518.2 KB828.2 KB0.0 KB/s4.2 KB47:40:08
6news.cmpublishers.com285.4 KB3.0 MB3.3 MB0.0 KB/s2.8 KB47:40:08
7news.snarked.org244.3 KB79.4 KB323.7 KB0.0 KB/s8.5 KB47:39:28
8news.tnetconsulting.net222.9 KB0.0 KB222.9 KB0.0 KB/s11.1 KB47:34:02
9newsfeed.neva.ru106.7 KB171.4 KB278.1 KB0.0 KB/s8.7 KB47:49:46
10remote6hme0.ripco.com3.8 KB33.0 KB36.8 KB0.0 KB/s4.6 KB01:32:08
TOTAL: 1015.7 MB4.2 MB19.9 MB0.0 KB/s5.6 KB430:32:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 8362.6 MB 410 2 000:09:00
2shell3.ripco.com 12 4421.2 MB 42 2 002:31:18
TOTAL: 2 298 12783.8 MB 452 4 002:40:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 8362.6 MB 410 2 000:09:00
2*.ripco.com 12 4421.2 MB 42 2 002:31:18
TOTAL: 2 298 12783.8 MB 452 4 002:40:19

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 4.128 2.992 0.00002:31:18
ftupet.com 46.816 21.628 0.00000:09:00
91.241.19.60 0.200 0.052 0.00000:00:00
183.136.225.45 0.200 0.050 0.00000:00:00
TOTAL: 4 51.344 24.722 0.00002:40:20

NNRP no permission clients:

SystemConn
91.241.19.60 2
183.136.225.45 2
TOTAL: 2 4

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 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1022 80.0%
2comp 150 11.7%
3alt 72 5.6%
4misc 14 1.1%
5sci 12 0.9%
6chi 6 0.5%
7news 2 0.2%
TOTAL: 7 1278100.0%

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

NewsgroupCount
1rec.arts.tv 624
2rec.food.cooking 262
3comp.sys.mac.system 128
4rec.bicycles.tech 116
5alt.comp.os.windows-10 30
6alt.online-service.comcast 28
7misc.consumers.frugal-living 14
8sci.electronics.repair 12
9comp.mobile.android 10
10rec.outdoors.rv-travel 8
11alt.bittorrent 8
12comp.unix.bsd.freebsd.misc 6
13alt.comp.periphs.mainboard.asus 4
14rec.radio.broadcasting 4
15comp.mail.sendmail 4
16chi.weather 4
17news.groups 2
18alt.stupidity 2
19rec.radio.shortwave 2
20rec.gardens.edible 2
21chi.forsale 2
22rec.puzzles 2
23comp.mail.pine 2
24rec.radio.swap 2
TOTAL: 24 1278