Daily Usenet report for news.ripco.com

Nov 4 00:01:03 -- Nov 4 23:58:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Nov 4 03:52:52 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping
Nov 4 07:37:29 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping
Nov 4 08:31:16 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping
Nov 4 08:32:31 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping
Nov 4 08:39:35 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping
Nov 4 09:09:22 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping
Nov 4 09:17:18 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping
Nov 4 09:24:32 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping
Nov 4 09:33:46 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping
Nov 4 09:40:14 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping
Nov 4 09:47:54 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping
Nov 4 10:00:54 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping
Nov 4 12:40:07 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping
Nov 4 19:09:05 remote5bge0 overchan[24215]: [ID 702911 news.error] input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 34174 42.3%4.2 MB 35.1%
innd 21513 26.6%3.3 MB 27.7%
inn 21389 26.5%3.7 MB 30.7%
innfeed 3766 4.7%793.7 KB 6.5%
overchan 14 0.0%1.9 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 80858 100.0%12.0 MB100.0%

History cache:

ReasonCount%Count
Cache misses 191726 53.3%
Do not exist 168040 46.7%
Negative hits 0 0.0%
Positive hits 0 0.0%
TOTAL: 4 359766 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%180 0.000 0.000 0.000
article cleanup00:00:00.484 0.0%42490 0.000 0.011 0.056
article logging00:00:00.888 0.0%42832 0.000 0.021 0.980
article parse00:00:01.602 0.0%98560 0.000 0.016 0.046
article write00:00:42.534 0.0%30438 0.350 1.397 34.627
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.294 0.0%369664 0.000 0.001 0.004
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:02.346 0.0%360404 0.001 0.007 0.274
history sync00:00:00.296 0.0%828 0.000 0.357 2.500
history write00:00:04.602 0.0%42488 0.015 0.108 2.177
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle49:59:44.064 99.9%403244 233.276 446.340 1240.506
nntp read00:00:02.370 0.0%401252 0.002 0.006 0.015
overview write00:00:00.202 0.0%30438 0.000 0.007 0.051
perl filter00:00:55.922 0.0%42454 1.020 1.317 2.856
python filter00:00:01.020 0.0%42456 0.000 0.024 0.062
site send00:00:01.632 0.0%91212 0.000 0.018 0.049
TOTAL: 50:02:10.90650:01:38.256100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.096 0.0%30318 0.000 0.003 0.042
article prepare00:00:00.002 0.0%24544 0.000 0.000 0.007
article read00:00:00.514 0.0%4858 0.000 0.106 8.875
backlog stats00:00:00.182 0.0%362444 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%239290 0.000 0.009 0.022
data write00:00:03.396 0.0%209256 0.000 0.016 0.031
idle49:35:46.712100.0%362444 273.705 492.619 1968.108
status file00:00:06.638 0.0%364 0.000 18.236 93.071
TOTAL: 49:36:14.69249:35:59.726100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.026 0.0%1880 0.000 0.014 0.052
idle10:38:35.378 99.7%36540 18.210 1048.587200089.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:20.830 0.1%1110726 0.000 0.019 0.333
readart00:00:19.798 0.1%2244 0.000 8.823 38.500
TOTAL: 10:40:34.09010:39:16.032 99.8%----

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 48 39020 9936 25762 3322 25%52:14:00
2ripco-out.feed.uzoreto.com 1196 36842 8670 23848 4324 23%98:40:06
3newsfeed.neva.ru 596 55356 5392 48292 1672 9%289:14:04
4feeder3.feed-ams.uzoreto.com 598 17420 5112 11314 994 29%49:18:54
5newsfeed.fu-berlin.de 4 22296 1018 21228 50 4%70:07:34
6news.lightlink.com 2 8040 262 7458 320 3%45:01:30
7news-in.rahul.net 598 17974 166 17776 32 0%49:19:28
8ripco-out.feeder.erje.net 598 33594 110 32392 1092 0%49:16:46
9news.cmpublishers.com 54 9068 10 9052 6 0%51:59:38
10localhost 152 2 2 0 0 100%00:00:00
TOTAL: 10 3846 239612 30678 197122 11812 12%755:12:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.snarked.org31.1 MB0.0 KB11.1 MB42.2 MB 73%3.3 KB
2ripco-out.feed.uzoreto.com23.2 MB0.0 KB8.8 MB32.0 MB 72%2.5 KB
3newsfeed.neva.ru16.9 MB9.4 KB5.4 MB22.3 MB 75%3.2 KB
4feeder3.feed-ams.uzoreto.com12.3 MB0.0 KB1.8 MB14.1 MB 87%2.4 KB
5news-in.rahul.net6.6 MB0.0 KB1.5 MB8.1 MB 81%41.7 KB
6newsfeed.fu-berlin.de4.3 MB0.0 KB353.7 KB4.7 MB 92%4.5 KB
7news.lightlink.com3.1 MB0.0 KB10.9 MB14.0 MB 22%24.6 KB
8ripco-out.feeder.erje.net245.4 KB0.0 KB6.7 MB6.9 MB 3%5.9 KB
9news.cmpublishers.com26.5 KB0.0 KB20.1 KB46.7 KB 56%2.9 KB
10localhost4.1 KB0.0 KB0.0 KB4.1 KB100%2.0 KB
TOTAL: 1097.8 MB9.4 KB46.5 MB144.3 MB 67%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 4 00:01:03 - 00:59:59 219 1.4% 0.06846.2 KB 1.7% 0.24
Nov 4 01:00:00 - 01:59:59 611 4.0% 0.172.2 MB 4.5% 0.62
Nov 4 02:00:00 - 02:59:59 455 3.0% 0.131.5 MB 3.1% 0.42
Nov 4 03:00:00 - 03:59:59 522 3.4% 0.141.6 MB 3.4% 0.47
Nov 4 04:00:00 - 04:59:59 632 4.2% 0.181.9 MB 3.9% 0.53
Nov 4 05:00:00 - 05:59:59 621 4.1% 0.171.6 MB 3.4% 0.47
Nov 4 06:00:00 - 06:59:59 610 4.0% 0.171.9 MB 3.9% 0.54
Nov 4 07:00:00 - 07:59:59 809 5.3% 0.222.1 MB 4.4% 0.61
Nov 4 08:00:00 - 08:59:59 750 4.9% 0.212.5 MB 5.2% 0.71
Nov 4 09:00:00 - 09:59:59 790 5.2% 0.222.0 MB 4.1% 0.57
Nov 4 10:00:00 - 10:59:59 904 5.9% 0.252.7 MB 5.6% 0.78
Nov 4 11:00:00 - 11:59:59 943 6.2% 0.263.5 MB 7.2% 0.99
Nov 4 12:00:00 - 12:59:59 907 6.0% 0.252.7 MB 5.6% 0.77
Nov 4 13:00:00 - 13:59:59 869 5.7% 0.242.5 MB 5.2% 0.72
Nov 4 14:00:00 - 14:59:59 845 5.6% 0.232.7 MB 5.6% 0.77
Nov 4 15:00:00 - 15:59:59 858 5.6% 0.242.9 MB 5.9% 0.82
Nov 4 16:00:00 - 16:59:59 639 4.2% 0.182.2 MB 4.5% 0.62
Nov 4 17:00:00 - 17:59:59 545 3.6% 0.151.9 MB 3.9% 0.53
Nov 4 18:00:00 - 18:59:59 543 3.6% 0.152.3 MB 4.7% 0.65
Nov 4 19:00:00 - 19:59:59 522 3.4% 0.141.3 MB 2.6% 0.36
Nov 4 20:00:00 - 20:59:59 438 2.9% 0.121.7 MB 3.5% 0.48
Nov 4 21:00:00 - 21:59:59 413 2.7% 0.111.3 MB 2.7% 0.37
Nov 4 22:00:00 - 22:59:59 345 2.3% 0.101.1 MB 2.2% 0.30
Nov 4 23:00:00 - 23:58:02 406 2.7% 0.121.6 MB 3.3% 0.47
TOTAL: 23:56:59 15196 100.0% 0.1848.5 MB 100.0% 0.58
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1ripco-out.feed.uzoreto.com 2173 1705 0 0 0 0 0 0 468
2news.snarked.org 1711 73 0 0 1 0 0 0 1637
3newsfeed.neva.ru 892 510 0 2 1 0 0 0 379
4ripco-out.feeder.erje.net 548 545 0 0 0 0 0 0 3
5feeder3.feed-ams.uzoreto.com 505 366 0 0 1 0 0 0 138
6news.lightlink.com 223 7 0 0 0 0 0 0 216
7newsfeed.fu-berlin.de 123 0 0 0 0 0 0 0 123
8news-in.rahul.net 16 0 0 0 0 0 0 0 16
9news.cmpublishers.com 2 0 0 0 0 0 0 0 2
TOTAL: 9 6193 3206 0 2 3 0 0 0 2982

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 2222
alt.binaries.ftd 172
alt.astrology.pro 63
alt.binaries.e-book 52
perl.cpan.uploads 44
free.ucp 40
alt.binaries.pictures.wallpaper 36
it.comp.os.win.windows10 32
free.it.scienza.fisica 30
it.tlc.cellulari.android 26
free.uk.astrology 25
alt.binaries.drwho 24
alt.clearing.o5 24
alt.binaries.pictures.rail 23
alt.binaries.nl 18
fido7.su.pol.news 18
de.soc.arbeitslos 14
alt.binaries.pictures.scenic 14
alt.binaries.pictures.aviation 13
alt.binaries.nospam.female.bodyhair.pubes 13
TOTAL: 161 3206

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

GroupsCount
bit.listserv.catholic 2
alt.christnet.christnews 1
TOTAL: 2 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3924
Too many newsgroups 1102
Binary in non-binary group 274
EMP (phl) 76
Attached HTML file 66
Scoring filter (16) 62
Scoring filter (8) 32
Scoring filter (9) 18
Scoring filter (10) 8
Scoring filter (18) 6
Scoring filter (11) 6
Scoring filter (17) 6
HTML post 6
Scoring filter (12) 2
TOTAL: 14 5588

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
ripco-out.feed.uzoreto.com 13
feeder3.feed-ams.uzoreto.com 2
ripco-out.feeder.erje.net 1
TOTAL: 3 16
Bad Message-ID's offered
ripco-out.feeder.erje.net 12
TOTAL: 1 12
Including strange strings
newsfeed.fu-berlin.de 101
newsfeed.neva.ru 52
ripco-out.feed.uzoreto.com 9
feeder3.feed-ams.uzoreto.com 8
ripco-out.feeder.erje.net 1
TOTAL: 5 171
TOTAL: 3 199

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.lightlink.com 10282 2354 5348 12 0 0 22%49:48:52
2rahul.net 24104 1350 13344 36 0 4 5%49:33:38
3fu-berlin.de 27242 140 27102 0 0 0 0%49:40:06
4news.cmpublishers.com 35994 114 25460 1134 0 3292 0%49:39:56
5news.uzoreto.com 16698 102 15470 624 0 0 0%49:40:04
6news.snarked.org 34224 36 20216 0 0 48 0%49:46:32
7feeder.erje.net 30014 28 28346 54 0 0 0%49:40:06
8newsfeed.neva.ru 25622 26 24638 130 0 70 0%49:45:20
9remote6hme0.ripco.com 0 0 0 0 0 6 0%49:40:06
TOTAL: 9 204180 4150 159924 1990 0 3420 2%447:14:40
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.lightlink.com7.3 MB30.8 KB7.4 MB0.0 KB/s3.2 KB49:48:52
2rahul.net3.6 MB109.2 KB3.7 MB0.0 KB/s2.7 KB49:33:38
3news.cmpublishers.com368.3 KB3.1 MB3.5 MB0.0 KB/s2.9 KB49:39:56
4fu-berlin.de346.1 KB0.0 KB346.1 KB0.0 KB/s2.5 KB49:40:06
5news.uzoreto.com269.2 KB1.6 MB1.8 MB0.0 KB/s2.6 KB49:40:04
6feeder.erje.net112.7 KB209.9 KB322.6 KB0.0 KB/s3.9 KB49:40:06
7news.snarked.org110.1 KB0.0 KB110.1 KB0.0 KB/s3.1 KB49:46:32
8newsfeed.neva.ru83.2 KB386.0 KB469.2 KB0.0 KB/s3.0 KB49:45:20
9remote6hme0.ripco.com0.0 KB0.0 KB0.0 KB0.0 KB/s049:40:06
TOTAL: 912.2 MB5.4 MB17.6 MB0.0 KB/s2.9 KB447:14:40
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ftupet.com 298 10082.8 MB 428 2 000:06:56
2shell3 10 216622.6 KB 30 0 001:43:37
3p5492d5bb.dip0.t-ipconnect.de 8 684.9 KB 2 0 001:07:28
475-151-74-61-independence.hfc.comcastbusiness.net 8 43.8 KB 4 0 000:13:24
TOTAL: 4 324 12343.5 MB 464 2 010:40:27

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.com 298 10082.8 MB 428 2 000:06:56
2? 10 216622.6 KB 30 0 001:43:37
3*.dip0.t-ipconnect.de 8 684.9 KB 2 0 001:07:28
4*.hfc.comcastbusiness.net 8 43.8 KB 4 0 000:13:24
5*.adsl-ull.clienti.tiscali.it 4 00.0 KB 0 0 000:04:47
6unresolved 54 00.0 KB 0 0 007:24:12
TOTAL: 6 382 12343.5 MB 464 2 010:40:27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
155.94.244.66 3.270 0.794 0.00007:23:42
shell3 3.562 1.978 0.00001:43:37
p5492d5bb.dip0.t-ipconnect.de 1.178 0.278 0.00001:07:28
75-151-74-61-independence.hfc.comcastbusiness.net 1.542 1.302 0.00000:13:24
ftupet.com 48.090 7.874 0.00000:06:56
94-36-184-140.adsl-ull.clienti.tiscali.it 0.596 0.290 0.00000:04:47
109.236.87.136 1.132 0.214 0.00000:00:14
89.238.177.252 0.802 0.172 0.00000:00:09
134.19.181.150 0.334 0.056 0.00000:00:03
95.174.67.132 0.338 0.048 0.00000:00:02
TOTAL: 10 60.844 13.006 0.00010:40:27

Curious NNRP server explorers [Top 20]:

SystemConn
155.94.244.66 32
109.236.87.136 10
89.238.177.252 8
94-36-184-140.adsl-ull.clienti.tiscali.it 4
95.174.67.132 2
134.19.181.150 2
TOTAL: 6 58

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
155.94.244.66 32 0
p5492d5bb.dip0.t-ipconnect.de 6 0
shell3 4 0
TOTAL: 3 42 0

Newsgroup request counts (by category):

CategoryCountPct
1rec 1120 90.8%
2comp 52 4.2%
3alt 18 1.5%
4news 14 1.1%
5sci 12 1.0%
6chi 6 0.5%
7z-netz 6 0.5%
8hsv 2 0.2%
9ba 2 0.2%
10de 2 0.2%
TOTAL: 10 1234100.0%

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

NewsgroupCount
1rec.arts.tv 630
2rec.food.cooking 450
3comp.sys.mac.system 30
4rec.bicycles.tech 28
5alt.games.warcraft 18
6comp.dcom.telecom 12
7sci.electronics.repair 12
8comp.unix.bsd.freebsd.misc 8
9z-netz.alt.liebesleben.geschichten 6
10news.software.readers 6
11news.admin.net-abuse.email 6
12chi.weather 6
13rec.radio.broadcasting 4
14rec.radio.swap 4
15rec.puzzles 4
16hsv.forsale 2
17news.admin.net-abuse.misc 2
18de.comp.lang.forth 2
19comp.protocols.dns.bind 2
20ba.food 2
TOTAL: 20 1234