Daily Usenet report for news.niel.me

Aug 13 04:15:01 -- Aug 14 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 2393 29.3%452.8 KB 34.1%
innd 2040 25.0%361.9 KB 27.3%
nnrpd 1870 22.9%224.0 KB 16.9%
innfeed 1850 22.7%288.1 KB 21.7%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 8155 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 10927 58.6%
Negative hits 5354 28.7%
Do not exist 2375 12.7%
Cache misses 2 0.0%
TOTAL: 4 18658 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.009 0.0%8 0.000 1.125 2.000
article cancel00:00:00.002 0.0%8 0.000 0.250 1.000
article cleanup00:00:00.058 0.0%2377 0.000 0.024 0.200
article logging00:00:00.181 0.0%2377 0.000 0.076 0.400
article parse00:00:00.299 0.0%6138 0.000 0.049 0.211
article write00:00:01.183 0.0%2125 0.000 0.557 1.286
artlog/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.109 0.0%20570 0.000 0.005 0.029
hisgrep/artcncl00:00:00.002 0.0%8 0.000 0.250 1.000
hisgrep/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%22 0.000 0.045 0.500
hishave/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.313 0.0%18642 0.000 0.017 0.133
history sync00:00:00.044 0.0%398 0.000 0.111 1.000
history write00:00:00.415 0.0%2375 0.000 0.175 0.556
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:46.962100.0%22907 901.404 3773.823 26100.739
nntp read00:00:00.567 0.0%22065 0.000 0.026 0.088
overview write00:00:00.647 0.0%2125 0.000 0.304 5.000
perl filter00:00:08.414 0.0%2375 1.500 3.543 8.500
python filter00:00:00.013 0.0%2375 0.000 0.005 0.200
site send00:00:00.360 0.0%4287 0.000 0.084 0.333
TOTAL: 24:01:06.16824:00:59.579100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:01:20.833 0.1%12452112 0.003 0.006 0.010
article prepare00:00:00.004 0.0%1284 0.000 0.003 0.250
article read00:00:00.052 0.0%303 0.000 0.172 4.000
backlog stats00:00:34.559 0.0%6742084 0.002 0.005 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:01:44.177 0.1%4815637 0.008 0.022 0.036
data write00:01:37.124 0.1%4785171 0.010 0.020 0.032
idle23:38:39.758 99.1%6742084 10.947 12.625 14.625
status file00:00:00.419 0.0%239 0.000 1.753 5.000
TOTAL: 23:52:10.95223:43:56.926 99.4%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:13:55.530 87.5%5906 10.500 141.471 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.901 0.1%21041 0.000 0.043 0.500
readart00:00:00.575 0.1%4452 0.129 0.129 0.129
TOTAL: 00:15:55.03400:13:57.006 87.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
1feed-out.gegeweb.org 3 1963 1189 774 0 60%23:55:14
2gegeweb-out.news.tnetconsulting.net 1 1883 346 1438 99 18%23:06:35
3i2pn.org 2 4100 274 3821 5 6%45:38:31
4news.samoylyk.net 3 2275 142 2131 2 6%25:02:51
5usenet.pasdenom.info 6 1376 139 1189 48 10%25:51:10
6nntp.terraraq.uk 2 1913 49 1864 0 2%23:58:57
7localhost 25 0 0 0 0 0%00:00:00
8news.glou.org 1 0 0 0 0 0%00:00:00
9news.nntp4.net 1 0 0 0 0 0%00:10:03
TOTAL: 9 44 13510 2139 11217 154 15%167:43:21
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org4.6 MB0.0 KB0.0 KB4.6 MB100%4.0 KB
2gegeweb-out.news.tnetconsulting.net1.4 MB3.3 KB440.6 KB1.8 MB 75%4.1 KB
3news.samoylyk.net1.1 MB0.0 KB14.0 KB1.1 MB 98%8.0 KB
4i2pn.org910.6 KB3.3 KB13.7 KB927.5 KB 98%3.3 KB
5nntp.terraraq.uk372.3 KB0.0 KB0.0 KB372.3 KB100%7.6 KB
6usenet.pasdenom.info301.5 KB0.0 KB77.6 KB379.1 KB 79%2.0 KB
7localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
8news.glou.org0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 98.6 MB6.6 KB545.9 KB9.2 MB 94%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 13 04:15:01 - 04:59:59 31 1.5% 0.01121.2 KB 1.4% 0.04
Aug 13 05:00:00 - 05:59:59 58 2.7% 0.02230.4 KB 2.6% 0.06
Aug 13 06:00:00 - 06:59:59 52 2.4% 0.01166.1 KB 1.9% 0.05
Aug 13 07:00:00 - 07:59:59 57 2.7% 0.02199.3 KB 2.3% 0.06
Aug 13 08:00:00 - 08:59:59 53 2.5% 0.01156.9 KB 1.8% 0.04
Aug 13 09:00:00 - 09:59:59 70 3.3% 0.02285.6 KB 3.3% 0.08
Aug 13 10:00:00 - 10:59:59 105 4.9% 0.03469.0 KB 5.3% 0.13
Aug 13 11:00:00 - 11:59:59 64 3.0% 0.02315.0 KB 3.6% 0.09
Aug 13 12:00:00 - 12:59:59 98 4.6% 0.03276.6 KB 3.2% 0.08
Aug 13 13:00:00 - 13:59:59 97 4.6% 0.03295.3 KB 3.4% 0.08
Aug 13 14:00:00 - 14:59:59 106 5.0% 0.03316.3 KB 3.6% 0.09
Aug 13 15:00:00 - 15:59:59 104 4.9% 0.03279.6 KB 3.2% 0.08
Aug 13 16:00:00 - 16:59:59 98 4.6% 0.03326.8 KB 3.7% 0.09
Aug 13 17:00:00 - 17:59:59 95 4.5% 0.03274.3 KB 3.1% 0.08
Aug 13 18:00:00 - 18:59:59 108 5.1% 0.03316.8 KB 3.6% 0.09
Aug 13 19:00:00 - 19:59:59 110 5.2% 0.03379.5 KB 4.3% 0.11
Aug 13 20:00:00 - 20:59:59 169 8.0% 0.051.7 MB 19.7% 0.48
Aug 13 21:00:00 - 21:59:59 115 5.4% 0.03423.8 KB 4.8% 0.12
Aug 13 22:00:00 - 22:59:59 104 4.9% 0.03606.1 KB 6.9% 0.17
Aug 13 23:00:00 - 23:59:59 85 4.0% 0.02286.6 KB 3.3% 0.08
Aug 14 00:00:00 - 00:59:59 100 4.7% 0.03371.5 KB 4.2% 0.10
Aug 14 01:00:00 - 01:59:59 74 3.5% 0.02266.3 KB 3.0% 0.07
Aug 14 02:00:00 - 02:59:59 78 3.7% 0.02215.4 KB 2.5% 0.06
Aug 14 03:00:00 - 03:59:59 69 3.2% 0.02288.7 KB 3.3% 0.08
Aug 14 04:00:00 - 04:15:01 25 1.2% 0.03176.8 KB 2.0% 0.20
TOTAL: 24:00:00 2125 100.0% 0.028.6 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.glou.org 106 0 0 0 0 0 0 0 106
2gegeweb-out.news.tnetconsulting.net 90 0 0 1 0 0 0 0 89
3usenet.pasdenom.info 47 0 0 0 0 0 0 0 47
4nntp.terraraq.uk 5 0 0 0 0 0 0 0 5
5i2pn.org 2 0 0 1 0 0 0 0 1
6news.samoylyk.net 2 0 0 0 0 0 0 0 2
TOTAL: 6 252 0 0 2 0 0 0 0 250

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 132
Bad path (news.giganews.com.POSTED) 93
EMP (md5) 6
HTML Multipart 3
Cancel of <ca046d4b3e95c5e5dddb6556293d85139fa28cf4@i2pn2.org> without Cancel-Key 1
Cancel of <b8bb447c419e1d7122ad6f2bab64025621d0ee41@i2pn2.org> without Cancel-Key 1
Cancel of <MPG.4125fa4cc22b4d7298a4ff@news.individual.net> without Cancel-Key 1
Cancel of <3f79ff03b68aee30eae2af3ee72e6f6fd8c06310@i2pn2.org> without Cancel-Key 1
Cancel of <MPG.4125fa14d75ff2e298a4fe@news.individual.net> without Cancel-Key 1
Cancel of <01810a92fd834127bbfefaa87caedbd89aabcc46@i2pn2.org> without Cancel-Key 1
Cancel of <a7c0df32206d3184f556b07b48699bcc5eea1187@i2pn2.org> without Cancel-Key 1
Cancel of <44ef02dc926cbed7da7dc7a5f1180b3f362d62e0@i2pn2.org> without Cancel-Key 1
Cancel of <1e7f29a07f9733ca21529ce18f36c1f867e6ec17@i2pn2.org> without Cancel-Key 1
Cancels abusifs 1
Cancel of <41401a7d2c64db1a811c03cd1f90d177e089856e@i2pn2.org> without Cancel-Key 1
Cancel for rejected article 1
Cancel of <d66bee6b271309b7def4102dfb1f231f395902c7@i2pn2.org> without Cancel-Key 1
Cancel of <46ed06a680ec353d7c29d086b42e5995dd48df2c@i2pn2.org> without Cancel-Key 1
Cancel of <fff8c68a4a42f8026e167724941d5ad1266f2142@i2pn2.org> without Cancel-Key 1
Cancel of <f3db77f8f16320ca02bae23b5f3cb60efca7437e@i2pn2.org> without Cancel-Key 1
TOTAL: 20 250

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 967 147 801 0 0 0 15%23:57:11
2i2pn.org 3237 95 1851 22 0 32 2%23:58:19
3news.samoylyk.net 2540 14 1935 29 0 15 0%23:58:17
4news.tnetconsulting.net 3380 7 2111 4 0 11 0%23:57:05
5nntp.terraraq.uk 1329 1 1290 1 0 0 0%23:56:40
6news.pasdenom.info 1817 1 1646 0 0 0 0%23:56:44
7news.aioe.org 0 0 0 0 0 1691 0%24:00:00
8news.nntp4.net12616475 0 0 0 012531336 0%23:59:26
TOTAL: 812629745 265 9634 56 012533085 0%191:43:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org429.6 KB0.0 KB429.6 KB0.0 KB/s2.9 KB23:57:11
2i2pn.org281.3 KB452.2 KB733.5 KB0.0 KB/s6.3 KB23:58:19
3news.samoylyk.net53.5 KB165.0 KB218.5 KB0.0 KB/s5.1 KB23:58:17
4news.tnetconsulting.net15.0 KB11.6 KB26.7 KB0.0 KB/s2.4 KB23:57:05
5nntp.terraraq.uk2.5 KB2.1 KB4.6 KB0.0 KB/s2.3 KB23:56:40
6news.pasdenom.info2.0 KB0.0 KB2.0 KB0.0 KB/s2.0 KB23:56:44
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:26
TOTAL: 8783.8 KB631.0 KB1.4 MB0.0 KB/s4.4 KB191:43:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
169.10.48.174 2 445217.9 MB 1 0 000:13:06
TOTAL: 1 2 445217.9 MB 1 0 000:15:54

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 9 445217.9 MB 1 0 000:13:49
2*.ip.linodeusercontent.com 2 00.0 KB 0 0 000:00:01
3*.gegeweb.eu 288 00.0 KB 0 0 000:01:47
4*.monitoring.internet-measurement.com 11 00.0 KB 0 0 000:00:13
5*.150.216.162.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:01
TOTAL: 5 312 445217.9 MB 1 0 000:15:54

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
69.10.48.174 0.629 1.982 0.00000:13:06
mail.gegeweb.eu 4.764 3.983 1.60100:01:47
206.168.34.32 0.034 0.023 0.00000:00:18
198.235.24.144 0.008 0.016 0.00000:00:10
147.185.132.106 0.016 0.006 0.00000:00:10
vivacious.monitoring.internet-measurement.com 0.037 0.029 0.00000:00:06
pretty.monitoring.internet-measurement.com 0.068 0.027 0.00000:00:05
88.214.25.65 0.027 0.023 0.00000:00:01
gorgeous.monitoring.internet-measurement.com 0.040 0.024 0.00000:00:01
172-232-203-69.ip.linodeusercontent.com 0.009 0.014 0.00000:00:00
108.150.216.162.bc.googleusercontent.com 0.079 0.008 0.00000:00:00
55.150.216.162.bc.googleusercontent.com 0.068 0.020 0.00000:00:00
172-232-217-148.ip.linodeusercontent.com 0.026 0.026 0.00000:00:00
198.235.24.195 0.025 0.021 0.00000:00:00
194.165.16.73 0.031 0.023 0.00000:00:00
electrifying.monitoring.internet-measurement.com 0.089 0.038 0.00000:00:00
sturdy.monitoring.internet-measurement.com 0.037 0.025 0.00000:00:00
80.66.76.134 0.035 0.016 0.00000:00:00
fun.monitoring.internet-measurement.com 0.036 0.028 0.00000:00:00
timely.monitoring.internet-measurement.com 0.033 0.029 0.00000:00:00
TOTAL: 21 6.123 6.389 1.60100:15:54

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
electrifying.monitoring.internet-measurement.com 2
80.66.76.134 1
gutsy.monitoring.internet-measurement.com 1
88.214.25.65 1
upstanding.monitoring.internet-measurement.com 1
gorgeous.monitoring.internet-measurement.com 1
147.185.132.106 1
172-232-217-148.ip.linodeusercontent.com 1
172-232-203-69.ip.linodeusercontent.com 1
timely.monitoring.internet-measurement.com 1
55.150.216.162.bc.googleusercontent.com 1
fun.monitoring.internet-measurement.com 1
108.150.216.162.bc.googleusercontent.com 1
vivacious.monitoring.internet-measurement.com 1
majestic.monitoring.internet-measurement.com 1
sturdy.monitoring.internet-measurement.com 1
194.165.16.73 1
198.235.24.195 1
198.235.24.144 1
TOTAL: 22 310

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
55.150.216.162.bc.googleusercontent.com 4
108.150.216.162.bc.googleusercontent.com 4
88.214.25.65 1
206.168.34.32 1
TOTAL: 4 10

NNRP unrecognized commands (by command):

CommandCount
Accept-Encoding: gzip 2
User-Agent: Expanse, a Palo Alto Network... 2
GET / HTTP/1.1 2
Host: 45.13.105.36:563 2
EHLO www.censys.io 1
#003 1
TOTAL: 6 10

NNRP client timeouts [Top 20]:

SystemConnPeer
88.214.25.65 1 1
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 4452100.0%
TOTAL: 1 4452100.0%

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

NewsgroupCount
1grisbi.bugsreports 4452
TOTAL: 1 4452