Daily Usenet report for news.ripco.com

Oct 10 00:01:04 -- Oct 10 23:58:30

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Oct 10 08:40:42 remote5bge0 overchan[22214]: [ID 702911 news.error] input line too long, skipping
Oct 10 09:05:45 remote5bge0 overchan[22214]: [ID 702911 news.error] input line too long, skipping
Oct 10 09:21:14 remote5bge0 overchan[22214]: [ID 702911 news.error] input line too long, skipping
Oct 10 09:38:24 remote5bge0 overchan[22214]: [ID 702911 news.error] input line too long, skipping
Oct 10 10:47:12 remote5bge0 overchan[22214]: [ID 702911 news.error] input line too long, skipping
Oct 10 11:05:47 remote5bge0 overchan[22214]: [ID 702911 news.error] input line too long, skipping
Oct 10 11:09:55 remote5bge0 overchan[22214]: [ID 702911 news.error] input line too long, skipping
Oct 10 13:41:23 remote5bge0 overchan[22214]: [ID 702911 news.error] input line too long, skipping
Oct 10 14:23:13 remote5bge0 overchan[22214]: [ID 702911 news.error] input line too long, skipping
Oct 10 16:27:11 remote5bge0 overchan[22214]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 307873 87.6%40.7 MB 84.9%
inn 21718 6.2%3.7 MB 7.8%
innd 18291 5.2%2.7 MB 5.7%
innfeed 3654 1.0%777.2 KB 1.6%
overchan 10 0.0%1.1 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 351548 100.0%48.0 MB100.0%

History cache:

ReasonCount%Count
Cache misses 181330 50.8%
Do not exist 175958 49.2%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 357288 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%132 0.000 0.000 0.000
article cleanup00:00:00.626 0.0%42998 0.000 0.015 0.044
article logging00:00:00.946 0.0%43370 0.000 0.022 0.224
article parse00:00:01.774 0.0%108432 0.000 0.016 0.044
article write00:00:42.880 0.0%31724 0.407 1.352 13.552
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.524 0.0%373970 0.000 0.001 0.006
hishave/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.096 0.0%360134 0.001 0.011 0.598
history sync00:00:00.454 0.0%742 0.000 0.612 3.500
history write00:00:05.696 0.0%42988 0.018 0.133 6.691
hiswrite/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
idle47:27:20.428 99.5%540278 194.415 316.208 640.736
nntp read00:00:03.930 0.0%405464 0.003 0.010 0.094
overview write00:00:00.310 0.0%31724 0.000 0.010 0.048
perl filter00:01:12.836 0.0%42980 1.175 1.695 3.311
python filter00:00:02.526 0.0%42990 0.011 0.059 0.573
site send00:00:03.874 0.0%95140 0.007 0.041 0.260
TOTAL: 47:41:45.43047:29:40.900 99.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.130 0.0%33196 0.000 0.004 0.022
article prepare00:00:00.002 0.0%19288 0.000 0.000 0.016
article read00:00:00.444 0.0%3976 0.000 0.112 8.222
backlog stats00:00:00.272 0.0%363102 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.022 0.0%243850 0.002 0.008 0.023
data write00:00:03.756 0.0%212722 0.007 0.018 0.031
idle47:35:30.800100.0%363102 259.133 471.853 1246.857
status file00:00:04.758 0.0%342 0.000 13.912 33.000
TOTAL: 47:35:53.82847:35:42.184100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:01.116 0.0%53548 0.000 0.021 0.459
idle153:58:33.270 97.7%224800 0.333 2465.806300292.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:57.228 0.0%1591776 0.000 0.036 17.200
readart00:00:19.098 0.0%2922 0.000 6.536 39.000
TOTAL: 157:34:27.370153:59:50.712 97.7%----

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 51050 14488 31578 4984 28%94:37:00
2news.snarked.org 54 39454 9324 27912 2218 23%56:14:38
3newsfeed.neva.ru 568 54318 6792 45060 2466 12%295:15:50
4newsfeed.fu-berlin.de 12 16392 770 15554 68 4%60:31:16
5news-in.rahul.net 574 16744 222 16496 26 1%47:20:32
6news.lightlink.com 2 7608 206 6852 550 2%44:22:30
7ripco-out.feeder.erje.net 574 34662 42 33628 992 0%47:16:48
8news.cmpublishers.com 50 9230 26 9196 8 0%47:59:56
9localhost 154 10 10 0 0 100%00:00:00
TOTAL: 9 3136 229468 31880 186276 11312 13%693:38:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com40.2 MB3.2 KB9.8 MB50.0 MB 80%2.6 KB
2news.snarked.org27.8 MB0.0 KB6.7 MB34.6 MB 80%3.1 KB
3newsfeed.neva.ru21.0 MB12.8 KB18.7 MB39.8 MB 52%4.4 KB
4news-in.rahul.net9.0 MB0.0 KB1.4 MB10.5 MB 86%43.3 KB
5newsfeed.fu-berlin.de3.6 MB0.0 KB2.3 MB5.9 MB 61%7.2 KB
6news.lightlink.com2.5 MB0.0 KB21.6 MB24.1 MB 10%32.6 KB
7ripco-out.feeder.erje.net75.2 KB0.0 KB10.7 MB10.8 MB 0%10.7 KB
8news.cmpublishers.com64.4 KB0.0 KB20.8 KB85.2 KB 75%2.5 KB
9localhost25.7 KB0.0 KB0.0 KB25.7 KB100%2.6 KB
TOTAL: 9104.4 MB16.0 KB71.3 MB175.7 MB 59%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 10 00:01:04 - 00:59:59 575 3.6% 0.162.1 MB 4.0% 0.60
Oct 10 01:00:00 - 01:59:59 509 3.2% 0.141.4 MB 2.7% 0.40
Oct 10 02:00:00 - 02:59:59 593 3.7% 0.161.5 MB 2.9% 0.42
Oct 10 03:00:00 - 03:59:59 668 4.2% 0.192.2 MB 4.2% 0.62
Oct 10 04:00:00 - 04:59:59 691 4.4% 0.192.1 MB 3.9% 0.58
Oct 10 05:00:00 - 05:59:59 644 4.1% 0.181.9 MB 3.7% 0.55
Oct 10 06:00:00 - 06:59:59 641 4.0% 0.182.0 MB 3.8% 0.56
Oct 10 07:00:00 - 07:59:59 772 4.9% 0.212.1 MB 4.0% 0.59
Oct 10 08:00:00 - 08:59:59 831 5.2% 0.232.6 MB 4.9% 0.73
Oct 10 09:00:00 - 09:59:59 992 6.2% 0.282.7 MB 5.2% 0.78
Oct 10 10:00:00 - 10:59:59 863 5.4% 0.242.9 MB 5.5% 0.81
Oct 10 11:00:00 - 11:59:59 996 6.3% 0.283.2 MB 6.1% 0.90
Oct 10 12:00:00 - 12:59:59 902 5.7% 0.252.8 MB 5.4% 0.80
Oct 10 13:00:00 - 13:59:59 886 5.6% 0.253.6 MB 6.9% 1.02
Oct 10 14:00:00 - 14:59:59 839 5.3% 0.232.7 MB 5.1% 0.76
Oct 10 15:00:00 - 15:59:59 747 4.7% 0.212.4 MB 4.6% 0.69
Oct 10 16:00:00 - 16:59:59 868 5.5% 0.242.8 MB 5.4% 0.81
Oct 10 17:00:00 - 17:59:59 609 3.8% 0.172.4 MB 4.5% 0.67
Oct 10 18:00:00 - 18:59:59 464 2.9% 0.131.9 MB 3.7% 0.55
Oct 10 19:00:00 - 19:59:59 422 2.7% 0.121.4 MB 2.7% 0.40
Oct 10 20:00:00 - 20:59:59 314 2.0% 0.091.4 MB 2.7% 0.41
Oct 10 21:00:00 - 21:59:59 399 2.5% 0.111.6 MB 3.0% 0.44
Oct 10 22:00:00 - 22:59:59 337 2.1% 0.091.4 MB 2.6% 0.39
Oct 10 23:00:00 - 23:58:30 318 2.0% 0.091.1 MB 2.2% 0.33
TOTAL: 23:57:26 15880 100.0% 0.1852.1 MB 100.0% 0.62
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2503 1926 0 1 12 0 0 0 564
2newsfeed.neva.ru 1290 602 0 4 4 0 0 0 680
3news.snarked.org 1113 72 0 0 5 0 0 0 1036
4ripco-out.feeder.erje.net 496 494 0 0 0 0 0 0 2
5news.lightlink.com 273 0 0 0 0 0 0 0 273
6newsfeed.fu-berlin.de 147 0 0 0 0 0 0 0 147
7news-in.rahul.net 13 0 0 0 0 0 0 0 13
8news.cmpublishers.com 3 2 0 0 0 0 0 0 1
TOTAL: 8 5838 3096 0 5 21 0 0 0 2716

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2084
alt.binaries.ftd 298
alt.astrology.pro 78
it.comp.os.win.windows10 53
fido7.su.pol.news 47
uk.net.news.moderation 31
free.it.scienza.fisica 29
perl.cpan.uploads 28
it.tlc.cellulari.android 17
alt.binaries.e-book 17
gmane.linux.alsa.devel 16
alt.binaries.drwho 16
it.comp.os.win.windows7 14
alt.binaries.nl 13
free.ucp 13
alt.binaries.test.yenc 13
free.willey 12
alt.binaries.humor.skewed 12
muc.lists.netbsd.tech.toolchain 11
aioe.news.assistenza 10
TOTAL: 146 3096

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

GroupsCount
fr.comp.securite 14
christnet.bible 3
pl.praca.oferowana 1
alt.penthouse.sex.sissy.slut 1
alt.christnet.christnews 1
rec.travel.resorts.all-inclusive 1
TOTAL: 6 21

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3194
Too many newsgroups 912
Binary in non-binary group 748
Attached HTML file 62
EMP (phl) 44
Scoring filter (8) 26
Scoring filter (16) 20
Scoring filter (10) 18
Scoring filter (9) 14
Scoring filter (18) 4
Scoring filter (11) 2
Scoring filter (12) 2
HTML post 2
TOTAL: 13 5048

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
ripco-out.feed.uzoreto.com 4
TOTAL: 1 4
Bad Message-ID's offered
ripco-out.feeder.erje.net 18
TOTAL: 1 18
Huge articles
newsfeed.fu-berlin.de 2
TOTAL: 1 2
Including strange strings
newsfeed.fu-berlin.de 116
newsfeed.neva.ru 60
ripco-out.feed.uzoreto.com 8
news.snarked.org 3
TOTAL: 4 187
TOTAL: 4 211

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 7906 2024 4344 10 0 0 25%47:41:38
2rahul.net 23564 994 13206 12 0 0 4%47:51:24
3news.cmpublishers.com 40480 92 30340 946 0 74 0%47:40:10
4news.uzoreto.com 17838 88 16590 156 0 0 0%47:38:10
5feeder.erje.net 29578 80 28446 184 0 0 0%47:40:08
6news.snarked.org 36546 78 22144 8 0 120 0%47:40:10
7fu-berlin.de 28964 38 28846 0 0 1270 0%47:36:54
8newsfeed.neva.ru 25252 30 24698 90 0 90 0%47:41:32
9remote6hme0.ripco.com 0 0 0 0 0 8 0%47:40:04
TOTAL: 9 210128 3424 168614 1406 0 1562 1%429:10:10
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com6.2 MB14.3 KB6.2 MB0.0 KB/s3.1 KB47:41:38
2rahul.net3.8 MB197.4 KB4.0 MB0.0 KB/s4.1 KB47:51:24
3news.uzoreto.com338.3 KB510.3 KB848.6 KB0.0 KB/s3.5 KB47:38:10
4news.snarked.org291.0 KB15.1 KB306.1 KB0.0 KB/s3.6 KB47:40:10
5news.cmpublishers.com266.5 KB2.7 MB2.9 MB0.0 KB/s2.9 KB47:40:10
6feeder.erje.net244.7 KB710.0 KB954.7 KB0.0 KB/s3.6 KB47:40:08
7newsfeed.neva.ru199.1 KB251.7 KB450.9 KB0.0 KB/s3.8 KB47:41:32
8fu-berlin.de158.2 KB0.0 KB158.2 KB0.0 KB/s4.2 KB47:36:54
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:04
TOTAL: 911.5 MB4.3 MB15.8 MB0.0 KB/s3.3 KB429:10:10
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 12983.7 MB 498 8 000:07:09
2shell3 26 314917.1 KB 36 2 001:40:25
375-151-74-61-independence.hfc.comcastbusiness.net 8 45.4 KB 4 0 000:13:54
TOTAL: 3 320 16164.6 MB 538 10 0157:14:10

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 12983.7 MB 498 8 000:07:09
2? 26 314917.1 KB 36 2 001:40:34
3*.hfc.comcastbusiness.net 8 45.4 KB 4 0 000:13:54
4*.w83-113.abo.wanadoo.fr 2 00.0 KB 0 0 000:20:27
5*.dedicatedpanel.com 64 00.0 KB 0 0 015:52:21
6unresolved68602 00.0 KB 0 0 0117:52:26
7*.stwserver.net 74 00.0 KB 0 0 021:01:30
8*.socal.res.rr.com 24 00.0 KB 0 0 000:00:20
9*.208-100-26.static.steadfastdns.net 2 00.0 KB 0 0 000:00:00
10*.as13285.net 4 00.0 KB 0 0 000:05:25
TOTAL: 1069092 16164.6 MB 538 10 0157:14:10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.11.163.217 0.870 0.322 0.000110:59:32
mkh188.stwserver.net 8.066 2.482 0.00021:01:30
usloft5361.dedicatedpanel.com 7.144 2.432 0.00015:52:21
185.149.90.76 6866.275 1502.004 0.00006:51:40
shell3 8.304 3.090 0.00001:40:25
atoulon-652-1-50-98.w83-113.abo.wanadoo.fr 0.298 0.150 0.00000:20:27
75-151-74-61-independence.hfc.comcastbusiness.net 1.700 1.340 0.00000:13:54
ftupet.com 45.984 7.370 0.00000:07:09
host-80-43-109-16.as13285.net 0.680 0.086 0.00000:05:25
79.46.90.101 16.084 3.546 0.00000:01:14
cpe-172-116-7-35.socal.res.rr.com 2.404 0.528 0.00000:00:20
? 3.402 0.888 0.00000:00:09
ip233.208-100-26.static.steadfastdns.net 0.244 0.066 0.00000:00:00
TOTAL: 13 6961.455 1524.304 0.000157:14:10

Curious NNRP server explorers [Top 20]:

SystemConn
185.149.90.76 68434
79.46.90.101 160
mkh188.stwserver.net 74
usloft5361.dedicatedpanel.com 64
cpe-172-116-7-35.socal.res.rr.com 24
66.11.163.217 8
host-80-43-109-16.as13285.net 4
atoulon-652-1-50-98.w83-113.abo.wanadoo.fr 2
ip233.208-100-26.static.steadfastdns.net 2
TOTAL: 9 68772

NNRP unrecognized commands (by host):

SystemConn
shell3 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 4
TOTAL: 1 4

NNRP client timeouts [Top 20]:

SystemConnPeer
mkh188.stwserver.net 74 0
usloft5361.dedicatedpanel.com 64 0
66.11.163.217 8 0
shell3 2 0
atoulon-652-1-50-98.w83-113.abo.wanadoo.fr 2 0
TOTAL: 5 150 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1480 91.6%
2comp 66 4.1%
3alt 30 1.9%
4chi 14 0.9%
5ba 10 0.6%
6sci 10 0.6%
7news 4 0.2%
8soc 2 0.1%
TOTAL: 8 1616100.0%

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

NewsgroupCount
1rec.arts.tv 836
2rec.food.cooking 484
3rec.bicycles.tech 138
4comp.sys.mac.system 32
5alt.stupidity 16
6comp.security.ssh 14
7sci.electronics.repair 10
8chi.weather 10
9ba.food 10
10alt.games.warcraft 8
11rec.gardens.edible 8
12rec.radio.broadcasting 6
13comp.unix.solaris 6
14alt.free.newsservers 6
15comp.sys.mac.apps 4
16rec.radio.swap 4
17news.admin.net-abuse.email 4
18comp.protocols.dns.bind 4
19chi.general 4
20rec.video.cable-tv 2
21comp.os.linux.misc 2
22comp.sys.ibm.pc.games.strategic 2
23soc.culture.indian.marathi 2
24comp.sys.sun.hardware 2
25rec.puzzles 2
TOTAL: 25 1616