Daily Usenet report for news.niel.me

Feb 2 04:15:01 -- Feb 3 04:15:02

Log entries by program:

Program nameLines%LinesSize%Size
inn 6441 39.8%1.1 MB 45.2%
innfeed 5490 33.9%715.8 KB 29.5%
innd 2428 15.0%411.3 KB 16.9%
nnrpd 1827 11.3%203.8 KB 8.4%
nocem 2 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 16189 100.0%2.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 28105 61.7%
Negative hits 11399 25.0%
Do not exist 5757 12.6%
Cache misses 297 0.7%
TOTAL: 4 45558 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:01.021 0.0%302 0.000 3.381 7.000
article cancel00:00:00.042 0.0%304 0.000 0.138 1.000
article cleanup00:00:00.100 0.0%5804 0.000 0.017 0.136
article logging00:00:00.429 0.0%5827 0.000 0.074 0.200
article parse00:00:00.947 0.0%10496 0.000 0.090 0.267
article write00:00:05.838 0.0%5120 0.267 1.140 50.593
artlog/artcncl00:00:00.018 0.0%303 0.000 0.059 1.000
artlog/artcncl/perl00:00:00.021 0.0%302 0.000 0.070 0.074
data move00:00:00.117 0.0%49578 0.000 0.002 0.013
hisgrep/artcncl00:00:00.004 0.0%303 0.000 0.013 0.014
hisgrep/artcncl/perl00:00:00.015 0.0%302 0.000 0.050 1.000
hisgrep/perl00:00:00.014 0.0%304 0.000 0.046 0.333
hishave/artcncl00:00:00.002 0.0%304 0.000 0.007 0.007
hishave/artcncl/perl00:00:00.007 0.0%302 0.000 0.023 0.025
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.640 0.0%45024 0.000 0.014 0.050
history sync00:00:00.038 0.0%401 0.000 0.095 1.000
history write00:00:01.319 0.0%5764 0.000 0.229 0.804
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle24:00:08.907 99.9%49815 240.642 1734.596 5557.806
nntp read00:00:01.504 0.0%49255 0.006 0.031 0.075
overview write00:00:02.965 0.0%5120 0.077 0.579 6.556
perl filter00:00:27.367 0.0%5764 2.882 4.748 11.919
python filter00:00:00.006 0.0%5764 0.000 0.001 0.062
site send00:00:01.334 0.0%10275 0.000 0.130 0.474
TOTAL: 24:01:06.92324:00:52.655100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.064 0.0%6964 0.000 0.009 0.105
article prepare00:00:00.003 0.0%1388 0.000 0.002 0.125
article read00:00:00.036 0.0%302 0.000 0.119 8.000
backlog stats00:00:00.137 0.0%70362 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.958 0.0%41569 0.000 0.023 0.069
data write00:00:02.291 0.0%36574 0.027 0.063 0.129
idle23:57:02.122100.0%70362 312.051 1225.407 3269.141
status file00:00:10.031 0.0%2610 1.000 3.843 82.692
TOTAL: 23:57:23.14623:57:15.642100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:19.957 5.2%1450 0.000 13.763 548.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.134 0.0%3464 0.000 0.039 0.273
readart00:00:00.020 0.0%28 0.714 0.714 0.714
TOTAL: 00:06:24.55200:00:20.111 5.2%----

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 5684 2973 2592 119 52%26:29:20
2i2pn.org 1 5092 1171 3785 136 22%24:24:26
3feed-out.gegeweb.org 3 3710 675 3024 11 18%24:04:08
4nntp.terraraq.uk 1 6300 417 5650 233 6%28:53:30
5usenet.pasdenom.info 2 3585 93 3492 0 2%23:59:24
6news.nntp4.net 2 7754 68 7471 215 0%31:51:42
7gegeweb-out.news.tnetconsulting.net 1 3290 14 3270 6 0%16:12:16
8localhost 26 0 0 0 0 0%00:00:00
TOTAL: 8 38 35415 5411 29284 720 15%175:54:46
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org9.2 MB46.7 KB329.4 KB9.6 MB 96%3.2 KB
2i2pn.org5.1 MB8.1 KB478.8 KB5.6 MB 91%4.4 KB
3feed-out.gegeweb.org3.6 MB48.3 KB48.3 KB3.7 MB 97%5.5 KB
4nntp.terraraq.uk2.9 MB10.3 KB1.2 MB4.1 MB 71%6.4 KB
5news.nntp4.net1.7 MB5.6 KB710.0 KB2.4 MB 70%8.7 KB
6usenet.pasdenom.info201.0 KB0.0 KB0.0 KB201.0 KB100%2.2 KB
7gegeweb-out.news.tnetconsulting.net65.1 KB5.7 KB19.8 KB90.7 KB 71%4.5 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 822.8 MB124.8 KB2.7 MB25.6 MB 88%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 2 04:15:01 - 04:59:59 85 1.7% 0.03241.2 KB 1.1% 0.09
Feb 2 05:00:00 - 05:59:59 210 4.1% 0.06607.2 KB 2.8% 0.17
Feb 2 06:00:00 - 06:59:59 400 7.8% 0.112.1 MB 9.9% 0.59
Feb 2 07:00:00 - 07:59:59 146 2.8% 0.04531.4 KB 2.5% 0.15
Feb 2 08:00:00 - 08:59:59 102 2.0% 0.03478.6 KB 2.2% 0.13
Feb 2 09:00:00 - 09:59:59 119 2.3% 0.03455.2 KB 2.1% 0.13
Feb 2 10:00:00 - 10:59:59 164 3.2% 0.05432.0 KB 2.0% 0.12
Feb 2 11:00:00 - 11:59:59 112 2.2% 0.03553.5 KB 2.6% 0.15
Feb 2 12:00:00 - 12:59:59 147 2.9% 0.04711.3 KB 3.3% 0.20
Feb 2 13:00:00 - 13:59:59 121 2.4% 0.03471.7 KB 2.2% 0.13
Feb 2 14:00:00 - 14:59:59 229 4.5% 0.061.6 MB 7.4% 0.44
Feb 2 15:00:00 - 15:59:59 321 6.3% 0.091.6 MB 7.5% 0.45
Feb 2 16:00:00 - 16:59:59 226 4.4% 0.061.7 MB 7.9% 0.47
Feb 2 17:00:00 - 17:59:59 258 5.0% 0.071.1 MB 5.3% 0.32
Feb 2 18:00:00 - 18:59:59 301 5.9% 0.08926.0 KB 4.3% 0.26
Feb 2 19:00:00 - 19:59:59 272 5.3% 0.08794.0 KB 3.7% 0.22
Feb 2 20:00:00 - 20:59:59 288 5.6% 0.08948.2 KB 4.4% 0.26
Feb 2 21:00:00 - 21:59:59 324 6.3% 0.091.1 MB 5.2% 0.31
Feb 2 22:00:00 - 22:59:59 219 4.3% 0.06787.3 KB 3.6% 0.22
Feb 2 23:00:00 - 23:59:59 214 4.2% 0.06768.0 KB 3.5% 0.21
Feb 3 00:00:00 - 00:59:59 245 4.8% 0.07818.7 KB 3.8% 0.23
Feb 3 01:00:00 - 01:59:59 254 5.0% 0.07834.0 KB 3.9% 0.23
Feb 3 02:00:00 - 02:59:59 218 4.3% 0.061.4 MB 6.6% 0.39
Feb 3 03:00:00 - 03:59:59 123 2.4% 0.03445.4 KB 2.1% 0.12
Feb 3 04:00:00 - 04:15:02 30 0.6% 0.03103.5 KB 0.5% 0.11
TOTAL: 24:00:01 5128 100.0% 0.0621.1 MB 100.0% 0.25
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 273 0 0 3 0 0 0 0 270
2news.nntp4.net 146 0 0 1 0 0 0 0 145
3news-out.aioe.org 134 20 0 21 0 0 0 0 93
4i2pn.org 133 0 0 3 0 0 0 0 130
5feed-out.gegeweb.org 13 0 0 11 0 0 0 0 2
6gegeweb-out.news.tnetconsulting.net 8 0 0 1 0 0 0 0 7
7usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
TOTAL: 7 708 20 0 40 0 0 0 0 648

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.survival 16
soc.culture.russia 2
alt.fan.rush-limbaugh 1
news.test 1
TOTAL: 4 20

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 187
Bad path (news.giganews.com.POSTED) 163
EMP (phn nph) 147
EMP (md5) 87
User-issued spam cancel 40
Cancel of non-existing ID <BTKJJ.9647$rU.4727@fx34.iad> 1
TOTAL: 6 625

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1011
TOTAL: 11011

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 7477 166 3772 0 0 206 2%23:59:51
2news.tnetconsulting.net 8692 51 5068 5 0 247 0%23:59:54
3news.nntp4.net 5645 25 5049 0 0 235 0%23:59:28
4news.gegeweb.org 4880 18 4386 45 0 0 0%23:59:42
5news.pasdenom.info 4923 9 4661 14 0 355 0%23:59:54
6nntp.terraraq.uk 3363 0 3290 0 0 0 0%23:59:53
7news.aioe.org 806 0 0 0 0 2578 0%23:57:45
TOTAL: 7 35786 269 26226 64 0 3621 0%167:56:27
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org528.2 KB0.0 KB528.2 KB0.0 KB/s3.2 KB23:59:51
2news.tnetconsulting.net179.6 KB9.1 KB188.6 KB0.0 KB/s3.4 KB23:59:54
3news.nntp4.net99.9 KB0.0 KB99.9 KB0.0 KB/s4.0 KB23:59:28
4news.gegeweb.org77.6 KB359.1 KB436.7 KB0.0 KB/s6.9 KB23:59:42
5news.pasdenom.info74.6 KB111.6 KB186.2 KB0.0 KB/s8.1 KB23:59:54
6nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:45
TOTAL: 7959.9 KB479.7 KB1.4 MB0.0 KB/s4.3 KB167:56:27
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12a0e:e701:1154:0:247c:68f8:d386:5c9d 1 15124.7 KB 7 0 000:03:04
TOTAL: 1 1 15124.7 KB 7 0 000:06:23

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 1 15124.7 KB 7 0 000:03:04
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3unresolved 1 00.0 KB 0 0 000:00:01
4*.us-west-2.compute.amazonaws.com 2 00.0 KB 0 0 000:00:00
5*.gegeweb.eu 288 00.0 KB 0 0 000:03:16
TOTAL: 5 293 15124.7 KB 7 0 000:06:23

NNRP auth users [Top 20]:

UserConn
mailman 288
gerald 1
TOTAL: 2 289

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 7.766 8.171 3.07700:03:16
2a0e:e701:1154:0:247c:68f8:d386:5c9d 0.119 0.018 0.01500:03:04
43.130.57.239 0.010 0.039 0.00000:00:01
scanner-05.ch1.censys-scanner.com 0.023 0.045 0.00000:00:00
ec2-35-87-227-253.us-west-2.compute.amazonaws.com 0.065 0.022 0.00000:00:00
ec2-35-86-34-160.us-west-2.compute.amazonaws.com 0.030 0.020 0.00000:00:00
TOTAL: 6 8.013 8.315 3.09200:06:23

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
ec2-35-87-227-253.us-west-2.compute.amazonaws.com 1
43.130.57.239 1
scanner-05.ch1.censys-scanner.com 1
ec2-35-86-34-160.us-west-2.compute.amazonaws.com 1
TOTAL: 5 292

NNRP unrecognized commands (by host):

SystemConn
43.130.57.239 3
scanner-05.ch1.censys-scanner.com 1
TOTAL: 2 4

NNRP unrecognized commands (by command):

CommandCount
À#024 1
EHLO www.censys.io 1
#026#003#001 1
#023#001#023#002#023#003#001 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
43.130.57.239 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1fr 12 80.0%
2grisbi 2 13.3%
3news 1 6.7%
TOTAL: 3 15100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 5
2fr.comp.usenet.lecteurs-de-news 2
3fr.usenet.documents 2
4fr.usenet.distribution 2
5grisbi.test 2
6news.admin.peering 1
7fr.usenet.forums.annonces 1
TOTAL: 7 15