Daily Usenet report for news.ripco.com

Jul 13 00:01:01 -- Jul 13 23:57:41

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Jul 13 05:03:53 remote5bge0 overchan[27550]: [ID 702911 news.error] input line too long, skipping
Jul 13 05:07:00 remote5bge0 overchan[27550]: [ID 702911 news.error] input line too long, skipping
Jul 13 08:57:28 remote5bge0 overchan[27550]: [ID 702911 news.error] input line too long, skipping
Jul 13 10:24:02 remote5bge0 overchan[27550]: [ID 702911 news.error] input line too long, skipping
Jul 13 13:58:33 remote5bge0 overchan[27550]: [ID 702911 news.error] input line too long, skipping
Jul 13 21:04:05 remote5bge0 overchan[27550]: [ID 702911 news.error] input line too long, skipping
Jul 13 23:37:36 remote5bge0 overchan[27550]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 19455 32.1%3.8 MB 40.7%
nnrpd 18834 31.1%2.0 MB 21.3%
innd 18481 30.5%2.8 MB 30.3%
innfeed 3766 6.2%744.6 KB 7.7%
overchan 7 0.0%0.8 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 60545 100.0%9.4 MB100.0%

History cache:

ReasonCount%Count
Cache misses 245652 58.6%
Do not exist 173544 41.4%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 419196 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%160 0.000 0.000 0.000
article cleanup00:00:00.478 0.0%38676 0.000 0.012 0.043
article logging00:00:00.738 0.0%39074 0.000 0.019 0.067
article parse00:00:01.450 0.0%96314 0.000 0.015 0.042
article write00:01:31.566 0.1%30222 1.437 3.030 87.140
artlog/artparse00:00:00.000 0.0%6 0.000 0.000 0.000
data move00:00:00.328 0.0%359778 0.000 0.001 0.003
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.880 0.0%421810 0.001 0.007 0.018
history sync00:00:00.278 0.0%796 0.000 0.349 2.500
history write00:00:03.256 0.0%38680 0.000 0.084 1.211
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:56:56.808 99.8%398840 83.539 432.797 984.719
nntp read00:00:02.608 0.0%395972 0.001 0.007 0.021
overview write00:00:00.330 0.0%30222 0.000 0.011 0.060
perl filter00:00:56.406 0.0%38674 1.115 1.458 2.333
python filter00:00:01.290 0.0%38678 0.000 0.033 0.108
site send00:00:02.764 0.0%90650 0.005 0.030 0.078
TOTAL: 48:02:11.90647:59:41.180 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.284 0.0%108972 0.000 0.003 0.044
article prepare00:00:00.002 0.0%8448 0.000 0.000 0.008
article read00:00:00.396 0.0%1586 0.000 0.250 72.000
backlog stats00:00:00.246 0.0%406652 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.186 0.0%252326 0.001 0.009 0.021
data write00:00:03.996 0.0%222188 0.005 0.018 0.046
idle47:51:28.658100.0%406652 30.855 423.676 1204.144
status file00:00:03.728 0.0%422 1.000 8.834 39.000
TOTAL: 47:51:59.91047:51:39.496100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:16:39.414 71.6%17648 18.250 56.630 4576.132
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.286 0.2%213142 0.000 0.011 1.000
readart00:00:18.296 1.3%2044 1.167 8.951 36.500
TOTAL: 00:23:15.40600:16:59.996 73.1%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 30222 11396 15518 3308 37%94:38:14
2feeder3.feed-ams.uzoreto.com 574 18018 7018 8788 2212 38%47:18:56
3newsfeed.neva.ru 584 34294 5232 27634 1428 15%280:51:16
4ripco-out.news.tnetconsulting.net 4 27570 3070 24296 204 11%37:31:06
5news.snarked.org 24 91704 2294 89226 184 2%23:51:42
6newsfeed.fu-berlin.de 2 14460 578 13862 20 3%47:43:22
7news.lightlink.com 2 8180 196 7798 186 2%43:52:52
8news-in.rahul.net 574 15090 56 14970 64 0%47:20:30
9ripco-out.feeder.erje.net 574 30848 26 30106 716 0%47:17:36
10news.cmpublishers.com 50 7924 8 7906 10 0%48:00:00
11localhost 150 4 4 0 0 100%00:00:00
TOTAL: 11 3686 278314 29878 240104 8332 10%718:25:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com29.6 MB0.0 KB6.5 MB36.1 MB 81%2.5 KB
2ripco-out.news.tnetconsulting.net19.8 MB0.0 KB1.6 MB21.4 MB 92%6.7 KB
3newsfeed.neva.ru17.7 MB7.5 KB3.4 MB21.1 MB 83%3.3 KB
4feeder3.feed-ams.uzoreto.com16.5 MB0.0 KB3.9 MB20.4 MB 80%2.3 KB
5news.lightlink.com7.1 MB0.0 KB8.5 MB15.6 MB 45%41.8 KB
6news.snarked.org6.2 MB0.0 KB534.8 KB6.7 MB 92%2.8 KB
7newsfeed.fu-berlin.de4.8 MB0.0 KB1.1 MB5.8 MB 81%10.0 KB
8news-in.rahul.net1.3 MB0.0 KB2.7 MB4.0 MB 33%33.9 KB
9ripco-out.feeder.erje.net104.8 KB0.0 KB4.8 MB4.9 MB 2%6.7 KB
10news.cmpublishers.com16.3 KB3.0 KB12.2 KB31.5 KB 51%1.8 KB
11localhost10.1 KB0.0 KB0.0 KB10.1 KB100%2.5 KB
TOTAL: 11103.0 MB10.4 KB33.0 MB136.0 MB 75%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 13 00:01:01 - 00:59:59 309 2.1% 0.092.1 MB 4.1% 0.61
Jul 13 01:00:00 - 01:59:59 453 3.0% 0.131.5 MB 3.0% 0.44
Jul 13 02:00:00 - 02:59:59 577 3.8% 0.161.7 MB 3.3% 0.49
Jul 13 03:00:00 - 03:59:59 571 3.8% 0.161.7 MB 3.2% 0.47
Jul 13 04:00:00 - 04:59:59 734 4.9% 0.202.9 MB 5.7% 0.84
Jul 13 05:00:00 - 05:59:59 763 5.1% 0.212.5 MB 4.7% 0.70
Jul 13 06:00:00 - 06:59:59 715 4.8% 0.202.5 MB 4.8% 0.70
Jul 13 07:00:00 - 07:59:59 792 5.3% 0.222.3 MB 4.5% 0.66
Jul 13 08:00:00 - 08:59:59 704 4.7% 0.202.3 MB 4.5% 0.67
Jul 13 09:00:00 - 09:59:59 818 5.4% 0.232.7 MB 5.2% 0.76
Jul 13 10:00:00 - 10:59:59 827 5.5% 0.232.5 MB 4.8% 0.71
Jul 13 11:00:00 - 11:59:59 899 6.0% 0.253.1 MB 6.0% 0.88
Jul 13 12:00:00 - 12:59:59 782 5.2% 0.222.5 MB 4.8% 0.71
Jul 13 13:00:00 - 13:59:59 822 5.5% 0.232.9 MB 5.5% 0.81
Jul 13 14:00:00 - 14:59:59 731 4.9% 0.202.4 MB 4.7% 0.69
Jul 13 15:00:00 - 15:59:59 739 4.9% 0.212.4 MB 4.7% 0.69
Jul 13 16:00:00 - 16:59:59 747 5.0% 0.213.5 MB 6.7% 0.99
Jul 13 17:00:00 - 17:59:59 678 4.5% 0.192.0 MB 3.9% 0.58
Jul 13 18:00:00 - 18:59:59 569 3.8% 0.162.1 MB 4.0% 0.59
Jul 13 19:00:00 - 19:59:59 478 3.2% 0.131.8 MB 3.6% 0.53
Jul 13 20:00:00 - 20:59:59 339 2.3% 0.091.1 MB 2.0% 0.30
Jul 13 21:00:00 - 21:59:59 321 2.1% 0.09893.0 KB 1.7% 0.25
Jul 13 22:00:00 - 22:59:59 367 2.4% 0.101.6 MB 3.0% 0.44
Jul 13 23:00:00 - 23:57:41 302 2.0% 0.09814.1 KB 1.5% 0.24
TOTAL: 23:56:40 15037 100.0% 0.1751.7 MB 100.0% 0.61
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1655 1009 0 0 5 0 0 0 641
2feeder3.feed-ams.uzoreto.com 1109 888 0 0 2 0 0 0 219
3newsfeed.neva.ru 755 426 0 1 0 0 0 0 328
4ripco-out.feeder.erje.net 357 355 0 0 0 0 0 0 2
5newsfeed.fu-berlin.de 165 0 0 0 0 0 0 0 165
6news.lightlink.com 137 0 0 0 0 0 0 0 137
7ripco-out.news.tnetconsulting.net 105 45 0 0 0 0 0 0 60
8news.snarked.org 99 30 0 0 0 0 0 0 69
9news-in.rahul.net 32 0 0 0 0 0 0 0 32
10news.cmpublishers.com 4 4 0 0 0 0 0 0 0
TOTAL: 10 4418 2757 0 1 7 0 0 0 1653

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2012
alt.binaries.ftd 162
alt.binaries.e-book 49
fido7.su.pol.news 48
perl.cpan.uploads 43
scinet.stats 30
it.tlc.cellulari.android 27
uk.net.news.moderation 26
scot.general 25
alt.paranormal.spells 24
abg.test04 23
free.it.scienza.fisica 16
alt.binaries.e-book.magazines 10
alt.binaries.test.yenc 10
alt.binaries.pictures.scenic 8
alt.binaries.e-books 8
alt.culture 7
it.comp.os.win.windows10 7
alt.binaries.sounds.lossless 6
alt.bestjobsusa.computer.jobs 6
TOTAL: 129 2757

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1568
Too many newsgroups 936
EMP (phl) 200
Binary in non-binary group 146
Scoring filter (8) 28
Scoring filter (10) 8
Scoring filter (11) 6
Scoring filter (9) 6
Scoring filter (17) 2
Scoring filter (15) 2
HTML post 2
TOTAL: 11 2904

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 30
ripco-out.feed.uzoreto.com 14
feeder3.feed-ams.uzoreto.com 4
TOTAL: 3 48
Including strange strings
newsfeed.fu-berlin.de 158
newsfeed.neva.ru 37
feeder3.feed-ams.uzoreto.com 3
ripco-out.feed.uzoreto.com 1
TOTAL: 4 199
No colon-space in header
ripco-out.feed.uzoreto.com 2
ripco-out.feeder.erje.net 1
TOTAL: 2 3
TOTAL: 3 250

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 24442 854 13138 26 0 0 3%47:40:00
2feeder.erje.net 35442 310 29012 82 0 6 0%47:53:18
3fu-berlin.de 27408 114 27294 0 0 0 0%47:40:04
4news.tnetconsulting.net 43962 52 26806 4 0 56 0%47:52:50
5news.uzoreto.com 11404 52 10990 166 0 0 0%47:40:00
6news.cmpublishers.com 43052 28 29176 392 0 38 0%47:40:00
7news.snarked.org 90140 22 85682 0 0 18108 0%47:36:48
8news.lightlink.com 0 0 0 0 0 7178 0%47:40:00
9newsfeed.neva.ru 0 0 0 0 0 24892 0%47:59:50
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:06
TOTAL: 10 275856 1432 222098 676 0 50278 0%430:54:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net9.5 MB143.4 KB9.7 MB0.1 KB/s11.2 KB47:40:00
2fu-berlin.de1.5 MB0.0 KB1.5 MB0.0 KB/s13.4 KB47:40:04
3feeder.erje.net1.0 MB308.3 KB1.3 MB0.0 KB/s3.5 KB47:53:18
4news.snarked.org488.9 KB0.0 KB488.9 KB0.0 KB/s22.2 KB47:36:48
5news.tnetconsulting.net179.8 KB12.5 KB192.4 KB0.0 KB/s3.4 KB47:52:50
6news.uzoreto.com159.3 KB592.2 KB751.5 KB0.0 KB/s3.4 KB47:40:00
7news.cmpublishers.com113.0 KB1.1 MB1.2 MB0.0 KB/s2.9 KB47:40:00
8news.lightlink.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
9newsfeed.neva.ru0.0 KB0.0 KB0.0 KB0.0 KB/s047:59:50
10remote6hme0.ripco.com0.0 KB25.4 KB25.4 KB0.0 KB/s4.2 KB01:12:06
TOTAL: 1013.0 MB2.1 MB15.1 MB0.0 KB/s7.3 KB430:54:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9942.6 MB 430 2 000:08:10
2shell3.ripco.com 6 54134.6 KB 22 2 000:11:17
TOTAL: 2 292 10482.7 MB 452 4 000:22:52

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9942.6 MB 430 2 000:08:10
2*.ripco.com 6 54134.6 KB 22 2 000:11:17
TOTAL: 2 292 10482.7 MB 452 4 000:19:27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 1.302 0.594 0.00000:11:17
ftupet.com 47.704 21.008 0.00000:08:10
84-105-134-55.cable.dynamic.v4.ziggo.nl 42.030 10.998 0.00000:03:24
TOTAL: 3 91.036 32.600 0.00000:22:52

NNRP no permission clients:

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

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 986 94.1%
2comp 30 2.9%
3alt 12 1.1%
4seattle 8 0.8%
5news 8 0.8%
6chi 4 0.4%
TOTAL: 6 1048100.0%

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

NewsgroupCount
1rec.arts.tv 546
2rec.food.cooking 412
3comp.sys.mac.system 18
4rec.bicycles.tech 14
5alt.stupidity 12
6seattle.general 8
7rec.gardens.edible 8
8rec.radio.swap 4
9chi.weather 4
10comp.protocols.dns.bind 4
11news.software.nntp 4
12comp.risks 2
13rec.radio.broadcasting 2
14comp.unix.bsd.freebsd.misc 2
15comp.mail.sendmail 2
16news.admin.net-abuse.usenet 2
17news.software.readers 2
18comp.security.ssh 2
TOTAL: 18 1048