Daily Usenet report for news.niel.me

Mar 17 04:15:02 -- Mar 18 04:15:02

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Mar 18 03:19:27 rpi-studio nnrpd[19069]: 2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 noperm ihave without permission
Mar 18 03:24:28 rpi-studio nnrpd[19186]: 2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 noperm ihave without permission
Mar 18 03:29:28 rpi-studio nnrpd[19426]: 2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 noperm ihave without permission
Mar 18 03:34:28 rpi-studio nnrpd[19524]: 2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 noperm ihave without permission
Mar 18 03:39:29 rpi-studio nnrpd[19771]: 2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 noperm ihave without permission
Mar 18 03:44:29 rpi-studio nnrpd[19874]: 2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 noperm ihave without permission
Mar 18 03:49:32 rpi-studio nnrpd[20140]: 2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 noperm ihave without permission
Mar 18 03:54:32 rpi-studio nnrpd[20283]: 2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 noperm ihave without permission
Mar 18 03:59:32 rpi-studio nnrpd[20543]: 2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 noperm ihave without permission
Mar 18 04:04:32 rpi-studio nnrpd[20640]: 2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 noperm ihave without permission
Mar 18 04:09:33 rpi-studio nnrpd[20886]: 2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 noperm ihave without permission
Mar 18 04:14:33 rpi-studio nnrpd[20998]: 2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
inn 2798 31.4%508.9 KB 36.0%
innd 2353 26.4%404.2 KB 28.6%
nnrpd 1942 21.8%212.3 KB 15.0%
innfeed 1830 20.5%288.7 KB 20.4%
controlchan 1 0.0%0.0 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8925 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 14855 63.8%
Negative hits 5635 24.2%
Do not exist 2787 12.0%
Cache misses 1 0.0%
TOTAL: 4 23278 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.002 0.0%2 1.000 1.000 1.000
article cancel00:00:00.000 0.0%2 0.000 0.000 0.000
article cleanup00:00:00.057 0.0%2794 0.000 0.020 0.250
article logging00:00:00.218 0.0%2794 0.000 0.078 0.375
article parse00:00:00.348 0.0%7391 0.000 0.047 0.182
article write00:00:01.386 0.0%2382 0.000 0.582 1.750
artlog/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.112 0.0%25716 0.000 0.004 0.034
hisgrep/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%2 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%2 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%2 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.362 0.0%23333 0.000 0.016 0.064
history sync00:00:00.042 0.0%408 0.000 0.103 0.667
history write00:00:00.447 0.0%2794 0.000 0.160 0.556
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:57.297100.0%28189 1074.565 3067.058 15346.538
nntp read00:00:00.679 0.0%27415 0.000 0.025 0.068
overview write00:00:01.334 0.0%2382 0.000 0.560 11.000
perl filter00:00:10.556 0.0%2794 2.280 3.778 10.000
python filter00:00:00.011 0.0%2794 0.000 0.004 0.071
site send00:00:00.998 0.0%4969 0.000 0.201 0.523
TOTAL: 24:01:22.26024:01:13.849100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.018 0.0%2391 0.000 0.008 0.143
article prepare00:00:00.005 0.0%1288 0.000 0.004 0.125
article read00:00:00.042 0.0%297 0.000 0.141 3.000
backlog stats00:00:00.207 0.0%37848 0.000 0.005 0.031
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.490 0.0%19951 0.000 0.025 0.094
data write00:00:01.052 0.0%17931 0.000 0.059 0.143
idle23:59:45.663100.0%37848 973.240 2282.437 9795.984
status file00:00:00.413 0.0%235 0.000 1.757 7.000
TOTAL: 23:59:51.66623:59:47.890100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:18.704 15.6%1479 10.000 12.646 1236.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.109 0.1%3266 0.000 0.033 1.000
TOTAL: 00:01:59.98500:00:18.813 15.7%----

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
1feed-out.gegeweb.org 4 2285 1086 1199 0 47%24:10:59
2i2pn.org 2 2880 364 2515 1 12%28:35:54
3news.nntp4.net 1 2938 355 2381 202 12%25:18:25
4gegeweb-out.news.tnetconsulting.net 3 2508 322 2113 73 12%28:32:46
5nntp.terraraq.uk 3 2205 124 2078 3 5%23:20:27
62a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 0 1192 119 1070 3 9%14:56:28
7news.glou.org 3 1983 95 1774 114 4%23:51:35
8news.samoylyk.net 2 4744 68 4676 0 1%46:55:30
9usenet.pasdenom.info 4 591 61 523 7 10%13:03:33
10localhost 25 0 0 0 0 0%00:00:00
TOTAL: 10 47 21326 2594 18329 403 12%228:45:37
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org3.8 MB0.0 KB0.0 KB3.8 MB100%3.6 KB
2news.nntp4.net2.5 MB0.0 KB1.6 MB4.2 MB 60%7.7 KB
3i2pn.org1.1 MB0.0 KB5.4 KB1.1 MB 99%3.1 KB
4news.samoylyk.net917.1 KB0.0 KB0.0 KB917.1 KB100%13.5 KB
5gegeweb-out.news.tnetconsulting.net916.2 KB0.0 KB456.3 KB1.3 MB 66%3.5 KB
6news.glou.org397.0 KB0.0 KB236.2 KB633.2 KB 62%3.0 KB
7nntp.terraraq.uk359.7 KB0.0 KB40.9 KB400.6 KB 89%3.2 KB
82a01:e0a:21:ea80:e65f:1ff:fe14:e7a4257.1 KB0.0 KB6.0 KB263.0 KB 97%2.2 KB
9usenet.pasdenom.info154.4 KB0.0 KB12.5 KB166.9 KB 92%2.5 KB
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1010.4 MB0.0 KB2.4 MB12.8 MB 81%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 17 04:15:02 - 04:59:59 29 1.2% 0.01100.9 KB 1.1% 0.04
Mar 17 05:00:00 - 05:59:59 84 3.5% 0.02351.5 KB 3.7% 0.10
Mar 17 06:00:00 - 06:59:59 63 2.6% 0.02179.6 KB 1.9% 0.05
Mar 17 07:00:00 - 07:59:59 49 2.1% 0.01170.4 KB 1.8% 0.05
Mar 17 08:00:00 - 08:59:59 37 1.6% 0.0199.3 KB 1.1% 0.03
Mar 17 09:00:00 - 09:59:59 54 2.3% 0.01205.6 KB 2.2% 0.06
Mar 17 10:00:00 - 10:59:59 107 4.5% 0.03324.7 KB 3.5% 0.09
Mar 17 11:00:00 - 11:59:59 68 2.9% 0.02210.4 KB 2.2% 0.06
Mar 17 12:00:00 - 12:59:59 97 4.1% 0.03504.2 KB 5.4% 0.14
Mar 17 13:00:00 - 13:59:59 131 5.5% 0.04695.6 KB 7.4% 0.19
Mar 17 14:00:00 - 14:59:59 131 5.5% 0.04869.2 KB 9.3% 0.24
Mar 17 15:00:00 - 15:59:59 120 5.0% 0.03382.4 KB 4.1% 0.11
Mar 17 16:00:00 - 16:59:59 125 5.3% 0.03385.5 KB 4.1% 0.11
Mar 17 17:00:00 - 17:59:59 146 6.1% 0.04510.9 KB 5.4% 0.14
Mar 17 18:00:00 - 18:59:59 182 7.6% 0.05659.9 KB 7.0% 0.18
Mar 17 19:00:00 - 19:59:59 126 5.3% 0.04599.8 KB 6.4% 0.17
Mar 17 20:00:00 - 20:59:59 164 6.9% 0.05540.7 KB 5.8% 0.15
Mar 17 21:00:00 - 21:59:59 158 6.6% 0.04474.5 KB 5.0% 0.13
Mar 17 22:00:00 - 22:59:59 148 6.2% 0.04583.0 KB 6.2% 0.16
Mar 17 23:00:00 - 23:59:59 108 4.5% 0.03330.1 KB 3.5% 0.09
Mar 18 00:00:00 - 00:59:59 88 3.7% 0.02360.1 KB 3.8% 0.10
Mar 18 01:00:00 - 01:59:59 67 2.8% 0.02411.0 KB 4.4% 0.11
Mar 18 02:00:00 - 02:59:59 55 2.3% 0.02190.6 KB 2.0% 0.05
Mar 18 03:00:00 - 03:59:59 24 1.0% 0.01189.0 KB 2.0% 0.05
Mar 18 04:00:00 - 04:15:02 19 0.8% 0.0266.7 KB 0.7% 0.07
TOTAL: 24:00:00 2380 100.0% 0.039.2 MB 100.0% 0.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 226 1 0 0 0 0 0 0 225
2news.glou.org 114 0 0 0 0 0 0 0 114
3gegeweb-out.news.tnetconsulting.net 61 0 0 0 0 0 0 0 61
4usenet.pasdenom.info 9 0 0 0 0 0 0 0 9
5nntp.terraraq.uk 3 0 0 0 0 0 0 0 3
6i2pn.org 1 0 0 0 0 0 0 0 1
TOTAL: 6 414 1 0 0 0 0 0 0 413

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 150
EMP (phn path) 122
EMP (md5) 69
Bad path (news.giganews.com.POSTED) 66
HTML Multipart 2
Cancel for rejected article 2
Too many newsgroups (meow) 1
Cancels abusifs 1
TOTAL: 8 413

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3391 137 1914 3 0 3 4%23:51:23
2news.gegeweb.org 1391 110 1190 2 0 0 7%23:37:26
3news.samoylyk.net 3339 27 2311 0 0 3 0%23:47:16
4news.tnetconsulting.net 3859 23 2339 14 0 6 0%23:51:31
5news.nntp4.net 2147 3 2038 0 0 0 0%23:49:00
6nntp.terraraq.uk 1562 1 1329 1 0 0 0%23:51:36
7news.pasdenom.info 2168 1 1874 0 0 0 0%23:51:36
8news.aioe.org 0 0 0 0 0 1977 0%23:59:56
TOTAL: 8 17857 302 12995 20 0 1989 1%190:39:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org456.4 KB12.6 KB469.1 KB0.0 KB/s3.4 KB23:51:23
2news.gegeweb.org327.4 KB7.1 KB334.5 KB0.0 KB/s3.0 KB23:37:26
3news.tnetconsulting.net79.1 KB54.7 KB133.8 KB0.0 KB/s3.6 KB23:51:31
4news.samoylyk.net57.0 KB0.0 KB57.0 KB0.0 KB/s2.1 KB23:47:16
5news.nntp4.net8.1 KB0.0 KB8.1 KB0.0 KB/s2.7 KB23:49:00
6nntp.terraraq.uk5.2 KB3.2 KB8.4 KB0.0 KB/s4.2 KB23:51:36
7news.pasdenom.info3.6 KB0.0 KB3.6 KB0.0 KB/s3.6 KB23:51:36
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 8936.8 KB77.7 KB1014.4 KB0.0 KB/s3.2 KB190:39:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1masterful.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
2erudite.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
345.227.254.8 1 00.0 KB 0 0 000:00:00
4208.100.26.233 10 00.0 KB 0 0 000:00:02
5mail.gegeweb.eu 288 00.0 KB 0 0 000:01:22
650.31.21.7 3 00.0 KB 0 0 000:00:20
7enchanting.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:05
845.227.254.49 1 00.0 KB 0 0 000:00:00
9thorough.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
10angelic.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
112a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 12 00.0 KB 0 0 000:00:05
TOTAL: 11 320 00.0 KB 0 0 000:01:59

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:08
2*.gegeweb.eu 288 00.0 KB 0 0 000:01:22
3? 12 00.0 KB 0 0 000:00:05
4unresolved 15 00.0 KB 0 0 000:00:22
TOTAL: 4 320 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.301 3.998 1.47900:01:22
50.31.21.7 0.117 0.047 0.00000:00:20
2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 0.266 0.242 0.00000:00:05
enchanting.monitoring.internet-measurement.com 0.032 0.012 0.00000:00:05
thorough.monitoring.internet-measurement.com 0.031 0.024 0.00000:00:02
208.100.26.233 0.181 0.111 0.00000:00:02
erudite.monitoring.internet-measurement.com 0.019 0.010 0.00000:00:00
masterful.monitoring.internet-measurement.com 0.044 0.020 0.00000:00:00
45.227.254.49 0.029 0.024 0.00000:00:00
45.227.254.8 0.019 0.008 0.00000:00:00
angelic.monitoring.internet-measurement.com 0.017 0.010 0.00000:00:00
TOTAL: 11 5.056 4.506 1.47900:01:59

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
45.227.254.49 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
#003 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.49 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