Daily Usenet report for news.ripco.com

Jan 23 00:01:03 -- Jan 23 23:58:35

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Jan 23 09:11:31 remote5bge0 overchan[18437]: [ID 702911 news.error] input line too long, skipping
Jan 23 11:15:51 remote5bge0 overchan[18437]: [ID 702911 news.error] input line too long, skipping
Jan 23 11:41:01 remote5bge0 overchan[18437]: [ID 702911 news.error] input line too long, skipping
Jan 23 11:48:39 remote5bge0 overchan[18437]: [ID 702911 news.error] input line too long, skipping
Jan 23 21:54:19 remote5bge0 overchan[18437]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 345950 89.2%42.7 MB 85.9%
inn 19533 5.0%3.4 MB 6.9%
innd 18821 4.9%2.9 MB 5.7%
innfeed 3574 0.9%752.6 KB 1.5%
overchan 5 0.0%0.6 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 387885 100.0%49.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 165188 51.7%
Cache misses 154258 48.3%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 319446 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%192 0.000 0.000 0.000
article cleanup00:00:00.538 0.0%38708 0.000 0.014 0.050
article logging00:00:00.750 0.0%39116 0.000 0.019 0.176
article parse00:00:01.458 0.0%91306 0.000 0.016 0.094
article write00:00:57.222 0.0%29706 0.735 1.926 30.489
artlog/artparse00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:00.370 0.0%324432 0.000 0.001 0.009
hishave/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.842 0.0%320278 0.000 0.009 0.017
history sync00:00:00.158 0.0%760 0.000 0.208 1.500
history write00:00:02.490 0.0%38708 0.000 0.064 0.365
hiswrite/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
idle47:21:41.164 98.6%488832 227.667 348.793 669.717
nntp read00:00:03.284 0.0%361898 0.002 0.009 0.022
overview write00:00:00.324 0.0%29706 0.000 0.011 0.053
perl filter00:01:11.936 0.0%38700 1.505 1.859 2.768
python filter00:00:02.374 0.0%38708 0.006 0.061 0.143
site send00:00:02.562 0.0%89096 0.005 0.029 0.061
TOTAL: 48:01:50.64847:24:07.472 98.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.142 0.0%29672 0.000 0.005 0.040
article prepare00:00:00.004 0.0%18840 0.000 0.000 0.015
article read00:00:00.464 0.0%4192 0.000 0.111 5.462
backlog stats00:00:00.202 0.0%365652 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.176 0.0%237796 0.005 0.013 0.027
data write00:00:04.038 0.0%208750 0.009 0.019 0.032
idle47:35:37.450100.0%365652 280.213 468.581 1261.722
status file00:00:01.058 0.0%318 0.000 3.327 42.000
TOTAL: 47:35:58.20247:35:46.534100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:08:26.808 51.3%18346 8.667 812.537 62063.364
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:12.462 0.0%959206 0.000 0.013 114.000
readart00:00:20.898 0.1%2574 1.500 8.119 58.000
TOTAL: 08:04:18.81204:09:00.168 51.4%----

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 1146 40790 12670 23120 5000 31%94:59:14
2news.snarked.org 40 26934 8564 17842 528 31%46:07:20
3newsfeed.neva.ru 602 39386 5604 32032 1750 14%275:31:52
4feeder3.feed-ams.uzoreto.com 574 9222 1628 6818 776 17%47:18:58
5newsfeed.fu-berlin.de 2 24746 830 23898 18 3%79:28:24
6news-in.rahul.net 574 15354 198 15130 26 1%47:20:00
7news.lightlink.com 2 3608 158 3448 2 4%27:14:46
8ripco-out.feeder.erje.net 574 31222 40 30292 890 0%47:18:24
9news.cmpublishers.com 52 8052 22 8026 4 0%48:00:04
10localhost 154 8 8 0 0 100%00:00:00
TOTAL: 10 3720 199322 29722 160606 8994 14%713:19:02
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com31.2 MB0.0 KB10.8 MB42.0 MB 74%2.4 KB
2news.snarked.org25.4 MB9.9 KB1.6 MB27.0 MB 93%3.0 KB
3newsfeed.neva.ru17.4 MB31.5 KB4.2 MB21.6 MB 80%3.0 KB
4newsfeed.fu-berlin.de5.2 MB0.0 KB1.7 MB6.9 MB 75%8.3 KB
5news-in.rahul.net4.9 MB0.0 KB785.1 KB5.7 MB 86%26.1 KB
6feeder3.feed-ams.uzoreto.com4.5 MB0.0 KB1.9 MB6.5 MB 70%2.8 KB
7news.lightlink.com1.3 MB0.0 KB150.4 KB1.4 MB 89%8.9 KB
8ripco-out.feeder.erje.net210.9 KB0.0 KB8.9 MB9.1 MB 2%10.0 KB
9news.cmpublishers.com66.0 KB0.0 KB33.3 KB99.3 KB 66%3.8 KB
10localhost17.5 KB0.0 KB0.0 KB17.5 KB100%2.2 KB
TOTAL: 1090.2 MB41.4 KB30.1 MB120.3 MB 74%3.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 23 00:01:03 - 00:59:59 392 2.6% 0.111.2 MB 2.6% 0.33
Jan 23 01:00:00 - 01:59:59 421 2.8% 0.121.3 MB 3.0% 0.38
Jan 23 02:00:00 - 02:59:59 541 3.6% 0.151.3 MB 3.0% 0.38
Jan 23 03:00:00 - 03:59:59 652 4.4% 0.181.6 MB 3.6% 0.46
Jan 23 04:00:00 - 04:59:59 638 4.3% 0.182.1 MB 4.7% 0.59
Jan 23 05:00:00 - 05:59:59 718 4.8% 0.202.1 MB 4.6% 0.59
Jan 23 06:00:00 - 06:59:59 832 5.6% 0.232.6 MB 5.8% 0.73
Jan 23 07:00:00 - 07:59:59 734 5.0% 0.201.8 MB 4.0% 0.51
Jan 23 08:00:00 - 08:59:59 777 5.2% 0.222.2 MB 4.8% 0.61
Jan 23 09:00:00 - 09:59:59 769 5.2% 0.212.1 MB 4.8% 0.61
Jan 23 10:00:00 - 10:59:59 838 5.7% 0.232.8 MB 6.4% 0.81
Jan 23 11:00:00 - 11:59:59 865 5.8% 0.242.3 MB 5.1% 0.65
Jan 23 12:00:00 - 12:59:59 896 6.0% 0.252.5 MB 5.6% 0.71
Jan 23 13:00:00 - 13:59:59 738 5.0% 0.202.5 MB 5.6% 0.71
Jan 23 14:00:00 - 14:59:59 836 5.6% 0.232.7 MB 6.0% 0.77
Jan 23 15:00:00 - 15:59:59 777 5.2% 0.222.8 MB 6.2% 0.79
Jan 23 16:00:00 - 16:59:59 755 5.1% 0.212.2 MB 5.0% 0.64
Jan 23 17:00:00 - 17:59:59 541 3.6% 0.151.8 MB 4.0% 0.51
Jan 23 18:00:00 - 18:59:59 472 3.2% 0.131.4 MB 3.1% 0.39
Jan 23 19:00:00 - 19:59:59 409 2.8% 0.111.2 MB 2.6% 0.34
Jan 23 20:00:00 - 20:59:59 386 2.6% 0.111.2 MB 2.7% 0.34
Jan 23 21:00:00 - 21:59:59 269 1.8% 0.071.1 MB 2.4% 0.30
Jan 23 22:00:00 - 22:59:59 265 1.8% 0.071.1 MB 2.5% 0.32
Jan 23 23:00:00 - 23:58:35 304 2.1% 0.09947.6 KB 2.1% 0.27
TOTAL: 23:57:32 14825 100.0% 0.1744.7 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2506 1624 0 0 8 0 0 0 874
2newsfeed.neva.ru 931 362 0 3 0 0 0 0 566
3ripco-out.feeder.erje.net 445 443 0 0 0 0 0 0 2
4feeder3.feed-ams.uzoreto.com 391 141 0 0 0 0 0 0 250
5news.snarked.org 267 177 0 1 2 0 0 0 87
6newsfeed.fu-berlin.de 141 0 0 0 0 0 0 0 141
7news.lightlink.com 13 1 0 0 0 0 0 0 12
8news-in.rahul.net 13 10 0 0 0 0 0 0 3
9news.cmpublishers.com 1 1 0 0 0 0 0 0 0
TOTAL: 9 4708 2759 0 4 10 0 0 0 1935

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1907
alt.binaries.ftd 185
scot.general 55
perl.cpan.uploads 48
free.it.scienza.fisica 48
fido7.su.pol.news 43
it.tlc.cellulari.android 38
alt.binaries.nl 35
it.comp.os.win.windows10 19
alt.binaries.nospam.female.bodyhair.pubes 17
alt.binaries.comics.dcp 16
alt.tv.star-trek 15
alt.binaries.movies.xvid 14
wales.test 12
alt.binaries.e-book 12
alt.binaries.nospam.breasts.natural 11
alt.binaries.humor.skewed 11
alt.binaries.pictures.scenic 11
alt.binaries.ebooks 11
fr.rec.loisirs-creatifs 9
TOTAL: 138 2759

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

GroupsCount
fr.sci.geosciences 3
christnet.bible 2
bit.listserv.catholic 2
christnet.theology 1
alt.christnet.religion 1
alt.penthouse.sex.masterbation 1
TOTAL: 6 10

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2218
Too many newsgroups 928
EMP (phl) 150
Binary in non-binary group 78
Scoring filter (8) 30
Scoring filter (9) 24
Scoring filter (10) 8
Scoring filter (11) 6
Scoring filter (12) 4
HTML post 4
Scoring filter (13) 2
Scoring filter (14) 2
TOTAL: 12 3454

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 20
feeder3.feed-ams.uzoreto.com 2
TOTAL: 2 22
Huge articles
newsfeed.fu-berlin.de 2
TOTAL: 1 2
Including strange strings
newsfeed.fu-berlin.de 138
newsfeed.neva.ru 56
ripco-out.feed.uzoreto.com 6
feeder3.feed-ams.uzoreto.com 3
TOTAL: 4 203
No colon-space in header
ripco-out.feeder.erje.net 2
ripco-out.feed.uzoreto.com 1
feeder3.feed-ams.uzoreto.com 1
TOTAL: 3 4
TOTAL: 4 231

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9366 1670 4620 8 0 0 17%47:40:00
2rahul.net 22538 566 12526 24 0 2 2%47:49:44
3news.cmpublishers.com 43786 320 27288 1734 0 22 0%47:40:00
4fu-berlin.de 27268 48 27220 0 0 0 0%47:50:26
5news.snarked.org 34542 34 20610 10 0 94 0%47:40:00
6news.uzoreto.com 15332 34 14914 128 0 0 0%47:40:00
7feeder.erje.net 27928 26 27524 92 0 0 0%47:40:00
8newsfeed.neva.ru 24648 16 23916 8 0 0 0%47:40:00
9remote6hme0.ripco.com 0 0 0 0 0 6 0%47:40:00
TOTAL: 9 205408 2714 158618 2004 0 124 1%429:20:10
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com5.0 MB39.4 KB5.1 MB0.0 KB/s3.1 KB47:40:00
2rahul.net1.9 MB78.3 KB2.0 MB0.0 KB/s3.5 KB47:49:44
3news.cmpublishers.com908.1 KB4.4 MB5.2 MB0.0 KB/s2.6 KB47:40:00
4fu-berlin.de798.3 KB0.0 KB798.3 KB0.0 KB/s16.6 KB47:50:26
5feeder.erje.net134.6 KB272.7 KB407.3 KB0.0 KB/s3.5 KB47:40:00
6news.uzoreto.com131.1 KB444.7 KB575.9 KB0.0 KB/s3.6 KB47:40:00
7news.snarked.org117.2 KB29.0 KB146.2 KB0.0 KB/s3.3 KB47:40:00
8newsfeed.neva.ru36.0 KB52.8 KB88.8 KB0.0 KB/s3.7 KB47:40:00
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 99.1 MB5.3 MB14.3 MB0.0 KB/s3.1 KB429:20:10
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 284 9642.8 MB 434 6 000:06:41
2shell3 20 6402.0 MB 64 2 004:02:56
TOTAL: 2 304 16044.8 MB 498 8 007:35:52

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 284 9642.8 MB 434 6 000:06:41
2? 20 6402.0 MB 64 2 004:02:56
TOTAL: 2 304 16044.8 MB 498 8 004:09:38

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 5.208 3.408 0.00004:02:56
216.154.28.124 6615.575 1528.427 0.00003:26:12
ftupet.com 45.560 7.702 0.00000:06:41
79.184.61.221.ipv4.supernova.orange.pl 0.800 0.166 0.00000:00:01
TOTAL: 4 6667.143 1539.703 0.00007:35:52

NNRP no permission clients:

SystemConn
216.154.28.124 65756
79.184.61.221.ipv4.supernova.orange.pl 8
TOTAL: 2 65764

NNRP unrecognized commands (by host):

SystemConn
shell3 6
TOTAL: 1 6

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 6
TOTAL: 1 6

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 4 0
TOTAL: 1 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1268 79.1%
2misc 90 5.6%
3alt 88 5.5%
4comp 68 4.2%
5news 52 3.2%
6sci 18 1.1%
7rocksolid 14 0.9%
8chi 4 0.2%
9houston 2 0.1%
TOTAL: 9 1604100.0%

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

NewsgroupCount
1rec.arts.tv 836
2rec.food.cooking 224
3rec.bicycles.tech 174
4misc.phone.mobile.iphone 86
5alt.comp.os.windows-10 54
6news.software.nntp 28
7comp.protocols.dns.bind 24
8sci.electronics.repair 18
9comp.sys.mac.system 18
10rec.gardens.edible 14
11alt.bittorrent 10
12comp.mobile.android 10
13news.groups 10
14news.admin.net-abuse.usenet 8
15alt.stupidity 8
16rocksolid.shared.tor 8
17rocksolid.shared.security 6
18comp.sys.apple2 6
19rec.outdoors.rv-travel 6
20rec.bicycles.misc 6
21comp.unix.solaris 6
22comp.mail.sendmail 4
23alt.sports.football.pro.kc-chiefs 4
24rec.radio.broadcasting 4
25misc.phone.mobile 4
26news.software.readers 4
27alt.security.alarms 4
28alt.video.tape-trading 4
29chi.weather 4
30houston.general 2
31alt.tv.twin-peaks 2
32rec.puzzles 2
33rec.radio.swap 2
34alt.satellite.gps.garmin 2
35news.groups.questions 2
TOTAL: 35 1604