Daily Usenet report for news.ripco.com

May 3 00:01:02 -- May 3 23:57:37

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

May 3 08:13:00 remote5bge0 overchan[11677]: [ID 702911 news.error] input line too long, skipping
May 3 08:28:37 remote5bge0 overchan[11677]: [ID 702911 news.error] input line too long, skipping
May 3 09:10:00 remote5bge0 overchan[11677]: [ID 702911 news.error] input line too long, skipping
May 3 09:54:36 remote5bge0 overchan[11677]: [ID 702911 news.error] input line too long, skipping
May 3 14:35:16 remote5bge0 overchan[11677]: [ID 702911 news.error] input line too long, skipping
May 3 17:15:36 remote5bge0 overchan[11677]: [ID 702911 news.error] input line too long, skipping
May 3 23:55:2

Log entries by program:

Program nameLines%LinesSize%Size
inn 20794 34.1%4.0 MB 41.5%
innd 19065 31.2%2.9 MB 30.9%
nnrpd 17282 28.3%1.8 MB 18.8%
innfeed 3902 6.4%861.6 KB 8.8%
overchan 6 0.0%0.7 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 61051 100.0%9.5 MB100.0%

History cache:

ReasonCount%Count
Cache misses 191138 50.5%
Do not exist 187512 49.5%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 378650 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%114 0.000 0.000 0.000
article cleanup00:00:00.456 0.0%41064 0.000 0.011 0.048
article logging00:00:01.012 0.0%41668 0.000 0.024 0.836
article parse00:00:01.442 0.0%103038 0.000 0.014 0.037
article write00:01:34.914 0.1%29812 1.471 3.184 37.458
artlog/artparse00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:00.436 0.0%388056 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:03.174 0.0%379996 0.001 0.008 0.016
history sync00:00:00.246 0.0%790 0.000 0.311 2.000
history write00:00:04.694 0.0%41074 0.000 0.114 4.347
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle47:56:35.136 99.8%427628 208.203 403.610 1192.064
nntp read00:00:03.438 0.0%428448 0.001 0.008 0.018
overview write00:00:00.314 0.0%29812 0.000 0.011 0.057
perl filter00:01:00.700 0.0%41064 1.205 1.478 2.708
python filter00:00:01.442 0.0%41066 0.000 0.035 0.132
site send00:00:02.220 0.0%89338 0.005 0.025 0.054
TOTAL: 48:02:10.36447:59:29.624 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.162 0.0%30080 0.000 0.005 0.043
article prepare00:00:00.002 0.0%14224 0.000 0.000 0.014
article read00:00:00.392 0.0%2988 0.000 0.131 70.000
backlog stats00:00:00.340 0.0%435044 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.004 0.0%280860 0.000 0.011 0.023
data write00:00:04.004 0.0%251216 0.007 0.016 0.032
idle47:35:54.308100.0%435044 201.023 393.878 1019.256
status file00:00:02.002 0.0%350 1.000 5.720 79.000
TOTAL: 47:36:25.72647:36:04.214100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:54:01.650 98.7%18092 18.319 577.142 45037.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:06.698 0.1%659716 0.000 0.010 0.044
readart00:00:21.946 0.2%2278 2.958 9.634 36.500
TOTAL: 02:56:17.15002:54:30.294 99.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1148 35108 9056 20660 5392 25%94:37:54
2news.snarked.org 60 29972 7164 22310 498 23%55:21:52
3feeder3.feed-ams.uzoreto.com 574 18608 6570 10118 1920 35%47:28:12
4newsfeed.neva.ru 604 35530 5032 28510 1988 14%274:09:56
5newsfeed.fu-berlin.de 2 13602 726 12866 10 5%45:38:12
6ripco-out.news.tnetconsulting.net 6 26846 688 26084 74 2%41:19:06
7news-in.rahul.net 574 15232 250 14920 62 1%47:18:58
8news.lightlink.com 2 7308 110 7018 180 1%43:34:40
9ripco-out.feeder.erje.net 574 33094 104 31900 1090 0%47:26:24
10news.cmpublishers.com 52 10220 4 10216 0 0%47:59:00
11localhost 148 2 2 0 0 100%00:00:04
TOTAL: 11 3744 225522 29706 184602 11214 13%744:54:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com24.7 MB0.0 KB9.9 MB34.6 MB 71%2.5 KB
2news.snarked.org20.9 MB0.0 KB1.4 MB22.4 MB 93%3.0 KB
3newsfeed.neva.ru17.4 MB0.0 KB5.3 MB22.7 MB 76%3.3 KB
4feeder3.feed-ams.uzoreto.com16.4 MB0.0 KB4.5 MB20.9 MB 78%2.5 KB
5ripco-out.news.tnetconsulting.net7.8 MB0.0 KB1.9 MB9.7 MB 80%13.0 KB
6newsfeed.fu-berlin.de2.7 MB0.0 KB602.6 KB3.3 MB 82%4.6 KB
7news-in.rahul.net2.7 MB0.0 KB1.8 MB4.4 MB 60%14.5 KB
8news.lightlink.com2.1 MB0.0 KB7.6 MB9.7 MB 21%34.3 KB
9ripco-out.feeder.erje.net174.4 KB0.0 KB7.8 MB7.9 MB 2%6.8 KB
10news.cmpublishers.com25.1 KB0.0 KB0.0 KB25.1 KB100%6.3 KB
11localhost4.1 KB0.0 KB0.0 KB4.1 KB100%2.1 KB
TOTAL: 1194.9 MB0.0 KB40.7 MB135.6 MB 70%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 3 00:01:02 - 00:59:59 310 2.1% 0.09871.3 KB 1.7% 0.25
May 3 01:00:00 - 01:59:59 357 2.4% 0.101.2 MB 2.3% 0.33
May 3 02:00:00 - 02:59:59 524 3.5% 0.151.9 MB 3.8% 0.53
May 3 03:00:00 - 03:59:59 655 4.4% 0.182.6 MB 5.2% 0.73
May 3 04:00:00 - 04:59:59 591 4.0% 0.161.9 MB 3.8% 0.54
May 3 05:00:00 - 05:59:59 679 4.6% 0.192.1 MB 4.3% 0.60
May 3 06:00:00 - 06:59:59 773 5.2% 0.212.2 MB 4.4% 0.62
May 3 07:00:00 - 07:59:59 808 5.4% 0.222.1 MB 4.2% 0.59
May 3 08:00:00 - 08:59:59 856 5.8% 0.243.5 MB 7.1% 1.00
May 3 09:00:00 - 09:59:59 762 5.1% 0.212.5 MB 5.0% 0.70
May 3 10:00:00 - 10:59:59 869 5.8% 0.242.9 MB 5.9% 0.83
May 3 11:00:00 - 11:59:59 924 6.2% 0.263.3 MB 6.7% 0.94
May 3 12:00:00 - 12:59:59 1026 6.9% 0.283.4 MB 7.0% 0.98
May 3 13:00:00 - 13:59:59 867 5.8% 0.242.6 MB 5.2% 0.73
May 3 14:00:00 - 14:59:59 866 5.8% 0.243.0 MB 6.0% 0.85
May 3 15:00:00 - 15:59:59 706 4.7% 0.202.0 MB 4.1% 0.57
May 3 16:00:00 - 16:59:59 632 4.3% 0.182.2 MB 4.5% 0.63
May 3 17:00:00 - 17:59:59 623 4.2% 0.172.3 MB 4.7% 0.66
May 3 18:00:00 - 18:59:59 430 2.9% 0.121.4 MB 2.8% 0.40
May 3 19:00:00 - 19:59:59 374 2.5% 0.101.3 MB 2.6% 0.37
May 3 20:00:00 - 20:59:59 337 2.3% 0.091.1 MB 2.2% 0.31
May 3 21:00:00 - 21:59:59 348 2.3% 0.101.2 MB 2.4% 0.34
May 3 22:00:00 - 22:59:59 306 2.1% 0.091015.9 KB 2.0% 0.28
May 3 23:00:00 - 23:57:37 245 1.6% 0.071.0 MB 2.1% 0.30
TOTAL: 23:56:35 14868 100.0% 0.1749.4 MB 100.0% 0.59
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2736 2174 0 0 0 0 0 0 562
2newsfeed.neva.ru 1044 519 0 0 2 0 0 0 523
3feeder3.feed-ams.uzoreto.com 965 573 0 0 3 0 0 0 389
4ripco-out.feeder.erje.net 545 538 0 0 0 0 0 0 7
5news.snarked.org 248 156 0 0 2 0 0 0 90
6newsfeed.fu-berlin.de 211 0 0 0 0 0 0 0 211
7news.lightlink.com 112 0 0 0 0 0 0 0 112
8ripco-out.news.tnetconsulting.net 34 15 0 0 0 0 0 0 19
9news-in.rahul.net 31 0 0 0 0 0 0 0 31
TOTAL: 9 5926 3975 0 0 7 0 0 0 1944

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2945
alt.binaries.ftd 228
scot.general 87
aioe.news.assistenza 66
uk.net.news.moderation 49
free.it.scienza.fisica 39
alt.binaries.e-book 33
perl.cpan.uploads 32
alt.binaries.nospam.female.bodyhair.pubes 32
alt.binaries.sounds.lossless.jazz 30
fido7.su.pol.news 26
it.comp.os.win.windows10 23
alt.binaries.3d.poser 18
alt.binaries.backup 15
alt.binaries.pictures.wallpaper 15
free.willey 14
alt.binaries.pictures.purebeauty 14
mozilla.dev.security.policy 10
alt.binaries.pictures.rail 10
alt.binaries.nospam.breasts.natural 9
TOTAL: 135 3975

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

GroupsCount
fr.comp.securite 3
christnet.bible 2
fr.comp.lang.php 1
alt.christnet.religion 1
TOTAL: 4 7

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1956
Too many newsgroups 798
EMP (phl) 248
Binary in non-binary group 222
Scoring filter (8) 28
Scoring filter (9) 10
Scoring filter (10) 6
HTML post 4
Poison newsgroup 2
TOTAL: 9 3274

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 206
newsfeed.neva.ru 51
ripco-out.feed.uzoreto.com 40
feeder3.feed-ams.uzoreto.com 5
TOTAL: 4 302
No colon-space in header
feeder3.feed-ams.uzoreto.com 3
ripco-out.feed.uzoreto.com 2
TOTAL: 2 5
TOTAL: 3 325

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9710 1092 5668 4 0 0 11%47:40:02
2rahul.net 22430 688 12634 38 0 0 3%47:48:42
3news.cmpublishers.com 43214 236 27836 1190 0 122 0%47:34:42
4fu-berlin.de 26508 68 26440 0 0 0 0%47:42:18
5news.tnetconsulting.net 42684 32 28722 4 0 136 0%47:40:02
6news.uzoreto.com 14028 26 13516 124 0 0 0%47:38:42
7news.snarked.org 37350 10 22038 4 0 230 0%47:40:02
8newsfeed.neva.ru 25098 10 24546 8 0 0 0%47:40:02
9feeder.erje.net 28820 8 27888 22 0 0 0%47:39:26
10remote6hme0.ripco.com 0 0 0 0 0 8 0%47:40:02
TOTAL: 10 249842 2170 189288 1394 0 496 0%476:44:00
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com4.1 MB25.3 KB4.1 MB0.0 KB/s3.9 KB47:40:02
2rahul.net3.6 MB98.3 KB3.7 MB0.0 KB/s5.2 KB47:48:42
3fu-berlin.de678.5 KB0.0 KB678.5 KB0.0 KB/s10.0 KB47:42:18
4news.cmpublishers.com630.4 KB3.3 MB3.9 MB0.0 KB/s2.8 KB47:34:42
5news.tnetconsulting.net99.8 KB7.5 KB107.3 KB0.0 KB/s3.0 KB47:40:02
6news.uzoreto.com92.2 KB526.9 KB619.1 KB0.0 KB/s4.1 KB47:38:42
7news.snarked.org45.4 KB7.5 KB52.9 KB0.0 KB/s3.8 KB47:40:02
8feeder.erje.net38.3 KB51.9 KB90.2 KB0.0 KB/s3.0 KB47:39:26
9newsfeed.neva.ru29.7 KB35.3 KB65.0 KB0.0 KB/s3.6 KB47:40:02
10remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:02
TOTAL: 109.3 MB4.0 MB13.3 MB0.0 KB/s3.8 KB476:44:00
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9082.5 MB 452 2 000:07:33
2shell3 10 4601.2 MB 44 0 002:48:33
TOTAL: 2 296 13683.7 MB 496 2 002:56:07

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9082.5 MB 452 2 000:07:33
2? 10 4601.2 MB 44 0 002:48:34
TOTAL: 2 296 13683.7 MB 496 2 002:56:07

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
shell3 3.412 6.554 0.00002:48:33
ftupet.com 47.694 21.696 0.00000:07:33
? 0.448 0.114 0.00000:00:00
TOTAL: 3 51.554 28.364 0.00002:56:07

NNRP client timeouts [Top 20]:

SystemConnPeer
shell3 4 0
TOTAL: 1 4 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1186 86.7%
2comp 64 4.7%
3alt 44 3.2%
4misc 28 2.0%
5chi 22 1.6%
6news 10 0.7%
7sci 8 0.6%
8rocksolid 4 0.3%
9ba 2 0.1%
TOTAL: 9 1368100.0%

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

NewsgroupCount
1rec.arts.tv 700
2rec.food.cooking 278
3rec.bicycles.tech 116
4rec.outdoors.rv-travel 50
5misc.phone.mobile.iphone 28
6alt.games.warcraft 22
7comp.mobile.android 20
8comp.protocols.dns.bind 20
9rec.puzzles 20
10rec.gardens.edible 18
11comp.sys.mac.system 18
12chi.general 16
13alt.security.alarms 14
14sci.electronics.repair 8
15comp.unix.bsd.freebsd.misc 6
16chi.weather 6
17news.groups.questions 6
18rocksolid.nodes 4
19rec.radio.broadcasting 2
20news.admin.net-abuse.misc 2
21rec.radio.swap 2
22alt.vacation.las-vegas 2
23alt.sports.football.pro.kc-chiefs 2
24ba.general 2
25news.groups 2
26alt.satellite.gps.garmin 2
27alt.internet.wireless 2
TOTAL: 27 1368