Daily Usenet report for news.niel.me

Mar 11 04:15:01 -- Mar 12 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Mar 11 16:50:02 rpi-studio controlchan[22162]: Multiple control headers in article <IgQ4x-fWN7-5@gated-at.bofh.it>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2922 33.0%540.7 KB 37.9%
innd 2379 26.9%404.9 KB 28.4%
innfeed 1783 20.1%291.1 KB 20.4%
nnrpd 1770 20.0%189.8 KB 13.3%
controlchan 2 0.0%0.1 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8857 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 15378 63.6%
Negative hits 5893 24.4%
Do not exist 2898 12.0%
Cache misses 1 0.0%
TOTAL: 4 24170 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.008 0.0%10 0.000 0.800 2.000
article cancel00:00:00.003 0.0%10 0.000 0.300 1.000
article cleanup00:00:00.068 0.0%2902 0.000 0.023 0.333
article logging00:00:00.226 0.0%2902 0.000 0.078 0.267
article parse00:00:00.331 0.0%6804 0.000 0.049 0.300
article write00:00:01.301 0.0%2478 0.125 0.525 1.071
artlog/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%10 0.000 0.100 1.000
data move00:00:00.110 0.0%25523 0.000 0.004 0.039
hisgrep/artcncl00:00:00.001 0.0%10 0.000 0.100 1.000
hisgrep/artcncl/perl00:00:00.000 0.0%10 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%10 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%10 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.413 0.0%24170 0.000 0.017 0.073
history sync00:00:00.048 0.0%393 0.000 0.122 1.000
history write00:00:00.507 0.0%2902 0.000 0.175 0.857
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:41.512100.0%28591 1038.311 3023.382 9840.885
nntp read00:00:00.709 0.0%27858 0.000 0.025 0.065
overview write00:00:01.659 0.0%2478 0.000 0.669 6.000
perl filter00:00:12.486 0.0%2902 2.600 4.303 10.375
python filter00:00:00.009 0.0%2902 0.000 0.003 0.111
site send00:00:00.880 0.0%5181 0.000 0.170 0.600
TOTAL: 24:01:11.11724:01:00.272100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.027 0.0%2493 0.000 0.011 0.118
article prepare00:00:00.003 0.0%760 0.000 0.004 0.250
article read00:00:00.019 0.0%182 0.000 0.104 4.000
backlog stats00:00:00.197 0.0%39819 0.000 0.005 0.027
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.507 0.0%21295 0.000 0.024 0.069
data write00:00:01.134 0.0%19103 0.018 0.059 0.115
idle23:50:28.263100.0%39819 872.317 2155.460 7245.867
status file00:00:00.413 0.0%206 0.000 2.005 7.000
TOTAL: 23:50:35.64223:50:30.563100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:17.236 14.8%1441 10.400 11.961 1350.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.104 0.1%3176 0.000 0.033 0.273
TOTAL: 00:01:56.41000:00:17.340 14.9%----

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 6 2358 1213 1145 0 51%25:55:44
2gegeweb-out.news.tnetconsulting.net 1 2160 301 1816 43 13%25:15:01
3i2pn.org 7 2443 236 2207 0 9%23:13:55
4news.nntp4.net 1 2399 207 1987 205 8%20:48:10
5news.glou.org 1 2214 158 1963 93 7%23:59:58
6usenet.pasdenom.info 1 435 42 390 3 9%08:45:24
7news.samoylyk.net 2 2512 29 2483 0 1%24:12:31
8nntp.terraraq.uk 1 284 13 271 0 4%04:46:52
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 45 14805 2199 12262 344 14%156:57:35
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org4.4 MB0.0 KB0.0 KB4.4 MB100%3.7 KB
2gegeweb-out.news.tnetconsulting.net894.4 KB0.0 KB255.7 KB1.1 MB 77%3.3 KB
3i2pn.org860.8 KB0.0 KB0.0 KB860.8 KB100%3.6 KB
4news.nntp4.net838.3 KB0.0 KB750.1 KB1.6 MB 52%3.9 KB
5news.glou.org630.2 KB0.0 KB223.9 KB854.1 KB 73%3.4 KB
6news.samoylyk.net292.0 KB0.0 KB0.0 KB292.0 KB100%10.1 KB
7usenet.pasdenom.info106.4 KB0.0 KB4.9 KB111.3 KB 95%2.5 KB
8nntp.terraraq.uk37.3 KB0.0 KB0.0 KB37.3 KB100%2.9 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 98.0 MB0.0 KB1.2 MB9.2 MB 86%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 11 04:15:01 - 04:59:59 29 1.2% 0.01146.1 KB 1.6% 0.05
Mar 11 05:00:00 - 05:59:59 65 2.6% 0.02320.8 KB 3.6% 0.09
Mar 11 06:00:00 - 06:59:59 67 2.7% 0.02336.2 KB 3.8% 0.09
Mar 11 07:00:00 - 07:59:59 50 2.0% 0.01161.8 KB 1.8% 0.04
Mar 11 08:00:00 - 08:59:59 76 3.1% 0.02303.5 KB 3.4% 0.08
Mar 11 09:00:00 - 09:59:59 112 4.5% 0.03389.7 KB 4.3% 0.11
Mar 11 10:00:00 - 10:59:59 79 3.2% 0.02253.1 KB 2.8% 0.07
Mar 11 11:00:00 - 11:59:59 63 2.5% 0.02279.7 KB 3.1% 0.08
Mar 11 12:00:00 - 12:59:59 102 4.1% 0.03297.1 KB 3.3% 0.08
Mar 11 13:00:00 - 13:59:59 118 4.8% 0.03433.3 KB 4.8% 0.12
Mar 11 14:00:00 - 14:59:59 127 5.1% 0.04417.1 KB 4.7% 0.12
Mar 11 15:00:00 - 15:59:59 115 4.6% 0.03391.6 KB 4.4% 0.11
Mar 11 16:00:00 - 16:59:59 150 6.1% 0.04612.8 KB 6.8% 0.17
Mar 11 17:00:00 - 17:59:59 191 7.7% 0.05772.1 KB 8.6% 0.21
Mar 11 18:00:00 - 18:59:59 145 5.8% 0.04435.8 KB 4.9% 0.12
Mar 11 19:00:00 - 19:59:59 113 4.6% 0.03397.4 KB 4.4% 0.11
Mar 11 20:00:00 - 20:59:59 125 5.0% 0.03396.4 KB 4.4% 0.11
Mar 11 21:00:00 - 21:59:59 147 5.9% 0.04441.2 KB 4.9% 0.12
Mar 11 22:00:00 - 22:59:59 137 5.5% 0.04484.0 KB 5.4% 0.13
Mar 11 23:00:00 - 23:59:59 91 3.7% 0.03381.9 KB 4.3% 0.11
Mar 12 00:00:00 - 00:59:59 102 4.1% 0.03363.1 KB 4.1% 0.10
Mar 12 01:00:00 - 01:59:59 108 4.4% 0.03382.8 KB 4.3% 0.11
Mar 12 02:00:00 - 02:59:59 79 3.2% 0.02260.2 KB 2.9% 0.07
Mar 12 03:00:00 - 03:59:59 73 2.9% 0.02252.4 KB 2.8% 0.07
Mar 12 04:00:00 - 04:15:02 15 0.6% 0.0248.5 KB 0.5% 0.05
TOTAL: 24:00:01 2479 100.0% 0.038.7 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 267 0 0 0 0 0 0 0 267
2news.glou.org 93 0 0 0 0 0 0 0 93
3gegeweb-out.news.tnetconsulting.net 45 0 0 0 0 0 0 0 45
4usenet.pasdenom.info 14 0 0 0 0 0 0 0 14
5nntp.terraraq.uk 4 0 0 0 0 0 0 0 4
TOTAL: 5 423 0 0 0 0 0 0 0 423

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 264
EMP (phn path) 96
Bad path (news.giganews.com.POSTED) 54
Cancels abusifs 6
HTML Multipart 1
EMP (md5) 1
Too many newsgroups (meow) 1
TOTAL: 7 423

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 1318 96 1159 0 0 0 7%23:59:09
2i2pn.org 3707 60 2176 8 0 1 1%23:59:25
3news.samoylyk.net 3439 7 2465 0 0 1 0%23:56:47
4news.tnetconsulting.net 4106 7 2466 5 0 0 0%23:59:55
5news.pasdenom.info 2493 4 2126 0 0 0 0%23:59:32
6nntp.terraraq.uk 1758 0 1588 0 0 0 0%23:57:28
7news.nntp4.net 2278 0 2204 3 0 0 0%23:59:26
8news.aioe.org 0 0 0 0 0 1995 0%23:59:55
TOTAL: 8 19099 174 14184 16 0 1997 0%191:51:37
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org365.2 KB0.0 KB365.2 KB0.0 KB/s3.8 KB23:59:09
2i2pn.org134.6 KB21.9 KB156.5 KB0.0 KB/s2.3 KB23:59:25
3news.tnetconsulting.net14.3 KB25.6 KB39.9 KB0.0 KB/s3.3 KB23:59:55
4news.samoylyk.net14.2 KB0.0 KB14.2 KB0.0 KB/s2.0 KB23:56:47
5news.pasdenom.info4.7 KB0.0 KB4.7 KB0.0 KB/s1.2 KB23:59:32
6nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:28
7news.nntp4.net0.0 KB35.2 KB35.2 KB0.0 KB/s11.7 KB23:59:26
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 8533.0 KB82.7 KB615.7 KB0.0 KB/s3.2 KB191:51:37
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mail.gegeweb.eu 286 00.0 KB 0 0 000:01:39
2sturdy.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
3patient.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
4194.165.16.73 1 00.0 KB 0 0 000:00:00
5thrilling.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:05
6chivalrous.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
780.66.88.215 1 00.0 KB 0 0 000:00:00
8sys.gegeweb.eu 2 00.0 KB 0 0 000:00:06
9eloquent.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
TOTAL: 9 295 00.0 KB 0 0 000:01:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:08
2unresolved 2 00.0 KB 0 0 000:00:01
3*.gegeweb.eu 288 00.0 KB 0 0 000:01:45
TOTAL: 3 295 00.0 KB 0 0 000:01:56

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.365 4.057 1.52300:01:39
sys.gegeweb.eu 0.060 0.050 0.01900:00:06
thrilling.monitoring.internet-measurement.com 0.046 0.017 0.00000:00:05
eloquent.monitoring.internet-measurement.com 0.035 0.019 0.00000:00:02
194.165.16.73 0.012 0.012 0.00000:00:00
sturdy.monitoring.internet-measurement.com 0.016 0.012 0.00000:00:00
80.66.88.215 0.011 0.015 0.00000:00:00
patient.monitoring.internet-measurement.com 0.019 0.009 0.00000:00:00
chivalrous.monitoring.internet-measurement.com 0.038 0.017 0.00000:00:00
TOTAL: 9 4.602 4.208 1.54200:01:56

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
194.165.16.73 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
#003 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

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