Daily Usenet report for news.ripco.com

Jan 5 00:01:02 -- Jan 5 23:57:48

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Jan 5 08:54:24 remote5bge0 overchan[2473]: [ID 702911 news.error] input line too long, skipping
Jan 5 08:55:40 remote5bge0 overchan[2473]: [ID 702911 news.error] input line too long, skipping
Jan 5 08:57:46 remote5bge0 overchan[2473]: [ID 702911 news.error] input line too long, skipping
Jan 5 08:58:40 remote5bge0 overchan[2473]: [ID 702911 news.error] input line too long, skipping
Jan 5 09:00:15 remote5bge0 overchan[2473]: [ID 702911 news.error] input line too long, skipping
Jan 5 09:13:26 remote5bge0 overchan[2473]: [ID 702911 news.error] input line too long, skipping
Jan 5 09:16:29 remote5bge0 overchan[2473]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 18832 32.8%3.6 MB 40.6%
innd 17727 30.9%2.8 MB 30.9%
nnrpd 17178 29.9%1.8 MB 19.9%
innfeed 3682 6.4%788.1 KB 8.6%
overchan 7 0.0%0.9 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 57428 100.0%9.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 185536 52.3%
Cache misses 168970 47.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 354506 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%50 0.000 0.000 0.000
article cleanup00:00:00.472 0.0%37272 0.000 0.013 0.068
article logging00:00:00.892 0.0%37704 0.000 0.024 0.397
article parse00:00:01.550 0.0%97016 0.000 0.016 0.043
article write00:01:31.556 0.1%28076 1.302 3.261 73.393
artlog/artparse00:00:00.000 0.0%16 0.000 0.000 0.000
data move00:00:00.374 0.0%335386 0.000 0.001 0.008
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.954 0.0%358174 0.001 0.008 0.023
history sync00:00:00.222 0.0%790 0.000 0.281 2.500
history write00:00:03.442 0.0%37286 0.000 0.092 1.306
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:56:50.232 99.8%374606 96.025 460.778 1604.070
nntp read00:00:02.910 0.0%374678 0.001 0.008 0.021
overview write00:00:00.324 0.0%28076 0.000 0.012 0.065
perl filter00:00:58.318 0.0%37270 1.240 1.565 2.726
python filter00:00:01.386 0.0%37272 0.000 0.037 0.125
site send00:00:02.150 0.0%84162 0.000 0.026 0.063
TOTAL: 48:02:06.73847:59:36.782 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.126 0.0%29132 0.000 0.004 0.067
article prepare00:00:00.000 0.0%5248 0.000 0.000 0.000
article read00:00:00.292 0.0%996 0.000 0.293 73.000
backlog stats00:00:00.270 0.0%365288 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.682 0.0%230104 0.002 0.012 0.025
data write00:00:04.000 0.0%202544 0.005 0.020 0.043
idle47:51:29.914100.0%365288 194.951 471.655 1435.727
status file00:00:10.892 0.0%372 1.000 29.280 2077.500
TOTAL: 47:52:12.68047:51:48.176100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:56:49.368 98.0%17896 6.667 592.835 25797.919
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:06.376 0.1%647260 0.000 0.010 1.000
readart00:00:19.984 0.2%2036 0.000 9.815 36.000
TOTAL: 03:00:22.98402:57:15.728 98.3%----

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 32878 11438 16748 4692 34%94:46:58
2feeder3.feed-ams.uzoreto.com 574 53384 8048 43984 1352 15%47:18:40
3newsfeed.neva.ru 578 17974 6538 9900 1536 36%279:06:40
4ripco-out.news.tnetconsulting.net 4 29794 742 28776 276 2%44:25:02
5newsfeed.fu-berlin.de 2 12252 448 11778 26 3%45:50:50
6news.lightlink.com 2 7692 448 6974 270 5%43:14:26
7news-in.rahul.net 574 13372 242 13114 16 1%47:21:36
8ripco-out.feeder.erje.net 576 29640 72 28610 958 0%47:27:24
9news.cmpublishers.com 52 7906 36 7836 34 0%47:59:38
10localhost 148 2 2 0 0 100%00:00:00
TOTAL: 10 3658 204894 28014 167720 9160 13%697:31:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com31.5 MB0.0 KB9.1 MB40.6 MB 77%2.6 KB
2newsfeed.neva.ru22.3 MB0.0 KB5.1 MB27.4 MB 81%3.5 KB
3feeder3.feed-ams.uzoreto.com20.8 MB5.9 KB3.2 MB24.0 MB 86%2.6 KB
4ripco-out.news.tnetconsulting.net9.6 MB0.0 KB1.0 MB10.6 MB 90%10.7 KB
5news.lightlink.com8.5 MB0.0 KB11.1 MB19.6 MB 43%27.9 KB
6newsfeed.fu-berlin.de6.1 MB0.0 KB248.0 KB6.4 MB 96%13.8 KB
7news-in.rahul.net2.3 MB0.0 KB364.4 KB2.7 MB 86%10.7 KB
8ripco-out.feeder.erje.net204.3 KB0.0 KB7.6 MB7.8 MB 2%7.7 KB
9news.cmpublishers.com94.3 KB0.0 KB62.8 KB157.1 KB 60%2.2 KB
10localhost3.0 KB0.0 KB0.0 KB3.0 KB100%1.5 KB
TOTAL: 10101.4 MB5.9 KB37.7 MB139.2 MB 72%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 5 00:01:02 - 00:59:59 277 2.0% 0.081.8 MB 3.4% 0.51
Jan 5 01:00:00 - 01:59:59 356 2.5% 0.102.2 MB 4.2% 0.63
Jan 5 02:00:00 - 02:59:59 488 3.5% 0.141.5 MB 2.9% 0.43
Jan 5 03:00:00 - 03:59:59 617 4.4% 0.172.1 MB 3.9% 0.58
Jan 5 04:00:00 - 04:59:59 593 4.2% 0.161.8 MB 3.4% 0.51
Jan 5 05:00:00 - 05:59:59 630 4.5% 0.172.4 MB 4.5% 0.67
Jan 5 06:00:00 - 06:59:59 659 4.7% 0.182.1 MB 4.0% 0.59
Jan 5 07:00:00 - 07:59:59 734 5.2% 0.202.5 MB 4.7% 0.70
Jan 5 08:00:00 - 08:59:59 839 6.0% 0.232.6 MB 5.0% 0.75
Jan 5 09:00:00 - 09:59:59 886 6.3% 0.254.2 MB 8.0% 1.20
Jan 5 10:00:00 - 10:59:59 995 7.1% 0.283.2 MB 6.1% 0.91
Jan 5 11:00:00 - 11:59:59 879 6.3% 0.242.9 MB 5.5% 0.83
Jan 5 12:00:00 - 12:59:59 894 6.4% 0.252.8 MB 5.3% 0.79
Jan 5 13:00:00 - 13:59:59 630 4.5% 0.172.1 MB 3.9% 0.59
Jan 5 14:00:00 - 14:59:59 670 4.8% 0.193.3 MB 6.2% 0.93
Jan 5 15:00:00 - 15:59:59 730 5.2% 0.202.5 MB 4.7% 0.70
Jan 5 16:00:00 - 16:59:59 776 5.5% 0.223.1 MB 5.9% 0.89
Jan 5 17:00:00 - 17:59:59 533 3.8% 0.152.4 MB 4.5% 0.68
Jan 5 18:00:00 - 18:59:59 491 3.5% 0.141.6 MB 3.1% 0.47
Jan 5 19:00:00 - 19:59:59 345 2.5% 0.101008.1 KB 1.9% 0.28
Jan 5 20:00:00 - 20:59:59 300 2.1% 0.081.3 MB 2.5% 0.37
Jan 5 21:00:00 - 21:59:59 248 1.8% 0.07967.2 KB 1.8% 0.27
Jan 5 22:00:00 - 22:59:59 212 1.5% 0.061.7 MB 3.2% 0.48
Jan 5 23:00:00 - 23:57:48 237 1.7% 0.07689.0 KB 1.3% 0.20
TOTAL: 23:56:46 14019 100.0% 0.1652.5 MB 100.0% 0.62
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2354 1852 0 0 4 0 0 0 498
2newsfeed.neva.ru 844 432 0 0 3 0 0 0 409
3feeder3.feed-ams.uzoreto.com 696 369 0 1 2 0 0 0 324
4ripco-out.feeder.erje.net 479 472 0 0 0 0 0 0 7
5ripco-out.news.tnetconsulting.net 149 136 0 0 0 0 0 0 13
6news.lightlink.com 146 0 0 0 0 0 0 0 146
7newsfeed.fu-berlin.de 120 0 0 0 0 0 0 0 120
8news.cmpublishers.com 17 12 0 0 0 0 0 0 5
9news-in.rahul.net 8 0 0 0 0 0 0 0 8
TOTAL: 9 4813 3273 0 1 9 0 0 0 1530

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2329
alt.binaries.ftd 228
uk.net.news.moderation 75
it.tlc.cellulari.android 42
nl.comp.os.linux.techniek 42
scinet.stats 31
alt.bestjobsusa.computer.jobs 31
alt.binaries.e-book 28
free.willey 18
it.comp.os.win.windows10 18
alt.binaries.pictures.scenic 18
scinet.general.chatter 18
fido7.su.pol.news 17
linux.debian.maint.hams 16
alt.binaries.nospam.breasts.natural 14
scot.general 14
alt.jobs.jobsearch 14
alt.binaries.nospam.female.bodyhair 14
grisbi.devel 14
alt.binaries.pictures.earlmiller 13
TOTAL: 121 3273

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

GroupsCount
pl.praca.oferowana 8
bit.listserv.catholic 1
TOTAL: 2 9

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1206
EMP (md5) 1112
Binary in non-binary group 172
EMP (phl) 64
HTML post 26
Scoring filter (8) 16
Scoring filter (9) 14
Scoring filter (10) 12
TOTAL: 8 2622

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 106
newsfeed.neva.ru 81
feeder3.feed-ams.uzoreto.com 21
ripco-out.feed.uzoreto.com 8
TOTAL: 4 216
No colon-space in header
ripco-out.feeder.erje.net 4
feeder3.feed-ams.uzoreto.com 2
ripco-out.feed.uzoreto.com 1
TOTAL: 3 7
TOTAL: 3 241

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 20374 478 11116 4 0 0 2%47:52:58
2news.lightlink.com 10590 236 6524 10 0 0 2%47:40:06
3news.tnetconsulting.net 44472 102 27060 6 0 284 0%47:37:02
4newsfeed.neva.ru 21870 74 21268 70 0 0 0%47:44:16
5feeder.erje.net 29724 62 26078 68 0 114 0%47:38:02
6news.uzoreto.com 8320 14 8074 2 0 0 0%47:40:06
7news.cmpublishers.com 42796 14 27448 154 0 742 0%47:43:10
8fu-berlin.de 24776 12 24764 0 0 0 0%47:44:44
9news.snarked.org 0 0 0 0 0 27698 0%47:40:04
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:12
TOTAL: 10 202928 992 152332 320 0 28838 0%430:32:40
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net5.8 MB29.2 KB5.9 MB0.0 KB/s12.4 KB47:52:58
2news.lightlink.com1.9 MB43.2 KB1.9 MB0.0 KB/s8.0 KB47:40:06
3news.tnetconsulting.net541.2 KB14.6 KB555.8 KB0.0 KB/s5.1 KB47:37:02
4feeder.erje.net228.7 KB221.9 KB450.7 KB0.0 KB/s3.5 KB47:38:02
5newsfeed.neva.ru218.8 KB376.1 KB594.9 KB0.0 KB/s4.1 KB47:44:16
6news.uzoreto.com97.8 KB3.4 KB101.3 KB0.0 KB/s6.3 KB47:40:06
7fu-berlin.de78.1 KB0.0 KB78.1 KB0.0 KB/s6.5 KB47:44:44
8news.cmpublishers.com62.5 KB543.2 KB605.8 KB0.0 KB/s3.6 KB47:43:10
9news.snarked.org0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:04
10remote6hme0.ripco.com0.0 KB24.9 KB24.9 KB0.0 KB/s4.2 KB01:12:12
TOTAL: 108.9 MB1.2 MB10.1 MB0.0 KB/s7.9 KB430:32:40
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 8383.0 MB 416 2 000:08:45
2shell3.ripco.com 14 3581.5 MB 30 0 002:51:26
TOTAL: 2 300 11964.6 MB 446 2 003:00:13

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 8383.0 MB 416 2 000:08:45
2*.ripco.com 14 3581.5 MB 30 0 002:51:26
TOTAL: 2 300 11964.6 MB 446 2 003:00:12

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 3.680 5.974 0.00002:51:26
ftupet.com 46.122 21.580 0.00000:08:45
ec2-54-153-65-25.us-west-1.compute.amazonaws.com 0.252 0.072 0.00000:00:00
ec2-54-215-190-119.us-west-1.compute.amazonaws.com 0.200 0.050 0.00000:00:00
TOTAL: 4 50.254 27.676 0.00003:00:13

NNRP no permission clients:

SystemConn
ec2-54-215-190-119.us-west-1.compute.amazonaws.com 2
ec2-54-153-65-25.us-west-1.compute.amazonaws.com 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 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1086 90.8%
2comp 56 4.7%
3news 22 1.8%
4chi 20 1.7%
5misc 6 0.5%
6sci 4 0.3%
7alt 2 0.2%
TOTAL: 7 1196100.0%

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

NewsgroupCount
1rec.arts.tv 562
2rec.food.cooking 372
3rec.bicycles.tech 140
4comp.sys.mac.system 32
5comp.mail.uucp 24
6news.software.readers 14
7chi.general 10
8chi.weather 10
9misc.consumers.frugal-living 6
10rec.radio.broadcasting 6
11rec.radio.shortwave 4
12sci.electronics.repair 4
13news.admin.net-abuse.misc 4
14news.admin.net-abuse.usenet 4
15alt.gathering.rainbow 2
16rec.radio.swap 2
TOTAL: 16 1196