Daily Usenet report for news.ripco.com

Oct 13 00:01:02 -- Oct 13 23:57:57

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Oct 13 00:50:51 remote5bge0 overchan[12809]: [ID 702911 news.error] input line too long, skipping
Oct 13 11:26:47 remote5bge0 overchan[12809]: [ID 702911 news.error] input line too long, skipping
Oct 13 13:10:02 s_local@remote5bge0 controlchan[12798]: [ID 702911 news.notice] Multiple control headers in article <AZwUh-1Dz-5@gated-at.bofh.it>
Oct 13 13:10:02 remote5bge0 controlchan[12798]: [ID 702911 news.notice] Multiple control headers in article <AZwUh-1Dz-5@gated-at.bofh.it>
Oct 13 13:12:09 remote5bge0 overchan[12809]: [ID 702911 news.error] input line too long, skipping
Oct 13 14:42:06 remote5bge0 overchan[12809]: [ID 702911 news.error] input line too long, skipping
Oct 13 14:46:32 remote5bge0 overchan[12809]: [ID 702911 news.error] input line too long, skipping
Oct 13 14:59:11 remote5bge0 overchan[12809]: [ID 702911 news.error] input line too long, skipping
Oct 13 15:05:34 remote5bge0 overchan[12809]: [ID 702911 news.error] input line too long, skipping
Oct 13 15:07:41 remote5bge0 overchan[12809]: [ID 702911 news.error] input line too long, skipping
Oct 13 17:38:54 remote5bge0 overchan[12809]: [ID 702911 news.error] input line too long, skipping
Oct 13 20:19:18 remote5bge0 overchan[12809]: [ID 702911 news.error] input line too long, skipping
Oct 13 20:50:00 remote5bge0 overchan[12809]: [ID 702911 news.error] input line too long, skipping
Oct 13 21:16:19 remote5bge0 overchan[12809]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 18345 31.8%2.9 MB 31.8%
inn 18312 31.8%3.6 MB 39.5%
nnrpd 17286 30.0%1.8 MB 19.9%
innfeed 3654 6.3%810.7 KB 8.8%
overchan 12 0.0%1.7 KB 0.0%
controlchan 4 0.0%0.4 KB 0.0%
TOTAL: 6 57613 100.0%9.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 170776 50.5%
Cache misses 167316 49.5%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 338092 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%38 0.000 0.000 0.000
article cleanup00:00:00.470 0.0%36386 0.000 0.013 0.067
article logging00:00:00.702 0.0%36680 0.000 0.019 0.065
article parse00:00:01.454 0.0%92510 0.000 0.016 0.053
article write00:01:48.146 0.1%27896 1.782 3.877 64.843
artlog/artparse00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:00.374 0.0%342044 0.000 0.001 0.006
hishave/artparse00:00:00.000 0.0%6 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.128 0.0%339030 0.000 0.009 0.018
history sync00:00:00.224 0.0%782 0.000 0.286 4.667
history write00:00:03.678 0.0%36388 0.029 0.101 2.478
hiswrite/artparse00:00:00.000 0.0%6 0.000 0.000 0.000
idle47:56:37.966 99.8%381084 233.180 452.913 1153.498
nntp read00:00:03.078 0.0%380352 0.003 0.008 0.016
overview write00:00:00.282 0.0%27896 0.000 0.010 0.065
perl filter00:00:53.962 0.0%36384 1.213 1.483 2.413
python filter00:00:01.402 0.0%36388 0.000 0.039 0.170
site send00:00:01.982 0.0%83638 0.000 0.024 0.065
TOTAL: 48:02:10.83847:59:36.848 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.320 0.0%28232 0.000 0.011 0.056
article prepare00:00:00.010 0.0%13224 0.000 0.001 0.018
article read00:00:00.532 0.0%2924 0.000 0.182 71.000
backlog stats00:00:00.312 0.0%432816 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.726 0.0%272300 0.001 0.010 0.020
data write00:00:04.674 0.0%245698 0.009 0.019 0.032
idle47:52:41.280100.0%432816 212.925 398.232 1002.652
status file00:00:02.196 0.0%360 0.000 6.100 32.000
TOTAL: 47:53:13.10247:52:52.050100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:55:26.372 95.7%18140 5.000 580.285 36471.378
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.690 0.1%909300 0.000 0.010 0.062
readart00:00:20.312 0.2%2238 0.000 9.076 36.000
TOTAL: 03:03:23.78802:55:55.374 95.9%----

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 34534 12352 17416 4766 35%94:38:28
2newsfeed.neva.ru 582 31432 5774 24464 1194 18%275:49:42
3news.snarked.org 42 24404 5282 18908 214 21%47:06:28
4feeder3.feed-ams.uzoreto.com 574 11966 3158 7620 1188 26%47:19:32
5newsfeed.fu-berlin.de 6 11832 464 11360 8 3%45:56:04
6ripco-out.news.tnetconsulting.net 2 26046 396 25578 72 1%39:26:00
7news-in.rahul.net 574 14180 58 14102 20 0%47:17:30
8ripco-out.feeder.erje.net 576 28856 54 27924 878 0%47:27:40
9news.lightlink.com 2 8458 22 8412 24 0%52:29:26
10localhost 150 4 4 0 0 100%00:00:00
11news.cmpublishers.com 52 7114 2 7104 8 0%47:59:32
TOTAL: 11 3708 198826 27566 162888 8372 13%745:30:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com30.7 MB0.0 KB9.4 MB40.1 MB 76%2.4 KB
2news.snarked.org15.2 MB0.0 KB795.0 KB16.0 MB 95%3.0 KB
3newsfeed.neva.ru15.2 MB5.2 KB2.9 MB18.1 MB 83%2.7 KB
4ripco-out.news.tnetconsulting.net11.0 MB0.0 KB868.0 KB11.9 MB 92%26.0 KB
5feeder3.feed-ams.uzoreto.com7.9 MB0.0 KB2.5 MB10.5 MB 75%2.5 KB
6newsfeed.fu-berlin.de3.0 MB0.0 KB295.4 KB3.3 MB 91%7.1 KB
7news-in.rahul.net2.7 MB0.0 KB1.4 MB4.0 MB 66%52.8 KB
8news.lightlink.com1.1 MB0.0 KB1.8 MB2.9 MB 38%64.4 KB
9ripco-out.feeder.erje.net144.2 KB0.0 KB6.8 MB6.9 MB 2%7.6 KB
10localhost13.0 KB0.0 KB0.0 KB13.0 KB100%3.3 KB
11news.cmpublishers.com4.7 KB0.0 KB21.0 KB25.7 KB 18%2.6 KB
TOTAL: 1187.0 MB5.2 KB26.7 MB113.6 MB 76%3.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 13 00:01:02 - 00:59:59 301 2.2% 0.09916.0 KB 2.0% 0.26
Oct 13 01:00:00 - 01:59:59 441 3.2% 0.121.4 MB 3.1% 0.39
Oct 13 02:00:00 - 02:59:59 461 3.3% 0.131.2 MB 2.6% 0.34
Oct 13 03:00:00 - 03:59:59 677 4.9% 0.191.9 MB 4.3% 0.55
Oct 13 04:00:00 - 04:59:59 625 4.5% 0.172.1 MB 4.6% 0.59
Oct 13 05:00:00 - 05:59:59 633 4.5% 0.182.5 MB 5.5% 0.70
Oct 13 06:00:00 - 06:59:59 666 4.8% 0.181.8 MB 4.1% 0.52
Oct 13 07:00:00 - 07:59:59 638 4.6% 0.182.0 MB 4.5% 0.57
Oct 13 08:00:00 - 08:59:59 710 5.1% 0.201.9 MB 4.3% 0.54
Oct 13 09:00:00 - 09:59:59 894 6.4% 0.253.5 MB 7.9% 1.00
Oct 13 10:00:00 - 10:59:59 819 5.9% 0.232.2 MB 4.8% 0.62
Oct 13 11:00:00 - 11:59:59 764 5.5% 0.212.4 MB 5.3% 0.67
Oct 13 12:00:00 - 12:59:59 685 4.9% 0.192.2 MB 4.9% 0.62
Oct 13 13:00:00 - 13:59:59 815 5.9% 0.232.8 MB 6.3% 0.80
Oct 13 14:00:00 - 14:59:59 854 6.1% 0.242.5 MB 5.7% 0.72
Oct 13 15:00:00 - 15:59:59 652 4.7% 0.181.9 MB 4.2% 0.53
Oct 13 16:00:00 - 16:59:59 631 4.5% 0.181.7 MB 3.8% 0.48
Oct 13 17:00:00 - 17:59:59 507 3.6% 0.141.6 MB 3.6% 0.46
Oct 13 18:00:00 - 18:59:59 499 3.6% 0.141.4 MB 3.1% 0.39
Oct 13 19:00:00 - 19:59:59 332 2.4% 0.091.1 MB 2.5% 0.31
Oct 13 20:00:00 - 20:59:59 362 2.6% 0.101.2 MB 2.6% 0.33
Oct 13 21:00:00 - 21:59:59 292 2.1% 0.082.0 MB 4.4% 0.56
Oct 13 22:00:00 - 22:59:59 321 2.3% 0.091.5 MB 3.4% 0.43
Oct 13 23:00:00 - 23:57:57 343 2.5% 0.101.1 MB 2.5% 0.33
TOTAL: 23:56:55 13922 100.0% 0.1644.6 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2394 1585 0 0 3 0 0 0 806
2newsfeed.neva.ru 629 305 0 1 3 0 0 0 320
3feeder3.feed-ams.uzoreto.com 596 333 0 0 3 0 0 0 260
4ripco-out.feeder.erje.net 440 435 0 0 0 0 0 0 5
5news.snarked.org 110 31 0 0 0 0 0 0 79
6newsfeed.fu-berlin.de 109 0 0 0 0 0 0 0 109
7ripco-out.news.tnetconsulting.net 58 29 0 0 0 0 0 0 29
8news.lightlink.com 38 4 0 0 0 0 0 0 34
9news-in.rahul.net 10 0 0 0 0 0 0 0 10
10news.cmpublishers.com 6 2 0 0 0 0 0 0 4
TOTAL: 10 4390 2724 0 1 9 0 0 0 1656

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1959
alt.binaries.ftd 200
it.tlc.cellulari.android 64
fido7.su.pol.news 36
scinet.stats 31
alt.binaries.e-book 25
it.comp.os.win.windows10 22
alt.bestjobsusa.computer.jobs 17
scot.general 16
grisbi.bugsreports 15
alt.binaries.nospam.breasts.natural 15
alt.binaries.b4e.erotica 14
alt.binaries.pictures.purebeauty 12
alt.binaries.pictures.earlmiller 12
alt.binaries.pictures.scenic 9
free.it.scienza.fisica 8
alt.binaries.pictures.rail 8
alt.binaries.sounds.lossless.jazz 8
alt.binaries.e-books 8
linux.debian.ports.arm 8
TOTAL: 130 2724

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

GroupsCount
pl.praca.oferowana 5
christnet.bible 3
bit.listserv.catholic 1
TOTAL: 3 9

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1380
Too many newsgroups 1196
EMP (phl) 250
Binary in non-binary group 104
Scoring filter (8) 34
Scoring filter (13) 18
Scoring filter (9) 12
Scoring filter (10) 12
Scoring filter (11) 4
HTML post 2
Scoring filter (16) 2
TOTAL: 11 3014

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 26
ripco-out.feed.uzoreto.com 6
feeder3.feed-ams.uzoreto.com 2
TOTAL: 3 34
Huge articles
newsfeed.fu-berlin.de 6
TOTAL: 1 6
Including strange strings
newsfeed.fu-berlin.de 102
newsfeed.neva.ru 31
ripco-out.feed.uzoreto.com 11
feeder3.feed-ams.uzoreto.com 2
news.snarked.org 1
TOTAL: 5 147
No colon-space in header
feeder3.feed-ams.uzoreto.com 1
TOTAL: 1 1
TOTAL: 4 188

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 12100 1516 5138 516 0 0 12%47:40:02
2rahul.net 21778 710 11996 4 0 0 3%47:40:02
3feeder.erje.net 31088 180 26536 154 0 0 0%47:47:02
4news.snarked.org 36662 36 22018 16 0 62 0%47:40:04
5fu-berlin.de 25552 16 25496 0 0 156 0%47:41:30
6news.tnetconsulting.net 42550 16 27246 0 0 86 0%47:51:18
7newsfeed.neva.ru 22372 12 21892 0 0 0 0%47:43:14
8news.uzoreto.com 12044 8 11880 4 0 0 0%47:49:04
9remote6hme0.ripco.com 6 0 0 6 0 0 0%01:11:58
10news.cmpublishers.com 40472 0 27364 102 0 124 0%47:44:26
TOTAL: 10 244624 2494 179566 802 0 428 1%430:48:40
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com7.7 MB3.1 MB10.8 MB0.1 KB/s5.5 KB47:40:02
2rahul.net4.4 MB55.6 KB4.5 MB0.0 KB/s6.4 KB47:40:02
3feeder.erje.net539.4 KB370.1 KB909.4 KB0.0 KB/s2.7 KB47:47:02
4news.snarked.org179.4 KB36.8 KB216.1 KB0.0 KB/s4.2 KB47:40:04
5news.tnetconsulting.net76.3 KB0.0 KB76.3 KB0.0 KB/s4.8 KB47:51:18
6fu-berlin.de70.8 KB0.0 KB70.8 KB0.0 KB/s4.4 KB47:41:30
7newsfeed.neva.ru65.2 KB0.0 KB65.2 KB0.0 KB/s5.4 KB47:43:14
8news.uzoreto.com41.9 KB23.3 KB65.2 KB0.0 KB/s5.4 KB47:49:04
9remote6hme0.ripco.com0.0 KB31.7 KB31.7 KB0.0 KB/s5.3 KB01:11:58
10news.cmpublishers.com0.0 KB193.3 KB193.3 KB0.0 KB/s1.9 KB47:44:26
TOTAL: 1013.1 MB3.8 MB16.9 MB0.0 KB/s5.3 KB430:48:40
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9282.5 MB 426 2 000:12:47
2shell3.ripco.com 20 3801.0 MB 60 2 002:50:25
TOTAL: 2 306 13083.5 MB 486 4 003:03:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9282.5 MB 426 2 000:12:47
2*.ripco.com 20 3801.0 MB 60 2 002:50:25
TOTAL: 2 306 13083.5 MB 486 4 003:03:13

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 5.598 7.504 0.00002:50:25
ftupet.com 46.530 21.360 0.00000:12:47
5.187.75.190 0.206 0.052 0.00000:00:00
192.241.221.114 0.208 0.052 0.00000:00:00
TOTAL: 4 52.542 28.968 0.00003:03:14

NNRP no permission clients:

SystemConn
5.187.75.190 2
192.241.221.114 2
TOTAL: 2 4

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 4 0
TOTAL: 1 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1074 82.1%
2alt 106 8.1%
3misc 34 2.6%
4comp 34 2.6%
5chi 22 1.7%
6rocksolid 18 1.4%
7sci 14 1.1%
8news 6 0.5%
TOTAL: 8 1308100.0%

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

NewsgroupCount
1rec.arts.tv 470
2rec.food.cooking 422
3rec.bicycles.tech 116
4alt.comp.os.windows-10 78
5misc.consumers.frugal-living 32
6rec.gardens.edible 28
7alt.stupidity 24
8rec.outdoors.rv-travel 22
9sci.electronics.repair 14
10chi.general 12
11rocksolid.shared.general 12
12comp.sys.apple2 10
13chi.weather 10
14comp.mobile.ipad 10
15rec.radio.shortwave 8
16comp.sys.mac.system 6
17comp.sys.mac.apps 6
18rec.radio.broadcasting 6
19news.admin.net-abuse.usenet 4
20rocksolid.nodes.announce 4
21alt.marketing.online.ebay 2
22rocksolid.nodes.help 2
23rec.radio.swap 2
24alt.hvac 2
25misc.phone.mobile.iphone 2
26comp.mobile.android 2
27news.admin.hierarchies 2
TOTAL: 27 1308