Daily Usenet report for news.ripco.com

Aug 3 00:01:01 -- Aug 3 23:57:22

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Aug 3 08:33:11 remote5bge0 overchan[23442]: [ID 702911 news.error] input line too long, skipping
Aug 3 09:11:52 remote5bge0 overchan[23442]: [ID 702911 news.error] input line too long, skipping
Aug 3 09:24:52 remote5bge0 overchan[23442]: [ID 702911 news.error] input line too long, skipping
Aug 3 12:44:25 remote5bge0 overchan[23442]: [ID 702911 news.error] input line too long, skipping
Aug 3 12:58:25 remote5bge0 overchan[23442]: [ID 702911 news.error] input line too long, skipping
Aug 3 23:51:43 remote5bge0 overchan[23442]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 24672 37.1%2.8 MB 28.7%
innd 20183 30.4%3.1 MB 31.6%
inn 18026 27.1%3.1 MB 31.9%
innfeed 3601 5.4%778.3 KB 7.8%
controlchan 8 0.0%1.4 KB 0.0%
overchan 6 0.0%0.8 KB 0.0%
TOTAL: 6 66496 100.0%9.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 150282 51.3%
Cache misses 142670 48.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 292952 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%88 0.000 0.000 0.000
article cleanup00:00:00.398 0.0%35722 0.000 0.011 0.050
article logging00:00:00.818 0.0%36218 0.000 0.023 0.699
article parse00:00:01.438 0.0%86788 0.000 0.017 0.043
article write00:01:20.074 0.0%25622 0.297 3.125 562.500
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.370 0.0%304176 0.000 0.001 0.005
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.076 0.0%295332 0.000 0.007 0.019
history sync00:00:00.260 0.0%808 0.000 0.322 21.000
history write00:00:03.846 0.0%35722 0.015 0.108 4.760
idle48:16:56.826 99.8%340076 284.866 511.112 1602.624
nntp read00:00:02.846 0.0%334736 0.002 0.009 0.020
overview write00:00:00.206 0.0%25622 0.000 0.008 0.044
perl filter00:00:54.252 0.0%35718 1.224 1.519 2.608
python filter00:00:01.506 0.0%35720 0.000 0.042 0.158
site send00:00:02.192 0.0%76726 0.006 0.029 0.073
TOTAL: 48:22:09.79448:19:27.108 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.160 0.0%25572 0.000 0.006 0.077
article prepare00:00:00.004 0.0%13864 0.000 0.000 0.021
article read00:00:00.410 0.0%2922 0.000 0.140 36.500
backlog stats00:00:00.228 0.0%310372 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.628 0.0%202532 0.000 0.008 0.021
data write00:00:03.318 0.0%177900 0.007 0.019 0.033
idle47:35:37.734100.0%310372 335.321 552.040 1616.863
status file00:00:04.954 0.0%328 1.000 15.104 780.000
TOTAL: 47:36:05.79047:35:48.436100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:25:41.078 93.7%17818 19.946 490.576150002.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:05.362 0.1%486058 0.000 0.011 1.000
readart00:00:19.256 0.2%2038 0.111 9.448 78.000
TOTAL: 02:35:31.81402:26:05.696 93.9%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de002002
TOTAL002002

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 33552 9822 19148 4582 29%94:39:20
2news.snarked.org 56 25094 7688 16924 482 30%47:18:02
3newsfeed.neva.ru 626 36442 4566 29266 2610 12%276:32:02
4feeder3.feed-ams.uzoreto.com 574 11110 1998 8312 800 17%47:28:58
5newsfeed.fu-berlin.de 2 16324 942 15336 46 5%53:24:20
6news.cmpublishers.com 50 8456 262 8162 32 3%48:00:02
7news-in.rahul.net 576 14896 242 14570 84 1%47:29:46
8ripco-out.feeder.erje.net 576 28282 162 26808 1312 0%47:27:44
9news.lightlink.com 2 7734 68 7526 140 0%48:55:18
10localhost 148 2 2 0 0 100%00:00:00
TOTAL: 10 3758 181892 25752 146052 10088 14%711:15:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com24.7 MB0.0 KB9.9 MB34.7 MB 71%2.5 KB
2news.snarked.org21.7 MB0.0 KB1.9 MB23.7 MB 91%3.0 KB
3newsfeed.neva.ru14.1 MB0.0 KB13.2 MB27.3 MB 51%3.9 KB
4newsfeed.fu-berlin.de10.9 MB0.0 KB401.2 KB11.2 MB 96%11.7 KB
5feeder3.feed-ams.uzoreto.com5.4 MB0.0 KB1.8 MB7.1 MB 75%2.6 KB
6news-in.rahul.net4.4 MB96.6 KB5.5 MB10.0 MB 44%31.3 KB
7news.lightlink.com3.4 MB0.0 KB8.1 MB11.6 MB 29%57.0 KB
8news.cmpublishers.com837.8 KB0.0 KB157.9 KB995.8 KB 84%3.4 KB
9ripco-out.feeder.erje.net372.9 KB0.0 KB14.9 MB15.2 MB 2%10.6 KB
10localhost3.7 KB0.0 KB0.0 KB3.7 KB100%1.8 KB
TOTAL: 1085.7 MB96.6 KB55.9 MB141.7 MB 60%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 3 00:01:01 - 00:59:59 302 2.4% 0.09971.2 KB 2.3% 0.27
Aug 3 01:00:00 - 01:59:59 359 2.8% 0.102.0 MB 4.9% 0.57
Aug 3 02:00:00 - 02:59:59 377 3.0% 0.101.2 MB 2.9% 0.34
Aug 3 03:00:00 - 03:59:59 493 3.9% 0.141.4 MB 3.4% 0.39
Aug 3 04:00:00 - 04:59:59 547 4.3% 0.151.6 MB 3.9% 0.45
Aug 3 05:00:00 - 05:59:59 510 4.0% 0.141.5 MB 3.6% 0.42
Aug 3 06:00:00 - 06:59:59 545 4.3% 0.151.6 MB 4.0% 0.46
Aug 3 07:00:00 - 07:59:59 599 4.7% 0.171.5 MB 3.7% 0.43
Aug 3 08:00:00 - 08:59:59 702 5.5% 0.202.4 MB 5.9% 0.68
Aug 3 09:00:00 - 09:59:59 739 5.8% 0.212.0 MB 4.9% 0.57
Aug 3 10:00:00 - 10:59:59 748 5.9% 0.212.6 MB 6.4% 0.75
Aug 3 11:00:00 - 11:59:59 637 5.0% 0.182.3 MB 5.5% 0.64
Aug 3 12:00:00 - 12:59:59 736 5.8% 0.202.0 MB 5.0% 0.58
Aug 3 13:00:00 - 13:59:59 679 5.3% 0.192.5 MB 6.1% 0.71
Aug 3 14:00:00 - 14:59:59 688 5.4% 0.192.1 MB 5.2% 0.61
Aug 3 15:00:00 - 15:59:59 724 5.7% 0.202.3 MB 5.7% 0.66
Aug 3 16:00:00 - 16:59:59 644 5.1% 0.182.3 MB 5.7% 0.65
Aug 3 17:00:00 - 17:59:59 563 4.4% 0.161.5 MB 3.7% 0.43
Aug 3 18:00:00 - 18:59:59 458 3.6% 0.131.3 MB 3.2% 0.37
Aug 3 19:00:00 - 19:59:59 354 2.8% 0.101.0 MB 2.5% 0.30
Aug 3 20:00:00 - 20:59:59 488 3.8% 0.141.8 MB 4.4% 0.51
Aug 3 21:00:00 - 21:59:59 367 2.9% 0.101.3 MB 3.1% 0.36
Aug 3 22:00:00 - 22:59:59 251 2.0% 0.07755.9 KB 1.8% 0.21
Aug 3 23:00:00 - 23:57:22 229 1.8% 0.07879.2 KB 2.1% 0.26
TOTAL: 23:56:21 12739 100.0% 0.1540.7 MB 100.0% 0.48
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2301 1447 0 0 1 0 0 0 853
2newsfeed.neva.ru 1332 439 0 0 2 0 0 0 891
3ripco-out.feeder.erje.net 656 654 0 0 0 0 0 0 2
4feeder3.feed-ams.uzoreto.com 403 192 0 0 1 0 0 0 210
5news.snarked.org 241 107 0 0 2 0 0 0 132
6newsfeed.fu-berlin.de 218 0 0 0 0 0 0 0 218
7news.lightlink.com 74 0 0 0 0 0 0 0 74
8news-in.rahul.net 42 0 0 1 0 0 0 0 41
9news.cmpublishers.com 20 1 0 0 0 0 0 0 19
TOTAL: 9 5287 2840 0 1 6 0 0 0 2440

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1758
alt.binaries.ftd 446
free.it.scienza.fisica 60
free.willey 58
it.tlc.cellulari.android 42
perl.cpan.uploads 32
fido7.su.pol.news 27
alt.binaries.pictures.rail 25
de.soc.arbeitslos 17
scot.general 17
alt.binaries.pictures.wallpaper 16
alt.binaries.mac.games 15
alt.binaries.bungalow 13
alt.bestjobsusa.computer.jobs 10
alt.binaries.e-book 10
alt.binaries.pictures.scenic 8
alt.binaries.test.yenc 8
alt.my.job.sucks 7
alt.binaries.humor.skewed 7
alt.binaries.emulators.mame 6
TOTAL: 178 2840

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

GroupsCount
rec.travel.resorts.all-inclusive 2
fr.comp.securite 1
pl.praca.oferowana 1
alt.christnet.religion 1
bit.listserv.catholic 1
TOTAL: 5 6

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2224
Too many newsgroups 1010
Binary in non-binary group 948
EMP (phl) 108
Scoring filter (8) 32
Scoring filter (9) 28
Scoring filter (10) 18
Scoring filter (11) 8
Scoring filter (16) 4
Scoring filter (13) 2
Scoring filter (12) 2
TOTAL: 11 4384

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 201
newsfeed.neva.ru 33
ripco-out.feed.uzoreto.com 10
feeder3.feed-ams.uzoreto.com 3
TOTAL: 4 247
No colon-space in header
ripco-out.feed.uzoreto.com 1
TOTAL: 1 1
TOTAL: 3 266

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10312 1796 4692 8 0 12 17%47:40:04
2rahul.net 21096 624 12334 20 0 10 2%47:40:04
3news.cmpublishers.com 33864 94 24088 732 0 58 0%47:40:04
4news.snarked.org 29648 30 17472 10 0 210 0%47:45:14
5news.uzoreto.com 13490 22 13136 76 0 0 0%47:39:20
6newsfeed.neva.ru 20894 12 20694 12 0 0 0%47:40:06
7fu-berlin.de 22840 12 22828 0 0 0 0%47:40:04
8feeder.erje.net 23464 10 22870 10 0 0 0%47:42:00
9remote6hme0.ripco.com 0 0 0 0 0 8 0%47:40:02
TOTAL: 9 175608 2600 138114 868 0 298 1%429:06:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com4.8 MB19.7 KB4.8 MB0.0 KB/s2.7 KB47:40:04
2rahul.net3.3 MB49.2 KB3.3 MB0.0 KB/s5.3 KB47:40:04
3news.cmpublishers.com301.1 KB2.1 MB2.4 MB0.0 KB/s3.0 KB47:40:04
4news.snarked.org186.8 KB27.3 KB214.2 KB0.0 KB/s5.4 KB47:45:14
5newsfeed.neva.ru140.2 KB38.6 KB178.8 KB0.0 KB/s7.4 KB47:40:06
6news.uzoreto.com92.3 KB334.2 KB426.5 KB0.0 KB/s4.4 KB47:39:20
7fu-berlin.de63.4 KB0.0 KB63.4 KB0.0 KB/s5.3 KB47:40:04
8feeder.erje.net51.0 KB39.0 KB90.0 KB0.0 KB/s4.5 KB47:42:00
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
TOTAL: 98.9 MB2.6 MB11.5 MB0.0 KB/s3.4 KB429:06:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 8582.3 MB 412 2 000:08:22
2shell3 10 3201.0 MB 34 0 002:19:12
TOTAL: 2 296 11783.3 MB 446 2 002:34:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 8582.3 MB 412 2 000:08:22
2? 10 3201.0 MB 34 0 002:19:12
TOTAL: 2 296 11783.3 MB 446 2 002:27:34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 3.012 1.564 0.00002:19:12
ftupet.com 46.196 22.842 0.00000:08:22
84-105-134-55.cable.dynamic.v4.ziggo.nl 188.708 48.924 0.00000:06:50
117.50.6.201 1.014 0.262 0.00000:00:06
124-169-155-229.dyn.iinet.net.au 0.206 0.052 0.00000:00:02
58.109-247-134.customer.lyse.net 0.402 0.112 0.00000:00:02
TOTAL: 6 239.538 73.756 0.00002:34:36

NNRP no permission clients:

SystemConn
84-105-134-55.cable.dynamic.v4.ziggo.nl 1860
117.50.6.201 10
58.109-247-134.customer.lyse.net 4
124-169-155-229.dyn.iinet.net.au 2
TOTAL: 4 1876

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 6 0
TOTAL: 1 6 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1074 91.2%
2comp 54 4.6%
3chi 18 1.5%
4sci 18 1.5%
5soc 6 0.5%
6alt 4 0.3%
7news 4 0.3%
TOTAL: 7 1178100.0%

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

NewsgroupCount
1rec.arts.tv 450
2rec.food.cooking 438
3rec.bicycles.tech 164
4comp.sys.mac.system 44
5sci.electronics.repair 18
6comp.protocols.dns.bind 10
7rec.radio.swap 8
8chi.general 8
9rec.gardens.edible 8
10soc.history.what-if 6
11chi.weather 6
12rec.puzzles 4
13chi.eats 4
14rec.radio.broadcasting 2
15news.admin.hierarchies 2
16alt.online-services.roadrunner 2
17news.admin.net-abuse.email 2
18alt.satellite.gps.garmin 2
TOTAL: 18 1178