Daily Usenet report for news.ripco.com

Sep 27 00:01:02 -- Sep 27 23:57:04

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Sep 27 05:24:12 remote5bge0 overchan[19776]: [ID 702911 news.error] input line too long, skipping
Sep 27 05:27:36 remote5bge0 overchan[19776]: [ID 702911 news.error] input line too long, skipping
Sep 27 05:30:46 remote5bge0 overchan[19776]: [ID 702911 news.error] input line too long, skipping
Sep 27 06:26:47 remote5bge0 overchan[19776]: [ID 702911 news.error] input line too long, skipping
Sep 27 07:19:15 remote5bge0 overchan[19776]: [ID 702911 news.error] input line too long, skipping
Sep 27 08:26:02 remote5bge0 overchan[19776]: [ID 702911 news.error] input line too long, skipping
Sep 27 11:35:47 remote5bge0 overchan[19776]: [ID 702911 news.error] input line too long, skipping
Sep 27 12:22:54 remote5bge0 overchan[19776]: [ID 702911 news.error] input line too long, skipping
Sep 27 16:41:11 remote5bge0 overchan[19776]: [ID 702911 news.error] input line too long, skipping
Sep 27 19:31:56 remote5bge0 overchan[19776]: [ID 702911 news.error] input line too long, skipping
Sep 27 21:44:15 remote5bge0 overchan[19776]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 18247 32.1%2.8 MB 32.2%
inn 17670 31.1%3.4 MB 38.5%
nnrpd 17204 30.3%1.8 MB 20.2%
innfeed 3639 6.4%819.8 KB 9.1%
overchan 11 0.0%1.6 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 56773 100.0%8.8 MB100.0%

History cache:

ReasonCount%Count
Cache misses 169318 52.8%
Do not exist 151344 47.2%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 320662 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%82 0.000 0.000 0.000
article cleanup00:00:00.460 0.0%34894 0.000 0.013 0.042
article logging00:00:00.856 0.0%35310 0.000 0.024 0.568
article parse00:00:01.370 0.0%88478 0.000 0.015 0.035
article write00:01:11.958 0.0%25594 1.492 2.812 42.588
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.332 0.0%331046 0.000 0.001 0.004
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.990 0.0%322004 0.002 0.009 0.020
history sync00:00:00.160 0.0%796 0.000 0.201 1.500
history write00:00:03.366 0.0%34892 0.024 0.096 3.014
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:37:18.488 99.8%367176 241.599 466.911 1294.365
nntp read00:00:02.902 0.0%365828 0.002 0.008 0.022
overview write00:00:00.276 0.0%25594 0.000 0.011 0.042
perl filter00:00:51.098 0.0%34892 1.192 1.464 2.123
python filter00:00:01.414 0.0%34894 0.000 0.041 0.143
site send00:00:02.106 0.0%76760 0.000 0.027 0.057
TOTAL: 47:42:06.20047:39:37.776 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.130 0.0%26540 0.000 0.005 0.040
article prepare00:00:00.008 0.0%19000 0.000 0.000 0.028
article read00:00:00.522 0.0%3700 0.000 0.141 14.400
backlog stats00:00:00.266 0.0%403662 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.372 0.0%252940 0.002 0.009 0.025
data write00:00:04.370 0.0%227528 0.008 0.019 0.042
idle47:34:52.514100.0%403662 208.587 424.346 1336.875
status file00:00:02.022 0.0%356 1.000 5.680 43.000
TOTAL: 47:35:22.33647:35:02.204100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:05:51.742 97.1%18310 17.839 609.052 32366.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.210 0.1%849408 0.000 0.011 0.064
readart00:00:22.028 0.2%2658 0.000 8.287 71.000
TOTAL: 03:11:23.51003:06:22.980 97.4%----

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 33872 11342 16800 5730 33%94:47:12
2news.snarked.org 68 26944 6066 20404 474 22%60:59:12
3newsfeed.neva.ru 604 34206 4156 29046 1004 12%275:49:04
4feeder3.feed-ams.uzoreto.com 574 10706 2550 7088 1068 23%47:18:58
5newsfeed.fu-berlin.de 2 13278 618 12584 76 4%48:25:02
6ripco-out.news.tnetconsulting.net 2 29396 538 28738 120 1%47:52:56
7news.lightlink.com 2 1064 152 908 4 14%09:16:56
8news-in.rahul.net 574 13288 50 13188 50 0%47:29:46
9news.cmpublishers.com 50 9250 38 9168 44 0%47:58:46
10ripco-out.feeder.erje.net 574 28202 30 27330 842 0%47:18:40
11localhost 148 2 2 0 0 100%00:00:02
TOTAL: 11 3746 200208 25542 165254 9412 12%727:16:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com28.7 MB2.2 KB10.4 MB39.1 MB 73%2.3 KB
2news.snarked.org17.8 MB0.0 KB1.5 MB19.3 MB 92%3.0 KB
3ripco-out.news.tnetconsulting.net14.3 MB0.0 KB917.5 KB15.2 MB 94%23.6 KB
4newsfeed.neva.ru13.9 MB0.0 KB2.5 MB16.4 MB 84%3.3 KB
5feeder3.feed-ams.uzoreto.com6.7 MB0.0 KB2.1 MB8.7 MB 76%2.5 KB
6newsfeed.fu-berlin.de3.1 MB0.0 KB461.1 KB3.5 MB 87%5.2 KB
7news-in.rahul.net1.1 MB0.0 KB2.8 MB3.9 MB 27%39.9 KB
8news.lightlink.com903.5 KB0.0 KB129.2 KB1.0 MB 87%6.6 KB
9ripco-out.feeder.erje.net175.6 KB0.0 KB5.8 MB5.9 MB 2%7.0 KB
10news.cmpublishers.com132.6 KB0.0 KB108.3 KB240.8 KB 55%2.9 KB
11localhost3.7 KB0.0 KB0.0 KB3.7 KB100%1.8 KB
TOTAL: 1186.7 MB2.2 KB26.7 MB113.4 MB 76%3.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 27 00:01:02 - 00:59:59 214 1.7% 0.06626.4 KB 1.4% 0.18
Sep 27 01:00:00 - 01:59:59 362 2.8% 0.101.1 MB 2.4% 0.30
Sep 27 02:00:00 - 02:59:59 404 3.2% 0.111.3 MB 3.0% 0.38
Sep 27 03:00:00 - 03:59:59 472 3.7% 0.131.8 MB 4.1% 0.51
Sep 27 04:00:00 - 04:59:59 570 4.5% 0.161.8 MB 4.1% 0.51
Sep 27 05:00:00 - 05:59:59 546 4.3% 0.151.8 MB 4.0% 0.51
Sep 27 06:00:00 - 06:59:59 639 5.0% 0.181.9 MB 4.3% 0.54
Sep 27 07:00:00 - 07:59:59 650 5.1% 0.182.0 MB 4.5% 0.57
Sep 27 08:00:00 - 08:59:59 671 5.2% 0.192.0 MB 4.6% 0.58
Sep 27 09:00:00 - 09:59:59 585 4.6% 0.162.6 MB 5.8% 0.73
Sep 27 10:00:00 - 10:59:59 592 4.6% 0.162.1 MB 4.7% 0.59
Sep 27 11:00:00 - 11:59:59 717 5.6% 0.202.3 MB 5.3% 0.67
Sep 27 12:00:00 - 12:59:59 850 6.6% 0.242.9 MB 6.5% 0.82
Sep 27 13:00:00 - 13:59:59 777 6.1% 0.222.4 MB 5.3% 0.67
Sep 27 14:00:00 - 14:59:59 875 6.8% 0.243.8 MB 8.7% 1.09
Sep 27 15:00:00 - 15:59:59 674 5.3% 0.192.8 MB 6.3% 0.79
Sep 27 16:00:00 - 16:59:59 650 5.1% 0.181.9 MB 4.2% 0.53
Sep 27 17:00:00 - 17:59:59 531 4.1% 0.151.8 MB 4.2% 0.52
Sep 27 18:00:00 - 18:59:59 390 3.0% 0.111.4 MB 3.2% 0.40
Sep 27 19:00:00 - 19:59:59 312 2.4% 0.091.1 MB 2.4% 0.31
Sep 27 20:00:00 - 20:59:59 393 3.1% 0.111.4 MB 3.1% 0.39
Sep 27 21:00:00 - 21:59:59 310 2.4% 0.09952.8 KB 2.1% 0.26
Sep 27 22:00:00 - 22:59:59 309 2.4% 0.091.3 MB 3.0% 0.37
Sep 27 23:00:00 - 23:57:04 315 2.5% 0.091.3 MB 3.0% 0.39
TOTAL: 23:56:02 12808 100.0% 0.1544.3 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2880 2153 0 1 1 0 0 0 725
2newsfeed.neva.ru 537 330 0 0 0 0 0 0 207
3feeder3.feed-ams.uzoreto.com 535 344 0 0 1 0 0 0 190
4ripco-out.feeder.erje.net 422 407 0 0 0 0 0 0 15
5news.snarked.org 231 56 0 0 0 0 0 0 175
6newsfeed.fu-berlin.de 169 0 0 0 0 0 0 0 169
7ripco-out.news.tnetconsulting.net 43 8 0 0 0 0 0 0 35
8news-in.rahul.net 25 1 0 0 0 0 0 0 24
9news.cmpublishers.com 15 0 0 0 0 0 0 0 15
10news.lightlink.com 5 0 0 0 0 0 0 0 5
TOTAL: 10 4862 3299 0 1 2 0 0 0 1560

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2663
alt.binaries.ftd 193
scinet.stats 30
scot.general 30
alt.binaries.nospam.breasts.natural 26
alt.binaries.pictures.wallpaper 23
fido7.su.pol.news 22
free.it.scienza.fisica 20
alt.binaries.e-book 20
it.tlc.cellulari.android 19
alt.binaries.pictures.rail 18
free.willey 12
free.software 11
de.soc.arbeitslos 10
alt.binaries.sounds.lossless.classical 9
alt.binaries.test.yenc 8
alt.binaries.pictures.scenic 7
alt.binaries.mac.osx.apps 7
it.comp.os.win.windows10 7
alt.binaries.pictures.purebeauty 5
TOTAL: 119 3299

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

GroupsCount
bit.listserv.catholic 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1198
EMP (md5) 1128
EMP (phl) 202
Binary in non-binary group 88
Scoring filter (8) 32
Scoring filter (9) 20
Scoring filter (10) 16
Scoring filter (15) 10
Scoring filter (11) 4
Scoring filter (13) 2
Scoring filter (14) 2
Poison newsgroup 2
Scoring filter (18) 2
TOTAL: 13 2706

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 151
newsfeed.neva.ru 35
ripco-out.feed.uzoreto.com 16
news.snarked.org 4
ripco-out.feeder.erje.net 1
feeder3.feed-ams.uzoreto.com 1
TOTAL: 6 208
TOTAL: 2 226

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9516 1300 5314 26 0 0 13%47:40:02
2rahul.net 21144 962 11402 46 0 2 4%47:40:06
3news.cmpublishers.com 38974 162 23802 1264 0 488 0%47:40:02
4fu-berlin.de 22952 156 22796 0 0 0 0%47:40:04
5news.uzoreto.com 11610 108 10742 464 0 0 0%47:40:02
6newsfeed.neva.ru 22410 68 21248 26 0 0 0%47:40:02
7news.snarked.org 33314 60 19116 10 0 378 0%47:34:38
8feeder.erje.net 25428 38 24360 26 0 0 0%47:40:02
9news.tnetconsulting.net 39538 22 25080 0 0 124 0%47:51:46
10remote6hme0.ripco.com 12 6 0 6 0 0 50%01:52:14
TOTAL: 10 224898 2882 163860 1868 0 992 1%430:58:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com4.1 MB250.5 KB4.3 MB0.0 KB/s3.3 KB47:40:02
2rahul.net3.5 MB95.3 KB3.6 MB0.0 KB/s3.6 KB47:40:06
3news.cmpublishers.com599.9 KB3.5 MB4.1 MB0.0 KB/s3.0 KB47:40:02
4news.snarked.org567.4 KB31.7 KB599.1 KB0.0 KB/s8.6 KB47:34:38
5fu-berlin.de506.2 KB0.0 KB506.2 KB0.0 KB/s3.2 KB47:40:04
6newsfeed.neva.ru302.1 KB125.6 KB427.7 KB0.0 KB/s4.5 KB47:40:02
7news.uzoreto.com261.8 KB1.0 MB1.3 MB0.0 KB/s2.3 KB47:40:02
8news.tnetconsulting.net222.8 KB0.0 KB222.8 KB0.0 KB/s10.1 KB47:51:46
9feeder.erje.net131.9 KB76.2 KB208.1 KB0.0 KB/s3.3 KB47:40:02
10remote6hme0.ripco.com11.0 KB21.9 KB32.9 KB0.0 KB/s2.7 KB01:52:14
TOTAL: 1010.1 MB5.2 MB15.2 MB0.0 KB/s3.3 KB430:58:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10723.3 MB 474 2 000:10:29
2shell3.ripco.com 10 5121.4 MB 46 0 003:00:44
TOTAL: 2 296 15844.7 MB 520 2 003:11:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10723.3 MB 474 2 000:10:29
2*.ripco.com 10 5121.4 MB 46 0 003:00:44
TOTAL: 2 296 15844.7 MB 520 2 003:11:13

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 4.010 2.658 0.00003:00:44
ftupet.com 47.158 21.500 0.00000:10:29
183.136.225.45 0.202 0.054 0.00000:00:00
TOTAL: 3 51.370 24.212 0.00003:11:14

NNRP no permission clients:

SystemConn
183.136.225.45 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 1340 84.6%
2alt 88 5.6%
3misc 76 4.8%
4comp 38 2.4%
5chi 16 1.0%
6sci 14 0.9%
7news 12 0.8%
TOTAL: 7 1584100.0%

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

NewsgroupCount
1rec.arts.tv 680
2rec.food.cooking 448
3rec.bicycles.tech 174
4alt.comp.os.windows-10 62
5misc.phone.mobile.iphone 58
6misc.consumers.frugal-living 18
7comp.mobile.android 16
8sci.electronics.repair 14
9rec.outdoors.rv-travel 14
10rec.radio.shortwave 12
11alt.security.alarms 12
12alt.video.digital-tv 12
13comp.mail.sendmail 10
14comp.sys.apple2 10
15news.admin.net-abuse.usenet 10
16chi.general 6
17chi.weather 6
18chi.forsale 4
19rec.radio.broadcasting 4
20rec.bicycles.misc 4
21rec.radio.swap 2
22news.admin.net-abuse.misc 2
23comp.unix.bsd.freebsd.misc 2
24alt.video.tape-trading 2
25rec.gardens.edible 2
TOTAL: 25 1584