Daily Usenet report for news.ripco.com

Nov 18 00:01:03 -- Nov 18 23:57:37

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Nov 18 10:52:30 remote5bge0 overchan[12481]: [ID 702911 news.error] input line too long, skipping
Nov 18 14:11:09 remote5bge0 overchan[12481]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 21627 33.6%3.4 MB 35.4%
inn 20851 32.4%3.5 MB 36.9%
nnrpd 18110 28.2%1.9 MB 20.1%
innfeed 3686 5.7%736.9 KB 7.6%
overchan 2 0.0%0.3 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 64278 100.0%9.5 MB100.0%

History cache:

ReasonCount%Count
Cache misses 174092 51.2%
Do not exist 165844 48.8%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 339936 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%140 0.000 0.000 0.000
article cleanup00:00:00.382 0.0%41344 0.000 0.009 0.043
article logging00:00:00.766 0.0%41614 0.000 0.018 0.266
article parse00:00:01.742 0.0%105984 0.000 0.016 0.044
article write00:00:42.874 0.0%27634 0.200 1.551 103.783
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.364 0.0%362084 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.942 0.0%340616 0.000 0.009 0.405
history sync00:00:00.306 0.0%808 0.000 0.379 4.000
history write00:00:05.714 0.0%41346 0.000 0.138 5.869
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:39:29.296 99.9%394188 220.184 435.247 1297.508
nntp read00:00:02.290 0.0%390828 0.000 0.006 0.014
overview write00:00:00.172 0.0%27634 0.000 0.006 0.058
perl filter00:00:55.466 0.0%41338 1.000 1.342 3.443
python filter00:00:01.062 0.0%41350 0.000 0.026 0.065
site send00:00:02.092 0.0%82842 0.004 0.025 0.049
TOTAL: 47:41:59.43847:41:25.468100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.110 0.0%34722 0.000 0.003 0.028
article prepare00:00:00.016 0.0%42384 0.000 0.000 0.036
article read00:00:04.932 0.0%9528 0.000 0.518 7.700
backlog stats00:00:00.212 0.0%318260 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.604 0.0%209348 0.000 0.008 0.020
data write00:00:03.242 0.0%182048 0.004 0.018 0.045
idle47:52:04.562100.0%318260 131.469 541.458 1690.927
status file00:00:05.068 0.0%372 0.000 13.624 36.000
TOTAL: 47:52:30.55647:52:19.746100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:14.122 0.0%37690 0.000 0.375 1.767
idle75:06:33.006 99.9%57892 0.333 4670.645421309.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:34.032 0.0%1251096 0.000 0.027 0.899
readart00:00:18.516 0.0%2872 0.000 6.447 36.000
TOTAL: 75:09:56.74675:07:39.676 99.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
1news.snarked.org 72 37164 8126 26324 2714 21%55:42:14
2ripco-out.feed.uzoreto.com 1148 28094 6958 18796 2340 24%94:41:12
3feeder3.feed-ams.uzoreto.com 574 23318 6940 12374 4004 29%47:20:00
4newsfeed.neva.ru 574 49072 4540 42526 2006 9%279:31:20
5newsfeed.fu-berlin.de 2 15092 856 14136 100 5%52:07:00
6news-in.rahul.net 572 15448 138 15202 108 0%47:30:08
7news.lightlink.com 2 7242 90 6158 994 1%37:08:04
8ripco-out.feeder.erje.net 574 32614 68 31228 1318 0%47:18:08
9news.cmpublishers.com 40 7590 20 7566 4 0%36:22:38
10localhost 156 12 12 0 0 100%00:00:00
TOTAL: 10 3714 215646 27748 174310 13588 12%697:40:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org23.3 MB0.0 KB10.1 MB33.3 MB 69%3.1 KB
2feeder3.feed-ams.uzoreto.com17.1 MB0.0 KB8.5 MB25.6 MB 66%2.4 KB
3ripco-out.feed.uzoreto.com17.0 MB0.0 KB4.7 MB21.8 MB 78%2.4 KB
4newsfeed.neva.ru13.9 MB11.9 KB10.9 MB24.9 MB 56%3.9 KB
5news-in.rahul.net5.2 MB0.0 KB5.2 MB10.4 MB 50%43.3 KB
6news.lightlink.com3.1 MB0.0 KB34.1 MB37.2 MB 8%35.1 KB
7newsfeed.fu-berlin.de2.9 MB0.0 KB3.5 MB6.4 MB 45%6.9 KB
8ripco-out.feeder.erje.net126.7 KB0.0 KB12.7 MB12.9 MB 0%9.5 KB
9news.cmpublishers.com68.2 KB0.0 KB3.6 KB71.8 KB 94%3.0 KB
10localhost24.6 KB0.0 KB0.0 KB24.6 KB100%2.1 KB
TOTAL: 1082.9 MB11.9 KB89.7 MB172.6 MB 48%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 18 00:01:03 - 00:59:59 210 1.5% 0.06761.2 KB 1.8% 0.22
Nov 18 01:00:00 - 01:59:59 311 2.2% 0.091.1 MB 2.7% 0.32
Nov 18 02:00:00 - 02:59:59 434 3.1% 0.121.1 MB 2.6% 0.30
Nov 18 03:00:00 - 03:59:59 585 4.2% 0.161.5 MB 3.7% 0.44
Nov 18 04:00:00 - 04:59:59 527 3.8% 0.151.6 MB 3.8% 0.45
Nov 18 05:00:00 - 05:59:59 652 4.7% 0.182.0 MB 4.8% 0.57
Nov 18 06:00:00 - 06:59:59 568 4.1% 0.161.6 MB 3.9% 0.46
Nov 18 07:00:00 - 07:59:59 672 4.9% 0.191.6 MB 3.9% 0.47
Nov 18 08:00:00 - 08:59:59 590 4.3% 0.161.6 MB 4.0% 0.47
Nov 18 09:00:00 - 09:59:59 720 5.2% 0.201.9 MB 4.6% 0.55
Nov 18 10:00:00 - 10:59:59 862 6.2% 0.242.7 MB 6.4% 0.76
Nov 18 11:00:00 - 11:59:59 789 5.7% 0.222.5 MB 6.1% 0.72
Nov 18 12:00:00 - 12:59:59 847 6.1% 0.242.2 MB 5.4% 0.64
Nov 18 13:00:00 - 13:59:59 912 6.6% 0.252.6 MB 6.1% 0.73
Nov 18 14:00:00 - 14:59:59 891 6.4% 0.252.5 MB 6.1% 0.72
Nov 18 15:00:00 - 15:59:59 950 6.9% 0.263.4 MB 8.1% 0.96
Nov 18 16:00:00 - 16:59:59 708 5.1% 0.202.2 MB 5.2% 0.62
Nov 18 17:00:00 - 17:59:59 503 3.6% 0.141.3 MB 3.2% 0.38
Nov 18 18:00:00 - 18:59:59 427 3.1% 0.121.2 MB 2.8% 0.33
Nov 18 19:00:00 - 19:59:59 343 2.5% 0.101.5 MB 3.5% 0.42
Nov 18 20:00:00 - 20:59:59 382 2.8% 0.111.1 MB 2.6% 0.31
Nov 18 21:00:00 - 21:59:59 317 2.3% 0.09971.7 KB 2.3% 0.27
Nov 18 22:00:00 - 22:59:59 317 2.3% 0.091.1 MB 2.7% 0.32
Nov 18 23:00:00 - 23:57:37 336 2.4% 0.101.5 MB 3.6% 0.45
TOTAL: 23:56:34 13853 100.0% 0.1641.6 MB 100.0% 0.49
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feeder3.feed-ams.uzoreto.com 2003 1592 0 0 1 0 0 0 410
2news.snarked.org 1364 59 0 0 1 0 0 0 1304
3ripco-out.feed.uzoreto.com 1174 854 0 0 1 0 0 0 319
4newsfeed.neva.ru 1030 599 0 1 2 0 0 0 428
5ripco-out.feeder.erje.net 659 657 0 0 0 0 0 0 2
6news.lightlink.com 555 4 0 0 0 0 0 0 551
7newsfeed.fu-berlin.de 159 0 0 0 0 0 0 0 159
8news-in.rahul.net 54 0 0 0 0 0 0 0 54
TOTAL: 8 6998 3765 0 1 5 0 0 0 3227

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2664
alt.binaries.ftd 370
alt.astrology.pro 82
free.uk.astrology 65
alt.binaries.pictures.wallpaper 45
free.ucp 37
perl.cpan.uploads 35
alt.binaries.e-book 28
it.tlc.cellulari.android 26
free.it.scienza.fisica 24
uk.radio.amateur.moderated 20
fido7.su.pol.news 20
alt.binaries.nl 18
free.willey 17
alt.binaries.pictures.aviation 15
alt.binaries.pictures.rail 14
de.soc.arbeitslos 12
it.comp.os.win.windows10 9
alt.binaries.e-books 9
alt.binaries.movies.xvid 8
TOTAL: 140 3765

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

GroupsCount
fr.comp.securite 2
bit.listserv.catholic 2
christnet.theology 1
TOTAL: 3 5

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3554
Too many newsgroups 1258
Binary in non-binary group 1090
EMP (phl) 120
Scoring filter (16) 72
Scoring filter (8) 32
Attached HTML file 18
Scoring filter (9) 12
Scoring filter (12) 8
Scoring filter (10) 6
Scoring filter (18) 2
Scoring filter (13) 2
Scoring filter (11) 2
TOTAL: 13 6176

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
feeder3.feed-ams.uzoreto.com 2
TOTAL: 1 2
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
ripco-out.feed.uzoreto.com 2
TOTAL: 2 20
Including strange strings
newsfeed.fu-berlin.de 104
newsfeed.neva.ru 24
ripco-out.feed.uzoreto.com 5
news.snarked.org 1
feeder3.feed-ams.uzoreto.com 1
TOTAL: 5 135
No colon-space in header
feeder3.feed-ams.uzoreto.com 1
TOTAL: 1 1
TOTAL: 4 158

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 8150 1984 3868 6 0 0 24%47:45:58
2news.cmpublishers.com 33600 960 20542 5840 0 6942 2%47:38:16
3rahul.net 19858 846 11204 18 0 0 4%47:51:34
4fu-berlin.de 24404 108 24294 0 0 0 0%47:43:12
5news.uzoreto.com 13976 96 13018 316 0 0 0%47:40:04
6feeder.erje.net 24356 94 23614 206 0 0 0%47:40:04
7news.snarked.org 33232 32 19216 6 0 128 0%47:40:04
8newsfeed.neva.ru 23582 30 22988 54 0 0 0%47:52:46
9remote6hme0.ripco.com 0 0 0 0 0 14 0%47:40:04
TOTAL: 9 181158 4150 138744 6446 0 7084 2%429:32:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com5.7 MB27.7 KB5.7 MB0.0 KB/s2.9 KB47:45:58
2news.cmpublishers.com2.7 MB15.5 MB18.2 MB0.1 KB/s2.7 KB47:38:16
3rahul.net2.5 MB36.1 KB2.6 MB0.0 KB/s3.1 KB47:51:34
4news.uzoreto.com306.1 KB917.4 KB1.2 MB0.0 KB/s3.0 KB47:40:04
5feeder.erje.net276.4 KB677.9 KB954.4 KB0.0 KB/s3.2 KB47:40:04
6fu-berlin.de247.9 KB0.0 KB247.9 KB0.0 KB/s2.3 KB47:43:12
7news.snarked.org89.2 KB12.0 KB101.3 KB0.0 KB/s2.7 KB47:40:04
8newsfeed.neva.ru69.1 KB162.2 KB231.3 KB0.0 KB/s2.8 KB47:52:46
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:04
TOTAL: 911.9 MB17.3 MB29.1 MB0.0 KB/s2.8 KB429:32:02
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 12943.6 MB 454 10 000:06:41
2shell3 10 222721.1 KB 40 2 001:20:48
3a85-139-63-33.cpe.netcabo.pt 8 48280.2 KB 8 0 009:41:07
TOTAL: 3 304 15644.6 MB 502 12 075:09:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 12943.6 MB 454 10 000:06:41
2? 10 222721.1 KB 40 2 001:21:09
3*.cpe.netcabo.pt 8 48280.2 KB 8 0 009:41:07
4*.211.168.217.static-nl.twistednetworks.net 58 00.0 KB 0 0 008:47:02
5*.dyn.iinet.net.au 54 00.0 KB 0 0 025:09:46
6unresolved 72 00.0 KB 0 0 030:03:58
TOTAL: 6 488 15644.6 MB 502 12 075:09:46

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
124-170-174-26.dyn.iinet.net.au 5.408 1.118 0.00025:09:46
94.46.160.54 3.454 1.160 0.00015:26:14
96.43.140.146 6.956 2.214 0.00014:25:35
a85-139-63-33.cpe.netcabo.pt 1.016 0.320 0.00009:41:07
95.211.168.217.static-nl.twistednetworks.net 5.910 1.408 0.00008:47:02
shell3 10.238 3.722 0.00001:20:48
185.210.217.247 0.464 0.262 0.00000:11:59
ftupet.com 45.934 7.622 0.00000:06:41
? 0.448 0.112 0.00000:00:21
185.181.102.18 0.198 0.042 0.00000:00:06
185.100.87.247 0.242 0.060 0.00000:00:01
TOTAL: 11 80.268 18.040 0.00075:09:46

Curious NNRP server explorers [Top 20]:

SystemConn
96.43.140.146 64
95.211.168.217.static-nl.twistednetworks.net 58
124-170-174-26.dyn.iinet.net.au 54
185.210.217.247 4
185.181.102.18 2
185.100.87.247 2
TOTAL: 6 184

NNRP unrecognized commands (by host):

SystemConn
shell3 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
96.43.140.146 64 0
95.211.168.217.static-nl.twistednetworks.net 36 0
94.46.160.54 32 0
124-170-174-26.dyn.iinet.net.au 22 0
shell3 2 0
TOTAL: 5 156 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1418 90.7%
2comp 72 4.6%
3chi 18 1.2%
4alt 16 1.0%
5sci 16 1.0%
6news 12 0.8%
7ba 8 0.5%
8misc 4 0.3%
TOTAL: 8 1564100.0%

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

NewsgroupCount
1rec.food.cooking 768
2rec.arts.tv 522
3rec.bicycles.tech 116
4comp.lang.c 36
5comp.dcom.telecom 20
6chi.general 12
7sci.electronics.repair 8
8sci.math 8
9ba.food 8
10alt.vacation.las-vegas 6
11news.admin.net-abuse.email 6
12alt.comp.freeware 4
13rec.bicycles.misc 4
14rec.radio.swap 4
15comp.mail.sendmail 4
16news.software.readers 4
17alt.video.laserdisc 4
18chi.weather 4
19comp.protocols.dns.bind 4
20misc.consumers.frugal-living 4
21comp.sys.mac.apps 2
22rec.radio.broadcasting 2
23news.admin.net-abuse.misc 2
24comp.unix.solaris 2
25chi.test 2
26comp.sys.ibm.pc.games.rpg 2
27alt.free.newsservers 2
28rec.puzzles 2
29comp.sys.mac.system 2
TOTAL: 29 1564