Daily Usenet report for news.niel.me

Sep 28 04:15:01 -- Sep 29 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 4486 39.6%762.9 KB 44.0%
innd 3424 30.2%519.2 KB 30.0%
nnrpd 1827 16.1%200.1 KB 11.5%
innfeed 1586 14.0%250.9 KB 14.5%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 11325 100.0%1.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 17561 59.5%
Negative hits 7529 25.5%
Do not exist 4435 15.0%
Cache misses 5 0.0%
TOTAL: 4 29530 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.010 0.0%9 0.000 1.111 3.000
article cancel00:00:00.004 0.0%10 0.000 0.400 2.000
article cleanup00:00:00.109 0.0%4452 0.000 0.024 0.286
article logging00:00:00.382 0.0%4464 0.000 0.086 1.571
article parse00:00:00.832 0.0%7854 0.000 0.106 0.294
article write00:00:02.356 0.0%3872 0.167 0.608 3.800
artlog/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%9 0.000 0.000 0.000
data move00:00:00.098 0.0%33297 0.000 0.003 0.020
hisgrep/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.001 0.0%9 0.000 0.111 1.000
hisgrep/perl00:00:00.001 0.0%10 0.000 0.100 1.000
hishave/artcncl00:00:00.000 0.0%10 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.421 0.0%29627 0.000 0.014 0.043
history sync00:00:00.051 0.0%409 0.000 0.125 0.667
history write00:00:00.992 0.0%4452 0.000 0.223 0.684
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:27.224 99.9%33839 1051.177 2554.071 9377.984
nntp read00:00:01.188 0.0%33069 0.000 0.036 0.077
overview write00:00:03.330 0.0%3872 0.059 0.860 42.600
perl filter00:00:21.618 0.0%4452 3.161 4.856 11.833
python filter00:00:00.011 0.0%7221 0.000 0.002 0.042
site send00:00:01.166 0.0%7747 0.000 0.151 0.481
TOTAL: 24:01:11.55124:00:59.794100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.050 0.0%3915 0.000 0.013 0.091
article prepare00:00:00.000 0.0%768 0.000 0.000 0.000
article read00:00:00.035 0.0%173 0.000 0.202 8.000
backlog stats00:00:00.110 0.0%50410 0.000 0.002 0.013
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.691 0.0%28690 0.000 0.024 0.064
data write00:00:01.839 0.0%24766 0.022 0.074 0.138
idle23:50:20.359100.0%50410 600.855 1702.447 5782.029
status file00:00:00.456 0.0%183 1.000 2.492 7.000
TOTAL: 23:50:26.47423:50:23.540100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:48.747 32.6%1190 14.500 40.964 10029.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.096 0.1%2814 0.000 0.034 0.333
readart00:00:00.025 0.0%5 3.000 5.000 5.500
TOTAL: 00:02:29.67500:00:48.868 32.6%----

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 1 4342 1155 3079 108 26%25:34:04
2news.nntp4.net 2 4807 772 3876 159 16%26:37:51
3news-out.aioe.org 1 1290 653 625 12 50%10:32:10
4feed-out.gegeweb.org 291 2559 652 1907 0 25%23:53:56
5nntp.terraraq.uk 1 3687 547 2837 303 14%25:53:53
6usenet.pasdenom.info 2 5059 99 4960 0 1%38:45:13
7gegeweb-out.news.tnetconsulting.net 2 4127 18 4097 12 0%23:57:08
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 325 25871 3896 21381 594 15%175:14:15
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1i2pn.org4.8 MB0.0 KB584.9 KB5.3 MB 89%4.3 KB
2nntp.terraraq.uk4.6 MB0.0 KB1.4 MB6.0 MB 77%7.2 KB
3news.nntp4.net4.1 MB0.0 KB645.7 KB4.8 MB 86%5.2 KB
4news-out.aioe.org2.0 MB0.0 KB55.3 KB2.0 MB 97%3.1 KB
5feed-out.gegeweb.org2.0 MB0.0 KB0.0 KB2.0 MB100%3.1 KB
6gegeweb-out.news.tnetconsulting.net555.4 KB0.0 KB81.4 KB636.8 KB 87%21.2 KB
7usenet.pasdenom.info203.2 KB0.0 KB0.0 KB203.2 KB100%2.1 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 818.2 MB0.0 KB2.7 MB20.9 MB 87%4.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 28 04:15:01 - 04:59:59 92 2.4% 0.03558.6 KB 3.0% 0.21
Sep 28 05:00:00 - 05:59:59 77 2.0% 0.02212.1 KB 1.1% 0.06
Sep 28 06:00:00 - 06:59:59 69 1.8% 0.02273.4 KB 1.5% 0.08
Sep 28 07:00:00 - 07:59:59 106 2.7% 0.03375.7 KB 2.0% 0.10
Sep 28 08:00:00 - 08:59:59 149 3.8% 0.041.4 MB 7.6% 0.39
Sep 28 09:00:00 - 09:59:59 151 3.9% 0.04512.9 KB 2.7% 0.14
Sep 28 10:00:00 - 10:59:59 173 4.5% 0.05491.4 KB 2.6% 0.14
Sep 28 11:00:00 - 11:59:59 134 3.5% 0.04552.1 KB 2.9% 0.15
Sep 28 12:00:00 - 12:59:59 131 3.4% 0.04476.3 KB 2.5% 0.13
Sep 28 13:00:00 - 13:59:59 134 3.5% 0.04474.4 KB 2.5% 0.13
Sep 28 14:00:00 - 14:59:59 147 3.8% 0.04700.6 KB 3.7% 0.19
Sep 28 15:00:00 - 15:59:59 172 4.4% 0.05863.0 KB 4.6% 0.24
Sep 28 16:00:00 - 16:59:59 167 4.3% 0.05598.3 KB 3.2% 0.17
Sep 28 17:00:00 - 17:59:59 210 5.4% 0.06783.3 KB 4.2% 0.22
Sep 28 18:00:00 - 18:59:59 206 5.3% 0.06661.1 KB 3.5% 0.18
Sep 28 19:00:00 - 19:59:59 221 5.7% 0.061.8 MB 9.8% 0.51
Sep 28 20:00:00 - 20:59:59 240 6.2% 0.07927.5 KB 4.9% 0.26
Sep 28 21:00:00 - 21:59:59 239 6.2% 0.07818.6 KB 4.4% 0.23
Sep 28 22:00:00 - 22:59:59 220 5.7% 0.06706.3 KB 3.8% 0.20
Sep 28 23:00:00 - 23:59:59 202 5.2% 0.061.3 MB 6.9% 0.36
Sep 29 00:00:00 - 00:59:59 159 4.1% 0.041.1 MB 6.1% 0.32
Sep 29 01:00:00 - 01:59:59 152 3.9% 0.041019.2 KB 5.4% 0.28
Sep 29 02:00:00 - 02:59:59 110 2.8% 0.03524.3 KB 2.8% 0.15
Sep 29 03:00:00 - 03:59:59 176 4.5% 0.051.1 MB 6.0% 0.31
Sep 29 04:00:00 - 04:15:01 36 0.9% 0.04401.5 KB 2.1% 0.45
TOTAL: 24:00:00 3873 100.0% 0.0418.3 MB 100.0% 0.22
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 308 0 0 0 0 0 0 0 308
2news.nntp4.net 159 1 0 0 0 0 0 0 158
3i2pn.org 99 0 0 0 0 0 0 0 99
4news-out.aioe.org 17 2 0 0 0 0 0 0 15
5gegeweb-out.news.tnetconsulting.net 11 0 0 0 0 0 0 0 11
TOTAL: 5 594 3 0 0 0 0 0 0 591

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.fan.rush-limbaugh 1
fr.petites-annonces.informatique.materiel 1
news.test 1
TOTAL: 3 3

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 239
EMP (phn nph) 168
Bad path (news.giganews.com.POSTED) 135
EMP (md5) 21
User-issued spam cancel 11
Binary: misplaced binary 4
EMP (phl) 1
TOTAL: 7 579

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 5
news.nntp4.net 5
nntp.terraraq.uk 2
TOTAL: 3 12
TOTAL: 1 12

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 6282 62 3800 9 0 22 0%23:59:57
2i2pn.org 4993 31 2650 24 0 32 0%23:57:12
3news.gegeweb.org 3393 6 3102 53 0 0 0%23:59:57
4news.pasdenom.info 4255 4 3281 3 0 3 0%23:59:57
5news.aioe.org 590 1 476 0 0 2105 0%23:57:12
6news.nntp4.net 3224 0 3075 0 0 0 0%23:59:57
7nntp.terraraq.uk 2279 0 2240 0 0 0 0%23:59:57
TOTAL: 7 25016 104 18624 89 0 2162 0%167:54:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net271.4 KB17.3 KB288.7 KB0.0 KB/s4.1 KB23:59:57
2i2pn.org98.0 KB45.2 KB143.3 KB0.0 KB/s2.6 KB23:57:12
3news.pasdenom.info27.3 KB9.3 KB36.7 KB0.0 KB/s5.2 KB23:59:57
4news.gegeweb.org23.8 KB246.1 KB269.8 KB0.0 KB/s4.6 KB23:59:57
5news.aioe.org1.6 KB0.0 KB1.6 KB0.0 KB/s1.6 KB23:57:12
6news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
TOTAL: 7422.2 KB317.9 KB740.1 KB0.0 KB/s3.8 KB167:54:09
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1212.90.61.180 1 28.4 KB 1 0 000:00:01
2108b-gniel 1 16.1 KB 1 0 000:00:14
TOTAL: 2 2 314.5 KB 2 0 000:02:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 4 28.4 KB 1 0 000:00:02
2? 1 16.1 KB 1 0 000:00:14
3*.gegeweb.eu 288 00.0 KB 0 0 000:02:01
4*.about.spyse.com 1 00.0 KB 0 0 000:00:10
TOTAL: 4 294 314.5 KB 2 0 000:02:29

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
sys.gegeweb.eu 7.996 9.010 2.86700:02:01
108b-gniel 0.062 0.012 0.00000:00:14
scanner21.about.spyse.com 0.029 0.029 0.00000:00:10
212.90.61.180 0.035 0.044 0.00000:00:01
94.232.40.30 0.041 0.020 0.00000:00:00
94.232.43.10 0.056 0.030 0.00000:00:00
? 0.037 0.019 0.00000:00:00
TOTAL: 7 8.256 9.164 2.86700:02:29

Curious NNRP server explorers [Top 20]:

SystemConn
sys.gegeweb.eu 288
94.232.43.10 2
scanner21.about.spyse.com 1
94.232.40.30 1
TOTAL: 4 292

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
94.232.43.10 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
#003 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
94.232.43.10 2 2
TOTAL: 1 2 2

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 3100.0%
TOTAL: 1 3100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1grisbi.bugsreports 2
2grisbi.user.french 1
TOTAL: 2 3