Daily Usenet report for news.niel.me

Oct 9 04:15:01 -- Oct 10 04:15:01

Unknown entries from news log file:

First 50 / 238 lines (21.0%)

Oct 9 14:30:45 rpi-studio nnrpd[7143]: mail.schaffert.info noperm ihave without permission
Oct 9 14:31:15 rpi-studio nnrpd[7177]: mail.schaffert.info noperm ihave without permission
Oct 9 14:31:45 rpi-studio nnrpd[7193]: mail.schaffert.info noperm ihave without permission
Oct 9 14:32:15 rpi-studio nnrpd[7199]: mail.schaffert.info noperm ihave without permission
Oct 9 14:32:45 rpi-studio nnrpd[7202]: mail.schaffert.info noperm ihave without permission
Oct 9 14:33:15 rpi-studio nnrpd[7209]: mail.schaffert.info noperm ihave without permission
Oct 9 14:33:45 rpi-studio nnrpd[7212]: mail.schaffert.info noperm ihave without permission
Oct 9 14:34:15 rpi-studio nnrpd[7229]: mail.schaffert.info noperm ihave without permission
Oct 9 14:34:46 rpi-studio nnrpd[7232]: mail.schaffert.info noperm ihave without permission
Oct 9 14:35:17 rpi-studio nnrpd[7243]: mail.schaffert.info noperm ihave without permission
Oct 9 14:35:47 rpi-studio nnrpd[7386]: mail.schaffert.info noperm ihave without permission
Oct 9 14:36:17 rpi-studio nnrpd[7393]: mail.schaffert.info noperm ihave without permission
Oct 9 14:36:48 rpi-studio nnrpd[7407]: mail.schaffert.info noperm ihave without permission
Oct 9 14:37:18 rpi-studio nnrpd[7413]: mail.schaffert.info noperm ihave without permission
Oct 9 14:37:48 rpi-studio nnrpd[7416]: mail.schaffert.info noperm ihave without permission
Oct 9 14:38:18 rpi-studio nnrpd[7421]: mail.schaffert.info noperm ihave without permission
Oct 9 14:38:48 rpi-studio nnrpd[7428]: mail.schaffert.info noperm ihave without permission
Oct 9 14:39:18 rpi-studio nnrpd[7434]: mail.schaffert.info noperm ihave without permission
Oct 9 14:39:48 rpi-studio nnrpd[7449]: mail.schaffert.info noperm ihave without permission
Oct 9 14:40:18 rpi-studio nnrpd[7460]: mail.schaffert.info noperm ihave without permission
Oct 9 14:40:48 rpi-studio nnrpd[7467]: mail.schaffert.info noperm ihave without permission
Oct 9 14:41:19 rpi-studio nnrpd[7473]: mail.schaffert.info noperm ihave without permission
Oct 9 14:41:49 rpi-studio nnrpd[7487]: mail.schaffert.info noperm ihave without permission
Oct 9 14:42:19 rpi-studio nnrpd[7492]: mail.schaffert.info noperm ihave without permission
Oct 9 14:42:50 rpi-studio nnrpd[7507]: mail.schaffert.info noperm ihave without permission
Oct 9 14:43:20 rpi-studio nnrpd[7512]: mail.schaffert.info noperm ihave without permission
Oct 9 14:43:50 rpi-studio nnrpd[7515]: mail.schaffert.info noperm ihave without permission
Oct 9 14:44:21 rpi-studio nnrpd[7520]: mail.schaffert.info noperm ihave without permission
Oct 9 14:44:51 rpi-studio nnrpd[7523]: mail.schaffert.info noperm ihave without permission
Oct 9 14:45:23 rpi-studio nnrpd[7534]: mail.schaffert.info noperm ihave without permission
Oct 9 14:45:53 rpi-studio nnrpd[7680]: mail.schaffert.info noperm ihave without permission
Oct 9 14:46:23 rpi-studio nnrpd[7713]: mail.schaffert.info noperm ihave without permission
Oct 9 14:46:53 rpi-studio nnrpd[7715]: mail.schaffert.info noperm ihave without permission
Oct 9 14:47:23 rpi-studio nnrpd[7722]: mail.schaffert.info noperm ihave without permission
Oct 9 14:47:54 rpi-studio nnrpd[7724]: mail.schaffert.info noperm ihave without permission
Oct 9 14:48:24 rpi-studio nnrpd[7731]: mail.schaffert.info noperm ihave without permission
Oct 9 14:48:54 rpi-studio nnrpd[7733]: mail.schaffert.info noperm ihave without permission
Oct 9 14:49:24 rpi-studio nnrpd[7740]: mail.schaffert.info noperm ihave without permission
Oct 9 14:49:54 rpi-studio nnrpd[7743]: mail.schaffert.info noperm ihave without permission
Oct 9 14:50:24 rpi-studio nnrpd[7751]: mail.schaffert.info noperm ihave without permission
Oct 9 14:50:54 rpi-studio nnrpd[7759]: mail.schaffert.info noperm ihave without permission
Oct 9 14:51:25 rpi-studio nnrpd[7777]: mail.schaffert.info noperm ihave without permission
Oct 9 14:51:55 rpi-studio nnrpd[7789]: mail.schaffert.info noperm ihave without permission
Oct 9 14:52:25 rpi-studio nnrpd[7795]: mail.schaffert.info noperm ihave without permission
Oct 9 14:52:55 rpi-studio nnrpd[7798]: mail.schaffert.info noperm ihave without permission
Oct 9 14:53:25 rpi-studio nnrpd[7803]: mail.schaffert.info noperm ihave without permission
Oct 9 14:53:56 rpi-studio nnrpd[7810]: mail.schaffert.info noperm ihave without permission
Oct 9 14:54:26 rpi-studio nnrpd[7827]: mail.schaffert.info noperm ihave without permission
Oct 9 14:54:56 rpi-studio nnrpd[7829]: mail.schaffert.info noperm ihave without permission
Oct 9 14:55:26 rpi-studio nnrpd[7839]: mail.schaffert.info noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
inn 3670 34.8%705.0 KB 42.3%
nnrpd 2903 27.5%299.3 KB 17.9%
innd 2252 21.4%386.5 KB 23.2%
innfeed 1714 16.3%277.0 KB 16.6%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 10541 100.0%1.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 21027 64.0%
Negative hits 8206 25.0%
Do not exist 3608 11.0%
Cache misses 1 0.0%
TOTAL: 4 32842 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.013 0.0%15 0.000 0.867 1.000
article cancel00:00:00.003 0.0%16 0.000 0.188 1.000
article cleanup00:00:00.090 0.0%3613 0.000 0.025 0.200
article logging00:00:00.262 0.0%3623 0.000 0.072 0.389
article parse00:00:00.585 0.0%6916 0.000 0.085 0.214
article write00:00:04.017 0.0%3271 0.067 1.228 135.867
artlog/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%15 0.000 0.000 0.000
data move00:00:00.098 0.0%35777 0.000 0.003 0.015
hisgrep/artcncl00:00:00.000 0.0%15 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%15 0.000 0.000 0.000
hisgrep/perl00:00:00.004 0.0%16 0.000 0.250 1.000
hishave/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%15 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.442 0.0%32851 0.000 0.013 0.055
history sync00:00:00.064 0.0%406 0.000 0.158 2.333
history write00:00:00.798 0.0%3613 0.000 0.221 0.571
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:50:36.500100.0%36944 1034.838 2323.422 12248.265
nntp read00:00:01.107 0.0%35876 0.000 0.031 0.081
overview write00:00:02.313 0.0%3271 0.062 0.707 5.524
perl filter00:00:16.601 0.0%3613 2.950 4.595 8.429
python filter00:00:00.009 0.0%3613 0.000 0.002 0.062
site send00:00:00.915 0.0%6624 0.000 0.138 0.471
TOTAL: 23:51:19.09223:51:03.821100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.038 0.0%3281 0.000 0.012 0.118
article prepare00:00:00.000 0.0%692 0.000 0.000 0.000
article read00:00:00.028 0.0%140 0.000 0.200 7.000
backlog stats00:00:00.120 0.0%47737 0.000 0.003 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.649 0.0%27158 0.000 0.024 0.064
data write00:00:01.604 0.0%23925 0.000 0.067 0.135
idle23:52:47.975100.0%47737 923.571 1800.867 6536.130
status file00:00:00.450 0.0%168 1.000 2.679 6.000
TOTAL: 23:52:53.54123:52:50.864100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:51.880 67.0%2160 11.400 107.352 63510.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.153 0.0%4691 0.000 0.033 1.000
TOTAL: 00:05:46.03400:03:52.033 67.1%----

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
1news-out.aioe.org 1 3114 1228 1841 45 39%21:51:56
2news.glou.org 1 3865 733 3084 48 18%29:54:55
3i2pn.org 2 2997 717 2071 209 23%20:24:21
4feed-out.gegeweb.org 3 2282 267 2009 6 11%23:53:03
5usenet.pasdenom.info 1 2608 182 2415 11 6%23:59:54
6nntp.terraraq.uk 2 5746 137 5599 10 2%42:14:56
7gegeweb-out.news.tnetconsulting.net 2 3063 13 3050 0 0%23:58:22
8news.samoylyk.net 1 122 5 117 0 4%01:15:43
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 38 23797 3282 20186 329 13%187:33:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.glou.org4.6 MB0.0 KB110.4 KB4.7 MB 97%6.1 KB
2news-out.aioe.org4.2 MB0.0 KB145.1 KB4.4 MB 96%3.5 KB
3i2pn.org2.6 MB0.0 KB492.6 KB3.1 MB 84%3.4 KB
4feed-out.gegeweb.org807.5 KB0.0 KB9.7 KB817.1 KB 98%3.0 KB
5nntp.terraraq.uk602.8 KB0.0 KB19.3 KB622.1 KB 96%4.2 KB
6usenet.pasdenom.info424.3 KB0.0 KB15.8 KB440.1 KB 96%2.3 KB
7gegeweb-out.news.tnetconsulting.net219.2 KB0.0 KB0.0 KB219.2 KB100%16.9 KB
8news.samoylyk.net200.4 KB0.0 KB0.0 KB200.4 KB100%40.1 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 913.6 MB0.0 KB792.9 KB14.3 MB 94%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 9 04:15:01 - 04:59:59 79 2.4% 0.03259.9 KB 2.0% 0.10
Oct 9 05:00:00 - 05:59:59 87 2.6% 0.02494.7 KB 3.7% 0.14
Oct 9 06:00:00 - 06:59:59 72 2.2% 0.02423.0 KB 3.2% 0.12
Oct 9 07:00:00 - 07:59:59 87 2.6% 0.02547.7 KB 4.1% 0.15
Oct 9 08:00:00 - 08:59:59 89 2.7% 0.02375.5 KB 2.8% 0.10
Oct 9 09:00:00 - 09:59:59 91 2.8% 0.03435.4 KB 3.3% 0.12
Oct 9 10:00:00 - 10:59:59 101 3.1% 0.03351.6 KB 2.7% 0.10
Oct 9 11:00:00 - 11:59:59 144 4.4% 0.04465.3 KB 3.5% 0.13
Oct 9 12:00:00 - 12:59:59 124 3.8% 0.03446.6 KB 3.4% 0.12
Oct 9 13:00:00 - 13:59:59 139 4.2% 0.04427.8 KB 3.2% 0.12
Oct 9 14:00:00 - 14:59:59 152 4.6% 0.04591.0 KB 4.5% 0.16
Oct 9 15:00:00 - 15:59:59 143 4.4% 0.04468.8 KB 3.5% 0.13
Oct 9 16:00:00 - 16:59:59 134 4.1% 0.04395.2 KB 3.0% 0.11
Oct 9 17:00:00 - 17:59:59 165 5.0% 0.05696.3 KB 5.3% 0.19
Oct 9 18:00:00 - 18:59:59 195 5.9% 0.05666.4 KB 5.0% 0.19
Oct 9 19:00:00 - 19:59:59 219 6.7% 0.06777.9 KB 5.9% 0.22
Oct 9 20:00:00 - 20:59:59 209 6.4% 0.06890.8 KB 6.7% 0.25
Oct 9 21:00:00 - 21:59:59 202 6.1% 0.061.4 MB 10.6% 0.39
Oct 9 22:00:00 - 22:59:59 239 7.3% 0.07879.9 KB 6.6% 0.24
Oct 9 23:00:00 - 23:59:59 190 5.8% 0.05729.3 KB 5.5% 0.20
Oct 10 00:00:00 - 00:59:59 127 3.9% 0.04377.1 KB 2.8% 0.10
Oct 10 01:00:00 - 01:59:59 84 2.6% 0.02306.9 KB 2.3% 0.09
Oct 10 02:00:00 - 02:59:59 112 3.4% 0.03504.2 KB 3.8% 0.14
Oct 10 03:00:00 - 03:59:59 82 2.5% 0.02294.7 KB 2.2% 0.08
Oct 10 04:00:00 - 04:15:01 21 0.6% 0.0252.4 KB 0.4% 0.06
TOTAL: 24:00:00 3287 100.0% 0.0412.9 MB 100.0% 0.15
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1i2pn.org 235 0 0 0 0 0 0 0 235
2news-out.aioe.org 54 1 0 0 0 0 0 0 53
3news.glou.org 43 0 0 0 0 0 0 0 43
4nntp.terraraq.uk 8 0 0 0 0 0 0 0 8
5feed-out.gegeweb.org 6 0 0 0 0 0 0 0 6
6usenet.pasdenom.info 4 0 0 0 0 0 0 0 4
7gegeweb-out.news.tnetconsulting.net 1 1 0 0 0 0 0 0 0
8news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 8 352 2 0 0 0 0 0 0 350

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
fr.petites-annonces.informatique.materiel 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (phl) 99
EMP (phn nph) 99
Bad path (news.giganews.com.POSTED) 90
Too many newsgroups 33
EMP (md5) 11
EMP (phn path) 3
Cancel for rejected article 3
Too many newsgroups (meow) 2
TOTAL: 8 340

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 9
news.samoylyk.net 1
TOTAL: 2 10
TOTAL: 1 10

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 4269 81 2384 5 0 4 1%23:59:20
2nntp.terraraq.uk 2595 19 2089 12 0 2 0%23:59:57
3news.gegeweb.org 3084 15 2991 13 0 0 0%23:59:57
4news.tnetconsulting.net 5179 10 3268 8 0 3 0%23:59:04
5news.samoylyk.net 3936 0 3246 8 0 0 0%23:59:57
6news.nntp4.net 0 0 0 0 0 3287 0%23:59:57
7news.aioe.org 1704 0 1530 2 0 0 0%23:59:20
8news.pasdenom.info 3272 0 2845 0 0 0 0%23:59:57
TOTAL: 8 24039 125 18353 48 0 3296 0%191:57:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.terraraq.uk310.3 KB607.6 KB917.9 KB0.0 KB/s29.6 KB23:59:57
2i2pn.org194.1 KB67.3 KB261.4 KB0.0 KB/s3.0 KB23:59:20
3news.gegeweb.org36.1 KB64.7 KB100.9 KB0.0 KB/s3.6 KB23:59:57
4news.tnetconsulting.net31.6 KB143.6 KB175.2 KB0.0 KB/s9.7 KB23:59:04
5news.samoylyk.net0.0 KB164.8 KB164.8 KB0.0 KB/s20.6 KB23:59:57
6news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
7news.aioe.org0.0 KB61.9 KB61.9 KB0.0 KB/s31.0 KB23:59:20
8news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
TOTAL: 8572.2 KB1.1 MB1.6 MB0.0 KB/s9.7 KB191:57:29
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1104.156.155.18 81 00.0 KB 0 0 000:00:18
2192.241.217.189 1 00.0 KB 0 0 000:00:00
345.227.254.55 2 00.0 KB 0 0 000:00:00
4mail.gegeweb.eu 288 00.0 KB 0 0 000:01:20
5mail.schaffert.info 238 00.0 KB 0 0 000:04:04
TOTAL: 5 610 00.0 KB 0 0 000:05:45

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 84 00.0 KB 0 0 000:00:19
2*.gegeweb.eu 288 00.0 KB 0 0 000:01:20
3*.schaffert.info 238 00.0 KB 0 0 000:04:04
TOTAL: 3 610 00.0 KB 0 0 000:05:45

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.schaffert.info 6.387 6.303 0.00000:04:04
mail.gegeweb.eu 7.870 8.288 2.47200:01:20
104.156.155.18 2.629 0.603 0.00000:00:18
45.227.254.55 0.046 0.028 0.00000:00:00
192.241.217.189 0.022 0.032 0.00000:00:00
? 0.022 0.022 0.00000:00:00
TOTAL: 6 16.976 15.276 2.47200:05:45

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
45.227.254.55 2
192.241.217.189 1
TOTAL: 2 3

NNRP unrecognized commands (by command):

CommandCount
#003 2
MGLNDD_45.13.105.36_119 1
TOTAL: 2 3

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.55 2 2
TOTAL: 1 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