Daily Usenet report for news.niel.me

Nov 17 04:15:01 -- Nov 18 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 4781 40.2%813.7 KB 44.5%
innd 3614 30.4%528.7 KB 28.9%
nnrpd 1908 16.1%208.9 KB 11.4%
innfeed 1568 13.2%276.7 KB 15.1%
nocem 9 0.1%0.9 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 11881 100.0%1.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 21937 63.7%
Negative hits 7762 22.5%
Do not exist 4720 13.7%
Cache misses 8 0.0%
TOTAL: 4 34427 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.015 0.0%13 1.000 1.154 2.000
article cancel00:00:00.003 0.0%18 0.000 0.167 1.000
article cleanup00:00:00.108 0.0%4729 0.000 0.023 0.150
article logging00:00:00.394 0.0%4747 0.000 0.083 0.231
article parse00:00:00.768 0.0%7281 0.000 0.105 0.208
article write00:00:03.108 0.0%4078 0.158 0.762 11.280
artlog/artcncl00:00:00.001 0.0%18 0.000 0.056 1.000
artlog/artcncl/perl00:00:00.001 0.0%13 0.000 0.077 0.333
data move00:00:00.101 0.0%37078 0.000 0.003 0.012
hisgrep/artcncl00:00:00.000 0.0%15 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%13 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%15 0.000 0.067 0.333
hishave/artcncl00:00:00.001 0.0%18 0.000 0.056 0.333
hishave/artcncl/perl00:00:00.000 0.0%13 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.516 0.0%34475 0.000 0.015 0.040
history sync00:00:00.054 0.0%412 0.000 0.131 1.000
history write00:00:01.114 0.0%4729 0.000 0.236 1.103
hiswrite/artcncl00:00:00.001 0.0%3 0.000 0.333 0.500
idle24:00:25.562 99.9%37805 802.490 2286.088 7499.363
nntp read00:00:01.206 0.0%37087 0.006 0.033 0.079
overview write00:00:02.702 0.0%4078 0.000 0.663 8.000
perl filter00:00:21.535 0.0%4729 2.291 4.554 9.000
python filter00:00:00.009 0.0%4729 0.000 0.002 0.050
site send00:00:01.308 0.0%8165 0.000 0.160 0.483
TOTAL: 24:01:11.11224:00:58.508100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.055 0.0%4270 0.000 0.013 0.133
article prepare00:00:00.002 0.0%792 0.000 0.003 0.062
article read00:00:00.035 0.0%179 0.000 0.196 7.000
backlog stats00:00:00.117 0.0%60145 0.000 0.002 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.836 0.0%34301 0.000 0.024 0.051
data write00:00:02.150 0.0%30116 0.032 0.071 0.133
idle23:59:10.055100.0%60145 467.672 1435.698 3888.840
status file00:00:00.440 0.0%181 1.000 2.431 7.000
TOTAL: 23:59:16.93623:59:13.690100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:42.211 65.7%1216 21.500 182.739 4123.872
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.121 0.0%2905 0.000 0.042 0.333
readart00:00:00.021 0.0%53 0.396 0.396 0.396
TOTAL: 00:05:38.39500:03:42.353 65.7%----

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 2 3996 2202 1711 83 55%22:51:39
2i2pn.org 2 4240 807 3349 84 19%24:28:01
3feed-out.gegeweb.org 291 2850 370 2448 32 12%23:52:16
4nntp.terraraq.uk 1 4966 331 4237 398 6%28:13:18
5news.nntp4.net 2 4360 218 4041 101 5%23:40:43
6usenet.pasdenom.info 1 2226 50 2175 1 2%12:44:47
7gegeweb-out.news.tnetconsulting.net 2 4037 11 4014 12 0%23:56:57
8localhost 28 0 0 0 0 0%00:00:00
TOTAL: 8 329 26675 3989 21975 711 14%159:47:41
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org6.7 MB0.0 KB285.4 KB7.0 MB 96%3.1 KB
2i2pn.org3.2 MB0.0 KB272.2 KB3.5 MB 92%4.0 KB
3nntp.terraraq.uk3.2 MB0.0 KB1.7 MB4.9 MB 64%6.9 KB
4news.nntp4.net1.4 MB0.0 KB230.0 KB1.6 MB 86%5.2 KB
5feed-out.gegeweb.org815.5 KB0.0 KB34.6 KB850.2 KB 95%2.1 KB
6usenet.pasdenom.info103.2 KB0.0 KB1.0 KB104.2 KB 99%2.0 KB
7gegeweb-out.news.tnetconsulting.net34.5 KB0.0 KB186.5 KB221.0 KB 15%9.6 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 815.5 MB0.0 KB2.7 MB18.2 MB 84%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 17 04:15:01 - 04:59:59 61 1.5% 0.02196.2 KB 1.2% 0.07
Nov 17 05:00:00 - 05:59:59 121 3.0% 0.03389.8 KB 2.4% 0.11
Nov 17 06:00:00 - 06:59:59 150 3.7% 0.04536.1 KB 3.3% 0.15
Nov 17 07:00:00 - 07:59:59 91 2.2% 0.03429.3 KB 2.7% 0.12
Nov 17 08:00:00 - 08:59:59 94 2.3% 0.03331.3 KB 2.1% 0.09
Nov 17 09:00:00 - 09:59:59 128 3.1% 0.04375.4 KB 2.3% 0.10
Nov 17 10:00:00 - 10:59:59 124 3.0% 0.03459.6 KB 2.9% 0.13
Nov 17 11:00:00 - 11:59:59 165 4.0% 0.05573.2 KB 3.6% 0.16
Nov 17 12:00:00 - 12:59:59 145 3.6% 0.04913.6 KB 5.7% 0.25
Nov 17 13:00:00 - 13:59:59 198 4.8% 0.06819.6 KB 5.1% 0.23
Nov 17 14:00:00 - 14:59:59 158 3.9% 0.04516.1 KB 3.2% 0.14
Nov 17 15:00:00 - 15:59:59 130 3.2% 0.04373.8 KB 2.3% 0.10
Nov 17 16:00:00 - 16:59:59 219 5.4% 0.06758.8 KB 4.7% 0.21
Nov 17 17:00:00 - 17:59:59 176 4.3% 0.05950.0 KB 5.9% 0.26
Nov 17 18:00:00 - 18:59:59 237 5.8% 0.07853.6 KB 5.3% 0.24
Nov 17 19:00:00 - 19:59:59 272 6.7% 0.08790.9 KB 4.9% 0.22
Nov 17 20:00:00 - 20:59:59 235 5.8% 0.07705.8 KB 4.4% 0.20
Nov 17 21:00:00 - 21:59:59 180 4.4% 0.05840.6 KB 5.2% 0.23
Nov 17 22:00:00 - 22:59:59 219 5.4% 0.061.1 MB 6.7% 0.30
Nov 17 23:00:00 - 23:59:59 181 4.4% 0.05789.0 KB 4.9% 0.22
Nov 18 00:00:00 - 00:59:59 268 6.6% 0.07876.6 KB 5.4% 0.24
Nov 18 01:00:00 - 01:59:59 219 5.4% 0.06846.4 KB 5.3% 0.24
Nov 18 02:00:00 - 02:59:59 151 3.7% 0.041012.1 KB 6.3% 0.28
Nov 18 03:00:00 - 03:59:59 127 3.1% 0.04443.2 KB 2.8% 0.12
Nov 18 04:00:00 - 04:15:01 34 0.8% 0.04232.9 KB 1.4% 0.26
TOTAL: 24:00:00 4083 100.0% 0.0515.7 MB 100.0% 0.19
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 345 0 0 0 0 0 0 0 345
2news-out.aioe.org 102 2 0 0 0 0 0 0 100
3news.nntp4.net 97 0 0 0 0 0 0 0 97
4i2pn.org 80 0 0 0 0 0 0 0 80
5feed-out.gegeweb.org 32 0 0 0 0 0 0 0 32
6gegeweb-out.news.tnetconsulting.net 10 0 0 0 0 0 0 0 10
TOTAL: 6 666 2 0 0 0 0 0 0 664

Unwanted newsgroups [Top 20]:

NewsgroupCount
france.admin.test 1
news.test 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 230
EMP (md5) 143
EMP (phn nph) 122
Bad path (news.giganews.com.POSTED) 108
User-issued spam cancel 40
Too many newsgroups (meow) 1
Cancel of <mn.8aa37e5bc6ef9e21.145333@Rotto.eu> without Cancel-Key 1
Cancel of non-existing ID <61954f2e$0$20253$426a74cc@news.free.fr> 1
TOTAL: 8 646

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com6066
TOTAL: 16066

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 17
news.nntp4.net 1
TOTAL: 2 18
TOTAL: 1 18

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 6287 37 3206 21 0 110 0%23:59:57
2news.tnetconsulting.net 7110 24 4053 5 0 78 0%23:58:51
3news.pasdenom.info 4565 14 3376 17 0 3 0%23:59:57
4news.gegeweb.org 3864 11 3628 60 0 0 0%23:59:43
5news.nntp4.net 4502 5 3861 0 0 0 0%23:59:57
6news.aioe.org 1499 4 1398 0 0 0 0%23:57:59
7nntp.terraraq.uk 2556 0 2492 0 0 0 0%23:59:03
TOTAL: 7 30383 95 22014 103 0 191 0%167:55:27
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org148.4 KB41.5 KB189.9 KB0.0 KB/s3.3 KB23:59:57
2news.tnetconsulting.net114.0 KB18.5 KB132.5 KB0.0 KB/s4.6 KB23:58:51
3news.pasdenom.info65.5 KB785.7 KB851.2 KB0.0 KB/s27.5 KB23:59:57
4news.gegeweb.org39.3 KB233.1 KB272.4 KB0.0 KB/s3.8 KB23:59:43
5news.nntp4.net13.4 KB0.0 KB13.4 KB0.0 KB/s2.7 KB23:59:57
6news.aioe.org12.9 KB0.0 KB12.9 KB0.0 KB/s3.2 KB23:57:59
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:03
TOTAL: 7393.5 KB1.1 MB1.4 MB0.0 KB/s7.4 KB167:55:27
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 1 2453.5 KB 4 0 000:03:13
TOTAL: 1 1 2453.5 KB 4 0 000:05:37

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 1 2453.5 KB 4 0 000:03:13
2unresolved 16 00.0 KB 0 0 000:00:08
3*.gegeweb.eu 288 00.0 KB 0 0 000:02:15
TOTAL: 3 305 2453.5 KB 4 0 000:05:37

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
108b-gniel 0.048 0.048 0.00000:03:13
sys.gegeweb.eu 8.029 9.169 3.03700:02:15
208.100.26.244 0.244 0.107 0.00000:00:03
88.165.5.23 0.105 0.190 0.00000:00:02
170.106.174.246 0.010 0.048 0.00000:00:02
TOTAL: 5 8.436 9.562 3.03700:05:37

Curious NNRP server explorers [Top 20]:

SystemConn
sys.gegeweb.eu 288
208.100.26.244 10
88.165.5.23 5
170.106.174.246 1
TOTAL: 4 304

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
170.106.174.246 3
TOTAL: 1 3

NNRP unrecognized commands (by command):

CommandCount
À#024 1
#023#001#023#002#023#003#001 1
#026#003#001 1
TOTAL: 3 3

NNRP client timeouts [Top 20]:

SystemConnPeer
170.106.174.246 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1fr 23 95.8%
2grisbi 1 4.2%
TOTAL: 2 24100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 21
2fr.comp.lang.basic 1
3fr.comp.lang.ruby 1
4grisbi.test 1
TOTAL: 4 24