Daily Usenet report for news.ripco.com

Sep 29 00:01:02 -- Sep 29 23:57:51

Unknown entries from news log file:

First 50 / 66 lines (75.8%)

Sep 29 00:13:36 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 00:56:04 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 03:18:32 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 03:35:42 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 03:39:29 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 03:45:28 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 03:45:28 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 03:45:28 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 03:52:02 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 03:53:01 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 03:56:11 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 04:02:44 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 04:04:27 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 04:06:44 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 04:08:15 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 04:23:35 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 04:28:56 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 04:34:30 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 05:38:03 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 06:21:14 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 06:23:50 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 08:43:02 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 08:50:57 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 12:08:54 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 12:50:28 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 12:51:22 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 13:11:47 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 13:17:16 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 13:25:09 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 13:41:58 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 13:47:09 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 13:47:09 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 13:47:09 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 13:47:09 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 14:31:41 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 14:41:35 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 14:44:33 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 14:44:48 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 14:50:29 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 14:54:13 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 14:57:51 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 14:59:06 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 15:03:34 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 15:03:34 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 15:03:34 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 15:05:47 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 15:05:51 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 15:05:51 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 15:05:51 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping
Sep 29 15:12:59 remote5bge0 overchan[15813]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 18835 32.5%2.9 MB 32.3%
inn 18291 31.5%3.6 MB 39.3%
nnrpd 17177 29.6%1.8 MB 19.7%
innfeed 3608 6.2%802.2 KB 8.7%
overchan 66 0.1%9.3 KB 0.1%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 57979 100.0%9.1 MB100.0%

History cache:

ReasonCount%Count
Cache misses 170772 51.7%
Do not exist 159662 48.3%
Positive hits 0 0.0%
Negative hits 0 0.0%
TOTAL: 4 330434 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.002 0.0%124 0.000 0.016 0.333
article cleanup00:00:00.466 0.0%36142 0.000 0.013 0.052
article logging00:00:00.730 0.0%36506 0.000 0.020 0.087
article parse00:00:01.276 0.0%91106 0.000 0.014 0.034
article write00:01:16.514 0.0%27338 1.340 2.799 47.642
artlog/artparse00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:00.364 0.0%342508 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:03.064 0.0%331658 0.002 0.009 0.020
history sync00:00:00.246 0.0%810 0.000 0.304 1.667
history write00:00:03.694 0.0%36148 0.018 0.102 2.217
hiswrite/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
idle47:37:04.312 99.8%378966 211.438 452.347 1294.946
nntp read00:00:02.968 0.0%378510 0.003 0.008 0.016
overview write00:00:00.260 0.0%27338 0.000 0.010 0.070
perl filter00:00:52.988 0.0%36140 1.234 1.466 2.446
python filter00:00:01.480 0.0%36144 0.000 0.041 0.113
site send00:00:02.028 0.0%82000 0.004 0.025 0.059
TOTAL: 47:42:03.42847:39:30.392 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.140 0.0%27550 0.000 0.005 0.087
article prepare00:00:00.016 0.0%30896 0.000 0.001 0.028
article read00:00:00.604 0.0%5082 0.000 0.119 35.500
backlog stats00:00:00.278 0.0%457100 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.780 0.0%281598 0.003 0.010 0.022
data write00:00:04.768 0.0%254380 0.004 0.019 0.031
idle47:52:15.118100.0%457100 171.945 377.018 1355.070
status file00:00:03.002 0.0%360 1.000 8.339 39.250
TOTAL: 47:52:47.44247:52:26.706100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:16:34.968 91.8%17618 18.410 260.811 18312.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:06.138 0.1%650174 0.000 0.009 0.077
readart00:00:18.002 0.4%1598 2.500 11.265 57.500
TOTAL: 01:23:23.84201:16:59.108 92.3%----

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 33850 12064 16852 4934 35%94:47:50
2news.snarked.org 46 26044 6120 19558 366 23%55:14:36
3newsfeed.neva.ru 606 33180 4714 27300 1166 14%278:35:54
4feeder3.feed-ams.uzoreto.com 574 11674 2920 7514 1240 25%47:19:26
5newsfeed.fu-berlin.de 6 20260 878 19338 44 4%70:29:54
6ripco-out.news.tnetconsulting.net 2 25032 604 24346 82 2%41:21:10
7news.lightlink.com 2 8878 86 8770 22 0%52:29:26
8ripco-out.feeder.erje.net 574 29008 18 28136 854 0%47:17:34
9news.cmpublishers.com 52 7654 14 7630 10 0%47:59:54
10localhost 150 4 4 0 0 100%00:00:02
11news-in.rahul.net 574 14624 4 14620 0 0%47:18:30
TOTAL: 11 3734 210208 27426 174064 8718 13%782:54:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com30.4 MB0.0 KB10.2 MB40.6 MB 74%2.4 KB
2news.snarked.org20.3 MB0.0 KB1.3 MB21.6 MB 94%3.4 KB
3newsfeed.neva.ru12.7 MB2.7 KB2.8 MB15.5 MB 82%2.7 KB
4ripco-out.news.tnetconsulting.net11.3 MB0.0 KB1.0 MB12.3 MB 91%18.4 KB
5newsfeed.fu-berlin.de10.1 MB0.0 KB3.0 MB13.1 MB 76%14.5 KB
6feeder3.feed-ams.uzoreto.com8.7 MB0.0 KB2.9 MB11.6 MB 74%2.9 KB
7news-in.rahul.net294.7 KB0.0 KB0.0 KB294.7 KB100%73.7 KB
8news.lightlink.com254.5 KB0.0 KB1.6 MB1.8 MB 13%17.1 KB
9news.cmpublishers.com41.3 KB0.0 KB23.2 KB64.6 KB 64%2.7 KB
10ripco-out.feeder.erje.net28.5 KB0.0 KB4.9 MB4.9 MB 0%5.8 KB
11localhost9.2 KB0.0 KB0.0 KB9.2 KB100%2.3 KB
TOTAL: 1194.1 MB2.7 KB27.6 MB121.8 MB 77%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 29 00:01:02 - 00:59:59 327 2.4% 0.09930.6 KB 2.1% 0.26
Sep 29 01:00:00 - 01:59:59 406 3.0% 0.111.1 MB 2.5% 0.30
Sep 29 02:00:00 - 02:59:59 527 3.8% 0.151.4 MB 3.2% 0.39
Sep 29 03:00:00 - 03:59:59 665 4.9% 0.182.2 MB 5.2% 0.63
Sep 29 04:00:00 - 04:59:59 638 4.7% 0.181.8 MB 4.1% 0.50
Sep 29 05:00:00 - 05:59:59 601 4.4% 0.171.6 MB 3.6% 0.45
Sep 29 06:00:00 - 06:59:59 556 4.1% 0.151.5 MB 3.6% 0.44
Sep 29 07:00:00 - 07:59:59 651 4.8% 0.181.8 MB 4.1% 0.51
Sep 29 08:00:00 - 08:59:59 674 4.9% 0.192.5 MB 5.9% 0.72
Sep 29 09:00:00 - 09:59:59 975 7.1% 0.273.4 MB 8.0% 0.97
Sep 29 10:00:00 - 10:59:59 865 6.3% 0.243.2 MB 7.3% 0.90
Sep 29 11:00:00 - 11:59:59 819 6.0% 0.232.5 MB 5.8% 0.71
Sep 29 12:00:00 - 12:59:59 769 5.6% 0.212.1 MB 5.0% 0.61
Sep 29 13:00:00 - 13:59:59 667 4.9% 0.191.9 MB 4.4% 0.54
Sep 29 14:00:00 - 14:59:59 739 5.4% 0.212.3 MB 5.3% 0.64
Sep 29 15:00:00 - 15:59:59 623 4.6% 0.171.8 MB 4.1% 0.50
Sep 29 16:00:00 - 16:59:59 595 4.3% 0.171.8 MB 4.2% 0.51
Sep 29 17:00:00 - 17:59:59 475 3.5% 0.131.3 MB 3.1% 0.38
Sep 29 18:00:00 - 18:59:59 405 3.0% 0.112.1 MB 5.0% 0.61
Sep 29 19:00:00 - 19:59:59 364 2.7% 0.101.7 MB 4.0% 0.49
Sep 29 20:00:00 - 20:59:59 290 2.1% 0.08758.6 KB 1.7% 0.21
Sep 29 21:00:00 - 21:59:59 319 2.3% 0.091.0 MB 2.3% 0.29
Sep 29 22:00:00 - 22:59:59 373 2.7% 0.101.4 MB 3.2% 0.39
Sep 29 23:00:00 - 23:57:51 369 2.7% 0.111.0 MB 2.3% 0.30
TOTAL: 23:56:49 13692 100.0% 0.1643.0 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2476 1646 0 0 2 0 0 0 828
2feeder3.feed-ams.uzoreto.com 624 278 0 0 1 0 0 0 345
3newsfeed.neva.ru 606 309 0 1 0 0 0 0 296
4ripco-out.feeder.erje.net 427 425 0 0 0 0 0 0 2
5news.snarked.org 197 50 0 0 0 0 0 0 147
6newsfeed.fu-berlin.de 159 0 0 0 0 0 0 0 159
7news.lightlink.com 58 0 0 0 0 0 0 0 58
8ripco-out.news.tnetconsulting.net 45 10 0 0 0 0 0 0 35
9news.cmpublishers.com 7 1 0 0 0 0 0 0 6
TOTAL: 9 4599 2719 0 1 3 0 0 0 1876

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1950
alt.binaries.ftd 160
uk.net.news.moderation 53
fido7.su.pol.news 39
alt.binaries.nospam.female.bodyhair 29
scinet.stats 28
alt.binaries.pictures.scenic 27
alt.binaries.3d.poser 25
it.tlc.cellulari.android 24
scot.general 23
it.comp.os.win.windows10 20
free.software 19
alt.binaries.e-book 15
free.it.scienza.fisica 12
alt.binaries.humor.skewed 12
mozilla.support.calendar 10
alt.binaries.multimedia.erotica 9
alt.binaries.nospam.breasts.natural 9
de.soc.arbeitslos 8
alt.binaries.test.yenc 8
TOTAL: 124 2719

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

GroupsCount
bit.listserv.catholic 1
alt.christnet.christnews 1
rec.travel.resorts.all-inclusive 1
TOTAL: 3 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1828
Too many newsgroups 1136
Binary in non-binary group 174
EMP (phl) 150
Scoring filter (8) 46
Scoring filter (9) 18
HTML post 10
Scoring filter (10) 4
Poison newsgroup 4
Scoring filter (15) 2
Scoring filter (17) 2
Scoring filter (11) 2
TOTAL: 12 3376

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
Huge articles
newsfeed.fu-berlin.de 2
TOTAL: 1 2
Including strange strings
newsfeed.fu-berlin.de 146
newsfeed.neva.ru 24
ripco-out.feed.uzoreto.com 9
news.snarked.org 2
feeder3.feed-ams.uzoreto.com 2
TOTAL: 5 183
No colon-space in header
ripco-out.feed.uzoreto.com 2
feeder3.feed-ams.uzoreto.com 1
ripco-out.feeder.erje.net 1
TOTAL: 3 4
TOTAL: 4 211

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10602 1772 5574 30 0 6 16%47:40:08
2feeder.erje.net 31788 1612 22966 1864 0 10 5%47:40:10
3rahul.net 24900 810 12392 26 0 0 3%47:40:08
4news.cmpublishers.com 42716 124 25744 1296 0 74 0%47:43:04
5fu-berlin.de 24974 40 24934 0 0 0 0%47:46:58
6news.snarked.org 35102 24 20808 2 0 18 0%47:47:22
7news.tnetconsulting.net 41674 20 26600 2 0 70 0%47:40:00
8newsfeed.neva.ru 23672 18 22606 0 0 0 0%47:40:08
9news.uzoreto.com 12748 18 12094 36 0 0 0%47:47:36
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:04
TOTAL: 10 248182 4438 173718 3262 0 178 1%430:37:38
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com6.5 MB171.8 KB6.6 MB0.0 KB/s3.8 KB47:40:08
2feeder.erje.net4.5 MB5.4 MB9.9 MB0.1 KB/s2.9 KB47:40:10
3rahul.net3.8 MB51.8 KB3.8 MB0.0 KB/s4.7 KB47:40:08
4news.cmpublishers.com666.3 KB3.5 MB4.2 MB0.0 KB/s3.0 KB47:43:04
5fu-berlin.de188.4 KB0.0 KB188.4 KB0.0 KB/s4.7 KB47:46:58
6news.snarked.org132.1 KB10.8 KB142.8 KB0.0 KB/s5.5 KB47:47:22
7news.tnetconsulting.net123.8 KB3.6 KB127.4 KB0.0 KB/s5.8 KB47:40:00
8news.uzoreto.com122.3 KB126.7 KB249.0 KB0.0 KB/s4.6 KB47:47:36
9newsfeed.neva.ru119.4 KB0.0 KB119.4 KB0.0 KB/s6.6 KB47:40:08
10remote6hme0.ripco.com0.0 KB27.3 KB27.3 KB0.0 KB/s4.5 KB01:12:04
TOTAL: 1016.1 MB9.3 MB25.4 MB0.0 KB/s3.4 KB430:37:38
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 288 6601.7 MB 342 2 000:11:27
2shell3.ripco.com 16 276782.4 KB 36 2 001:11:45
TOTAL: 2 304 9362.5 MB 378 4 001:23:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 288 6601.7 MB 342 2 000:11:27
2*.ripco.com 16 276782.4 KB 36 2 001:11:45
TOTAL: 2 304 9362.5 MB 378 4 001:23:13

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 3.936 2.372 0.00001:11:45
ftupet.com 45.222 21.252 0.00000:11:27
33.20.97.83.ro.ovo.sc 0.202 0.050 0.00000:00:01
TOTAL: 3 49.360 23.674 0.00001:23:14

NNRP no permission clients:

SystemConn
33.20.97.83.ro.ovo.sc 2
TOTAL: 1 2

NNRP unrecognized commands (by host):

SystemConn
shell3.ripco.com 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 4
TOTAL: 1 4

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 822 87.8%
2comp 46 4.9%
3alt 38 4.1%
4sci 16 1.7%
5chi 6 0.6%
6misc 6 0.6%
7seattle 2 0.2%
TOTAL: 7 936100.0%

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

NewsgroupCount
1rec.arts.tv 448
2rec.food.cooking 282
3rec.bicycles.tech 64
4comp.mobile.android 36
5sci.electronics.repair 16
6alt.security.alarms 14
7rec.radio.shortwave 14
8rec.radio.broadcasting 8
9alt.online-service.comcast 8
10alt.stupidity 8
11comp.sys.mac.system 6
12alt.video.digital-tv 6
13misc.phone.mobile.iphone 4
14chi.weather 4
15alt.games.warcraft 2
16rec.radio.swap 2
17chi.general 2
18rec.gardens.edible 2
19rec.antiques.radio+phono 2
20comp.internet.services.video.youtube 2
21seattle.general 2
22misc.consumers.frugal-living 2
23comp.sys.mac.apps 2
TOTAL: 23 936