Daily Usenet report for news.niel.me

Oct 27 04:15:01 -- Oct 28 04:15:02

Log entries by program:

Program nameLines%LinesSize%Size
inn 2301 28.5%447.8 KB 34.0%
innd 2140 26.5%374.1 KB 28.4%
nnrpd 1872 23.2%205.4 KB 15.6%
innfeed 1755 21.7%290.5 KB 22.0%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 8070 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 12283 55.0%
Negative hits 7770 34.8%
Do not exist 2267 10.2%
Cache misses 1 0.0%
TOTAL: 4 22321 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.015 0.0%12 0.000 1.250 3.500
article cancel00:00:00.001 0.0%13 0.000 0.077 1.000
article cleanup00:00:00.057 0.0%2267 0.000 0.025 0.200
article logging00:00:00.167 0.0%2267 0.000 0.074 0.333
article parse00:00:00.342 0.0%4946 0.000 0.069 0.333
article write00:00:01.114 0.0%2069 0.000 0.538 1.556
artlog/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%12 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.119 0.0%22946 0.000 0.005 0.031
hisgrep/artcncl00:00:00.000 0.0%12 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%12 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%19 0.000 0.053 1.000
hishave/artcncl00:00:00.001 0.0%13 0.000 0.077 1.000
hishave/artcncl/perl00:00:00.000 0.0%12 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.346 0.0%22312 0.000 0.016 0.111
history sync00:00:00.048 0.0%348 0.000 0.138 1.000
history write00:00:00.404 0.0%2267 0.000 0.178 1.000
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:50:44.790100.0%24997 1060.101 3434.204 27282.000
nntp read00:00:00.678 0.0%24224 0.000 0.028 0.083
overview write00:00:00.718 0.0%2069 0.000 0.347 3.222
perl filter00:00:08.821 0.0%2267 1.207 3.891 11.000
python filter00:00:00.011 0.0%2267 0.000 0.005 0.333
site send00:00:01.022 0.0%4155 0.000 0.246 0.667
TOTAL: 23:51:05.84723:50:58.655100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%2361 0.000 0.010 0.333
article prepare00:00:00.002 0.0%708 0.000 0.003 0.250
article read00:00:00.035 0.0%168 0.000 0.208 2.000
backlog stats00:00:00.156 0.0%29160 0.000 0.005 0.033
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.421 0.0%16061 0.000 0.026 0.094
data write00:00:00.818 0.0%14291 0.000 0.057 0.222
idle23:50:51.273100.0%29160 955.282 2944.145 8707.667
status file00:00:00.540 0.0%229 0.000 2.358 7.000
TOTAL: 23:50:58.21323:50:53.269100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:43.226 16.1%1476 3.000 29.286 10037.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.138 0.1%3292 0.000 0.042 1.000
readart00:00:00.008 0.0%9 0.889 0.889 0.889
TOTAL: 00:04:28.45600:00:43.372 16.2%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 170

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1gegeweb-out.news.tnetconsulting.net 4 1870 943 890 37 50%25:10:10
2feed-out.gegeweb.org 3 1999 382 1616 1 19%23:55:52
3news.samoylyk.net 2 2262 279 1983 0 12%23:09:22
4news.nntp4.net 2 1752 141 1539 72 8%19:24:40
5i2pn.org 2 2089 138 1950 1 6%26:14:53
6usenet.pasdenom.info 5 1169 119 1044 6 10%24:32:16
7nntp.terraraq.uk 3 3271 69 3201 1 2%43:07:31
8news.glou.org 2 1598 51 1509 38 3%24:51:37
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 48 16010 2122 13732 156 13%210:26:21
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1gegeweb-out.news.tnetconsulting.net3.2 MB0.0 KB118.1 KB3.3 MB 96%3.4 KB
2news.samoylyk.net1.6 MB0.0 KB0.0 KB1.6 MB100%5.9 KB
3feed-out.gegeweb.org1.4 MB0.0 KB1.2 KB1.4 MB 99%3.8 KB
4nntp.terraraq.uk724.2 KB0.0 KB27.3 KB751.5 KB 96%10.7 KB
5news.nntp4.net605.5 KB0.0 KB365.8 KB971.3 KB 62%4.6 KB
6i2pn.org385.3 KB0.0 KB1.4 KB386.7 KB 99%2.8 KB
7usenet.pasdenom.info272.5 KB0.0 KB6.6 KB279.2 KB 97%2.2 KB
8news.glou.org216.6 KB0.0 KB128.0 KB344.6 KB 62%3.9 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 98.4 MB0.0 KB648.3 KB9.0 MB 92%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 27 04:15:01 - 04:59:59 36 1.7% 0.01120.3 KB 1.4% 0.04
Oct 27 05:00:00 - 05:59:59 58 2.8% 0.02177.0 KB 2.1% 0.05
Oct 27 06:00:00 - 06:59:59 57 2.7% 0.02193.2 KB 2.3% 0.05
Oct 27 07:00:00 - 07:59:59 26 1.3% 0.0181.9 KB 1.0% 0.02
Oct 27 08:00:00 - 08:59:59 51 2.5% 0.01235.1 KB 2.7% 0.07
Oct 27 09:00:00 - 09:59:59 71 3.4% 0.02232.4 KB 2.7% 0.06
Oct 27 10:00:00 - 10:59:59 61 2.9% 0.02209.7 KB 2.5% 0.06
Oct 27 11:00:00 - 11:59:59 217 10.4% 0.06985.7 KB 11.5% 0.27
Oct 27 12:00:00 - 12:59:59 75 3.6% 0.02263.8 KB 3.1% 0.07
Oct 27 13:00:00 - 13:59:59 75 3.6% 0.02263.6 KB 3.1% 0.07
Oct 27 14:00:00 - 14:59:59 86 4.1% 0.02298.9 KB 3.5% 0.08
Oct 27 15:00:00 - 15:59:59 110 5.3% 0.03441.4 KB 5.2% 0.12
Oct 27 16:00:00 - 16:59:59 84 4.0% 0.02263.8 KB 3.1% 0.07
Oct 27 17:00:00 - 17:59:59 108 5.2% 0.03275.7 KB 3.2% 0.08
Oct 27 18:00:00 - 18:59:59 132 6.4% 0.04398.7 KB 4.7% 0.11
Oct 27 19:00:00 - 19:59:59 152 7.3% 0.04470.6 KB 5.5% 0.13
Oct 27 20:00:00 - 20:59:59 158 7.6% 0.04779.6 KB 9.1% 0.22
Oct 27 21:00:00 - 21:59:59 94 4.5% 0.03899.7 KB 10.5% 0.25
Oct 27 22:00:00 - 22:59:59 102 4.9% 0.03731.7 KB 8.6% 0.20
Oct 27 23:00:00 - 23:59:59 90 4.3% 0.03267.9 KB 3.1% 0.07
Oct 28 00:00:00 - 00:59:59 61 2.9% 0.02328.6 KB 3.8% 0.09
Oct 28 01:00:00 - 01:59:59 54 2.6% 0.01211.5 KB 2.5% 0.06
Oct 28 02:00:00 - 02:59:59 55 2.6% 0.02178.9 KB 2.1% 0.05
Oct 28 03:00:00 - 03:59:59 41 2.0% 0.01180.1 KB 2.1% 0.05
Oct 28 04:00:00 - 04:15:02 24 1.2% 0.0363.4 KB 0.7% 0.07
TOTAL: 24:00:01 2078 100.0% 0.028.4 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 118 1 0 0 0 0 0 0 117
2news.glou.org 36 0 0 0 0 0 0 0 36
3gegeweb-out.news.tnetconsulting.net 36 1 0 0 0 0 0 0 35
4usenet.pasdenom.info 6 0 0 0 0 0 0 0 6
5feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
6nntp.terraraq.uk 1 0 0 0 0 0 0 0 1
TOTAL: 6 198 2 0 0 0 0 0 0 196

Unwanted newsgroups [Top 20]:

NewsgroupCount
soc.culture.iran 1
fr.petites-annonces.informatique.materiel 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 110
EMP (phn path) 42
Bad path (news.giganews.com.POSTED) 35
EMP (md5) 1
Cancel of <7efcae7e82740658290ccf42d3b27bfed7558441@i2pn2.org> without Cancel-Key 1
Cancel of non-existing ID <671e3ef8$0$11458$426a34cc@news.free.fr> 1
Cancel of <62a25b1cebac8a12daa5ca896725c1d0dbceb516@i2pn2.org> without Cancel-Key 1
HTML Multipart 1
Cancels abusifs 1
Cancel of <671df682$0$28484$426a74cc@news.free.fr> without Cancel-Key 1
Cancel of <733863738f5a32430b7e2941bc26cce98bfa55f8@i2pn2.org> without Cancel-Key 1
Cancel of <03b0d28f147a92218a53ad34e5fa3f9c69ec39ca@i2pn2.org> without Cancel-Key 1
TOTAL: 12 196

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 1840 78 1622 0 0 8 4%23:47:02
2i2pn.org 2761 57 1851 12 0 130 2%23:56:24
3news.tnetconsulting.net 2863 8 2059 8 0 48 0%23:56:26
4news.samoylyk.net 2281 5 1791 7 0 98 0%23:52:23
5news.pasdenom.info 1681 1 1534 0 0 0 0%23:52:28
6news.nntp4.net 2096 0 1911 1 0 7 0%23:56:20
7nntp.terraraq.uk 1172 0 1140 0 0 0 0%23:47:32
8news.aioe.org 0 0 0 0 0 1670 0%24:00:01
TOTAL: 8 14694 149 11908 28 0 1961 1%191:08:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org365.6 KB0.0 KB365.6 KB0.0 KB/s4.7 KB23:47:02
2i2pn.org159.4 KB61.8 KB221.2 KB0.0 KB/s3.2 KB23:56:24
3news.tnetconsulting.net25.1 KB19.6 KB44.7 KB0.0 KB/s2.8 KB23:56:26
4news.samoylyk.net23.6 KB29.4 KB53.0 KB0.0 KB/s4.4 KB23:52:23
5news.pasdenom.info2.2 KB0.0 KB2.2 KB0.0 KB/s2.2 KB23:52:28
6news.nntp4.net0.0 KB2.1 KB2.1 KB0.0 KB/s2.1 KB23:56:20
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:32
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 8575.9 KB112.9 KB688.8 KB0.0 KB/s3.9 KB191:08:36
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1162.250.122.68 4 912.2 KB 3 0 000:00:05
TOTAL: 1 4 912.2 KB 3 0 000:04:27

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 13 912.2 KB 3 0 000:02:48
2*.211.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:01
3*.survey.inspici.com 1 00.0 KB 0 0 000:00:04
4*.monitoring.internet-measurement.com 6 00.0 KB 0 0 000:00:07
5*.gegeweb.eu 288 00.0 KB 0 0 000:01:24
6*.stretchoid.com 1 00.0 KB 0 0 000:00:00
TOTAL: 6 311 912.2 KB 3 0 000:04:27

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 5.054 4.392 1.77600:01:24
206.168.34.209 0.028 0.020 0.00000:00:44
206.168.34.63 0.051 0.013 0.00000:00:31
206.168.34.121 0.031 0.027 0.00000:00:30
206.168.34.39 0.029 0.033 0.00000:00:30
147.185.132.141 0.032 0.020 0.00000:00:10
205.210.31.69 0.015 0.007 0.00000:00:10
162.250.122.68 0.088 0.071 0.00000:00:05
talented.monitoring.internet-measurement.com 0.049 0.023 0.00000:00:05
server-0-3.survey.inspici.com 0.024 0.024 0.00000:00:04
91.238.181.34 0.037 0.026 0.00000:00:02
sprightly.monitoring.internet-measurement.com 0.011 0.011 0.00000:00:01
147.45.112.147 0.025 0.012 0.00000:00:01
37.211.203.35.bc.googleusercontent.com 0.031 0.009 0.00000:00:01
azpdcgc23.stretchoid.com 0.025 0.025 0.00000:00:00
91.238.181.22 0.031 0.019 0.00000:00:00
82.211.203.35.bc.googleusercontent.com 0.062 0.019 0.00000:00:00
reverent.monitoring.internet-measurement.com 0.016 0.012 0.00000:00:00
masterful.monitoring.internet-measurement.com 0.035 0.030 0.00000:00:00
charming.monitoring.internet-measurement.com 0.015 0.012 0.00000:00:00
TOTAL: 20 5.689 4.805 1.77600:04:27

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
azpdcgc23.stretchoid.com 1
talented.monitoring.internet-measurement.com 1
147.45.112.147 1
91.238.181.34 1
37.211.203.35.bc.googleusercontent.com 1
206.168.34.39 1
82.211.203.35.bc.googleusercontent.com 1
server-0-3.survey.inspici.com 1
206.168.34.209 1
reverent.monitoring.internet-measurement.com 1
206.168.34.63 1
205.210.31.69 1
206.168.34.121 1
charming.monitoring.internet-measurement.com 1
masterful.monitoring.internet-measurement.com 1
91.238.181.22 1
vivid.monitoring.internet-measurement.com 1
sprightly.monitoring.internet-measurement.com 1
147.185.132.141 1
TOTAL: 20 307

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 7
TOTAL: 1 7

NNRP unrecognized commands (by host):

SystemConn
82.211.203.35.bc.googleusercontent.com 4
37.211.203.35.bc.googleusercontent.com 4
91.238.181.22 1
147.45.112.147 1
azpdcgc23.stretchoid.com 1
TOTAL: 5 11

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 2
Accept-Encoding: gzip 2
Host: 45.13.105.36:563 2
#003 2
User-Agent: Expanse, a Palo Alto Network... 2
MGLNDD_45.13.105.36_119 1
TOTAL: 6 11

NNRP client timeouts [Top 20]:

SystemConnPeer
147.45.112.147 1 1
91.238.181.22 1 1
TOTAL: 2 2 2

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 7 77.8%
2local 2 22.2%
TOTAL: 2 9100.0%

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

NewsgroupCount
1grisbi.bugsreports 4
2grisbi.test 3
3local.test 2
TOTAL: 3 9
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me