Daily Usenet report for news.ripco.com

Aug 14 00:01:01 -- Aug 14 23:58:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Aug 14 15:43:59 remote5bge0 overchan[24643]: [ID 702911 news.error] input line too long, skipping
Aug 14 15:49:56 remote5bge0 overchan[24643]: [ID 702911 news.error] input line too long, skipping
Aug 14 16:01:29 remote5bge0 overchan[24643]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 22134 32.3%2.4 MB 23.9%
innd 22091 32.3%3.4 MB 33.5%
inn 20535 30.0%3.5 MB 34.9%
innfeed 3726 5.4%794.2 KB 7.7%
overchan 3 0.0%0.4 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 68491 100.0%10.1 MB100.0%

History cache:

ReasonCount%Count
Cache misses 206082 50.8%
Do not exist 199678 49.2%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 405760 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%150 0.000 0.000 0.000
article cleanup00:00:00.376 0.0%40780 0.000 0.009 0.052
article logging00:00:00.652 0.0%41116 0.000 0.016 0.330
article parse00:00:02.220 0.0%118964 0.000 0.019 0.050
article write00:01:27.004 0.1%28066 0.400 3.100 104.272
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.320 0.0%393734 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:03.124 0.0%406918 0.000 0.008 0.031
history sync00:00:00.232 0.0%794 0.000 0.292 5.667
history write00:00:03.586 0.0%40782 0.000 0.088 0.987
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:57:49.462 99.9%424608 42.122 406.656 1073.775
nntp read00:00:02.466 0.0%425344 0.000 0.006 0.015
overview write00:00:00.190 0.0%28066 0.000 0.007 0.054
perl filter00:00:58.330 0.0%40778 1.015 1.430 4.023
python filter00:00:01.008 0.0%40784 0.000 0.025 0.078
site send00:00:02.000 0.0%84144 0.005 0.024 0.048
TOTAL: 48:02:04.58048:00:30.970 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.112 0.0%28668 0.000 0.004 0.038
article prepare00:00:00.002 0.0%3472 0.000 0.001 0.125
article read00:00:00.550 0.0%772 0.000 0.712 70.000
backlog stats00:00:00.160 0.0%320666 0.000 0.000 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.328 0.0%214396 0.000 0.006 0.015
data write00:00:02.990 0.0%187800 0.000 0.016 0.027
idle47:53:07.690100.0%320666 311.613 537.593 1113.393
status file00:00:02.384 0.0%380 0.600 6.274 61.000
TOTAL: 47:53:24.49447:53:15.216100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:57:45.294 96.7%18066 0.333 590.352 89447.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:07.492 0.1%819874 0.000 0.009 1.000
readart00:00:19.218 0.2%1950 0.000 9.855 36.000
TOTAL: 03:03:45.58802:58:12.004 97.0%----

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 1152 37042 15138 16616 5288 40%94:56:36
2newsfeed.neva.ru 572 19968 5554 11008 3406 27%274:11:24
3feeder3.feed-ams.uzoreto.com 576 11020 2974 7168 878 26%47:28:30
4news.snarked.org 46 26508 1906 24390 212 7%52:36:16
5newsfeed.fu-berlin.de 2 15062 878 14172 12 5%49:45:14
6news.cmpublishers.com 50 9308 806 8448 54 8%48:00:22
7news-in.rahul.net 576 15728 666 15036 26 4%47:30:28
8news.lightlink.com 28 83890 262 81856 1772 0%03:46:42
9ripco-out.feeder.erje.net 576 29976 74 28846 1056 0%47:27:04
10localhost 152 6 6 0 0 100%00:00:02
TOTAL: 10 3730 248508 28264 207540 12704 11%665:42:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com39.7 MB0.0 KB12.2 MB51.8 MB 76%2.6 KB
2news.lightlink.com24.9 MB0.0 KB81.3 MB106.2 MB 23%53.4 KB
3newsfeed.neva.ru17.2 MB3.4 KB18.4 MB35.6 MB 48%4.1 KB
4newsfeed.fu-berlin.de10.4 MB0.0 KB425.5 KB10.8 MB 96%12.5 KB
5feeder3.feed-ams.uzoreto.com9.0 MB0.0 KB2.2 MB11.2 MB 80%3.0 KB
6news.snarked.org6.3 MB0.0 KB800.6 KB7.1 MB 88%3.4 KB
7news-in.rahul.net4.0 MB0.0 KB387.3 KB4.4 MB 91%6.5 KB
8news.cmpublishers.com2.6 MB0.0 KB227.5 KB2.8 MB 92%3.4 KB
9ripco-out.feeder.erje.net262.8 KB0.0 KB10.4 MB10.6 MB 2%9.6 KB
10localhost11.1 KB0.0 KB0.0 KB11.1 KB100%1.9 KB
TOTAL: 10114.3 MB3.4 KB126.2 MB240.5 MB 47%6.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 14 00:01:01 - 00:59:59 417 3.0% 0.121.6 MB 2.9% 0.47
Aug 14 01:00:00 - 01:59:59 507 3.6% 0.141.5 MB 2.7% 0.43
Aug 14 02:00:00 - 02:59:59 537 3.8% 0.151.6 MB 2.8% 0.44
Aug 14 03:00:00 - 03:59:59 556 4.0% 0.151.5 MB 2.7% 0.43
Aug 14 04:00:00 - 04:59:59 637 4.5% 0.181.7 MB 3.1% 0.50
Aug 14 05:00:00 - 05:59:59 577 4.1% 0.162.2 MB 4.0% 0.64
Aug 14 06:00:00 - 06:59:59 608 4.3% 0.172.3 MB 4.1% 0.65
Aug 14 07:00:00 - 07:59:59 582 4.2% 0.161.7 MB 3.0% 0.47
Aug 14 08:00:00 - 08:59:59 642 4.6% 0.182.0 MB 3.6% 0.57
Aug 14 09:00:00 - 09:59:59 842 6.0% 0.232.2 MB 3.9% 0.62
Aug 14 10:00:00 - 10:59:59 729 5.2% 0.202.4 MB 4.2% 0.68
Aug 14 11:00:00 - 11:59:59 739 5.3% 0.212.0 MB 3.6% 0.58
Aug 14 12:00:00 - 12:59:59 868 6.2% 0.242.2 MB 3.9% 0.63
Aug 14 13:00:00 - 13:59:59 787 5.6% 0.222.4 MB 4.3% 0.68
Aug 14 14:00:00 - 14:59:59 774 5.5% 0.212.2 MB 3.9% 0.63
Aug 14 15:00:00 - 15:59:59 711 5.1% 0.202.8 MB 4.9% 0.79
Aug 14 16:00:00 - 16:59:59 675 4.8% 0.192.1 MB 3.8% 0.61
Aug 14 17:00:00 - 17:59:59 545 3.9% 0.151.8 MB 3.2% 0.51
Aug 14 18:00:00 - 18:59:59 425 3.0% 0.121.8 MB 3.2% 0.51
Aug 14 19:00:00 - 19:59:59 354 2.5% 0.101.1 MB 1.9% 0.31
Aug 14 20:00:00 - 20:59:59 443 3.2% 0.127.0 MB 12.4% 1.99
Aug 14 21:00:00 - 21:59:59 417 3.0% 0.128.0 MB 14.2% 2.27
Aug 14 22:00:00 - 22:59:59 285 2.0% 0.081010.4 KB 1.8% 0.28
Aug 14 23:00:00 - 23:58:02 360 2.6% 0.101.2 MB 2.1% 0.34
TOTAL: 23:57:01 14017 100.0% 0.1656.3 MB 100.0% 0.67
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2652 1829 0 0 2 0 0 0 821
2newsfeed.neva.ru 1745 515 0 1 0 0 0 0 1229
3news.lightlink.com 886 0 0 0 0 0 0 0 886
4ripco-out.feeder.erje.net 528 525 0 0 0 0 0 0 3
5feeder3.feed-ams.uzoreto.com 442 249 0 0 0 0 0 0 193
6newsfeed.fu-berlin.de 127 0 0 0 0 0 0 0 127
7news.snarked.org 101 42 0 0 0 0 0 0 59
8news.cmpublishers.com 24 2 0 0 0 0 0 0 22
9news-in.rahul.net 13 0 0 0 0 0 0 0 13
TOTAL: 9 6518 3162 0 1 2 0 0 0 3353

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2101
alt.binaries.ftd 265
alt.binaries.ftwclub 93
perl.cpan.uploads 62
free.it.scienza.fisica 61
fido7.su.pol.news 41
it.tlc.cellulari.android 38
scot.general 38
alt.binaries.nl 36
alt.binaries.pictures.purebeauty 28
free.willey 24
alt.binaries.e-book 20
alt.binaries.pictures.scenic 15
alt.binaries.mp3.audiobooks 14
alt.binaries.humor.skewed 14
alt.bestjobsusa.computer.jobs 14
zz.unity.chat 13
mozilla.dev.platform 12
alt.binaries.e-books 9
alt.my.job.sucks 8
TOTAL: 134 3162

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

GroupsCount
pl.praca.oferowana 1
rec.travel.resorts.all-inclusive 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3688
Binary in non-binary group 1708
Too many newsgroups 814
Scoring filter (9) 42
EMP (phl) 30
Poison newsgroup 28
Scoring filter (8) 24
Scoring filter (10) 14
HTML post 10
Scoring filter (11) 8
Scoring filter (16) 6
TOTAL: 11 6372

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 121
newsfeed.neva.ru 36
ripco-out.feed.uzoreto.com 7
feeder3.feed-ams.uzoreto.com 3
TOTAL: 4 167
No colon-space in header
ripco-out.feed.uzoreto.com 1
TOTAL: 1 1
TOTAL: 3 186

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1rahul.net 19992 480 12618 2 0 2 2%47:40:00
2news.lightlink.com 11368 144 6518 16 0 1122 1%47:37:20
3news.snarked.org 38602 36 25862 10 0 8 0%47:51:48
4feeder.erje.net 25266 14 25184 22 0 0 0%47:45:46
5news.cmpublishers.com 34914 10 26644 82 0 6 0%47:40:00
6newsfeed.neva.ru 22354 6 22266 30 0 0 0%47:40:00
7fu-berlin.de 25248 6 25242 0 0 0 0%47:40:00
8news.uzoreto.com 9420 4 9390 2 0 0 0%47:49:00
9remote6hme0.ripco.com 0 0 0 0 0 8 0%47:40:00
TOTAL: 9 187164 700 153724 164 0 1146 0%429:23:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1rahul.net32.2 MB4.3 KB32.2 MB0.2 KB/s68.3 KB47:40:00
2news.lightlink.com1.6 MB51.5 KB1.6 MB0.0 KB/s10.3 KB47:37:20
3news.snarked.org121.0 KB50.6 KB171.6 KB0.0 KB/s3.7 KB47:51:48
4news.cmpublishers.com32.3 KB266.2 KB298.5 KB0.0 KB/s3.2 KB47:40:00
5feeder.erje.net28.9 KB111.9 KB140.8 KB0.0 KB/s3.9 KB47:45:46
6newsfeed.neva.ru11.2 KB2.6 MB2.6 MB0.0 KB/s74.9 KB47:40:00
7fu-berlin.de11.2 KB0.0 KB11.2 KB0.0 KB/s1.9 KB47:40:00
8news.uzoreto.com7.8 KB3.3 KB11.2 KB0.0 KB/s1.9 KB47:49:00
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 933.9 MB3.1 MB37.0 MB0.0 KB/s43.9 KB429:23:54
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 288 8002.2 MB 436 2 000:07:48
2shell3 24 348986.9 KB 42 4 002:51:11
TOTAL: 2 312 11483.2 MB 478 6 003:03:10

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 288 8002.2 MB 436 2 000:07:48
2? 24 348986.9 KB 42 4 002:51:11
TOTAL: 2 312 11483.2 MB 478 6 002:59:00

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 5.610 2.440 0.00002:51:11
ftupet.com 45.586 7.606 0.00000:07:48
d54c176a7.access.telenet.be 77.224 16.658 0.00000:02:28
84-105-134-55.cable.dynamic.v4.ziggo.nl 35.438 7.610 0.00000:01:22
adore.lightlink.com 5.440 1.090 0.00000:00:12
58.109-247-134.customer.lyse.net 0.400 0.094 0.00000:00:02
ip-173-150-16-86.chcgil.spcsdns.net 1.410 0.298 0.00000:00:01
82-73-87-108.cable.dynamic.v4.ziggo.nl 0.200 0.042 0.00000:00:01
TOTAL: 8 171.308 35.838 0.00003:03:10

NNRP no permission clients:

SystemConn
d54c176a7.access.telenet.be 768
84-105-134-55.cable.dynamic.v4.ziggo.nl 352
adore.lightlink.com 54
ip-173-150-16-86.chcgil.spcsdns.net 14
58.109-247-134.customer.lyse.net 4
82-73-87-108.cable.dynamic.v4.ziggo.nl 2
TOTAL: 6 1194

NNRP unrecognized commands (by host):

SystemConn
shell3 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 4
TOTAL: 1 4

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 8 0
TOTAL: 1 8 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1002 87.3%
2misc 74 6.4%
3comp 20 1.7%
4alt 18 1.6%
5sci 14 1.2%
6chi 12 1.0%
7ba 2 0.2%
8soc 2 0.2%
9seattle 2 0.2%
10news 2 0.2%
TOTAL: 10 1148100.0%

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

NewsgroupCount
1rec.arts.tv 616
2rec.food.cooking 264
3rec.bicycles.tech 98
4misc.phone.mobile.iphone 56
5misc.consumers.frugal-living 18
6sci.electronics.repair 14
7comp.unix.bsd.freebsd.misc 12
8alt.stupidity 10
9chi.weather 10
10rec.radio.broadcasting 6
11rec.radio.swap 6
12comp.mail.pine 4
13alt.online-services.roadrunner 4
14rec.gardens.edible 4
15rec.puzzles 4
16comp.sys.mac.system 4
17soc.history.what-if 2
18rec.heraldry 2
19alt.autos.toyota 2
20rec.bicycles.misc 2
21chi.forsale 2
22news.admin.net-abuse.usenet 2
23alt.games.warcraft 2
24seattle.general 2
25ba.food 2
TOTAL: 25 1148