Daily Usenet report for news.niel.me

Aug 31 04:15:02 -- Sep 1 04:15:02

Log entries by program:

Program nameLines%LinesSize%Size
inn 5334 46.5%904.7 KB 50.2%
innd 2628 22.9%430.9 KB 23.9%
nnrpd 1942 16.9%203.7 KB 11.3%
innfeed 1535 13.4%261.9 KB 14.5%
nocem 14 0.1%1.4 KB 0.1%
controlchan 6 0.1%1.0 KB 0.1%
TOTAL: 6 11459 100.0%1.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 27239 66.0%
Negative hits 8712 21.1%
Do not exist 5286 12.8%
Cache misses 3 0.0%
TOTAL: 4 41240 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.017 0.0%12 0.000 1.417 5.000
article cancel00:00:00.004 0.0%23 0.000 0.174 3.000
article cleanup00:00:00.125 0.0%5284 0.000 0.024 0.125
article logging00:00:00.399 0.0%5303 0.000 0.075 0.308
article parse00:00:00.938 0.0%8366 0.000 0.112 0.214
article write00:00:04.767 0.0%4527 0.133 1.053 37.074
artlog/artcncl00:00:00.001 0.0%21 0.000 0.048 1.000
artlog/artcncl/perl00:00:00.000 0.0%12 0.000 0.000 0.000
data move00:00:00.131 0.0%44762 0.000 0.003 0.014
hisgrep/artcncl00:00:00.000 0.0%15 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%12 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%14 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%23 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%12 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.547 0.0%41276 0.000 0.013 0.032
history sync00:00:00.058 0.0%406 0.000 0.143 1.333
history write00:00:01.142 0.0%5284 0.000 0.216 0.562
hiswrite/artcncl00:00:00.001 0.0%8 0.000 0.125 0.333
idle24:00:12.297 99.9%44590 481.395 1937.930 6456.409
nntp read00:00:01.483 0.0%44229 0.006 0.034 0.062
overview write00:00:02.943 0.0%4527 0.167 0.650 4.733
perl filter00:00:25.669 0.0%5284 2.900 4.858 9.722
python filter00:00:00.016 0.0%8464 0.000 0.002 0.050
site send00:00:01.003 0.0%9069 0.000 0.111 0.455
TOTAL: 24:01:09.33124:00:51.541100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.046 0.0%4577 0.000 0.010 0.100
article prepare00:00:00.002 0.0%1448 0.000 0.001 0.062
article read00:00:00.064 0.0%325 0.000 0.197 2.250
backlog stats00:00:00.134 0.0%63735 0.000 0.002 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.867 0.0%37475 0.000 0.023 0.050
data write00:00:02.301 0.0%32819 0.026 0.070 0.134
idle23:59:40.142100.0%63735 339.386 1355.302 3408.452
status file00:00:00.396 0.0%161 1.000 2.460 8.000
TOTAL: 23:59:47.58423:59:43.952100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%1 0.000 0.000 0.000
idle00:13:30.242 77.5%1519 6.400 533.405 20833.379
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.149 0.0%3655 0.000 0.041 0.273
readart00:00:00.012 0.0%14 0.000 0.857 1.333
TOTAL: 00:17:25.91700:13:30.403 77.5%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
us-control@lists.killfile.org001001
TOTAL001001

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 1 4840 2003 2711 126 41%24:50:55
2i2pn.org 1 4365 756 3557 52 17%22:15:41
3nntp.terraraq.uk 2 4368 671 3185 512 15%25:00:01
4feed-out.gegeweb.org 2 3378 593 2785 0 17%23:59:16
5usenet.pasdenom.info 5 7050 285 6761 4 4%54:09:48
6news.nntp4.net 6 4658 191 4400 67 4%22:49:49
7gegeweb-out.news.tnetconsulting.net 2 4078 82 3962 34 2%23:58:00
8localhost 30 1 1 0 0 100%00:00:00
TOTAL: 8 49 32738 4582 27361 795 13%197:03:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org6.5 MB0.0 KB570.6 KB7.1 MB 92%3.4 KB
2nntp.terraraq.uk5.4 MB0.0 KB1.8 MB7.2 MB 75%6.3 KB
3i2pn.org2.9 MB0.0 KB177.7 KB3.0 MB 94%3.8 KB
4feed-out.gegeweb.org1.6 MB0.0 KB0.0 KB1.6 MB100%2.7 KB
5news.nntp4.net1.2 MB0.0 KB172.1 KB1.3 MB 87%5.3 KB
6usenet.pasdenom.info908.1 KB2.0 KB7.6 KB917.6 KB 98%3.2 KB
7gegeweb-out.news.tnetconsulting.net205.3 KB0.0 KB131.6 KB336.9 KB 60%2.9 KB
8localhost1.8 KB0.0 KB0.0 KB1.8 KB100%1.8 KB
TOTAL: 818.7 MB2.0 KB2.8 MB21.5 MB 86%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 31 04:15:02 - 04:59:59 83 1.8% 0.03322.9 KB 1.7% 0.12
Aug 31 05:00:00 - 05:59:59 115 2.5% 0.03434.4 KB 2.3% 0.12
Aug 31 06:00:00 - 06:59:59 108 2.4% 0.03360.4 KB 1.9% 0.10
Aug 31 07:00:00 - 07:59:59 117 2.6% 0.031018.5 KB 5.3% 0.28
Aug 31 08:00:00 - 08:59:59 90 2.0% 0.03250.4 KB 1.3% 0.07
Aug 31 09:00:00 - 09:59:59 127 2.8% 0.04378.2 KB 2.0% 0.11
Aug 31 10:00:00 - 10:59:59 133 2.9% 0.04410.7 KB 2.1% 0.11
Aug 31 11:00:00 - 11:59:59 126 2.8% 0.04959.7 KB 5.0% 0.27
Aug 31 12:00:00 - 12:59:59 130 2.9% 0.04397.6 KB 2.1% 0.11
Aug 31 13:00:00 - 13:59:59 158 3.5% 0.04657.0 KB 3.4% 0.18
Aug 31 14:00:00 - 14:59:59 183 4.0% 0.05529.9 KB 2.8% 0.15
Aug 31 15:00:00 - 15:59:59 217 4.8% 0.06624.3 KB 3.2% 0.17
Aug 31 16:00:00 - 16:59:59 202 4.5% 0.061.2 MB 6.3% 0.34
Aug 31 17:00:00 - 17:59:59 262 5.8% 0.07953.9 KB 5.0% 0.26
Aug 31 18:00:00 - 18:59:59 249 5.5% 0.07993.2 KB 5.2% 0.28
Aug 31 19:00:00 - 19:59:59 334 7.4% 0.091.2 MB 6.3% 0.33
Aug 31 20:00:00 - 20:59:59 246 5.4% 0.07874.3 KB 4.5% 0.24
Aug 31 21:00:00 - 21:59:59 340 7.5% 0.091.7 MB 9.1% 0.49
Aug 31 22:00:00 - 22:59:59 317 7.0% 0.091.2 MB 6.3% 0.33
Aug 31 23:00:00 - 23:59:59 247 5.5% 0.07880.5 KB 4.6% 0.24
Sep 1 00:00:00 - 00:59:59 209 4.6% 0.06833.3 KB 4.3% 0.23
Sep 1 01:00:00 - 01:59:59 202 4.5% 0.06739.6 KB 3.8% 0.21
Sep 1 02:00:00 - 02:59:59 198 4.4% 0.061.7 MB 9.3% 0.50
Sep 1 03:00:00 - 03:59:59 104 2.3% 0.03390.5 KB 2.0% 0.11
Sep 1 04:00:00 - 04:15:02 29 0.6% 0.0384.6 KB 0.4% 0.09
TOTAL: 24:00:00 4526 100.0% 0.0518.8 MB 100.0% 0.22
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 480 0 0 0 0 0 0 0 480
2news-out.aioe.org 135 2 0 0 0 0 0 0 133
3news.nntp4.net 70 1 0 0 0 0 0 0 69
4i2pn.org 59 0 0 0 0 0 0 0 59
5gegeweb-out.news.tnetconsulting.net 17 0 0 0 0 0 0 0 17
6usenet.pasdenom.info 13 0 0 0 0 0 0 0 13
7feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 775 3 0 0 0 0 0 0 772

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.petites-annonces.divers 1
news.test 1
ba.broadcast 1
TOTAL: 3 3

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 395
Bad path (news.giganews.com.POSTED) 147
EMP (phn nph) 129
EMP (phl) 50
EMP (md5) 17
User-issued spam cancel 13
Cancel of non-existing ID <612e5c46$0$6185$426a74cc@news.free.fr> 1
Cancels abusifs 1
TOTAL: 8 753

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1001010
TOTAL: 11001010

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 15
nntp.terraraq.uk 2
feed-out.gegeweb.org 1
usenet.pasdenom.info 1
TOTAL: 4 19
TOTAL: 1 19

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 6822 131 3418 86 0 27 1%23:59:57
2news.tnetconsulting.net 7725 70 4449 6 0 21 0%23:59:57
3news.gegeweb.org 4142 9 3896 37 0 0 0%23:59:57
4nntp.terraraq.uk 3016 7 2696 0 0 0 0%23:59:57
5news.nntp4.net 5021 7 4322 1 0 0 0%23:59:48
6news.pasdenom.info 3776 4 3662 3 0 1 0%23:59:57
7news.aioe.org 2413 1 1995 0 0 1 0%23:59:57
TOTAL: 7 32915 229 24438 133 0 50 0%167:59:30
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org337.5 KB172.2 KB509.6 KB0.0 KB/s2.3 KB23:59:57
2news.tnetconsulting.net248.2 KB18.4 KB266.6 KB0.0 KB/s3.5 KB23:59:57
3news.gegeweb.org29.1 KB180.4 KB209.5 KB0.0 KB/s4.6 KB23:59:57
4nntp.terraraq.uk27.0 KB0.0 KB27.0 KB0.0 KB/s3.9 KB23:59:57
5news.nntp4.net20.8 KB2.2 KB23.0 KB0.0 KB/s2.9 KB23:59:48
6news.pasdenom.info13.0 KB10.0 KB23.1 KB0.0 KB/s3.3 KB23:59:57
7news.aioe.org1.8 KB0.0 KB1.8 KB0.0 KB/s1.8 KB23:59:57
TOTAL: 7677.4 KB383.1 KB1.0 MB0.0 KB/s2.9 KB167:59:30
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 3 1432.5 KB 3 1 000:13:09
TOTAL: 1 3 1432.5 KB 3 1 000:17:25

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 3 1432.5 KB 3 1 000:13:09
2*.gegeweb.eu 287 00.0 KB 0 0 000:03:39
3*.security.ipip.net 1 00.0 KB 0 0 000:00:01
4unresolved 5 00.0 KB 0 0 000:00:33
5*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 5 297 1432.5 KB 3 1 000:17:25

NNRP auth users [Top 20]:

UserConn
mailman 287
TOTAL: 1 287

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
108b-gniel 0.162 0.130 0.00000:13:09
mail.gegeweb.eu 8.336 9.337 3.38800:03:39
88.165.5.23 0.097 0.089 0.00000:00:22
165.227.221.108 0.039 0.020 0.00000:00:10
scan-141.security.ipip.net 0.032 0.021 0.00000:00:01
89.248.168.226 0.043 0.011 0.00000:00:00
scanner-09.ch1.censys-scanner.com 0.038 0.028 0.00000:00:00
TOTAL: 7 8.747 9.636 3.38800:17:25

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 287
88.165.5.23 3
scanner-09.ch1.censys-scanner.com 1
165.227.221.108 1
89.248.168.226 1
scan-141.security.ipip.net 1
TOTAL: 6 294

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
scanner-09.ch1.censys-scanner.com 1
89.248.168.226 1
TOTAL: 3 6

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 1
Host: 185.73.232.189:119 1
Connection: close 1
EHLO www.censys.io 1
User-Agent: HTTP Banner Detection (https... 1
#003 1
TOTAL: 6 6

NNRP client timeouts [Top 20]:

SystemConnPeer
89.248.168.226 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1news 14100.0%
TOTAL: 1 14100.0%

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

NewsgroupCount
1news.admin.peering 14
TOTAL: 1 14