Daily Usenet report for news.ripco.com

Dec 31 00:01:05 -- Dec 31 23:58:23

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Dec 31 05:55:27 remote5bge0 overchan[18025]: [ID 702911 news.error] input line too long, skipping
Dec 31 08:55:57 remote5bge0 overchan[18025]: [ID 702911 news.error] input line too long, skipping
Dec 31 08:58:20 remote5bge0 overchan[18025]: [ID 702911 news.error] input line too long, skipping
Dec 31 11:41:56 remote5bge0 overchan[18025]: [ID 702911 news.error] input line too long, skipping
Dec 31 16:25:29 remote5bge0 overchan[18025]: [ID 702911 news.error] input line too long, skipping
Dec 31 19:09:46 remote5bge0 overchan[18025]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 275148 87.5%34.6 MB 83.9%
innd 18591 5.9%2.9 MB 7.0%
inn 16992 5.4%3.0 MB 7.3%
innfeed 3582 1.1%744.4 KB 1.8%
overchan 6 0.0%0.7 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 314321 100.0%41.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 142674 50.9%
Cache misses 137826 49.1%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 280500 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.492 0.0%33662 0.000 0.015 0.059
article logging00:00:00.740 0.0%33936 0.000 0.022 0.273
article parse00:00:01.340 0.0%78982 0.000 0.017 0.035
article write00:01:19.342 0.0%25980 1.063 3.054 288.442
artlog/artparse00:00:00.000 0.0%24 0.000 0.000 0.000
data move00:00:00.398 0.0%290264 0.000 0.001 0.025
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.672 0.0%281252 0.000 0.010 0.033
history sync00:00:00.246 0.0%756 0.000 0.325 11.667
history write00:00:03.696 0.0%33686 0.000 0.110 10.625
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:02:01.632 98.6%445178 239.072 380.346 758.228
nntp read00:00:02.820 0.0%319986 0.001 0.009 0.026
overview write00:00:00.340 0.0%25980 0.000 0.013 0.049
perl filter00:01:02.770 0.0%33656 1.542 1.865 2.564
python filter00:00:02.068 0.0%33666 0.012 0.061 0.188
site send00:00:03.016 0.0%77874 0.011 0.039 0.084
TOTAL: 47:41:53.96047:04:41.572 98.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.122 0.0%26404 0.000 0.005 0.031
article prepare00:00:00.006 0.0%18072 0.000 0.000 0.250
article read00:00:00.408 0.0%3934 0.000 0.104 9.000
backlog stats00:00:00.182 0.0%330576 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.820 0.0%212548 0.000 0.009 0.020
data write00:00:04.118 0.0%186904 0.009 0.022 0.045
idle47:36:29.928100.0%330576 281.486 518.458 1331.044
status file00:00:02.522 0.0%332 0.000 7.596 34.000
TOTAL: 47:36:48.13447:36:39.106100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle05:04:20.110 56.8%18646 5.333 979.304 86236.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:10.714 0.0%937018 0.000 0.011 29.000
readart00:00:21.034 0.1%2934 0.000 7.169 37.000
TOTAL: 08:55:25.41405:04:51.858 56.9%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 34996 12452 18786 3758 35%94:49:28
2news.snarked.org 72 23084 6500 15926 658 28%56:06:22
3newsfeed.neva.ru 638 32798 3980 27598 1220 12%273:00:16
4feeder3.feed-ams.uzoreto.com 574 8178 1778 5658 742 21%47:18:32
5news.lightlink.com 2 8606 460 7682 464 5%53:14:34
6newsfeed.fu-berlin.de 2 12950 400 12540 10 3%44:30:14
7news-in.rahul.net 576 14800 248 14524 28 1%47:30:30
8news.cmpublishers.com 50 8426 80 8284 62 0%48:00:02
9ripco-out.feeder.erje.net 574 28106 76 27200 830 0%47:15:58
10localhost 156 10 10 0 0 100%00:00:00
TOTAL: 10 3792 171954 25984 138198 7772 15%711:45:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com31.9 MB0.0 KB8.4 MB40.3 MB 79%2.5 KB
2news.snarked.org18.8 MB0.0 KB2.2 MB21.0 MB 89%3.0 KB
3newsfeed.neva.ru12.0 MB0.0 KB4.4 MB16.5 MB 73%3.2 KB
4news-in.rahul.net6.5 MB0.0 KB994.4 KB7.4 MB 86%27.5 KB
5feeder3.feed-ams.uzoreto.com4.2 MB0.0 KB1.7 MB5.9 MB 70%2.4 KB
6news.lightlink.com1.8 MB0.0 KB17.7 MB19.5 MB 9%21.6 KB
7newsfeed.fu-berlin.de1.8 MB0.0 KB197.3 KB2.0 MB 90%4.9 KB
8ripco-out.feeder.erje.net281.9 KB0.0 KB6.6 MB6.8 MB 4%7.7 KB
9news.cmpublishers.com143.1 KB0.0 KB114.6 KB257.7 KB 55%1.8 KB
10localhost17.4 KB0.0 KB0.0 KB17.4 KB100%1.7 KB
TOTAL: 1077.4 MB0.0 KB42.2 MB119.6 MB 64%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 31 00:01:05 - 00:59:59 212 1.6% 0.06643.8 KB 1.6% 0.18
Dec 31 01:00:00 - 01:59:59 442 3.4% 0.121.1 MB 2.9% 0.32
Dec 31 02:00:00 - 02:59:59 505 3.9% 0.141.4 MB 3.5% 0.39
Dec 31 03:00:00 - 03:59:59 503 3.9% 0.141.2 MB 3.2% 0.35
Dec 31 04:00:00 - 04:59:59 641 4.9% 0.182.1 MB 5.5% 0.60
Dec 31 05:00:00 - 05:59:59 655 5.0% 0.181.8 MB 4.7% 0.52
Dec 31 06:00:00 - 06:59:59 622 4.8% 0.171.9 MB 4.9% 0.54
Dec 31 07:00:00 - 07:59:59 592 4.6% 0.161.7 MB 4.5% 0.50
Dec 31 08:00:00 - 08:59:59 725 5.6% 0.202.3 MB 6.0% 0.66
Dec 31 09:00:00 - 09:59:59 703 5.4% 0.202.0 MB 5.0% 0.55
Dec 31 10:00:00 - 10:59:59 772 5.9% 0.212.5 MB 6.4% 0.70
Dec 31 11:00:00 - 11:59:59 954 7.3% 0.272.8 MB 7.2% 0.80
Dec 31 12:00:00 - 12:59:59 840 6.5% 0.232.5 MB 6.3% 0.70
Dec 31 13:00:00 - 13:59:59 684 5.3% 0.192.3 MB 5.8% 0.64
Dec 31 14:00:00 - 14:59:59 691 5.3% 0.192.0 MB 5.1% 0.57
Dec 31 15:00:00 - 15:59:59 523 4.0% 0.151.9 MB 4.9% 0.54
Dec 31 16:00:00 - 16:59:59 509 3.9% 0.141.4 MB 3.7% 0.40
Dec 31 17:00:00 - 17:59:59 530 4.1% 0.151.4 MB 3.5% 0.39
Dec 31 18:00:00 - 18:59:59 402 3.1% 0.111.4 MB 3.6% 0.39
Dec 31 19:00:00 - 19:59:59 391 3.0% 0.111.1 MB 2.7% 0.30
Dec 31 20:00:00 - 20:59:59 298 2.3% 0.08918.5 KB 2.3% 0.26
Dec 31 21:00:00 - 21:59:59 303 2.3% 0.081.0 MB 2.7% 0.29
Dec 31 22:00:00 - 22:59:59 246 1.9% 0.07770.2 KB 1.9% 0.21
Dec 31 23:00:00 - 23:58:23 260 2.0% 0.07734.1 KB 1.9% 0.21
TOTAL: 23:57:18 13003 100.0% 0.1538.7 MB 100.0% 0.46
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1888 1276 0 0 3 0 0 0 609
2newsfeed.neva.ru 649 280 0 0 0 0 0 0 369
3ripco-out.feeder.erje.net 416 408 0 0 0 0 0 0 8
4feeder3.feed-ams.uzoreto.com 371 221 0 0 1 0 0 0 149
5news.snarked.org 329 221 0 0 3 0 0 0 105
6news.lightlink.com 201 1 0 0 0 0 0 0 200
7newsfeed.fu-berlin.de 92 0 0 0 0 0 0 0 92
8news.cmpublishers.com 29 1 0 0 0 0 0 0 28
9news-in.rahul.net 14 6 0 0 0 0 0 0 8
TOTAL: 9 3989 2414 0 0 7 0 0 0 1568

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1737
alt.binaries.ftd 158
it.tlc.cellulari.android 39
alt.binaries.nl 33
free.it.scienza.fisica 31
alt.binaries.pictures.purebeauty 30
fido7.su.pol.news 27
perl.cpan.uploads 19
alt.binaries.mac.osx.apps 18
alt.binaries.pictures.scenic 18
scot.general 17
free.willey 14
alt.binaries.test 13
de.soc.arbeitslos 11
alt.binaries.e-book 10
alt.tv.star-trek 9
alt.binaries.ebooks 9
alt.binaries.3d.poser 9
alt.binaries.nospam.breasts.natural 6
free.ucp 6
TOTAL: 136 2414

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

GroupsCount
christnet.bible 2
bit.listserv.catholic 2
alt.christnet.religion 1
christnet.theology 1
alt.christnet.christnews 1
TOTAL: 5 7

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1362
Too many newsgroups 1086
Binary in non-binary group 250
EMP (phl) 64
Scoring filter (10) 18
Scoring filter (11) 16
Scoring filter (8) 16
Scoring filter (9) 10
Scoring filter (18) 4
HTML post 2
U2 violation - invalid distribution 2
TOTAL: 11 2830

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feed.uzoreto.com 64
ripco-out.feeder.erje.net 18
feeder3.feed-ams.uzoreto.com 8
TOTAL: 3 90
Including strange strings
newsfeed.fu-berlin.de 87
newsfeed.neva.ru 38
ripco-out.feed.uzoreto.com 11
news.snarked.org 1
ripco-out.feeder.erje.net 1
TOTAL: 5 138
No colon-space in header
ripco-out.feed.uzoreto.com 9
ripco-out.feeder.erje.net 2
feeder3.feed-ams.uzoreto.com 1
TOTAL: 3 12
TOTAL: 3 240

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10464 1800 5348 8 0 0 17%47:40:10
2rahul.net 23146 572 12712 8 0 0 2%47:40:10
3news.cmpublishers.com 36806 252 23922 1474 0 4 0%47:40:10
4feeder.erje.net 23256 42 22796 98 0 10 0%47:36:44
5news.snarked.org 31878 36 19082 12 0 500 0%47:36:54
6news.uzoreto.com 11712 32 11332 134 0 0 0%47:38:52
7newsfeed.neva.ru 22574 30 21884 6 0 0 0%47:40:10
8fu-berlin.de 23576 18 23558 0 0 0 0%47:40:10
9remote6hme0.ripco.com 0 0 0 0 0 12 0%47:40:02
TOTAL: 9 183412 2782 140634 1740 0 526 1%428:53:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com5.0 MB25.4 KB5.1 MB0.0 KB/s2.9 KB47:40:10
2rahul.net2.0 MB15.4 KB2.0 MB0.0 KB/s3.6 KB47:40:10
3news.cmpublishers.com705.9 KB3.9 MB4.6 MB0.0 KB/s2.7 KB47:40:10
4news.snarked.org143.4 KB41.5 KB184.9 KB0.0 KB/s3.9 KB47:36:54
5feeder.erje.net138.1 KB438.6 KB576.7 KB0.0 KB/s4.1 KB47:36:44
6news.uzoreto.com102.6 KB525.4 KB627.9 KB0.0 KB/s3.8 KB47:38:52
7fu-berlin.de60.1 KB0.0 KB60.1 KB0.0 KB/s3.3 KB47:40:10
8newsfeed.neva.ru58.1 KB22.3 KB80.3 KB0.0 KB/s2.2 KB47:40:10
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
TOTAL: 98.2 MB5.0 MB13.2 MB0.0 KB/s3.0 KB428:53:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 11283.0 MB 434 2 000:06:27
2shell3 28 3841.0 MB 32 8 004:58:35
3108-237-13-94.lightspeed.cicril.sbcglobal.net 2 292772.2 KB 10 0 000:00:28
TOTAL: 3 316 18044.8 MB 476 10 008:27:18

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 11283.0 MB 434 2 000:06:27
2? 28 3841.0 MB 32 8 004:58:35
3*.lightspeed.cicril.sbcglobal.net 2 292772.2 KB 10 0 000:00:28
TOTAL: 3 316 18044.8 MB 476 10 005:05:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 6.158 2.386 0.00004:58:35
69-165-140-93.dsl.teksavvy.com 6435.520 1463.000 0.00003:20:10
ftupet.com 46.002 7.650 0.00000:06:27
84-105-134-55.cable.dynamic.v4.ziggo.nl 12.864 2.888 0.00000:01:25
108-237-13-94.lightspeed.cicril.sbcglobal.net 0.356 0.066 0.00000:00:28
45.132.143.22 10.546 2.354 0.00000:00:11
worker-18.sfj.corp.censys.io 0.200 0.040 0.00000:00:00
159.203.201.55 0.200 0.040 0.00000:00:00
TOTAL: 8 6511.846 1478.424 0.00008:27:18

NNRP no permission clients:

SystemConn
69-165-140-93.dsl.teksavvy.com 64160
84-105-134-55.cable.dynamic.v4.ziggo.nl 128
45.132.143.22 104
worker-18.sfj.corp.censys.io 2
159.203.201.55 2
TOTAL: 5 64396

NNRP unrecognized commands (by host):

SystemConn
shell3 6
TOTAL: 1 6

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 6
TOTAL: 1 6

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 12 0
TOTAL: 1 12 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1306 72.4%
2misc 262 14.5%
3sci 112 6.2%
4chi 54 3.0%
5comp 50 2.8%
6alt 14 0.8%
7news 6 0.3%
TOTAL: 7 1804100.0%

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

NewsgroupCount
1rec.arts.tv 862
2rec.food.cooking 380
3misc.phone.mobile.iphone 236
4sci.electronics.repair 112
5rec.bicycles.tech 52
6chi.general 50
7comp.sys.mac.system 48
8misc.consumers.frugal-living 26
9alt.stupidity 8
10rec.radio.broadcasting 8
11alt.free.newsservers 6
12news.software.nntp 6
13chi.weather 4
14rec.radio.swap 4
15comp.mail.sendmail 2
TOTAL: 15 1804