Daily Usenet report for news.ripco.com

Sep 18 00:01:01 -- Sep 18 23:58:02

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Sep 18 03:59:26 remote5bge0 overchan[9936]: [ID 702911 news.error] input line too long, skipping
Sep 18 04:00:12 remote5bge0 overchan[9936]: [ID 702911 news.error] input line too long, skipping
Sep 18 07:19:07 remote5bge0 overchan[9936]: [ID 702911 news.error] input line too long, skipping
Sep 18 07:28:35 remote5bge0 overchan[9936]: [ID 702911 news.error] input line too long, skipping
Sep 18 07:36:24 remote5bge0 overchan[9936]: [ID 702911 news.error] input line too long, skipping
Sep 18 10:13:23 remote5bge0 overchan[9936]: [ID 702911 news.error] input line too long, skipping
Sep 18 13:08:15 remote5bge0 overchan[9936]: [ID 702911 news.error] input line too long, skipping
Sep 18 14:16:57 remote5bge0 overchan[9936]: [ID 702911 news.error] input line too long, skipping
Sep 18 15:14:21 remote5bge0 overchan[9936]: [ID 702911 news.error] input line too long, skipping
Sep 18 16:25:36 remote5bge0 overchan[9936]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 23838 37.7%2.7 MB 27.5%
innd 17926 28.4%2.8 MB 28.8%
inn 17772 28.1%3.5 MB 35.9%
innfeed 3652 5.8%773.7 KB 7.8%
overchan 10 0.0%1.2 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 63200 100.0%9.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 173894 58.0%
Cache misses 125736 42.0%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 299630 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%108 0.000 0.000 0.000
article cleanup00:00:00.404 0.0%35144 0.000 0.011 0.090
article logging00:00:00.862 0.0%35498 0.000 0.024 0.190
article parse00:00:01.320 0.0%90792 0.000 0.015 0.033
article write00:01:38.048 0.1%27298 1.241 3.592 178.205
artlog/artparse00:00:00.000 0.0%6 0.000 0.000 0.000
data move00:00:00.354 0.0%308102 0.000 0.001 0.007
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.864 0.0%299992 0.001 0.010 0.020
history sync00:00:00.190 0.0%794 0.000 0.239 1.500
history write00:00:04.824 0.0%35150 0.000 0.137 6.287
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:35:14.492 99.8%349836 276.543 489.699 1278.235
nntp read00:00:02.932 0.0%346308 0.004 0.008 0.020
overview write00:00:00.272 0.0%27298 0.000 0.010 0.059
perl filter00:00:52.638 0.0%35144 1.139 1.498 3.111
python filter00:00:01.328 0.0%35150 0.000 0.038 0.122
site send00:00:02.058 0.0%81880 0.000 0.025 0.049
TOTAL: 47:42:11.85647:38:02.586 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.122 0.0%27374 0.000 0.004 0.038
article prepare00:00:00.000 0.0%6184 0.000 0.000 0.000
article read00:00:00.306 0.0%1378 0.000 0.222 70.000
backlog stats00:00:00.272 0.0%344656 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.398 0.0%221560 0.000 0.011 0.024
data write00:00:03.696 0.0%194532 0.007 0.019 0.053
idle47:33:59.576100.0%344656 258.974 496.842 1411.986
status file00:00:03.802 0.0%352 1.000 10.801 62.867
TOTAL: 47:34:30.34447:34:10.172100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:27:53.872 89.2%18078 6.333 690.003 85776.286
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:10.140 0.1%1235546 0.000 0.008 5.000
readart00:00:20.332 0.1%2250 0.056 9.036 35.500
TOTAL: 03:53:03.25003:28:24.344 89.4%----

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
1ripco-out.feed.uzoreto.com 1148 33070 15400 12970 4700 46%94:47:44
2newsfeed.neva.ru 588 14776 5800 7696 1280 39%275:46:30
3feeder3.feed-ams.uzoreto.com 574 10444 4340 5382 722 41%47:28:30
4ripco-out.news.tnetconsulting.net 4 30492 876 29506 110 2%49:42:26
5newsfeed.fu-berlin.de 2 15144 600 14504 40 3%53:18:38
6news-in.rahul.net 574 14852 296 14462 94 1%47:21:10
7news.lightlink.com 2 8116 96 7888 132 1%52:29:26
8news.cmpublishers.com 50 7266 32 7184 50 0%47:56:58
9ripco-out.feeder.erje.net 574 28646 20 27952 674 0%47:16:34
10localhost 152 6 6 0 0 100%00:00:00
TOTAL: 10 3668 162812 27466 127544 7802 16%716:07:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com40.5 MB0.0 KB9.5 MB50.0 MB 80%2.5 KB
2newsfeed.neva.ru17.2 MB0.0 KB4.3 MB21.4 MB 80%3.1 KB
3feeder3.feed-ams.uzoreto.com11.3 MB0.0 KB1.7 MB12.9 MB 87%2.6 KB
4ripco-out.news.tnetconsulting.net10.9 MB0.0 KB1.6 MB12.5 MB 87%13.0 KB
5news.lightlink.com5.7 MB0.0 KB7.9 MB13.5 MB 42%60.8 KB
6news-in.rahul.net4.6 MB0.0 KB3.9 MB8.5 MB 53%22.3 KB
7newsfeed.fu-berlin.de3.4 MB0.0 KB868.0 KB4.2 MB 80%6.8 KB
8ripco-out.feeder.erje.net85.0 KB0.0 KB4.1 MB4.1 MB 2%6.1 KB
9news.cmpublishers.com80.6 KB0.0 KB138.7 KB219.3 KB 36%2.7 KB
10localhost16.6 KB0.0 KB0.0 KB16.6 KB100%2.8 KB
TOTAL: 1093.6 MB0.0 KB33.9 MB127.5 MB 73%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 18 00:01:01 - 00:59:59 329 2.4% 0.09851.8 KB 1.9% 0.24
Sep 18 01:00:00 - 01:59:59 379 2.8% 0.11971.5 KB 2.1% 0.27
Sep 18 02:00:00 - 02:59:59 553 4.0% 0.151.4 MB 3.2% 0.41
Sep 18 03:00:00 - 03:59:59 584 4.3% 0.161.5 MB 3.3% 0.42
Sep 18 04:00:00 - 04:59:59 670 4.9% 0.191.7 MB 3.7% 0.47
Sep 18 05:00:00 - 05:59:59 629 4.6% 0.172.1 MB 4.6% 0.58
Sep 18 06:00:00 - 06:59:59 547 4.0% 0.152.1 MB 4.7% 0.60
Sep 18 07:00:00 - 07:59:59 675 4.9% 0.191.8 MB 4.0% 0.51
Sep 18 08:00:00 - 08:59:59 732 5.4% 0.202.8 MB 6.2% 0.79
Sep 18 09:00:00 - 09:59:59 767 5.6% 0.211.9 MB 4.3% 0.55
Sep 18 10:00:00 - 10:59:59 811 5.9% 0.233.3 MB 7.3% 0.93
Sep 18 11:00:00 - 11:59:59 770 5.6% 0.212.5 MB 5.5% 0.70
Sep 18 12:00:00 - 12:59:59 684 5.0% 0.192.0 MB 4.6% 0.58
Sep 18 13:00:00 - 13:59:59 749 5.5% 0.213.2 MB 7.1% 0.90
Sep 18 14:00:00 - 14:59:59 738 5.4% 0.202.3 MB 5.1% 0.65
Sep 18 15:00:00 - 15:59:59 675 4.9% 0.192.4 MB 5.4% 0.69
Sep 18 16:00:00 - 16:59:59 589 4.3% 0.162.6 MB 5.8% 0.74
Sep 18 17:00:00 - 17:59:59 659 4.8% 0.182.5 MB 5.5% 0.70
Sep 18 18:00:00 - 18:59:59 373 2.7% 0.101.2 MB 2.7% 0.34
Sep 18 19:00:00 - 19:59:59 445 3.3% 0.121.4 MB 3.2% 0.40
Sep 18 20:00:00 - 20:59:59 480 3.5% 0.131.6 MB 3.5% 0.44
Sep 18 21:00:00 - 21:59:59 283 2.1% 0.08813.4 KB 1.8% 0.23
Sep 18 22:00:00 - 22:59:59 249 1.8% 0.07814.6 KB 1.8% 0.23
Sep 18 23:00:00 - 23:58:02 291 2.1% 0.081.4 MB 3.1% 0.42
TOTAL: 23:57:01 13661 100.0% 0.1644.9 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2351 1643 0 0 4 0 0 0 704
2newsfeed.neva.ru 723 360 0 0 2 0 0 0 361
3feeder3.feed-ams.uzoreto.com 364 177 0 0 0 0 0 0 187
4ripco-out.feeder.erje.net 337 332 0 0 0 0 0 0 5
5newsfeed.fu-berlin.de 103 0 0 0 0 0 0 0 103
6news.lightlink.com 92 6 0 0 0 0 0 0 86
7ripco-out.news.tnetconsulting.net 69 8 0 0 0 0 0 0 61
8news-in.rahul.net 47 0 0 0 0 0 0 0 47
9news.cmpublishers.com 25 0 0 0 0 0 0 0 25
TOTAL: 9 4111 2526 0 0 6 0 0 0 1579

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1825
alt.binaries.ftd 118
alt.bestjobsusa.computer.jobs 39
fido7.su.pol.news 33
scinet.stats 29
scot.general 25
it.comp.os.win.windows10 22
alt.binaries.pictures.erotica.vintage 21
alt.binaries.e-book 21
it.tlc.cellulari.android 21
alt.my.job.sucks 20
alt.binaries.pictures.scenic 15
alt.jobs.jobsearch 14
att.jobs 14
free.software 14
alt.binaries.3d.poser 11
fr.usenet.abus.nocem 11
aus.jobs 10
free.willey 10
alt.binaries.pictures.earlmiller 10
TOTAL: 133 2526

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

GroupsCount
pl.praca.oferowana 6
TOTAL: 1 6

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1422
EMP (md5) 828
EMP (phl) 302
Binary in non-binary group 178
Scoring filter (8) 18
Scoring filter (10) 12
Scoring filter (11) 10
Scoring filter (9) 6
Scoring filter (16) 4
Scoring filter (13) 4
Scoring filter (14) 4
Scoring filter (15) 2
Scoring filter (17) 2
UUencoded txt 2
Scoring filter (12) 2
Scoring filter (18) 2
TOTAL: 16 2798

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 90
newsfeed.neva.ru 83
ripco-out.feed.uzoreto.com 2
feeder3.feed-ams.uzoreto.com 2
TOTAL: 4 177
No colon-space in header
ripco-out.feeder.erje.net 2
ripco-out.feed.uzoreto.com 1
TOTAL: 2 3
TOTAL: 3 198

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 12058 582 6098 112 0 0 4%47:40:00
2rahul.net 21032 418 12308 4 0 0 1%47:40:00
3feeder.erje.net 28684 100 25826 74 0 26 0%47:40:00
4fu-berlin.de 24560 50 24508 0 0 0 0%47:40:00
5news.tnetconsulting.net 42980 46 26316 4 0 68 0%47:45:06
6news.cmpublishers.com 36350 14 26754 100 0 58 0%47:40:00
7newsfeed.neva.ru 21954 12 21414 4 0 0 0%47:32:32
8news.uzoreto.com 7208 12 7054 8 0 0 0%47:41:00
9remote6hme0.ripco.com 8 2 0 6 0 0 25%01:32:08
10news.snarked.org 0 0 0 0 0 27046 0%47:40:00
TOTAL: 10 194834 1236 150278 312 0 27198 0%430:30:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net2.2 MB58.4 KB2.3 MB0.0 KB/s5.5 KB47:40:00
2news.lightlink.com2.0 MB895.6 KB2.9 MB0.0 KB/s4.2 KB47:40:00
3fu-berlin.de658.2 KB0.0 KB658.2 KB0.0 KB/s13.2 KB47:40:00
4news.tnetconsulting.net272.7 KB19.5 KB292.3 KB0.0 KB/s5.8 KB47:45:06
5feeder.erje.net258.9 KB201.0 KB459.9 KB0.0 KB/s2.6 KB47:40:00
6newsfeed.neva.ru48.5 KB156.2 KB204.8 KB0.0 KB/s12.8 KB47:32:32
7news.uzoreto.com38.2 KB24.0 KB62.2 KB0.0 KB/s3.1 KB47:41:00
8news.cmpublishers.com32.3 KB307.6 KB339.9 KB0.0 KB/s3.0 KB47:40:00
9remote6hme0.ripco.com8.8 KB21.6 KB30.4 KB0.0 KB/s3.8 KB01:32:08
10news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 105.5 MB1.6 MB7.1 MB0.0 KB/s4.7 KB430:30:46
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9462.5 MB 424 2 000:10:55
2shell3.ripco.com 28 356893.4 KB 40 4 003:23:12
TOTAL: 2 314 13023.3 MB 464 6 003:51:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9462.5 MB 424 2 000:10:55
2*.ripco.com 28 356893.4 KB 40 4 003:23:12
TOTAL: 2 314 13023.3 MB 464 6 003:34:07

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 6.944 7.182 0.00003:23:12
84-105-134-55.cable.dynamic.v4.ziggo.nl 162.324 43.672 0.00000:17:22
ftupet.com 46.986 20.998 0.00000:10:55
TOTAL: 3 216.254 71.852 0.00003:51:30

NNRP no permission clients:

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

NNRP unrecognized commands (by host):

SystemConn
shell3.ripco.com 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 1058 81.3%
2misc 130 10.0%
3chi 42 3.2%
4comp 40 3.1%
5alt 20 1.5%
6sci 6 0.5%
7news 6 0.5%
TOTAL: 7 1302100.0%

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

NewsgroupCount
1rec.food.cooking 604
2rec.arts.tv 376
3misc.phone.mobile.iphone 122
4rec.bicycles.tech 68
5chi.general 36
6comp.sys.mac.apps 20
7alt.stupidity 14
8comp.mobile.android 10
9comp.security.ssh 8
10misc.consumers.frugal-living 8
11sci.electronics.repair 6
12chi.weather 6
13rec.radio.swap 4
14rec.radio.broadcasting 4
15alt.satellite.gps.garmin 4
16alt.free.newsservers 2
17news.admin.net-abuse.usenet 2
18rec.heraldry 2
19news.groups.questions 2
20comp.risks 2
21news.admin.net-abuse.email 2
TOTAL: 21 1302