Daily Usenet report for news.ripco.com

Sep 5 00:01:01 -- Sep 5 23:57:38

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Sep 5 08:09:04 remote5bge0 overchan[26715]: [ID 702911 news.error] input line too long, skipping
Sep 5 08:53:37 remote5bge0 overchan[26715]: [ID 702911 news.error] input line too long, skipping
Sep 5 09:10:37 remote5bge0 overchan[26715]: [ID 702911 news.error] input line too long, skipping
Sep 5 09:55:03 remote5bge0 overchan[26715]: [ID 702911 news.error] input line too long, skipping
Sep 5 10:34:19 remote5bge0 overchan[26715]: [ID 702911 news.error] input line too long, skipping
Sep 5 11:11:29 remote5bge0 overchan[26715]: [ID 702911 news.error] input line too long, skipping
Sep 5 12:00:27 remote5bge0 overchan[26715]: [ID 702911 news.error] input line too long, skipping
Sep 5 12:48:29 remote5bge0 overchan[26715]: [ID 702911 news.error] input line too long, skipping
Sep 5 12:58:21 remote5bge0 overchan[26715]: [ID 702911 news.error] input line too long, skipping
Sep 5 13:34:57 remote5bge0 overchan[26715]: [ID 702911 news.error] input line too long, skipping
Sep 5 14:00:10 remote5bge0 overchan[26715]: [ID 702911 news.error] input line too long, skipping
Sep 5 18:06:35 remote5bge0 overchan[26715]: [ID 702911 news.error] input line too long, skipping
Sep 5 18:09:40 remote5bge0 overchan[26715]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 18283 32.8%2.9 MB 33.3%
nnrpd 17732 31.8%1.9 MB 21.7%
inn 16043 28.8%3.1 MB 35.9%
innfeed 3602 6.5%800.3 KB 9.1%
overchan 13 0.0%2.1 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 55675 100.0%8.6 MB100.0%

History cache:

ReasonCount%Count
Cache misses 151530 52.3%
Do not exist 138444 47.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 289974 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%98 0.000 0.000 0.000
article cleanup00:00:00.468 0.0%31856 0.000 0.015 0.051
article logging00:00:00.702 0.0%32160 0.000 0.022 0.130
article parse00:00:01.290 0.0%84628 0.000 0.015 0.044
article write00:01:13.142 0.0%22650 1.178 3.229 32.075
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.416 0.0%306638 0.000 0.001 0.006
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.028 0.0%291290 0.002 0.007 0.014
history sync00:00:00.232 0.0%800 0.000 0.290 2.000
history write00:00:03.162 0.0%31858 0.029 0.099 3.250
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:57:20.450 99.8%337694 246.797 511.233 1139.078
nntp read00:00:02.660 0.0%336408 0.003 0.008 0.016
overview write00:00:00.212 0.0%22650 0.000 0.009 0.058
perl filter00:00:48.052 0.0%31856 1.217 1.508 2.733
python filter00:00:01.366 0.0%31858 0.000 0.043 0.148
site send00:00:01.716 0.0%67946 0.004 0.025 0.061
TOTAL: 48:02:11.75647:59:35.896 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.124 0.0%22686 0.000 0.005 0.044
article prepare00:00:00.012 0.0%32520 0.000 0.000 0.007
article read00:00:00.644 0.0%5342 0.000 0.121 7.200
backlog stats00:00:00.272 0.0%365608 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.202 0.0%228272 0.002 0.010 0.023
data write00:00:04.068 0.0%206334 0.009 0.020 0.040
idle47:35:51.522100.0%365608 240.512 468.676 1038.708
status file00:00:02.070 0.0%350 1.000 5.914 64.667
TOTAL: 47:36:19.29647:36:00.914100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:14:27.098 70.9%17632 6.000 49.178 4835.745
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.334 0.2%214802 0.000 0.011 1.000
readart00:00:18.382 1.5%2062 3.182 8.915 35.500
TOTAL: 00:20:23.14400:14:47.814 72.6%----

Control commands to INND:

CommandNumber
L 2
flush 2
go 4
logmode 2
mode 9
name 2
pause 2
paused 2
reserve 4
TOTAL: 9 29

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.snarked.org 50 23248 6222 16716 310 26%54:40:18
2ripco-out.feed.uzoreto.com 1148 24710 5890 14854 3966 23%94:43:16
3feeder3.feed-ams.uzoreto.com 574 16598 5534 8898 2166 33%47:19:20
4newsfeed.neva.ru 600 29508 3738 24222 1548 12%273:31:18
5ripco-out.news.tnetconsulting.net 2 28420 608 27758 54 2%55:40:22
6newsfeed.fu-berlin.de 2 12890 500 12356 34 3%50:07:02
7news.lightlink.com 2 12578 360 11876 342 2%90:30:28
8news.cmpublishers.com 50 6868 14 6840 14 0%48:00:00
9news-in.rahul.net 574 13506 10 13458 38 0%47:29:28
10ripco-out.feeder.erje.net 574 24712 10 23914 788 0%47:17:56
11localhost 148 2 2 0 0 100%00:00:02
TOTAL: 11 3724 193040 22888 160892 9260 11%809:19:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org19.1 MB0.0 KB1.3 MB20.4 MB 93%3.2 KB
2ripco-out.news.tnetconsulting.net15.8 MB0.0 KB1000.7 KB16.8 MB 94%26.0 KB
3ripco-out.feed.uzoreto.com15.0 MB0.0 KB7.6 MB22.7 MB 66%2.4 KB
4feeder3.feed-ams.uzoreto.com13.4 MB0.0 KB3.9 MB17.3 MB 77%2.3 KB
5newsfeed.neva.ru11.8 MB0.0 KB9.2 MB21.0 MB 56%4.1 KB
6news.lightlink.com7.5 MB0.0 KB13.8 MB21.3 MB 35%31.1 KB
7newsfeed.fu-berlin.de3.5 MB0.0 KB422.2 KB3.9 MB 89%7.5 KB
8news-in.rahul.net458.8 KB0.0 KB1.5 MB1.9 MB 23%40.6 KB
9news.cmpublishers.com42.0 KB0.0 KB56.1 KB98.1 KB 42%3.5 KB
10ripco-out.feeder.erje.net28.5 KB0.0 KB6.7 MB6.8 MB 0%8.7 KB
11localhost5.2 KB0.0 KB0.0 KB5.2 KB100%2.6 KB
TOTAL: 1186.7 MB0.0 KB45.4 MB132.2 MB 65%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 5 00:01:01 - 00:59:59 277 2.5% 0.081.4 MB 3.6% 0.41
Sep 5 01:00:00 - 01:59:59 414 3.7% 0.121.7 MB 4.3% 0.49
Sep 5 02:00:00 - 02:59:59 314 2.8% 0.091006.4 KB 2.5% 0.28
Sep 5 03:00:00 - 03:59:59 448 4.0% 0.121.9 MB 4.7% 0.53
Sep 5 04:00:00 - 04:59:59 406 3.6% 0.111.3 MB 3.2% 0.36
Sep 5 05:00:00 - 05:59:59 485 4.3% 0.132.2 MB 5.4% 0.62
Sep 5 06:00:00 - 06:59:59 613 5.4% 0.171.7 MB 4.2% 0.48
Sep 5 07:00:00 - 07:59:59 496 4.4% 0.141.5 MB 3.8% 0.43
Sep 5 08:00:00 - 08:59:59 617 5.5% 0.172.0 MB 4.9% 0.56
Sep 5 09:00:00 - 09:59:59 744 6.6% 0.212.9 MB 7.2% 0.81
Sep 5 10:00:00 - 10:59:59 676 6.0% 0.192.1 MB 5.3% 0.60
Sep 5 11:00:00 - 11:59:59 596 5.3% 0.171.9 MB 4.7% 0.54
Sep 5 12:00:00 - 12:59:59 630 5.6% 0.171.8 MB 4.6% 0.52
Sep 5 13:00:00 - 13:59:59 557 4.9% 0.151.8 MB 4.6% 0.52
Sep 5 14:00:00 - 14:59:59 547 4.8% 0.151.9 MB 4.7% 0.54
Sep 5 15:00:00 - 15:59:59 503 4.5% 0.141.6 MB 4.0% 0.46
Sep 5 16:00:00 - 16:59:59 477 4.2% 0.131.5 MB 3.7% 0.42
Sep 5 17:00:00 - 17:59:59 441 3.9% 0.121.8 MB 4.4% 0.50
Sep 5 18:00:00 - 18:59:59 394 3.5% 0.111.4 MB 3.6% 0.40
Sep 5 19:00:00 - 19:59:59 343 3.0% 0.101.3 MB 3.4% 0.38
Sep 5 20:00:00 - 20:59:59 428 3.8% 0.121.2 MB 3.0% 0.34
Sep 5 21:00:00 - 21:59:59 277 2.5% 0.08863.4 KB 2.1% 0.24
Sep 5 22:00:00 - 22:59:59 329 2.9% 0.091.4 MB 3.5% 0.39
Sep 5 23:00:00 - 23:57:38 280 2.5% 0.081.8 MB 4.5% 0.53
TOTAL: 23:56:37 11292 100.0% 0.1339.8 MB 100.0% 0.47
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1983 1383 0 0 5 0 0 0 595
2feeder3.feed-ams.uzoreto.com 1089 905 0 0 3 0 0 0 181
3newsfeed.neva.ru 834 416 0 0 3 0 0 0 415
4ripco-out.feeder.erje.net 394 390 0 0 0 0 0 0 4
5news.snarked.org 161 49 0 0 1 0 0 0 111
6newsfeed.fu-berlin.de 121 0 0 0 0 0 0 0 121
7news.lightlink.com 108 1 0 0 0 0 0 0 107
8ripco-out.news.tnetconsulting.net 34 23 0 0 0 0 0 0 11
9news-in.rahul.net 19 0 0 0 0 0 0 0 19
10news.cmpublishers.com 8 1 0 0 0 0 0 0 7
TOTAL: 10 4751 3168 0 0 12 0 0 0 1571

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2434
alt.binaries.ftd 201
scinet.stats 31
alt.binaries.pictures.purebeauty 26
free.software 24
alt.binaries.pictures.rail 21
it.comp.os.win.windows10 21
fido7.su.pol.news 19
scot.general 16
alt.binaries.pictures.scenic 15
alt.binaries.e-book 14
alt.bestjobsusa.computer.jobs 13
it.tlc.cellulari.android 13
de.soc.arbeitslos 11
free.it.scienza.fisica 10
alt.binaries.pictures.wallpaper 10
linux.debian.changes 10
alt.binaries.comics.dcp 9
alt.binaries.humor.skewed 8
alt.binaries.ebooks 8
TOTAL: 175 3168

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

GroupsCount
pl.praca.oferowana 6
christnet.bible 3
rec.travel.resorts.all-inclusive 2
bit.listserv.catholic 1
TOTAL: 4 12

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1154
Too many newsgroups 1052
EMP (phl) 394
Binary in non-binary group 146
Scoring filter (10) 26
Scoring filter (9) 20
Scoring filter (11) 16
Scoring filter (8) 10
Scoring filter (15) 8
Poison newsgroup 6
Scoring filter (18) 6
Scoring filter (13) 2
TOTAL: 12 2840

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 36
ripco-out.feed.uzoreto.com 16
feeder3.feed-ams.uzoreto.com 10
TOTAL: 3 62
Including strange strings
newsfeed.fu-berlin.de 101
newsfeed.neva.ru 45
feeder3.feed-ams.uzoreto.com 5
TOTAL: 3 151
No colon-space in header
ripco-out.feeder.erje.net 1
TOTAL: 1 1
TOTAL: 3 214

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feeder.erje.net 24950 3016 17362 1432 0 0 12%47:40:00
2news.lightlink.com 8614 1522 4956 12 0 0 17%47:45:18
3rahul.net 23814 704 11770 14 0 0 2%47:40:04
4news.cmpublishers.com 31056 144 21130 964 0 28 0%47:45:16
5fu-berlin.de 20364 72 20292 0 0 0 0%47:40:04
6news.tnetconsulting.net 32102 58 21936 2 0 14 0%47:40:00
7news.snarked.org 27278 32 16062 16 0 136 0%47:39:42
8news.uzoreto.com 11304 20 10700 88 0 0 0%47:39:10
9newsfeed.neva.ru 19514 20 18788 10 0 0 0%47:39:06
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:04
TOTAL: 10 199002 5588 142996 2544 0 178 2%430:20:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1feeder.erje.net9.0 MB3.7 MB12.7 MB0.1 KB/s2.9 KB47:40:00
2news.lightlink.com4.9 MB36.5 KB4.9 MB0.0 KB/s3.3 KB47:45:18
3rahul.net4.9 MB25.5 KB4.9 MB0.0 KB/s7.0 KB47:40:04
4news.cmpublishers.com596.9 KB2.9 MB3.5 MB0.0 KB/s3.2 KB47:45:16
5fu-berlin.de584.3 KB0.0 KB584.3 KB0.0 KB/s8.1 KB47:40:04
6news.tnetconsulting.net341.3 KB173.7 KB515.0 KB0.0 KB/s8.6 KB47:40:00
7news.snarked.org317.9 KB44.5 KB362.4 KB0.0 KB/s7.6 KB47:39:42
8newsfeed.neva.ru243.3 KB28.1 KB271.4 KB0.0 KB/s9.0 KB47:39:06
9news.uzoreto.com59.1 KB194.9 KB254.0 KB0.0 KB/s2.4 KB47:39:10
10remote6hme0.ripco.com0.0 KB37.2 KB37.2 KB0.0 KB/s6.2 KB01:12:04
TOTAL: 1020.8 MB7.2 MB28.0 MB0.0 KB/s3.5 KB430:20:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10103.2 MB 424 2 000:10:37
2shell3.ripco.com 4 40225.6 KB 16 0 000:08:20
TOTAL: 2 290 10503.4 MB 440 2 000:20:08

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10103.2 MB 424 2 000:10:37
2*.ripco.com 4 40225.6 KB 16 0 000:08:20
TOTAL: 2 290 10503.4 MB 440 2 000:18:57

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ftupet.com 47.786 21.370 0.00000:10:37
shell3.ripco.com 0.984 0.598 0.00000:08:20
84-105-134-55.cable.dynamic.v4.ziggo.nl 14.784 3.986 0.00000:01:11
TOTAL: 3 63.554 25.954 0.00000:20:08

NNRP no permission clients:

SystemConn
84-105-134-55.cable.dynamic.v4.ziggo.nl 146
TOTAL: 1 146

Newsgroup request counts (by category):

CategoryCountPct
1rec 1010 96.2%
2comp 14 1.3%
3sci 8 0.8%
4alt 6 0.6%
5chi 4 0.4%
6news 4 0.4%
7misc 4 0.4%
TOTAL: 7 1050100.0%

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

NewsgroupCount
1rec.food.cooking 570
2rec.arts.tv 386
3rec.bicycles.tech 44
4sci.electronics.repair 8
5comp.sys.mac.system 8
6rec.radio.broadcasting 6
7alt.free.newsservers 6
8comp.unix.bsd.freebsd.misc 6
9chi.weather 4
10misc.consumers.frugal-living 4
11rec.bicycles.misc 2
12news.admin.net-abuse.email 2
13news.admin.net-abuse.usenet 2
14rec.radio.swap 2
TOTAL: 14 1050