Daily Usenet report for news.ripco.com

Dec 15 00:01:01 -- Dec 15 23:56:23

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Dec 15 02:50:03 remote5bge0 overchan[28440]: [ID 702911 news.error] input line too long, skipping
Dec 15 09:11:40 remote5bge0 overchan[28440]: [ID 702911 news.error] input line too long, skipping
Dec 15 09:42:46 remote5bge0 overchan[28440]: [ID 702911 news.error] input line too long, skipping
Dec 15 09:43:54 remote5bge0 overchan[28440]: [ID 702911 news.error] input line too long, skipping
Dec 15 09:49:01 remote5bge0 overchan[28440]: [ID 702911 news.error] input line too long, skipping
Dec 15 12:58:35 remote5bge0 overchan[28440]: [ID 702911 news.error] input line too long, skipping
Dec 15 13:00:42 remote5bge0 overchan[28440]: [ID 702911 news.error] input line too long, skipping
Dec 15 14:02:17 remote5bge0 overchan[28440]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innd 18255 31.9%2.8 MB 31.8%
inn 18049 31.5%3.5 MB 38.9%
nnrpd 17384 30.4%1.8 MB 20.3%
innfeed 3550 6.2%815.8 KB 9.0%
controlchan 8 0.0%1.9 KB 0.0%
overchan 8 0.0%1.2 KB 0.0%
TOTAL: 6 57254 100.0%8.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 166612 50.6%
Cache misses 162872 49.4%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 329484 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%96 0.000 0.000 0.000
article cleanup00:00:00.478 0.0%35894 0.000 0.013 0.059
article logging00:00:01.664 0.0%36182 0.000 0.046 6.172
article parse00:00:01.340 0.0%92226 0.000 0.015 0.041
article write00:01:26.674 0.1%26292 1.231 3.297 87.850
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.398 0.0%337974 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:03.088 0.0%332420 0.002 0.009 0.021
history sync00:00:00.202 0.0%812 0.000 0.249 2.000
history write00:00:04.776 0.0%35892 0.000 0.133 6.156
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:56:45.792 99.8%375502 201.230 459.667 1603.711
nntp read00:00:03.064 0.0%375762 0.003 0.008 0.026
overview write00:00:00.232 0.0%26292 0.000 0.009 0.051
perl filter00:00:54.384 0.0%35888 1.216 1.515 2.706
python filter00:00:01.370 0.0%35894 0.000 0.038 0.087
site send00:00:02.502 0.0%78830 0.010 0.032 0.067
TOTAL: 48:01:59.99847:59:25.964 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.144 0.0%26592 0.000 0.005 0.067
article prepare00:00:00.006 0.0%10624 0.000 0.001 0.025
article read00:00:00.388 0.0%2152 0.000 0.180 10.286
backlog stats00:00:00.272 0.0%399170 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.980 0.0%252998 0.000 0.008 0.017
data write00:00:04.682 0.0%227284 0.009 0.021 0.044
idle47:37:27.162100.0%399170 222.586 429.509 1153.783
status file00:00:00.968 0.0%322 0.000 3.006 29.000
TOTAL: 47:37:55.66447:37:35.602100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:50:08.492 98.0%18180 18.475 561.523 24587.374
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:07.392 0.1%739048 0.000 0.010 0.053
readart00:00:21.472 0.2%2358 2.692 9.106 58.500
TOTAL: 02:53:38.50602:50:37.356 98.3%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org002002
TOTAL002002

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 29822 10158 16446 3218 34%94:49:04
2feeder3.feed-ams.uzoreto.com 576 17186 5382 8700 3104 31%47:10:04
3newsfeed.neva.ru 612 29862 4796 23426 1640 16%277:18:46
4news.snarked.org 70 26354 4390 21662 302 16%61:13:10
5newsfeed.fu-berlin.de 4 11600 528 11032 40 4%44:22:28
6ripco-out.news.tnetconsulting.net 2 27388 478 26834 76 1%43:01:18
7news.lightlink.com 2 6464 224 6182 58 3%44:03:24
8news-in.rahul.net 574 12828 60 12746 22 0%47:19:46
9ripco-out.feeder.erje.net 574 27632 52 26576 1004 0%47:18:12
10news.cmpublishers.com 52 7922 12 7902 8 0%47:59:22
11localhost 152 6 6 0 0 100%00:00:00
TOTAL: 11 3766 197064 26086 161506 9472 13%754:35:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com25.2 MB0.0 KB6.2 MB31.4 MB 80%2.4 KB
2newsfeed.neva.ru14.5 MB6.6 KB4.3 MB18.8 MB 76%3.0 KB
3feeder3.feed-ams.uzoreto.com14.2 MB0.0 KB5.5 MB19.7 MB 72%2.4 KB
4news.snarked.org12.7 MB0.0 KB1.1 MB13.7 MB 92%3.0 KB
5ripco-out.news.tnetconsulting.net12.5 MB0.0 KB2.0 MB14.5 MB 86%26.8 KB
6newsfeed.fu-berlin.de4.9 MB0.0 KB2.9 MB7.7 MB 62%13.9 KB
7news.lightlink.com2.7 MB133.7 KB4.7 MB7.5 MB 35%27.4 KB
8news-in.rahul.net1.0 MB0.0 KB1.3 MB2.3 MB 44%28.6 KB
9ripco-out.feeder.erje.net96.3 KB0.0 KB9.2 MB9.3 MB 1%9.0 KB
10news.cmpublishers.com22.2 KB0.0 KB18.4 KB40.6 KB 54%2.0 KB
11localhost9.0 KB0.0 KB0.0 KB9.0 KB100%1.5 KB
TOTAL: 1187.8 MB140.3 KB37.1 MB125.0 MB 70%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 15 00:01:01 - 00:59:59 438 3.3% 0.121.2 MB 2.7% 0.34
Dec 15 01:00:00 - 01:59:59 421 3.2% 0.121.7 MB 3.8% 0.47
Dec 15 02:00:00 - 02:59:59 492 3.8% 0.141.3 MB 2.9% 0.36
Dec 15 03:00:00 - 03:59:59 670 5.1% 0.192.6 MB 6.0% 0.74
Dec 15 04:00:00 - 04:59:59 630 4.8% 0.171.9 MB 4.3% 0.53
Dec 15 05:00:00 - 05:59:59 619 4.7% 0.172.2 MB 4.9% 0.61
Dec 15 06:00:00 - 06:59:59 627 4.8% 0.171.8 MB 4.2% 0.52
Dec 15 07:00:00 - 07:59:59 632 4.8% 0.181.9 MB 4.5% 0.55
Dec 15 08:00:00 - 08:59:59 762 5.8% 0.213.0 MB 6.9% 0.86
Dec 15 09:00:00 - 09:59:59 855 6.5% 0.242.6 MB 5.9% 0.73
Dec 15 10:00:00 - 10:59:59 835 6.4% 0.233.0 MB 6.8% 0.84
Dec 15 11:00:00 - 11:59:59 687 5.2% 0.192.3 MB 5.3% 0.65
Dec 15 12:00:00 - 12:59:59 784 6.0% 0.222.8 MB 6.5% 0.81
Dec 15 13:00:00 - 13:59:59 663 5.1% 0.181.9 MB 4.4% 0.54
Dec 15 14:00:00 - 14:59:59 677 5.2% 0.192.6 MB 6.0% 0.74
Dec 15 15:00:00 - 15:59:59 572 4.4% 0.161.6 MB 3.7% 0.46
Dec 15 16:00:00 - 16:59:59 536 4.1% 0.151.5 MB 3.4% 0.42
Dec 15 17:00:00 - 17:59:59 419 3.2% 0.121.3 MB 3.0% 0.38
Dec 15 18:00:00 - 18:59:59 372 2.8% 0.101.2 MB 2.8% 0.35
Dec 15 19:00:00 - 19:59:59 359 2.7% 0.101.8 MB 4.2% 0.52
Dec 15 20:00:00 - 20:59:59 263 2.0% 0.071.0 MB 2.3% 0.29
Dec 15 21:00:00 - 21:59:59 264 2.0% 0.07861.5 KB 1.9% 0.24
Dec 15 22:00:00 - 22:59:59 298 2.3% 0.08880.6 KB 2.0% 0.24
Dec 15 23:00:00 - 23:56:23 241 1.8% 0.07714.9 KB 1.6% 0.21
TOTAL: 23:55:22 13116 100.0% 0.1543.6 MB 100.0% 0.52
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 1618 1209 0 0 4 0 0 0 405
2feeder3.feed-ams.uzoreto.com 1556 1213 0 0 0 0 0 0 343
3newsfeed.neva.ru 847 428 0 2 0 0 0 0 417
4ripco-out.feeder.erje.net 504 503 0 0 0 0 0 0 1
5news.snarked.org 155 57 0 0 1 0 0 0 97
6newsfeed.fu-berlin.de 121 0 0 0 0 0 0 0 121
7ripco-out.news.tnetconsulting.net 62 39 0 0 0 0 0 0 23
8news.lightlink.com 54 1 0 1 0 0 0 0 52
9news-in.rahul.net 11 0 0 0 0 0 0 0 11
10news.cmpublishers.com 5 2 0 0 0 0 0 0 3
TOTAL: 10 4933 3452 0 3 5 0 0 0 1473

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2644
alt.binaries.ftd 305
fido7.su.pol.news 35
scinet.stats 31
alt.binaries.pictures.purebeauty 23
it.comp.os.win.windows7 22
de.soc.arbeitslos 20
alt.binaries.pictures.earlmiller 20
it.tlc.cellulari.android 20
free.it.scienza.fisica 18
alt.binaries.e-book 16
alt.bestjobsusa.computer.jobs 14
alt.binaries.nospam.breasts.natural 12
alt.binaries.nospam.female.bodyhair 11
scot.general 11
trollnet.cinema 11
alt.binaries.pictures.scenic 7
alt.binaries.pictures.rail 7
uk.net.news.moderation 7
it.comp.os.win.windows10 7
TOTAL: 121 3452

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

GroupsCount
pl.praca.oferowana 3
alt.christnet.religion 1
bit.listserv.catholic 1
TOTAL: 3 5

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 1076
EMP (md5) 1076
Binary in non-binary group 226
EMP (phl) 198
Scoring filter (9) 22
Scoring filter (8) 18
Scoring filter (10) 14
Scoring filter (11) 12
Scoring filter (12) 6
Scoring filter (15) 6
TOTAL: 10 2654

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 98
newsfeed.neva.ru 31
ripco-out.feed.uzoreto.com 9
feeder3.feed-ams.uzoreto.com 4
news.snarked.org 2
TOTAL: 5 144
No colon-space in header
ripco-out.feeder.erje.net 1
feeder3.feed-ams.uzoreto.com 1
TOTAL: 2 2
TOTAL: 3 164

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9080 1162 5186 8 0 0 12%47:40:04
2rahul.net 20806 710 11090 8 0 2 3%47:40:04
3news.tnetconsulting.net 39740 74 25508 6 0 62 0%47:40:00
4news.snarked.org 36590 46 21328 6 0 132 0%47:40:04
5newsfeed.neva.ru 21634 34 21248 32 0 0 0%47:40:06
6fu-berlin.de 23536 26 23510 0 0 0 0%47:40:06
7news.cmpublishers.com 39170 22 25348 402 0 268 0%47:40:04
8feeder.erje.net 25588 20 25366 48 0 0 0%47:45:50
9news.uzoreto.com 10444 18 10162 28 0 0 0%47:40:06
10remote6hme0.ripco.com 6 0 0 6 0 0 0%01:12:06
TOTAL: 10 226594 2112 168746 544 0 464 0%430:18:30
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com5.0 MB17.7 KB5.0 MB0.0 KB/s4.4 KB47:40:04
2rahul.net5.0 MB19.2 KB5.0 MB0.0 KB/s7.1 KB47:40:04
3news.tnetconsulting.net236.2 KB11.5 KB247.7 KB0.0 KB/s3.1 KB47:40:00
4news.snarked.org207.1 KB4.3 KB211.5 KB0.0 KB/s4.1 KB47:40:04
5newsfeed.neva.ru170.9 KB102.8 KB273.7 KB0.0 KB/s4.1 KB47:40:06
6fu-berlin.de142.6 KB0.0 KB142.6 KB0.0 KB/s5.5 KB47:40:06
7feeder.erje.net142.3 KB135.5 KB277.8 KB0.0 KB/s4.1 KB47:45:50
8news.uzoreto.com78.5 KB134.2 KB212.8 KB0.0 KB/s4.6 KB47:40:06
9news.cmpublishers.com62.8 KB1.1 MB1.2 MB0.0 KB/s2.8 KB47:40:04
10remote6hme0.ripco.com0.0 KB26.2 KB26.2 KB0.0 KB/s4.4 KB01:12:06
TOTAL: 1011.0 MB1.6 MB12.5 MB0.0 KB/s4.8 KB430:18:30
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 10003.0 MB 476 4 000:08:52
2shell3.ripco.com 10 3541.4 MB 42 2 002:44:35
TOTAL: 2 296 13544.4 MB 518 6 002:53:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 10003.0 MB 476 4 000:08:52
2*.ripco.com 10 3541.4 MB 42 2 002:44:35
TOTAL: 2 296 13544.4 MB 518 6 002:53:27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3.ripco.com 3.640 2.592 0.00002:44:35
ftupet.com 48.448 21.872 0.00000:08:52
business-176-094-041-133.static.arcor-ip.net 0.204 0.050 0.00000:00:01
TOTAL: 3 52.292 24.514 0.00002:53:28

NNRP no permission clients:

SystemConn
business-176-094-041-133.static.arcor-ip.net 2
TOTAL: 1 2

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

Newsgroup request counts (by category):

CategoryCountPct
1rec 1176 86.9%
2alt 72 5.3%
3misc 40 3.0%
4comp 32 2.4%
5sci 16 1.2%
6news 14 1.0%
7chi 4 0.3%
TOTAL: 7 1354100.0%

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

NewsgroupCount
1rec.arts.tv 556
2rec.food.cooking 432
3rec.bicycles.tech 160
4alt.comp.os.windows-10 60
5misc.phone.mobile.iphone 38
6comp.sys.apple2 18
7sci.electronics.repair 16
8comp.mobile.android 12
9rec.food.drink.tea 10
10rec.radio.shortwave 8
11rec.radio.broadcasting 6
12alt.security.alarms 6
13alt.free.newsservers 4
14rec.radio.swap 4
15news.admin.net-abuse.email 4
16news.admin.peering 4
17chi.weather 4
18news.announce.newgroups 2
19alt.bbs.searchlight 2
20comp.sys.mac.system 2
21news.groups 2
22news.admin.hierarchies 2
23misc.consumers.frugal-living 2
TOTAL: 23 1354