Daily Usenet report for news.ripco.com

Sep 30 00:01:03 -- Sep 30 23:58:02

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Sep 30 00:28:39 remote5bge0 overchan[14988]: [ID 702911 news.error] input line too long, skipping
Sep 30 07:13:42 remote5bge0 overchan[14988]: [ID 702911 news.error] input line too long, skipping
Sep 30 07:23:47 remote5bge0 overchan[14988]: [ID 702911 news.error] input line too long, skipping
Sep 30 11:13:45 remote5bge0 overchan[14988]: [ID 702911 news.error] input line too long, skipping
Sep 30 11:16:22 remote5bge0 overchan[14988]: [ID 702911 news.error] input line too long, skipping
Sep 30 11:17:59 remote5bge0 overchan[14988]: [ID 702911 news.error] input line too long, skipping
Sep 30 11:39:32 remote5bge0 overchan[14988]: [ID 702911 news.error] input line too long, skipping
Sep 30 11:59:00 remote5bge0 overchan[14988]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 33242 43.8%4.1 MB 36.6%
inn 21435 28.2%3.7 MB 32.7%
innd 17601 23.2%2.7 MB 24.0%
innfeed 3627 4.8%766.0 KB 6.6%
controlchan 10 0.0%1.8 KB 0.0%
overchan 8 0.0%1.1 KB 0.0%
TOTAL: 6 75923 100.0%11.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 177406 50.2%
Cache misses 176222 49.8%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 353628 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%214 0.000 0.000 0.000
article cleanup00:00:00.484 0.0%42404 0.000 0.011 0.043
article logging00:00:00.632 0.0%42792 0.000 0.015 0.158
article parse00:00:01.642 0.0%100498 0.000 0.016 0.034
article write00:00:46.422 0.0%30664 0.525 1.514 68.931
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.254 0.0%356248 0.000 0.001 0.004
hishave/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.436 0.0%354730 0.000 0.013 0.632
history sync00:00:00.254 0.0%758 0.000 0.335 4.333
history write00:00:06.170 0.0%42386 0.000 0.146 5.033
hiswrite/artparse00:00:00.002 0.0%4 0.000 0.500 1.000
idle47:39:22.574 99.9%392448 200.137 437.160 1416.870
nntp read00:00:02.260 0.0%390626 0.001 0.006 0.017
overview write00:00:00.170 0.0%30664 0.000 0.006 0.029
perl filter00:00:55.534 0.0%42386 1.023 1.310 3.033
python filter00:00:01.138 0.0%42390 0.000 0.027 0.074
site send00:00:01.724 0.0%91942 0.000 0.019 0.038
TOTAL: 47:41:56.38047:41:23.696100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.132 0.0%37928 0.000 0.003 0.064
article prepare00:00:00.006 0.0%10240 0.000 0.001 0.050
article read00:00:00.424 0.0%2162 0.000 0.196 14.800
backlog stats00:00:00.194 0.0%334228 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.186 0.0%225944 0.000 0.010 0.020
data write00:00:03.120 0.0%197232 0.005 0.016 0.042
idle47:51:51.356100.0%334228 219.394 515.550 1421.767
status file00:00:05.812 0.0%350 0.000 16.606 61.714
TOTAL: 47:52:15.51247:52:03.230100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:01.632 0.0%18666 0.000 0.087 3.047
idle136:34:25.186 99.7%60210 0.000 8165.839 39544.581
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.090 0.0%766632 0.000 0.012 0.067
readart00:00:19.086 0.0%2366 0.000 8.067 36.000
TOTAL: 136:58:14.228136:34:54.994 99.7%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
usenet@film.rlss.okayama-u.ac.jp002022
TOTAL002022

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1ripco-out.feed.uzoreto.com 1150 47740 13468 29072 5200 28%94:38:26
2news.snarked.org 64 38910 8702 27314 2894 22%59:02:56
3newsfeed.neva.ru 568 50664 7076 41738 1850 13%279:47:00
4newsfeed.fu-berlin.de 2 15026 766 14200 60 5%50:42:28
5news.lightlink.com 2 9372 246 8938 188 2%44:22:30
6news-in.rahul.net 574 16782 144 16612 26 0%47:22:36
7news.cmpublishers.com 44 8912 118 8786 8 1%39:58:40
8ripco-out.feeder.erje.net 574 33290 78 31588 1624 0%47:19:10
9localhost 148 4 4 0 0 100%00:00:00
TOTAL: 9 3126 220700 30602 178248 11850 13%663:13:46
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1ripco-out.feed.uzoreto.com36.8 MB16.1 KB9.8 MB46.6 MB 78%2.6 KB
2news.snarked.org25.3 MB20.7 KB9.7 MB34.9 MB 72%3.1 KB
3newsfeed.neva.ru23.8 MB45.0 KB4.5 MB28.3 MB 83%3.2 KB
4news.lightlink.com6.2 MB18.5 KB6.2 MB12.5 MB 49%29.4 KB
5news-in.rahul.net4.9 MB0.0 KB1.5 MB6.3 MB 76%38.2 KB
6newsfeed.fu-berlin.de3.1 MB0.0 KB1.6 MB4.7 MB 66%5.8 KB
7news.cmpublishers.com258.0 KB0.0 KB13.4 KB271.4 KB 95%2.2 KB
8ripco-out.feeder.erje.net255.0 KB4.4 KB16.2 MB16.4 MB 1%9.9 KB
9localhost9.2 KB0.0 KB0.0 KB9.2 KB100%2.3 KB
TOTAL: 9100.5 MB104.6 KB49.5 MB150.1 MB 66%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 30 00:01:03 - 00:59:59 352 2.3% 0.101.4 MB 2.7% 0.41
Sep 30 01:00:00 - 01:59:59 420 2.7% 0.121.6 MB 3.2% 0.47
Sep 30 02:00:00 - 02:59:59 413 2.7% 0.111.2 MB 2.4% 0.35
Sep 30 03:00:00 - 03:59:59 540 3.5% 0.151.9 MB 3.8% 0.55
Sep 30 04:00:00 - 04:59:59 631 4.1% 0.182.1 MB 4.1% 0.61
Sep 30 05:00:00 - 05:59:59 646 4.2% 0.182.0 MB 3.8% 0.56
Sep 30 06:00:00 - 06:59:59 741 4.8% 0.213.0 MB 5.7% 0.84
Sep 30 07:00:00 - 07:59:59 633 4.1% 0.182.0 MB 3.9% 0.57
Sep 30 08:00:00 - 08:59:59 757 4.9% 0.213.0 MB 5.8% 0.85
Sep 30 09:00:00 - 09:59:59 861 5.6% 0.242.3 MB 4.4% 0.64
Sep 30 10:00:00 - 10:59:59 765 5.0% 0.212.4 MB 4.6% 0.68
Sep 30 11:00:00 - 11:59:59 801 5.2% 0.222.5 MB 4.9% 0.72
Sep 30 12:00:00 - 12:59:59 821 5.3% 0.232.3 MB 4.4% 0.65
Sep 30 13:00:00 - 13:59:59 931 6.1% 0.263.7 MB 7.1% 1.04
Sep 30 14:00:00 - 14:59:59 932 6.1% 0.262.8 MB 5.3% 0.78
Sep 30 15:00:00 - 15:59:59 888 5.8% 0.253.0 MB 5.8% 0.86
Sep 30 16:00:00 - 16:59:59 1187 7.7% 0.334.1 MB 7.9% 1.17
Sep 30 17:00:00 - 17:59:59 774 5.0% 0.212.6 MB 5.1% 0.75
Sep 30 18:00:00 - 18:59:59 493 3.2% 0.141.5 MB 2.8% 0.41
Sep 30 19:00:00 - 19:59:59 460 3.0% 0.131.3 MB 2.5% 0.37
Sep 30 20:00:00 - 20:59:59 385 2.5% 0.111.4 MB 2.8% 0.41
Sep 30 21:00:00 - 21:59:59 323 2.1% 0.09983.7 KB 1.9% 0.27
Sep 30 22:00:00 - 22:59:59 241 1.6% 0.071.0 MB 2.0% 0.29
Sep 30 23:00:00 - 23:58:02 362 2.4% 0.101.6 MB 3.1% 0.47
TOTAL: 23:56:59 15357 100.0% 0.1851.8 MB 100.0% 0.62
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2607 2083 0 1 0 0 0 0 523
2news.snarked.org 1457 63 0 2 1 0 0 0 1391
3newsfeed.neva.ru 993 662 0 5 1 0 0 0 325
4ripco-out.feeder.erje.net 814 812 0 1 0 0 0 0 1
5newsfeed.fu-berlin.de 148 0 0 0 0 0 0 0 148
6news.lightlink.com 42 3 0 0 0 0 0 0 39
7news-in.rahul.net 13 0 0 0 0 0 0 0 13
8news.cmpublishers.com 4 2 0 0 0 0 0 0 2
TOTAL: 8 6078 3625 0 9 2 0 0 0 2442

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2461
alt.binaries.ftd 529
alt.astrology.pro 58
perl.cpan.uploads 47
alt.binaries.pictures.wallpaper 33
it.tlc.cellulari.android 27
free.it.scienza.fisica 18
alt.binaries.pictures.rail 18
de.soc.arbeitslos 17
fido7.su.pol.news 17
alt.binaries.pictures.scenic 14
alt.binaries.photos.original 14
free.uk.astrology 13
alt.binaries.nl 12
free.ucp 12
alt.binaries.e-book 12
alt.binaries.drwho 10
panix.chat.politics 10
free.willey 9
alt.binaries.pictures.aviation 9
TOTAL: 165 3625

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

GroupsCount
christnet.christianlife 1
bit.listserv.catholic 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3178
Too many newsgroups 954
Binary in non-binary group 168
EMP (phl) 124
Scoring filter (8) 30
Attached HTML file 12
Scoring filter (16) 10
Scoring filter (9) 6
Scoring filter (10) 4
Scoring filter (18) 2
HTML post 2
U2 violation - invalid distribution 2
TOTAL: 12 4492

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
ripco-out.feeder.erje.net 24
TOTAL: 1 24
Huge articles
newsfeed.fu-berlin.de 4
TOTAL: 1 4
Including strange strings
newsfeed.fu-berlin.de 119
newsfeed.neva.ru 68
ripco-out.feed.uzoreto.com 7
TOTAL: 3 194
TOTAL: 3 222

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10374 1238 5882 4 0 0 11%47:34:16
2rahul.net 22518 756 13128 14 0 2 3%47:42:04
3news.snarked.org 34636 64 21636 2 0 256 0%47:40:00
4feeder.erje.net 27684 44 27260 104 0 0 0%47:40:00
5news.cmpublishers.com 35712 16 30170 160 0 7014 0%47:53:40
6fu-berlin.de 27888 16 27872 0 0 0 0%47:36:52
7news.uzoreto.com 17676 16 16826 10 0 0 0%47:40:04
8newsfeed.neva.ru 24038 12 23356 98 0 0 0%47:40:02
9remote6hme0.ripco.com 0 0 0 0 0 10 0%47:40:00
TOTAL: 9 200526 2162 166130 392 0 7282 1%429:06:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com3.8 MB7.2 KB3.8 MB0.0 KB/s3.1 KB47:34:16
2rahul.net3.1 MB33.7 KB3.2 MB0.0 KB/s4.2 KB47:42:04
3news.snarked.org427.0 KB7.4 KB434.4 KB0.0 KB/s6.6 KB47:40:00
4newsfeed.neva.ru260.2 KB212.4 KB472.6 KB0.0 KB/s4.3 KB47:40:02
5feeder.erje.net165.0 KB325.6 KB490.6 KB0.0 KB/s3.3 KB47:40:00
6fu-berlin.de118.6 KB0.0 KB118.6 KB0.0 KB/s7.4 KB47:36:52
7news.uzoreto.com53.9 KB61.0 KB114.9 KB0.0 KB/s4.4 KB47:40:04
8news.cmpublishers.com35.3 KB517.2 KB552.4 KB0.0 KB/s3.1 KB47:53:40
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s047:40:00
TOTAL: 97.9 MB1.1 MB9.1 MB0.0 KB/s3.6 KB429:06:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 286 9622.6 MB 424 2 000:06:46
2shell3 8 4341.0 MB 50 2 001:44:40
375-151-74-61-independence.hfc.comcastbusiness.net 8 46.2 KB 4 0 000:14:02
4vvs78-1-88-173-43-113.fbx.proxad.net 60 26.4 KB 2 0 075:44:19
TOTAL: 4 362 14023.6 MB 480 4 0136:58:06

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 286 9622.6 MB 424 2 000:06:46
2? 8 4341.0 MB 50 2 001:44:40
3*.hfc.comcastbusiness.net 8 46.2 KB 4 0 000:14:02
4*.fbx.proxad.net 60 26.4 KB 2 0 075:44:19
5*.7-3.cable.virginm.net 4 00.0 KB 0 0 000:05:10
6unresolved 18 00.0 KB 0 0 000:22:00
7*.cpe.metrocast.net 26 00.0 KB 0 0 058:41:07
TOTAL: 7 410 14023.6 MB 480 4 0136:58:06

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
vvs78-1-88-173-43-113.fbx.proxad.net 6.218 1.654 0.00075:44:19
d-72-9-26-236.cpe.metrocast.net 2.936 1.184 0.00058:41:07
shell3 3.282 2.102 0.00001:44:40
172.83.40.221 1.610 0.386 0.00000:21:40
75-151-74-61-independence.hfc.comcastbusiness.net 1.674 1.306 0.00000:14:02
ftupet.com 45.870 7.306 0.00000:06:46
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 0.442 0.158 0.00000:05:10
107.170.203.131 0.198 0.040 0.00000:00:19
TOTAL: 8 62.230 14.136 0.000136:58:06

Curious NNRP server explorers [Top 20]:

SystemConn
d-72-9-26-236.cpe.metrocast.net 26
172.83.40.221 16
cpc124512-swan5-2-0-cust46.7-3.cable.virginm.net 4
107.170.203.131 2
TOTAL: 4 48

NNRP unrecognized commands (by host):

SystemConn
shell3 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
XTHREAD DBINIT 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
vvs78-1-88-173-43-113.fbx.proxad.net 16 0
d-72-9-26-236.cpe.metrocast.net 2 2
TOTAL: 2 18 2

Newsgroup request counts (by category):

CategoryCountPct
1rec 1142 81.5%
2comp 126 9.0%
3misc 48 3.4%
4alt 36 2.6%
5news 18 1.3%
6chi 14 1.0%
7sci 12 0.9%
8aus 2 0.1%
9fr 2 0.1%
10corel 2 0.1%
TOTAL: 10 1402100.0%

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

NewsgroupCount
1rec.arts.tv 584
2rec.food.cooking 494
3comp.sys.mac.system 58
4rec.bicycles.tech 52
5misc.phone.mobile.iphone 46
6comp.sys.mac.apps 26
7comp.sys.apple2 20
8comp.mobile.android 20
9alt.comp.os.windows-10 12
10alt.stupidity 12
11alt.online-service.comcast 10
12chi.weather 10
13sci.electronics.repair 8
14news.admin.net-abuse.email 6
15rec.gardens.edible 6
16news.groups.questions 6
17rec.radio.swap 4
18news.software.readers 4
19sci.crypt 4
20chi.general 4
21rec.video.cable-tv 2
22misc.transport.rail.americas 2
23corel.graphic_apps.draw9 2
24news.admin.net-abuse.misc 2
25fr.rec.anime 2
26comp.protocols.dns.bind 2
27alt.satellite.gps.garmin 2
28aus.cars 2
TOTAL: 28 1402