Daily Usenet report for news.niel.me

May 14 04:15:01 -- May 15 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 3148 34.1%588.3 KB 39.2%
innd 2390 25.9%408.7 KB 27.3%
nnrpd 1942 21.0%221.5 KB 14.8%
innfeed 1760 19.0%280.7 KB 18.7%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 9242 100.0%1.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 15635 58.4%
Negative hits 8049 30.1%
Do not exist 3038 11.4%
Cache misses 38 0.1%
TOTAL: 4 26760 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.069 0.0%43 1.000 1.605 8.000
article cancel00:00:00.006 0.0%43 0.000 0.140 0.500
article cleanup00:00:00.075 0.0%3050 0.000 0.025 0.143
article logging00:00:00.262 0.0%3066 0.000 0.085 0.308
article parse00:00:00.654 0.0%9523 0.000 0.069 0.208
article write00:00:03.274 0.0%2585 0.200 1.267 2.294
artlog/artcncl00:00:00.001 0.0%43 0.000 0.023 0.500
artlog/artcncl/perl00:00:00.002 0.0%43 0.000 0.047 1.000
data move00:00:00.118 0.0%32557 0.000 0.004 0.024
hisgrep/artcncl00:00:00.001 0.0%43 0.000 0.023 0.029
hisgrep/artcncl/perl00:00:00.000 0.0%43 0.000 0.000 0.000
hisgrep/perl00:00:00.003 0.0%145 0.000 0.021 0.500
hishave/artcncl00:00:00.000 0.0%43 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%43 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.348 0.0%26792 0.000 0.013 0.049
history sync00:00:00.064 0.0%401 0.000 0.160 1.333
history write00:00:00.654 0.0%3050 0.000 0.214 1.000
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:39.048100.0%33640 693.443 2569.532 13336.422
nntp read00:00:01.094 0.0%33017 0.000 0.033 0.096
overview write00:00:01.570 0.0%2585 0.000 0.607 4.714
perl filter00:00:15.455 0.0%3050 3.034 5.067 17.875
python filter00:00:00.006 0.0%3050 0.000 0.002 0.083
site send00:00:01.012 0.0%5203 0.000 0.195 0.453
TOTAL: 24:01:14.49124:01:03.716100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%2602 0.000 0.009 0.167
article prepare00:00:00.001 0.0%312 0.000 0.003 0.083
article read00:00:00.019 0.0%76 0.000 0.250 7.000
backlog stats00:00:00.103 0.0%35950 0.000 0.003 0.016
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.493 0.0%20516 0.000 0.024 0.101
data write00:00:01.066 0.0%18049 0.000 0.059 0.107
idle23:51:38.570100.0%35950 1098.453 2389.390 10175.373
status file00:00:00.449 0.0%205 0.000 2.190 7.000
TOTAL: 23:51:49.09223:51:40.725100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:21.345 17.7%1463 11.400 14.590 1893.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.062 0.1%3284 0.000 0.019 1.000
TOTAL: 00:02:00.26500:00:21.407 17.8%----

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
1i2pn.org 2 2639 669 1824 146 25%23:44:05
2feed-out.gegeweb.org 5 1725 512 1204 9 29%23:52:11
3news.samoylyk.net 2 3065 354 2675 36 11%27:03:01
4news.nntp4.net 1 2779 266 2335 178 9%22:57:40
5nntp.terraraq.uk 3 2174 248 1901 25 11%23:26:36
6news.glou.org 1 2116 180 1916 20 8%21:26:50
7gegeweb-out.news.tnetconsulting.net 1 2848 169 2659 20 5%23:59:57
8usenet.pasdenom.info 3 735 36 692 7 4%10:08:27
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 43 18081 2434 15206 441 13%176:38:47

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net3.7 MB3.0 KB81.0 KB3.8 MB 97%10.0 KB
2gegeweb-out.news.tnetconsulting.net3.6 MB2.9 KB41.1 KB3.6 MB 98%19.7 KB
3i2pn.org2.8 MB0.0 KB401.6 KB3.2 MB 87%4.1 KB
4news.nntp4.net1.8 MB0.0 KB442.4 KB2.2 MB 80%5.1 KB
5feed-out.gegeweb.org1.5 MB0.0 KB16.9 KB1.5 MB 98%3.0 KB
6nntp.terraraq.uk1.0 MB0.0 KB48.2 KB1.1 MB 95%4.1 KB
7news.glou.org721.0 KB0.0 KB61.6 KB782.6 KB 92%3.9 KB
8usenet.pasdenom.info91.4 KB0.0 KB9.6 KB101.0 KB 90%2.3 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 915.3 MB5.9 KB1.1 MB16.4 MB 93%5.8 KB

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 14 04:15:01 - 04:59:59 58 2.2% 0.02174.5 KB 1.0% 0.06
May 14 05:00:00 - 05:59:59 56 2.2% 0.02402.3 KB 2.4% 0.11
May 14 06:00:00 - 06:59:59 50 1.9% 0.01402.5 KB 2.4% 0.11
May 14 07:00:00 - 07:59:59 74 2.9% 0.021.5 MB 9.0% 0.42
May 14 08:00:00 - 08:59:59 30 1.2% 0.01425.7 KB 2.5% 0.12
May 14 09:00:00 - 09:59:59 82 3.2% 0.02362.4 KB 2.1% 0.10
May 14 10:00:00 - 10:59:59 84 3.3% 0.02419.6 KB 2.5% 0.12
May 14 11:00:00 - 11:59:59 121 4.7% 0.031.8 MB 11.1% 0.52
May 14 12:00:00 - 12:59:59 80 3.1% 0.02689.8 KB 4.1% 0.19
May 14 13:00:00 - 13:59:59 86 3.3% 0.02382.6 KB 2.3% 0.11
May 14 14:00:00 - 14:59:59 107 4.1% 0.03317.3 KB 1.9% 0.09
May 14 15:00:00 - 15:59:59 112 4.3% 0.03442.5 KB 2.6% 0.12
May 14 16:00:00 - 16:59:59 117 4.5% 0.031.3 MB 8.0% 0.37
May 14 17:00:00 - 17:59:59 128 5.0% 0.04835.2 KB 5.0% 0.23
May 14 18:00:00 - 18:59:59 156 6.0% 0.04825.5 KB 4.9% 0.23
May 14 19:00:00 - 19:59:59 140 5.4% 0.04599.5 KB 3.6% 0.17
May 14 20:00:00 - 20:59:59 148 5.7% 0.04602.8 KB 3.6% 0.17
May 14 21:00:00 - 21:59:59 131 5.1% 0.04573.8 KB 3.4% 0.16
May 14 22:00:00 - 22:59:59 166 6.4% 0.05837.0 KB 5.0% 0.23
May 14 23:00:00 - 23:59:59 143 5.5% 0.04616.7 KB 3.7% 0.17
May 15 00:00:00 - 00:59:59 181 7.0% 0.05603.2 KB 3.6% 0.17
May 15 01:00:00 - 01:59:59 102 4.0% 0.03405.7 KB 2.4% 0.11
May 15 02:00:00 - 02:59:59 87 3.4% 0.02348.9 KB 2.1% 0.10
May 15 03:00:00 - 03:59:59 120 4.7% 0.031.3 MB 7.9% 0.37
May 15 04:00:00 - 04:15:01 21 0.8% 0.02532.2 KB 3.2% 0.59
TOTAL: 24:00:00 2580 100.0% 0.0316.5 MB 100.0% 0.20

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 180 0 0 0 0 0 0 0 180
2i2pn.org 172 0 0 0 0 0 0 0 172
3news.samoylyk.net 45 0 0 0 0 0 0 0 45
4nntp.terraraq.uk 28 0 0 0 0 0 0 0 28
5usenet.pasdenom.info 23 0 0 0 0 0 0 0 23
6news.glou.org 20 0 0 0 0 0 0 0 20
7feed-out.gegeweb.org 11 0 0 0 0 0 0 0 11
8gegeweb-out.news.tnetconsulting.net 3 0 0 0 0 0 0 0 3
TOTAL: 8 482 0 0 0 0 0 0 0 482

INND Perl filter [Top 20]:

ReasonCount
Bad path (news.giganews.com.POSTED) 91
EMP (phl) 77
EMP (phn nph) 64
EMP (md5) 57
EMP (phn path) 43
Too many newsgroups 31
Cancel of non-existing ID <sf8ebr$c8t$1@dont-email.me> 1
Cancel of non-existing ID <shpeoh$7di$1@dont-email.me> 1
Cancel of non-existing ID <sfc8mv$qdq$1@dont-email.me> 1
Cancel of non-existing ID <shobo5$i2b$1@dont-email.me> 1
Cancel of non-existing ID <trtsa9$3q49u$1@dont-email.me> 1
Cancel of non-existing ID <sfr89c$12f$1@dont-email.me> 1
Cancel of non-existing ID <sfvhhe$3e2$1@dont-email.me> 1
Cancel of non-existing ID <sh8k40$avq$1@dont-email.me> 1
Cancel of non-existing ID <sfvfs9$qlq$1@dont-email.me> 1
Cancel of non-existing ID <trts1b$3q2po$1@dont-email.me> 1
Cancel of non-existing ID <sf93v7$aeh$1@dont-email.me> 1
Cancel of non-existing ID <sfg8sg$crn$1@dont-email.me> 1
Cancel of non-existing ID <sf8ehf$fed$1@dont-email.me> 1
Cancel of non-existing ID <ts0q6t$9o11$1@dont-email.me> 1
TOTAL: 109 466

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.samoylyk.net 13
feed-out.gegeweb.org 2
news.nntp4.net 1
TOTAL: 3 16
TOTAL: 1 16

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 2934 30 1844 1 0 3 1%23:52:54
2news.gegeweb.org 2232 22 2030 17 0 0 0%23:59:51
3news.tnetconsulting.net 3920 6 2567 0 0 20 0%23:59:51
4news.nntp4.net 2404 1 2277 0 0 8 0%23:57:15
5news.pasdenom.info 2309 1 2247 0 0 0 0%23:58:33
6nntp.terraraq.uk 1775 0 1671 1 0 0 0%23:56:43
7news.samoylyk.net 2515 0 2267 0 0 0 0%23:59:51
8news.aioe.org 0 0 0 0 0 1908 0%23:59:51
TOTAL: 8 18089 60 14903 19 0 1939 0%191:44:49

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org71.5 KB0.9 KB72.5 KB0.0 KB/s2.3 KB23:52:54
2news.gegeweb.org54.2 KB84.3 KB138.4 KB0.0 KB/s3.5 KB23:59:51
3news.nntp4.net35.8 KB0.0 KB35.8 KB0.0 KB/s35.8 KB23:57:15
4news.tnetconsulting.net13.4 KB0.0 KB13.4 KB0.0 KB/s2.2 KB23:59:51
5news.pasdenom.info2.7 KB0.0 KB2.7 KB0.0 KB/s2.7 KB23:58:33
6nntp.terraraq.uk0.0 KB118.9 KB118.9 KB0.0 KB/s118.9 KB23:56:43
7news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
TOTAL: 8177.6 KB204.1 KB381.8 KB0.0 KB/s4.8 KB191:44:49

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1upstanding.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
2208.100.26.237 10 00.0 KB 0 0 000:00:03
345.227.254.55 1 00.0 KB 0 0 000:00:00
4lucid.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
5sunny.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:07
6cool.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
7194.165.16.37 1 00.0 KB 0 0 000:00:00
8patient.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
9graceful.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:05
10mail.gegeweb.eu 288 00.0 KB 0 0 000:01:28
11194.165.16.76 1 00.0 KB 0 0 000:00:00
122607:ff10:c8:594::5 9 00.0 KB 0 0 000:00:09
1345.227.254.48 1 00.0 KB 0 0 000:00:00
TOTAL: 13 317 00.0 KB 0 0 000:01:59

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 9 00.0 KB 0 0 000:00:09
2unresolved 14 00.0 KB 0 0 000:00:05
3*.gegeweb.eu 288 00.0 KB 0 0 000:01:28
4*.monitoring.internet-measurement.com 6 00.0 KB 0 0 000:00:17
TOTAL: 4 317 00.0 KB 0 0 000:01:59

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.735 4.660 2.01600:01:28
2607:ff10:c8:594::5 0.207 0.257 0.00000:00:09
sunny.monitoring.internet-measurement.com 0.065 0.032 0.00000:00:07
graceful.monitoring.internet-measurement.com 0.077 0.019 0.00000:00:05
208.100.26.237 0.186 0.199 0.00000:00:03
lucid.monitoring.internet-measurement.com 0.034 0.011 0.00000:00:01
cool.monitoring.internet-measurement.com 0.020 0.040 0.00000:00:01
upstanding.monitoring.internet-measurement.com 0.052 0.017 0.00000:00:00
194.165.16.76 0.041 0.010 0.00000:00:00
194.165.16.37 0.038 0.029 0.00000:00:00
45.227.254.48 0.021 0.021 0.00000:00:00
45.227.254.55 0.019 0.047 0.00000:00:00
patient.monitoring.internet-measurement.com 0.020 0.020 0.00000:00:00
TOTAL: 13 5.515 5.362 2.01600:01:59

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
2607:ff10:c8:594::5 22
sunny.monitoring.internet-measurement.com 6
194.165.16.76 1
45.227.254.48 1
TOTAL: 4 30

NNRP unrecognized commands (by command):

CommandCount
Accept-Encoding: gzip 4
Accept: */* 4
Host: [2a0e:e701:1154:0:4e10:5c89:4af0:d... 4
GET / HTTP/1.1 4
#023#003#023#001#023#002#001 3
#026#003#001 3
User-Agent: Mozilla/5.0 (Windows NT 10.0... 3
#003 2
e\.Â,jÏ#021úv(,Y.ðZ #004ÆÊ#006ß&s#010B>#002íL÷#006Ñ#030¯¡Óø... 1
Connection: close 1
User-Agent: Mozilla/5.0 (compatible; Int... 1
TOTAL: 11 30

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.48 1 1
194.165.16.76 1 1
TOTAL: 2 2 2
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me