Daily Usenet report for news.niel.me

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

Log entries by program:

Program nameLines%LinesSize%Size
inn 4421 40.0%832.8 KB 46.1%
innd 2674 24.2%443.5 KB 24.6%
nnrpd 2206 20.0%243.8 KB 13.5%
innfeed 1748 15.8%284.2 KB 15.7%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 11051 100.0%1.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 21869 59.3%
Negative hits 10635 28.8%
Do not exist 4388 11.9%
Cache misses 3 0.0%
TOTAL: 4 36895 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.019 0.0%14 0.000 1.357 6.000
article cancel00:00:00.001 0.0%14 0.000 0.071 1.000
article cleanup00:00:00.092 0.0%4396 0.000 0.021 0.143
article logging00:00:00.269 0.0%4396 0.000 0.061 0.200
article parse00:00:00.965 0.0%18328 0.000 0.053 0.213
article write00:00:01.871 0.0%3652 0.222 0.512 1.000
artlog/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%14 0.000 0.000 0.000
data move00:00:00.272 0.0%48835 0.000 0.006 0.022
hisgrep/artcncl00:00:00.001 0.0%14 0.000 0.071 1.000
hisgrep/artcncl/perl00:00:00.001 0.0%14 0.000 0.071 1.000
hisgrep/perl00:00:00.000 0.0%15 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%14 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.570 0.0%36935 0.000 0.015 0.050
history sync00:00:00.041 0.0%358 0.000 0.115 1.000
history write00:00:00.775 0.0%4394 0.000 0.176 0.571
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:23.822100.0%50239 407.793 1720.254 7696.000
nntp read00:00:01.331 0.0%49374 0.003 0.027 0.068
overview write00:00:01.064 0.0%3652 0.000 0.291 1.727
perl filter00:00:18.163 0.0%4394 1.559 4.134 10.484
python filter00:00:00.023 0.0%4394 0.000 0.005 0.111
site send00:00:01.118 0.0%7439 0.000 0.150 0.452
TOTAL: 24:01:00.95224:00:50.398100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.036 0.0%4014 0.000 0.009 0.111
article prepare00:00:00.008 0.0%1708 0.000 0.005 0.250
article read00:00:00.053 0.0%321 0.000 0.165 3.000
backlog stats00:00:00.274 0.0%54043 0.000 0.005 0.018
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.703 0.0%32093 0.000 0.022 0.069
data write00:00:01.464 0.0%27286 0.011 0.054 0.105
idle23:52:08.662100.0%54043 662.899 1590.005 4164.910
status file00:00:00.325 0.0%199 0.000 1.633 8.000
TOTAL: 23:52:15.44923:52:11.525100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:39.674 22.0%1566 10.600 25.335 10051.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.122 0.1%3578 0.000 0.034 1.000
TOTAL: 00:03:00.70000:00:39.796 22.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feed-out.gegeweb.org 3 2120 1131 989 0 53%23:56:22
2gegeweb-out.news.tnetconsulting.net 2 4283 666 3603 14 15%28:41:33
3i2pn.org 1 3258 565 2585 108 17%20:10:53
4news.glou.org 1 2779 462 2179 138 16%20:14:01
5news.nntp4.net 2 4212 429 3328 455 10%23:27:03
6nntp.terraraq.uk 4 5671 174 5465 32 3%42:11:26
7usenet.pasdenom.info 2 2086 125 1955 6 5%25:33:56
8news.samoylyk.net 1 416 5 405 6 1%03:29:25
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 41 24825 3557 20509 759 14%187:44:39
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1gegeweb-out.news.tnetconsulting.net5.5 MB56.1 KB180.4 KB5.8 MB 95%8.7 KB
2feed-out.gegeweb.org5.5 MB0.0 KB0.0 KB5.5 MB100%5.0 KB
3news.glou.org5.2 MB0.0 KB864.7 KB6.0 MB 85%10.2 KB
4news.nntp4.net2.3 MB0.0 KB4.3 MB6.5 MB 34%7.6 KB
5i2pn.org1.8 MB56.0 KB473.2 KB2.3 MB 77%3.6 KB
6nntp.terraraq.uk877.4 KB0.0 KB546.5 KB1.4 MB 61%6.9 KB
7usenet.pasdenom.info733.4 KB0.0 KB15.2 KB748.6 KB 97%5.7 KB
8news.samoylyk.net12.0 KB0.0 KB22.1 KB34.1 KB 35%3.1 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 921.9 MB112.0 KB6.3 MB28.3 MB 77%6.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 27 04:15:02 - 04:59:59 70 1.9% 0.03611.6 KB 2.6% 0.23
Aug 27 05:00:00 - 05:59:59 91 2.5% 0.03384.3 KB 1.6% 0.11
Aug 27 06:00:00 - 06:59:59 66 1.8% 0.02350.9 KB 1.5% 0.10
Aug 27 07:00:00 - 07:59:59 139 3.8% 0.04759.9 KB 3.2% 0.21
Aug 27 08:00:00 - 08:59:59 136 3.7% 0.041.2 MB 5.2% 0.34
Aug 27 09:00:00 - 09:59:59 100 2.7% 0.03517.7 KB 2.2% 0.14
Aug 27 10:00:00 - 10:59:59 101 2.8% 0.03428.7 KB 1.8% 0.12
Aug 27 11:00:00 - 11:59:59 85 2.3% 0.02285.6 KB 1.2% 0.08
Aug 27 12:00:00 - 12:59:59 258 7.1% 0.071.5 MB 6.6% 0.43
Aug 27 13:00:00 - 13:59:59 156 4.3% 0.04544.3 KB 2.3% 0.15
Aug 27 14:00:00 - 14:59:59 131 3.6% 0.04542.2 KB 2.3% 0.15
Aug 27 15:00:00 - 15:59:59 97 2.7% 0.03292.2 KB 1.2% 0.08
Aug 27 16:00:00 - 16:59:59 218 6.0% 0.062.4 MB 10.6% 0.70
Aug 27 17:00:00 - 17:59:59 238 6.5% 0.071.0 MB 4.4% 0.29
Aug 27 18:00:00 - 18:59:59 219 6.0% 0.06820.8 KB 3.5% 0.23
Aug 27 19:00:00 - 19:59:59 155 4.2% 0.04671.5 KB 2.8% 0.19
Aug 27 20:00:00 - 20:59:59 210 5.8% 0.062.5 MB 10.7% 0.70
Aug 27 21:00:00 - 21:59:59 163 4.5% 0.05763.9 KB 3.2% 0.21
Aug 27 22:00:00 - 22:59:59 227 6.2% 0.061.7 MB 7.3% 0.48
Aug 27 23:00:00 - 23:59:59 172 4.7% 0.05828.6 KB 3.5% 0.23
Aug 28 00:00:00 - 00:59:59 177 4.9% 0.05982.4 KB 4.2% 0.27
Aug 28 01:00:00 - 01:59:59 149 4.1% 0.041.1 MB 4.6% 0.30
Aug 28 02:00:00 - 02:59:59 108 3.0% 0.031.3 MB 5.7% 0.37
Aug 28 03:00:00 - 03:59:59 147 4.0% 0.041.6 MB 6.8% 0.45
Aug 28 04:00:00 - 04:15:01 36 1.0% 0.04223.5 KB 0.9% 0.25
TOTAL: 23:59:59 3649 100.0% 0.0423.0 MB 100.0% 0.27
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 432 0 0 0 0 0 0 0 432
2news.glou.org 145 0 0 0 0 0 0 0 145
3i2pn.org 122 0 0 1 0 0 0 0 121
4nntp.terraraq.uk 25 0 0 0 0 0 0 0 25
5gegeweb-out.news.tnetconsulting.net 13 1 0 1 0 0 0 0 11
6usenet.pasdenom.info 5 0 0 0 0 0 0 0 5
7news.samoylyk.net 2 0 0 0 0 0 0 0 2
TOTAL: 7 744 1 0 2 0 0 0 0 741

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.petites-annonces.informatique.materiel 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 335
EMP (phn nph) 100
Too many newsgroups 86
EMP (phn path) 76
Bad path (news.giganews.com.POSTED) 67
EMP (phl) 58
hierarchy violation - crosspost outside sdnet 7
EMP (phr nph) 6
Binary: misplaced binary 5
Cancel of <64eb1e13$0$8239$426a74cc@news.free.fr> without Cancel-Key 1
TOTAL: 10 741

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.terraraq.uk 2757 202 2238 49 0 1 7%23:59:56
2news.samoylyk.net 5411 41 3570 4 0 107 0%23:59:56
3news.tnetconsulting.net 5569 38 3600 8 0 130 0%23:59:49
4i2pn.org 4857 36 2867 4 0 144 0%23:59:13
5news.nntp4.net 3521 34 3127 1 0 0 0%23:59:24
6news.gegeweb.org 2547 8 2491 2 0 0 0%23:59:48
7news.pasdenom.info 3035 0 2950 0 0 0 0%23:59:56
8news.aioe.org 0 0 0 0 0 2814 0%23:59:56
TOTAL: 8 27697 359 20843 68 0 3196 1%191:57:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.terraraq.uk1.1 MB2.3 MB3.4 MB0.0 KB/s14.0 KB23:59:56
2news.nntp4.net796.8 KB56.0 KB852.8 KB0.0 KB/s24.4 KB23:59:24
3news.tnetconsulting.net410.8 KB19.9 KB430.7 KB0.0 KB/s9.4 KB23:59:49
4news.samoylyk.net395.9 KB6.2 KB402.0 KB0.0 KB/s8.9 KB23:59:56
5i2pn.org200.1 KB27.8 KB228.0 KB0.0 KB/s5.7 KB23:59:13
6news.gegeweb.org27.0 KB6.4 KB33.4 KB0.0 KB/s3.3 KB23:59:48
7news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 82.9 MB2.4 MB5.3 MB0.0 KB/s12.8 KB191:57:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1natural.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:06
245.227.254.49 1 00.0 KB 0 0 000:00:00
3profound.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
4thrilling.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
5robust.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
6productive.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
7120.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
8innovative.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
9lputeaux-658-1-30-140.w80-13.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:11
10172-105-246-139.ip.linodeusercontent.com 100 00.0 KB 0 0 000:00:26
11mail.gegeweb.eu 288 00.0 KB 0 0 000:01:34
12fascinating.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
1345.143.201.62 3 00.0 KB 0 0 000:00:05
1445.227.254.55 1 00.0 KB 0 0 000:00:00
15radiant.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:05
162607:ff10:c8:594::e 9 00.0 KB 0 0 000:00:20
17sage.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
18gracious.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
19198.199.109.108 1 00.0 KB 0 0 000:00:01
TOTAL: 19 415 00.0 KB 0 0 000:03:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 6 00.0 KB 0 0 000:00:07
2*.monitoring.internet-measurement.com 10 00.0 KB 0 0 000:00:19
3*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
4*.gegeweb.eu 288 00.0 KB 0 0 000:01:34
5? 9 00.0 KB 0 0 000:00:20
6*.ip.linodeusercontent.com 100 00.0 KB 0 0 000:00:26
7*.w80-13.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:11
TOTAL: 7 415 00.0 KB 0 0 000:03:00

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 4.206 3.800 1.49400:01:34
172-105-246-139.ip.linodeusercontent.com 2.551 1.248 0.00000:00:26
2607:ff10:c8:594::e 0.210 0.175 0.00000:00:20
lputeaux-658-1-30-140.w80-13.abo.wanadoo.fr 0.012 0.012 0.00000:00:11
natural.monitoring.internet-measurement.com 0.043 0.015 0.00000:00:06
45.143.201.62 0.066 0.051 0.00000:00:05
radiant.monitoring.internet-measurement.com 0.029 0.013 0.00000:00:05
sage.monitoring.internet-measurement.com 0.023 0.023 0.00000:00:02
robust.monitoring.internet-measurement.com 0.034 0.019 0.00000:00:01
productive.monitoring.internet-measurement.com 0.035 0.023 0.00000:00:01
198.199.109.108 0.032 0.022 0.00000:00:01
120.210.203.35.bc.googleusercontent.com 0.070 0.019 0.00000:00:00
profound.monitoring.internet-measurement.com 0.012 0.016 0.00000:00:00
45.227.254.49 0.015 0.036 0.00000:00:00
fascinating.monitoring.internet-measurement.com 0.059 0.004 0.00000:00:00
innovative.monitoring.internet-measurement.com 0.026 0.039 0.00000:00:00
gracious.monitoring.internet-measurement.com 0.023 0.005 0.00000:00:00
45.227.254.55 0.039 0.019 0.00000:00:00
thrilling.monitoring.internet-measurement.com 0.036 0.020 0.00000:00:00
TOTAL: 19 7.521 5.559 1.49400:03:00

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
2607:ff10:c8:594::e 23
120.210.203.35.bc.googleusercontent.com 3
45.227.254.49 1
198.199.109.108 1
TOTAL: 4 28

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 4
Accept-Encoding: gzip 3
Accept: */* 3
Host: [2a0e:e701:1154:0:4e10:5c89:4af0:d... 3
User-Agent: Mozilla/5.0 (Windows NT 10.0... 3
#023#003#023#001#023#002#001 3
#026#003#001 3
‡²kF‚·;#035íp3M,#037)Nÿ<€Ï­g¿Êÿ•ZĪõ ìô[s#032#015iâ£... 1
Host: 45.13.105.36:563 1
MGLNDD_45.13.105.36_119 1
#003 1
#003ìÊ_p„#014“#003S¼#020-²{Qȝ#024á 1
User-Agent: Expanse, a Palo Alto Network... 1
TOTAL: 13 28

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.49 1 1
TOTAL: 1 1 1