Daily Usenet report for news.niel.me

Oct 16 04:15:01 -- Oct 17 04:15:02

Log entries by program:

Program nameLines%LinesSize%Size
inn 3922 39.2%732.3 KB 44.4%
innd 2499 25.0%414.8 KB 25.1%
nnrpd 1853 18.5%199.6 KB 12.1%
innfeed 1722 17.2%303.7 KB 18.4%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 9998 100.0%1.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 25895 65.0%
Negative hits 10086 25.3%
Do not exist 3881 9.7%
Cache misses 4 0.0%
TOTAL: 4 39866 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.028 0.0%9 0.500 3.111 12.000
article cancel00:00:00.001 0.0%9 0.000 0.111 0.500
article cleanup00:00:00.071 0.0%3886 0.000 0.018 0.133
article logging00:00:00.282 0.0%3906 0.000 0.072 0.300
article parse00:00:00.651 0.0%7637 0.000 0.085 0.263
article write00:00:02.451 0.0%3464 0.125 0.708 17.562
artlog/artcncl00:00:00.000 0.0%9 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%9 0.000 0.111 1.000
data move00:00:00.108 0.0%42160 0.000 0.003 0.013
hisgrep/artcncl00:00:00.001 0.0%9 0.000 0.111 0.500
hisgrep/artcncl/perl00:00:00.000 0.0%9 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%13 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%9 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%9 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.555 0.0%39896 0.000 0.014 0.049
history sync00:00:00.051 0.0%387 0.000 0.132 0.667
history write00:00:00.988 0.0%3886 0.000 0.254 1.561
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:34.246100.0%42774 972.985 2020.719 7692.795
nntp read00:00:01.313 0.0%42393 0.000 0.031 0.088
overview write00:00:02.295 0.0%3464 0.080 0.663 5.091
perl filter00:00:16.112 0.0%3886 1.962 4.146 17.625
python filter00:00:00.009 0.0%3886 0.000 0.002 0.053
site send00:00:01.071 0.0%6993 0.000 0.153 0.500
TOTAL: 24:01:12.33224:01:00.234100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.039 0.0%3634 0.000 0.011 0.250
article prepare00:00:00.000 0.0%424 0.000 0.000 0.000
article read00:00:00.017 0.0%73 0.000 0.233 5.000
backlog stats00:00:00.120 0.0%52714 0.000 0.002 0.023
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.750 0.0%31151 0.000 0.024 0.075
data write00:00:01.764 0.0%27957 0.021 0.063 0.109
idle23:50:37.406100.0%52714 818.069 1628.361 4353.101
status file00:00:00.481 0.0%182 1.000 2.643 14.000
TOTAL: 23:50:47.02023:50:40.577100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:50.411 29.4%1510 11.400 33.385 10010.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.124 0.1%3389 0.000 0.037 1.000
TOTAL: 00:02:51.47600:00:50.535 29.5%----

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
1news-out.aioe.org 1 3236 1427 1769 40 44%21:55:10
2i2pn.org 2 3968 845 2943 180 21%26:00:25
3news.glou.org 2 3094 528 2531 35 17%24:28:06
4feed-out.gegeweb.org 2 2528 338 2189 1 13%23:59:46
5usenet.pasdenom.info 1 2503 130 2371 2 5%23:59:54
6nntp.terraraq.uk 2 5541 106 5431 4 1%34:45:57
7news.nntp4.net 2 3586 31 3460 95 0%23:00:36
8gegeweb-out.news.tnetconsulting.net 3 6113 28 5978 107 0%37:00:17
9news.samoylyk.net 1 3744 6 3738 0 0%23:59:51
10localhost 25 0 0 0 0 0%00:00:00
TOTAL: 10 41 34313 3439 30410 464 10%239:10:02
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org4.9 MB0.0 KB146.1 KB5.0 MB 97%3.5 KB
2i2pn.org3.0 MB0.0 KB498.2 KB3.5 MB 86%3.5 KB
3news.glou.org2.7 MB0.0 KB71.7 KB2.8 MB 97%5.1 KB
4feed-out.gegeweb.org943.5 KB0.0 KB2.5 KB946.0 KB 99%2.8 KB
5nntp.terraraq.uk736.8 KB0.0 KB9.0 KB745.9 KB 98%6.8 KB
6news.nntp4.net669.7 KB0.0 KB239.3 KB909.0 KB 73%7.2 KB
7gegeweb-out.news.tnetconsulting.net392.5 KB0.0 KB238.6 KB631.1 KB 62%4.7 KB
8usenet.pasdenom.info357.5 KB0.0 KB2.1 KB359.6 KB 99%2.7 KB
9news.samoylyk.net262.9 KB0.0 KB0.0 KB262.9 KB100%43.8 KB
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1013.9 MB0.0 KB1.2 MB15.0 MB 92%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 16 04:15:01 - 04:59:59 84 2.4% 0.03350.2 KB 2.5% 0.13
Oct 16 05:00:00 - 05:59:59 106 3.1% 0.03312.5 KB 2.2% 0.09
Oct 16 06:00:00 - 06:59:59 117 3.4% 0.03404.4 KB 2.9% 0.11
Oct 16 07:00:00 - 07:59:59 100 2.9% 0.03633.8 KB 4.5% 0.18
Oct 16 08:00:00 - 08:59:59 85 2.5% 0.02326.8 KB 2.3% 0.09
Oct 16 09:00:00 - 09:59:59 93 2.7% 0.03439.7 KB 3.1% 0.12
Oct 16 10:00:00 - 10:59:59 106 3.1% 0.031.2 MB 9.0% 0.35
Oct 16 11:00:00 - 11:59:59 128 3.7% 0.04449.8 KB 3.2% 0.12
Oct 16 12:00:00 - 12:59:59 120 3.5% 0.03464.0 KB 3.3% 0.13
Oct 16 13:00:00 - 13:59:59 151 4.4% 0.04504.4 KB 3.6% 0.14
Oct 16 14:00:00 - 14:59:59 119 3.4% 0.03486.4 KB 3.5% 0.14
Oct 16 15:00:00 - 15:59:59 189 5.5% 0.05557.9 KB 4.0% 0.15
Oct 16 16:00:00 - 16:59:59 162 4.7% 0.04501.8 KB 3.6% 0.14
Oct 16 17:00:00 - 17:59:59 176 5.1% 0.05792.0 KB 5.6% 0.22
Oct 16 18:00:00 - 18:59:59 183 5.3% 0.05627.7 KB 4.5% 0.17
Oct 16 19:00:00 - 19:59:59 224 6.5% 0.06879.4 KB 6.3% 0.24
Oct 16 20:00:00 - 20:59:59 220 6.4% 0.06958.4 KB 6.8% 0.27
Oct 16 21:00:00 - 21:59:59 178 5.1% 0.05732.7 KB 5.2% 0.20
Oct 16 22:00:00 - 22:59:59 197 5.7% 0.05609.5 KB 4.3% 0.17
Oct 16 23:00:00 - 23:59:59 171 4.9% 0.05685.9 KB 4.9% 0.19
Oct 17 00:00:00 - 00:59:59 151 4.4% 0.04650.2 KB 4.6% 0.18
Oct 17 01:00:00 - 01:59:59 135 3.9% 0.04479.8 KB 3.4% 0.13
Oct 17 02:00:00 - 02:59:59 114 3.3% 0.03372.2 KB 2.6% 0.10
Oct 17 03:00:00 - 03:59:59 129 3.7% 0.04491.4 KB 3.5% 0.14
Oct 17 04:00:00 - 04:15:02 24 0.7% 0.0381.9 KB 0.6% 0.09
TOTAL: 24:00:01 3462 100.0% 0.0413.7 MB 100.0% 0.16
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1i2pn.org 141 0 0 0 0 0 0 0 141
2gegeweb-out.news.tnetconsulting.net 106 0 0 0 0 0 0 0 106
3news.nntp4.net 103 0 0 0 0 0 0 0 103
4news-out.aioe.org 53 0 0 0 0 0 0 0 53
5news.glou.org 35 0 0 0 0 0 0 0 35
6news.samoylyk.net 2 0 0 0 0 0 0 0 2
7feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
8nntp.terraraq.uk 1 0 0 0 0 0 0 0 1
TOTAL: 8 442 0 0 0 0 0 0 0 442

INND Perl filter [Top 20]:

ReasonCount
EMP (phl) 147
EMP (phn nph) 89
Bad path (news.giganews.com.POSTED) 70
EMP (phn path) 49
Too many newsgroups 39
EMP (md5) 17
HTML Multipart 4
Too many newsgroups (meow) 2
Cancel of non-existing ID <f32063b6-eb12-4da2-81d5-09d671f55f01n@googlegroups.com> 1
Cancel of <634bddb7$0$31558$426a74cc@news.free.fr> without Cancel-Key 1
Cancel of non-existing ID <46275bd7-01ec-4b0e-8d7c-02cd625728f2n@googlegroups.com> 1
Cancel of non-existing ID <db734114-e6f1-4254-9270-6590de513509n@googlegroups.com> 1
Cancel for rejected article 1
TOTAL: 13 422

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 13
news.nntp4.net 4
news.samoylyk.net 2
i2pn.org 1
TOTAL: 4 20
TOTAL: 1 20

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 4725 42 2597 3 0 93 0%23:59:54
2news.nntp4.net 3821 19 3361 0 0 0 0%23:58:17
3news.tnetconsulting.net 5586 13 3446 2 0 92 0%23:59:54
4nntp.terraraq.uk 2413 9 1985 3 0 2 0%23:55:54
5news.aioe.org 1586 6 1401 2 0 0 0%23:47:11
6news.gegeweb.org 3183 1 3125 2 0 0 0%23:59:17
7news.samoylyk.net 4149 1 3448 3 0 0 0%23:59:54
8news.pasdenom.info 3157 0 2737 0 0 0 0%23:57:53
TOTAL: 8 28620 91 22100 15 0 187 0%191:38:14
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.nntp4.net306.9 KB0.0 KB306.9 KB0.0 KB/s16.2 KB23:58:17
2i2pn.org195.5 KB4.7 KB200.2 KB0.0 KB/s4.4 KB23:59:54
3nntp.terraraq.uk97.3 KB83.0 KB180.4 KB0.0 KB/s15.0 KB23:55:54
4news.aioe.org60.5 KB3.4 KB63.9 KB0.0 KB/s8.0 KB23:47:11
5news.tnetconsulting.net41.6 KB3.0 KB44.7 KB0.0 KB/s3.0 KB23:59:54
6news.gegeweb.org3.8 KB7.7 KB11.5 KB0.0 KB/s3.8 KB23:59:17
7news.samoylyk.net3.0 KB4.9 KB7.9 KB0.0 KB/s2.0 KB23:59:54
8news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:53
TOTAL: 8708.6 KB106.9 KB815.5 KB0.0 KB/s7.7 KB191:38:14
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1instinctive.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:05
2159.223.128.100 1 00.0 KB 0 0 000:00:10
3valued.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
4steadfast.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
5motivating.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
6intuitive.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
7dignified.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
8192.241.214.44 1 00.0 KB 0 0 000:00:09
9192.241.217.64 1 00.0 KB 0 0 000:00:00
10passionate.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
11resounding.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
12principled.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
13kind.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
14139-162-229-202.ip.linodeusercontent.com 64 00.0 KB 0 0 000:00:21
15208.100.26.235 10 00.0 KB 0 0 000:00:03
16lustrous.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
17mail.gegeweb.eu 288 00.0 KB 0 0 000:01:55
18swanky.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
TOTAL: 18 377 00.0 KB 0 0 000:02:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.monitoring.internet-measurement.com 12 00.0 KB 0 0 000:00:09
2unresolved 13 00.0 KB 0 0 000:00:24
3*.ip.linodeusercontent.com 64 00.0 KB 0 0 000:00:21
4*.gegeweb.eu 288 00.0 KB 0 0 000:01:55
TOTAL: 4 377 00.0 KB 0 0 000:02:50

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 7.808 8.391 2.49300:01:55
139-162-229-202.ip.linodeusercontent.com 1.911 1.149 0.00000:00:21
159.223.128.100 0.035 0.018 0.00000:00:10
192.241.214.44 0.031 0.021 0.00000:00:09
instinctive.monitoring.internet-measurement.com 0.076 0.011 0.00000:00:05
208.100.26.235 0.117 0.077 0.00000:00:03
lustrous.monitoring.internet-measurement.com 0.020 0.030 0.00000:00:01
192.241.217.64 0.043 0.011 0.00000:00:00
swanky.monitoring.internet-measurement.com 0.077 0.010 0.00000:00:00
kind.monitoring.internet-measurement.com 0.073 0.009 0.00000:00:00
principled.monitoring.internet-measurement.com 0.050 0.010 0.00000:00:00
valued.monitoring.internet-measurement.com 0.064 0.009 0.00000:00:00
steadfast.monitoring.internet-measurement.com 0.036 0.000 0.00000:00:00
passionate.monitoring.internet-measurement.com 0.025 0.012 0.00000:00:00
motivating.monitoring.internet-measurement.com 0.027 0.009 0.00000:00:00
dignified.monitoring.internet-measurement.com 0.018 0.000 0.00000:00:00
resounding.monitoring.internet-measurement.com 0.017 0.000 0.00000:00:00
intuitive.monitoring.internet-measurement.com 0.017 0.000 0.00000:00:00
TOTAL: 18 10.445 9.767 2.49300:02:50

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
192.241.217.64 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_45.13.105.36_119 1
TOTAL: 1 1