Daily Usenet report for news.ripco.com

Oct 26 00:01:03 -- Oct 26 23:58:02

Unknown entries from news log file:

First 17 / 17 lines (100.0%)

Oct 26 00:07:32 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 00:16:11 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 01:47:54 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 05:42:32 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 06:24:15 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 06:30:21 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 08:43:56 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 10:14:21 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 10:15:06 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 10:33:33 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 10:41:00 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 12:00:31 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 12:06:19 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 12:15:43 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 13:24:03 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 13:50:41 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping
Oct 26 15:49:55 remote5bge0 overchan[26525]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 33136 42.4%4.1 MB 35.1%
inn 21121 27.0%3.7 MB 31.6%
innd 20266 25.9%3.1 MB 26.9%
innfeed 3614 4.6%764.6 KB 6.4%
overchan 17 0.0%2.5 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 78156 100.0%11.7 MB100.0%

History cache:

ReasonCount%Count
Cache misses 195218 54.8%
Do not exist 161256 45.2%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 356474 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%618 0.000 0.000 0.000
article cleanup00:00:00.404 0.0%41866 0.000 0.010 0.069
article logging00:00:00.732 0.0%42306 0.000 0.017 0.271
article parse00:00:01.444 0.0%96704 0.000 0.015 0.048
article write00:00:43.002 0.0%31676 0.333 1.358 41.096
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.238 0.0%362464 0.000 0.001 0.003
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.604 0.0%357176 0.001 0.007 0.267
history sync00:00:00.352 0.0%786 0.000 0.448 10.500
history write00:00:04.260 0.0%41862 0.015 0.102 2.986
hiswrite/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
idle47:59:46.002 99.9%397756 247.223 434.402 1089.964
nntp read00:00:02.306 0.0%394710 0.000 0.006 0.012
overview write00:00:00.200 0.0%31676 0.000 0.006 0.043
perl filter00:00:54.186 0.0%41856 0.946 1.295 2.418
python filter00:00:01.044 0.0%41868 0.000 0.025 0.067
site send00:00:02.184 0.0%94964 0.005 0.023 0.046
TOTAL: 48:02:11.18848:01:38.958100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.132 0.0%31992 0.000 0.004 0.032
article prepare00:00:00.008 0.0%22952 0.000 0.000 0.014
article read00:00:00.474 0.0%4802 0.000 0.099 7.400
backlog stats00:00:00.220 0.0%370396 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.898 0.0%247308 0.000 0.008 0.021
data write00:00:03.896 0.0%216388 0.009 0.018 0.037
idle47:34:00.108100.0%370396 229.085 462.316 1360.676
status file00:00:04.190 0.0%344 0.000 12.180 59.000
TOTAL: 47:34:22.21247:34:10.926100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.270 0.0%11954 0.000 0.023 0.155
idle88:54:39.064100.0%45758 17.132 6995.041274952.768
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.498 0.0%807406 0.000 0.012 0.037
readart00:00:19.614 0.0%2376 0.000 8.255 48.500
TOTAL: 88:56:23.82888:55:08.446100.0%----

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
1news.snarked.org 44 38548 10176 25090 3282 26%49:29:48
2ripco-out.feed.uzoreto.com 1148 32314 9474 21274 1566 29%94:47:40
3newsfeed.neva.ru 576 60238 5704 53028 1506 9%280:11:42
4feeder3.feed-ams.uzoreto.com 574 21230 5062 13554 2614 23%47:18:40
5newsfeed.fu-berlin.de 4 16780 756 15994 30 4%51:00:38
6news-in.rahul.net 574 17784 214 17524 46 1%47:20:30
7news.lightlink.com 2 8596 124 8290 182 1%45:01:30
8ripco-out.feeder.erje.net 574 33952 80 32950 922 0%47:16:54
9news.cmpublishers.com 50 8986 28 8954 4 0%48:00:02
10localhost 156 12 12 0 0 100%00:00:00
TOTAL: 10 3702 238440 31630 196658 10152 13%710:27:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org28.6 MB0.0 KB10.9 MB39.5 MB 72%3.0 KB
2ripco-out.feed.uzoreto.com22.2 MB0.0 KB4.1 MB26.3 MB 84%2.4 KB
3newsfeed.neva.ru15.7 MB9.4 KB5.7 MB21.4 MB 73%3.0 KB
4feeder3.feed-ams.uzoreto.com12.7 MB0.0 KB5.0 MB17.7 MB 71%2.4 KB
5news-in.rahul.net10.5 MB0.0 KB3.3 MB13.8 MB 76%54.4 KB
6newsfeed.fu-berlin.de2.8 MB0.0 KB872.6 KB3.6 MB 76%4.7 KB
7news.lightlink.com2.1 MB0.0 KB7.4 MB9.4 MB 21%31.5 KB
8ripco-out.feeder.erje.net164.6 KB0.0 KB6.4 MB6.6 MB 2%6.7 KB
9news.cmpublishers.com73.5 KB0.0 KB9.0 KB82.5 KB 89%2.6 KB
10localhost26.5 KB0.0 KB0.0 KB26.5 KB100%2.2 KB
TOTAL: 1094.9 MB9.4 KB43.5 MB138.4 MB 68%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 26 00:01:03 - 00:59:59 364 2.3% 0.101.1 MB 2.3% 0.32
Oct 26 01:00:00 - 01:59:59 490 3.1% 0.141.8 MB 3.7% 0.50
Oct 26 02:00:00 - 02:59:59 535 3.4% 0.151.2 MB 2.6% 0.36
Oct 26 03:00:00 - 03:59:59 819 5.2% 0.232.2 MB 4.6% 0.63
Oct 26 04:00:00 - 04:59:59 784 5.0% 0.222.0 MB 4.1% 0.56
Oct 26 05:00:00 - 05:59:59 792 5.0% 0.222.5 MB 5.1% 0.70
Oct 26 06:00:00 - 06:59:59 667 4.2% 0.192.1 MB 4.5% 0.61
Oct 26 07:00:00 - 07:59:59 718 4.5% 0.201.7 MB 3.6% 0.49
Oct 26 08:00:00 - 08:59:59 833 5.3% 0.232.6 MB 5.4% 0.73
Oct 26 09:00:00 - 09:59:59 913 5.8% 0.252.2 MB 4.7% 0.64
Oct 26 10:00:00 - 10:59:59 868 5.5% 0.242.9 MB 6.1% 0.84
Oct 26 11:00:00 - 11:59:59 848 5.4% 0.242.3 MB 4.9% 0.67
Oct 26 12:00:00 - 12:59:59 939 5.9% 0.262.5 MB 5.3% 0.72
Oct 26 13:00:00 - 13:59:59 961 6.1% 0.273.1 MB 6.5% 0.89
Oct 26 14:00:00 - 14:59:59 884 5.6% 0.252.7 MB 5.5% 0.76
Oct 26 15:00:00 - 15:59:59 884 5.6% 0.252.9 MB 6.0% 0.82
Oct 26 16:00:00 - 16:59:59 855 5.4% 0.242.4 MB 4.9% 0.68
Oct 26 17:00:00 - 17:59:59 510 3.2% 0.141.6 MB 3.3% 0.45
Oct 26 18:00:00 - 18:59:59 454 2.9% 0.132.0 MB 4.2% 0.58
Oct 26 19:00:00 - 19:59:59 380 2.4% 0.111.1 MB 2.3% 0.31
Oct 26 20:00:00 - 20:59:59 351 2.2% 0.101.1 MB 2.3% 0.31
Oct 26 21:00:00 - 21:59:59 330 2.1% 0.091021.1 KB 2.1% 0.28
Oct 26 22:00:00 - 22:59:59 304 1.9% 0.081.5 MB 3.2% 0.43
Oct 26 23:00:00 - 23:58:02 329 2.1% 0.091.4 MB 2.8% 0.40
TOTAL: 23:56:59 15812 100.0% 0.1848.0 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.snarked.org 1680 62 0 0 2 0 0 0 1616
2feeder3.feed-ams.uzoreto.com 1311 1076 0 0 2 0 0 0 233
3newsfeed.neva.ru 792 474 0 2 0 0 0 0 316
4ripco-out.feed.uzoreto.com 789 534 0 0 2 0 0 0 253
5ripco-out.feeder.erje.net 465 462 0 0 0 0 0 0 3
6newsfeed.fu-berlin.de 135 0 0 0 0 0 0 0 135
7news.lightlink.com 111 5 0 0 0 0 0 0 106
8news-in.rahul.net 23 0 0 0 0 0 0 0 23
9news.cmpublishers.com 3 0 0 0 0 0 0 0 3
TOTAL: 9 5309 2613 0 2 6 0 0 0 2688

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1689
alt.binaries.ftd 151
alt.astrology.pro 75
perl.cpan.uploads 51
fido7.su.pol.news 38
it.comp.os.win.windows10 32
gmane.comp.gis.openstreetmap.tagging 26
alt.binaries.pictures.erotica.vintage 26
free.willey 20
alt.music.pink-floyd.publius 20
alt.binaries.nl 18
it.tlc.cellulari.android 16
alt.binaries.sounds.karaoke 16
alt.binaries.humor.skewed 14
alt.binaries.pictures.scenic 14
alt.binaries.e-book 14
de.soc.arbeitslos 13
alt.binaries.mac.games 12
alt.clearing.o5 12
free.ucp 12
TOTAL: 152 2613

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

GroupsCount
fr.comp.securite 3
alt.penthouse.sex.masterbation 1
rec.travel.resorts.all-inclusive 1
bit.listserv.catholic 1
TOTAL: 4 6

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2850
Too many newsgroups 1216
EMP (phl) 336
Binary in non-binary group 286
Attached HTML file 116
Scoring filter (16) 54
Scoring filter (8) 28
Scoring filter (18) 16
Scoring filter (9) 12
Scoring filter (17) 6
HTML post 6
Scoring filter (10) 2
TOTAL: 12 4928

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
ripco-out.feed.uzoreto.com 2
TOTAL: 1 2
Bad Message-ID's offered
ripco-out.feeder.erje.net 20
ripco-out.feed.uzoreto.com 4
TOTAL: 2 24
Huge articles
newsfeed.fu-berlin.de 2
TOTAL: 1 2
Including strange strings
newsfeed.fu-berlin.de 123
news.snarked.org 56
newsfeed.neva.ru 35
ripco-out.feed.uzoreto.com 4
feeder3.feed-ams.uzoreto.com 2
TOTAL: 5 220
TOTAL: 4 248

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 9774 2794 4768 24 0 52 28%47:40:02
2rahul.net 24290 1048 13476 20 0 52 4%47:40:02
3feeder.erje.net 28822 114 27848 174 0 2 0%47:36:42
4news.cmpublishers.com 40884 98 30030 1070 0 166 0%47:53:14
5news.snarked.org 36030 62 21166 2 0 264 0%47:40:02
6newsfeed.neva.ru 26484 38 25560 118 0 0 0%47:42:26
7fu-berlin.de 28566 38 28528 0 0 0 0%47:34:32
8news.uzoreto.com 17526 36 16448 112 0 0 0%47:37:22
9remote6hme0.ripco.com 0 0 0 0 0 14 0%47:40:00
TOTAL: 9 212376 4228 167824 1520 0 550 1%429:04:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com7.7 MB55.3 KB7.7 MB0.0 KB/s2.8 KB47:40:02
2rahul.net3.3 MB46.2 KB3.4 MB0.0 KB/s3.3 KB47:40:02
3feeder.erje.net426.8 KB568.7 KB995.5 KB0.0 KB/s3.5 KB47:36:42
4fu-berlin.de291.4 KB0.0 KB291.4 KB0.0 KB/s7.7 KB47:34:32
5news.cmpublishers.com265.7 KB2.7 MB3.0 MB0.0 KB/s2.6 KB47:53:14
6news.snarked.org187.0 KB8.4 KB195.4 KB0.0 KB/s3.1 KB47:40:02
7newsfeed.neva.ru133.8 KB267.9 KB401.7 KB0.0 KB/s2.6 KB47:42:26
8news.uzoreto.com122.2 KB340.6 KB462.8 KB0.0 KB/s3.1 KB47:37:22
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 912.4 MB4.0 MB16.4 MB0.0 KB/s2.9 KB429:04:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9962.4 MB 416 8 000:06:54
2shell3 16 372952.2 KB 42 4 001:43:08
375-151-74-61-independence.hfc.comcastbusiness.net 8 43.7 KB 4 0 000:13:38
TOTAL: 3 310 13723.3 MB 462 12 088:56:17

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9962.4 MB 416 8 000:06:54
2? 16 372952.2 KB 42 4 001:43:08
3*.hfc.comcastbusiness.net 8 43.7 KB 4 0 000:13:38
4unresolved 52 00.0 KB 0 0 086:52:35
TOTAL: 4 362 13723.3 MB 462 12 088:56:17

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.11.163.217 0.442 0.184 0.00071:10:48
212.117.188.68 5.138 1.540 0.00015:41:46
shell3 4.268 2.130 0.00001:43:08
75-151-74-61-independence.hfc.comcastbusiness.net 1.686 1.304 0.00000:13:38
ftupet.com 46.706 7.300 0.00000:06:54
? 0.238 0.058 0.00000:00:00
TOTAL: 6 58.478 12.516 0.00088:56:17

Curious NNRP server explorers [Top 20]:

SystemConn
212.117.188.68 48
66.11.163.217 4
TOTAL: 2 52

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
212.117.188.68 48 0
66.11.163.217 4 0
TOTAL: 2 52 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1154 84.1%
2comp 122 8.9%
3alt 38 2.8%
4misc 30 2.2%
5news 12 0.9%
6chi 8 0.6%
7ba 6 0.4%
8fido7 2 0.1%
TOTAL: 8 1372100.0%

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

NewsgroupCount
1rec.arts.tv 714
2rec.food.cooking 406
3comp.dcom.telecom 42
4alt.stupidity 30
5comp.mobile.ipad 26
6rec.bicycles.tech 20
7comp.mobile.android 18
8misc.consumers.frugal-living 16
9misc.phone.mobile.iphone 14
10comp.sys.mac.apps 12
11comp.sys.mac.system 12
12news.admin.net-abuse.email 8
13rec.radio.broadcasting 6
14comp.protocols.dns.bind 6
15ba.food 6
16rec.radio.swap 4
17chi.weather 4
18comp.sys.ibm.pc.games.rpg 4
19chi.eats 4
20rec.gardens.edible 4
21alt.tv.x-files.creative 2
22alt.dbs.echostar 2
23fido7.ru.game.mmorpg 2
24alt.config 2
25comp.mail.misc 2
26alt.dss.hack 2
27news.software.readers 2
28news.groups 2
TOTAL: 28 1372