Daily Usenet report

Sep 21 03:30:00 -- Sep 22 03:30:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 11498 43.5%1.6 MB 45.6%
innd 6891 26.1%1022.8 KB 29.0%
nnrpd 4048 15.3%390.7 KB 11.1%
innfeed 3713 14.1%487.8 KB 13.8%
batcher 168 0.6%12.7 KB 0.4%
send-uucp 96 0.4%8.3 KB 0.2%
overchan 3 0.0%0.3 KB 0.0%
TOTAL: 7 26417 100.0%3.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 13477 36.6%
Negative hits 12024 32.6%
Do not exist 11354 30.8%
Cache misses 17 0.0%
TOTAL: 4 36872 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.391 0.0%68 0.000 5.750 28.800
article cleanup00:00:00.077 0.0%11385 0.000 0.007 0.125
article logging00:00:00.136 0.0%11455 0.000 0.012 0.080
article parse00:00:00.331 0.0%45224 0.000 0.007 0.180
article write00:00:05.672 0.0%6554 0.000 0.865 34.300
artlog/artcncl00:00:00.002 0.0%65 0.000 0.031 1.000
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.081 0.0%53889 0.000 0.002 0.045
hisgrep/artcncl00:00:00.002 0.0%67 0.000 0.030 0.500
hishave/artcncl00:00:00.000 0.0%68 0.000 0.000 0.000
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:00.325 0.0%36897 0.000 0.009 0.524
history sync00:00:00.147 0.0%548 0.000 0.268 20.000
history write00:00:11.033 0.0%11387 0.000 0.969 188.111
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:01:33.011 99.9%73549 337.849 1175.992 4490.746
nntp read00:00:00.328 0.0%71202 0.000 0.005 0.022
overview write00:00:00.023 0.0%6554 0.000 0.004 0.077
perl filter00:00:09.366 0.0%11382 0.450 0.823 2.000
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.112 0.0%13726 0.000 0.008 0.077
TOTAL: 24:02:18.05824:02:01.037100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.014 0.0%6548 0.000 0.002 0.111
article prepare00:00:00.029 0.0%29792 0.000 0.001 0.025
article read00:00:00.219 0.0%4603 0.000 0.048 0.375
backlog stats00:00:00.115 0.0%78724 0.000 0.001 0.015
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.250 0.0%44169 0.000 0.006 0.048
data write00:00:00.400 0.0%37848 0.000 0.011 0.057
idle24:00:10.721100.0%78724 469.766 1097.641 4550.955
newart/cb00:00:00.000 0.0%0 0.000 0.000 0.000
prepart/cb00:00:00.000 0.0%0 0.000 0.000 0.000
readart/cb00:00:00.000 0.0%0 0.000 0.000 0.000
status file00:00:00.447 0.0%1003 0.000 0.446 1.333
TOTAL: 24:00:31.52424:00:12.195100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle73:50:34.404100.0%3921 29.000 67797.604200494.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.063 0.0%9250 0.000 0.007 0.167
readart00:00:00.294 0.0%782 0.000 0.376 38.000
TOTAL: 73:52:08.90373:50:34.761100.0%----

Control commands to INND:

CommandNumber
flush 96
flushlogs 2
go 2
logmode 2
mode 5
name 2
pause 2
paused 2
renumber 1
reserve 2
TOTAL: 10 116

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feeder1-2.proxad.net 288 9558 3100 2177 4281 32%23:51:00
2mendel.ac-versailles.fr 39 5348 1685 3626 37 31%46:07:16
3feed-out.gegeweb.org 3 2973 1302 1599 72 43%23:58:38
4news.fdn.fr 2 4264 427 3407 430 10%23:43:02
5feed.agneau.org 33 97 14 83 0 14%09:48:19
6localhost 110 13 13 0 0 100%00:00:00
7ridley.ipv6.nerim.net 23 2493 5 2487 1 0%23:33:43
8news.delepine.info 1 0 0 0 0 0%00:10:00
9news.snof.org 2 5 0 5 0 0%00:30:26
TOTAL: 9 501 24751 6546 13384 4821 26%151:42:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feeder1-2.proxad.net10.1 MB0.0 KB21.9 MB32.1 MB 31%4.4 KB
2feed-out.gegeweb.org3.6 MB0.0 KB216.7 KB3.8 MB 94%2.9 KB
3mendel.ac-versailles.fr3.4 MB0.0 KB375.4 KB3.8 MB 90%2.2 KB
4news.fdn.fr1.2 MB0.0 KB2.3 MB3.5 MB 34%4.2 KB
5localhost29.1 KB0.0 KB0.0 KB29.1 KB100%2.2 KB
6feed.agneau.org27.9 KB0.0 KB0.0 KB27.9 KB100%2.0 KB
7ridley.ipv6.nerim.net20.0 KB0.0 KB1.3 KB21.3 KB 94%3.5 KB
8news.delepine.info0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9news.snof.org0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 918.4 MB0.0 KB24.8 MB43.3 MB 42%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 21 03:30:00 - 03:59:59 89 1.4% 0.05310.2 KB 1.6% 0.17
Sep 21 04:00:00 - 04:59:59 137 2.1% 0.04375.7 KB 2.0% 0.10
Sep 21 05:00:00 - 05:59:59 125 1.9% 0.03452.5 KB 2.4% 0.13
Sep 21 06:00:00 - 06:59:59 198 3.0% 0.06626.8 KB 3.3% 0.17
Sep 21 07:00:00 - 07:59:59 148 2.3% 0.04501.7 KB 2.7% 0.14
Sep 21 08:00:00 - 08:59:59 151 2.3% 0.04417.4 KB 2.2% 0.12
Sep 21 09:00:00 - 09:59:59 250 3.8% 0.07740.2 KB 3.9% 0.21
Sep 21 10:00:00 - 10:59:59 255 3.9% 0.07739.5 KB 3.9% 0.21
Sep 21 11:00:00 - 11:59:59 241 3.7% 0.07694.0 KB 3.7% 0.19
Sep 21 12:00:00 - 12:59:59 263 4.0% 0.07726.0 KB 3.8% 0.20
Sep 21 13:00:00 - 13:59:59 276 4.2% 0.08781.5 KB 4.1% 0.22
Sep 21 14:00:00 - 14:59:59 290 4.4% 0.08753.2 KB 4.0% 0.21
Sep 21 15:00:00 - 15:59:59 395 6.0% 0.111.0 MB 5.6% 0.29
Sep 21 16:00:00 - 16:59:59 344 5.3% 0.101012.8 KB 5.4% 0.28
Sep 21 17:00:00 - 17:59:59 304 4.6% 0.08809.2 KB 4.3% 0.22
Sep 21 18:00:00 - 18:59:59 337 5.1% 0.09988.9 KB 5.2% 0.27
Sep 21 19:00:00 - 19:59:59 333 5.1% 0.09905.2 KB 4.8% 0.25
Sep 21 20:00:00 - 20:59:59 361 5.5% 0.10907.6 KB 4.8% 0.25
Sep 21 21:00:00 - 21:59:59 439 6.7% 0.121.0 MB 5.7% 0.30
Sep 21 22:00:00 - 22:59:59 393 6.0% 0.111008.7 KB 5.3% 0.28
Sep 21 23:00:00 - 23:59:59 371 5.7% 0.101002.1 KB 5.3% 0.28
Sep 22 00:00:00 - 00:59:59 281 4.3% 0.08935.3 KB 5.0% 0.26
Sep 22 01:00:00 - 01:59:59 231 3.5% 0.06927.4 KB 4.9% 0.26
Sep 22 02:00:00 - 02:59:59 248 3.8% 0.07865.5 KB 4.6% 0.24
Sep 22 03:00:00 - 03:30:00 85 1.3% 0.05288.7 KB 1.5% 0.16
TOTAL: 24:00:00 6545 100.0% 0.0818.5 MB 100.0% 0.22
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feeder1-2.proxad.net 4274 2230 0 0 0 0 0 0 2044
2news.fdn.fr 439 407 0 0 0 0 0 0 32
3mendel.ac-versailles.fr 106 0 0 0 0 0 0 0 106
4feed-out.gegeweb.org 68 15 0 0 0 0 0 0 53
5ridley.ipv6.nerim.net 1 0 0 0 0 0 0 0 1
TOTAL: 5 4888 2652 0 0 0 0 0 0 2236

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.checkmate 141
linux.debian.bugs.dist 136
alt.religion.christian.roman-catholic 121
alt.home.repair 119
alt.fan.rush-limbaugh 116
alt.drugs.dealers.playground.bert-hoff 113
alt.bible.prophecy 107
alt.arts.poetry.comments 107
linux.debian.changes.devel 91
alt.comp.os.windows-10 73
alt.politics.homosexuality 56
linux.debian.bugs.rc 53
alt.assassination.jfk 53
alt.russian.z1 51
alt.real-estate.commercial.ca-south 46
alt.usage.english 45
alt.war.vietnam 42
alt.skate.figure 40
alt.baldspot 37
linux.gentoo.dev 28
TOTAL: 257 2652

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1731
Too many newsgroups 99
EMP (phl) 80
badword in subject & alt 68
Too many newsgroups2 46
HTML post 28
badword in From & alt 28
Scoring filter (8) 22
Bad path (news.theremailer.net) 14
Too many newsgroups (low_xpost) 10
Scoring filter (9) 9
Binary in non-binary group 8
Scoring filter (10) 8
Scoring filter (18) 2
Bad path (mail2news.mixmin.net) 2
badword in Newsgroups 2
Scoring filter (13) 1
Scoring filter (12) 1
Scoring filter (14) 1
Scoring filter (16) 1
TOTAL: 20 2161

Miscellaneous innd statistics [Top 10]:

EventServerNumber
No colon-space in header
feeder1-2.proxad.net 2
TOTAL: 1 2
TOTAL: 1 2

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 4981 1551 2578 0 0 0 31%23:49:36
2nerim.net 8879 1516 4299 54 0 0 17%23:52:29
3feed.ac-versailles.fr 4413 1190 3222 0 0 19 26%23:50:53
4delepine.info 636 636 0 0 0 0100%19:39:17
5frmug.org 636 611 0 25 0 0 96%19:46:44
6fdn.fr 6196 186 3518 1262 0 0 3%23:52:14
7agneau.org 652 134 348 142 0 0 20%19:37:09
8proxad.net 3082 79 2144 5 0 9 2%23:44:06
9snof.org 63 62 1 0 0 0 98%04:15:29
10pulsar.zoreil.com 0 0 0 0 0 0 0%24:00:00
11ircam.fr 0 0 0 0 0 4127 0%24:00:00
12news.teaser.net 0 0 0 0 0 636 0%24:00:02
TOTAL: 12 29538 5965 16110 1488 0 4791 20%254:27:59
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org4.9 MB0.0 KB4.9 MB0.1 KB/s3.2 KB23:49:36
2nerim.net4.8 MB142.7 KB4.9 MB0.1 KB/s3.2 KB23:52:29
3feed.ac-versailles.fr3.1 MB0.0 KB3.1 MB0.0 KB/s2.7 KB23:50:53
4delepine.info1.4 MB0.0 KB1.4 MB0.0 KB/s2.2 KB19:39:17
5frmug.org1.3 MB71.0 KB1.4 MB0.0 KB/s2.2 KB19:46:44
6fdn.fr552.8 KB2.3 MB2.8 MB0.0 KB/s2.0 KB23:52:14
7agneau.org370.3 KB329.5 KB699.7 KB0.0 KB/s2.5 KB19:37:09
8snof.org255.5 KB0.0 KB255.5 KB0.0 KB/s4.1 KB04:15:29
9proxad.net173.9 KB14.8 KB188.6 KB0.0 KB/s2.2 KB23:44:06
10pulsar.zoreil.com0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
11ircam.fr0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
12news.teaser.net0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:02
TOTAL: 1216.8 MB2.8 MB19.6 MB0.0 KB/s2.7 KB254:27:59
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
ircam.fr300.2 KB
news.teaser.net100.1 KB
TOTAL: 2400.3 KB

UUCP batches created:

ServerOfferedArticlesSizeElapsed
lolonet 84 6261.3 MB00:00:00
TOTAL: 1 84 6261.3 MB00:00:00

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1220.12.205.77.rev.sfr.net 57 142367.0 KB 64 12 008:41:50
2anancy-258-1-12-89.w90-40.abo.wanadoo.fr 2 2231.2 KB 3 0 000:00:15
32a01:e0a:2b7:70e1:b94:fcaa:6532:bc5b 2 1624.2 KB 4 0 000:21:29
4246.75.69.91.rev.sfr.net 1 1342.8 KB 1 1 000:09:23
52a01:e34:ec29:6bb0:9d80:4df4:8d3f:70b3 1 11.6 KB 1 0 000:01:53
TOTAL: 5 63 194466.8 KB 73 13 073:52:08

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.12.205.77.rev.sfr.net 57 142367.0 KB 64 12 008:41:50
2*.w90-40.abo.wanadoo.fr 2 2231.2 KB 3 0 000:00:15
3? 3 1725.8 KB 5 0 000:23:23
4*.75.69.91.rev.sfr.net 1 1342.8 KB 1 1 000:09:23
5*.unilim.fr 96 00.0 KB 0 0 016:02:15
6*.free.org 286 00.0 KB 0 0 047:09:21
7*.w86-203.abo.wanadoo.fr 10 00.0 KB 0 0 001:20:28
8unresolved 3 00.0 KB 0 0 000:05:11
TOTAL: 8 458 194466.8 KB 73 13 073:52:08

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
thor.free.org 0.484 11.106 0.00047:09:21
mamp-o-521-01.unilim.fr 0.161 1.952 5.28016:02:15
220.12.205.77.rev.sfr.net 0.097 1.552 2.67308:41:50
amarseille-655-1-48-118.w86-203.abo.wanadoo.fr 0.029 0.387 0.48901:20:28
2a01:e0a:2b7:70e1:b94:fcaa:6532:bc5b 0.012 0.040 0.09800:21:29
246.75.69.91.rev.sfr.net 0.000 0.026 0.04900:09:23
78.196.75.94 0.000 0.060 0.04900:05:01
2a01:e34:ec29:6bb0:9d80:4df4:8d3f:70b3 0.008 0.016 0.04900:01:53
anancy-258-1-12-89.w90-40.abo.wanadoo.fr 0.004 0.087 0.09800:00:15
159.203.201.227 0.007 0.014 0.00000:00:09
TOTAL: 10 0.802 15.240 8.78573:52:08

Curious NNRP server explorers [Top 20]:

SystemConn
thor.free.org 286
mamp-o-521-01.unilim.fr 96
amarseille-655-1-48-118.w86-203.abo.wanadoo.fr 10
78.196.75.94 2
159.203.201.227 1
TOTAL: 5 395

NNRP unrecognized commands (by host) [Top 100]:

SystemConn
78.196.75.94 1
TOTAL: 1 1

NNRP unrecognized commands (by command) [Top 100]:

CommandCount
XFEATURE COMPRESS GZIP TERMINATOR 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
thor.free.org 154 0
mamp-o-521-01.unilim.fr 96 0
220.12.205.77.rev.sfr.net 43 0
amarseille-655-1-48-118.w86-203.abo.wanadoo.fr 8 0
2a01:e0a:2b7:70e1:b94:fcaa:6532:bc5b 2 0
TOTAL: 5 303 0

Newsgroup request counts (by category):

CategoryCountPct
1fr 169 87.1%
2control 18 9.3%
3misc 4 2.1%
4alt 2 1.0%
5news 1 0.5%
TOTAL: 5 194100.0%

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

NewsgroupCount
1fr.rec.jeux.enigmes 39
2fr.usenet.abus.d 28
3fr.test 23
4control.cancel 18
5fr.sci.physique 14
6fr.sci.maths 14
7fr.usenet.abus.rapports 13
8fr.bio.medecine 13
9fr.misc.securite.routiere 10
10fr.rec.bricolage 7
11misc.transport.rail.europe 4
12alt.sysadmin.recovery 2
13fr.lettres.langue.francaise 2
14fr.comp.usenet.lecteurs-de-news 2
15fr.misc.droit 1
16fr.sci.electronique 1
17fr.rec.tv.programmes 1
18fr.comp.os.mac-os.x 1
19news.software.nntp 1
TOTAL: 19 194