Daily Usenet report for news.niel.me

Dec 18 04:15:01 -- Dec 19 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 4946 41.5%847.8 KB 45.8%
innd 3502 29.4%545.3 KB 29.4%
nnrpd 1904 16.0%208.3 KB 11.2%
innfeed 1560 13.1%250.2 KB 13.5%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 11914 100.0%1.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 22811 65.0%
Negative hits 7424 21.1%
Do not exist 4867 13.9%
Cache misses 3 0.0%
TOTAL: 4 35105 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.025 0.0%11 0.000 2.273 14.000
article cancel00:00:00.000 0.0%11 0.000 0.000 0.000
article cleanup00:00:00.117 0.0%4869 0.000 0.024 0.400
article logging00:00:00.393 0.0%4892 0.000 0.080 0.278
article parse00:00:01.328 0.0%11266 0.000 0.118 0.308
article write00:00:04.726 0.0%4292 0.000 1.101 32.095
artlog/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%11 0.000 0.091 1.000
data move00:00:00.118 0.0%42528 0.000 0.003 0.018
hisgrep/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%13 0.000 0.077 0.200
hishave/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.517 0.0%35098 0.000 0.015 0.047
history sync00:00:00.058 0.0%412 0.000 0.141 1.333
history write00:00:01.099 0.0%4869 0.000 0.226 0.610
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:50:17.028 99.9%42246 738.998 2031.365 13963.465
nntp read00:00:01.512 0.0%41614 0.007 0.036 0.112
overview write00:00:04.202 0.0%4292 0.105 0.979 31.833
perl filter00:00:26.162 0.0%4869 2.517 5.373 16.148
python filter00:00:00.014 0.0%4869 0.000 0.003 0.083
site send00:00:01.339 0.0%8650 0.000 0.155 0.536
TOTAL: 23:51:11.65623:50:58.640100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.056 0.0%4404 0.000 0.013 0.158
article prepare00:00:00.002 0.0%2012 0.000 0.001 0.083
article read00:00:00.083 0.0%463 0.000 0.179 6.000
backlog stats00:00:00.138 0.0%63657 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.867 0.0%36376 0.000 0.024 0.062
data write00:00:02.443 0.0%31966 0.034 0.076 0.161
idle23:58:28.773100.0%63657 650.142 1355.841 6008.180
status file00:00:00.448 0.0%176 1.000 2.545 8.000
TOTAL: 23:58:36.37323:58:32.810100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:57.209 35.1%1196 21.500 47.834 10047.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.087 0.1%2879 0.000 0.030 0.500
readart00:00:00.002 0.0%12 0.167 0.167 0.167
TOTAL: 00:02:43.01000:00:57.298 35.1%----

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 4029 1741 2233 55 43%22:27:28
2i2pn.org 1 4211 1245 2851 115 29%25:40:14
3news.nntp4.net 1 5239 684 4382 173 13%26:36:16
4nntp.terraraq.uk 1 6166 270 5553 343 4%31:05:09
5feed-out.gegeweb.org 292 3059 206 2852 1 6%23:56:52
6usenet.pasdenom.info 2 3163 156 3004 3 4%23:48:37
7gegeweb-out.news.tnetconsulting.net 1 3906 33 3867 6 0%23:57:16
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 325 29773 4335 24742 696 14%177:31:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net7.2 MB0.0 KB814.5 KB8.0 MB 90%9.6 KB
2news-out.aioe.org5.5 MB0.0 KB178.9 KB5.7 MB 96%3.3 KB
3i2pn.org5.0 MB0.0 KB536.2 KB5.6 MB 90%4.2 KB
4nntp.terraraq.uk4.0 MB0.0 KB5.9 MB9.9 MB 40%16.5 KB
5feed-out.gegeweb.org1.6 MB0.0 KB1.2 KB1.6 MB 99%7.9 KB
6gegeweb-out.news.tnetconsulting.net1.3 MB0.0 KB33.1 KB1.3 MB 97%34.3 KB
7usenet.pasdenom.info334.7 KB0.0 KB3.7 KB338.5 KB 98%2.1 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 825.0 MB0.0 KB7.4 MB32.4 MB 77%6.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 18 04:15:01 - 04:59:59 59 1.4% 0.02470.9 KB 1.7% 0.17
Dec 18 05:00:00 - 05:59:59 82 1.9% 0.02264.8 KB 1.0% 0.07
Dec 18 06:00:00 - 06:59:59 77 1.8% 0.02287.1 KB 1.0% 0.08
Dec 18 07:00:00 - 07:59:59 164 3.8% 0.05489.1 KB 1.8% 0.14
Dec 18 08:00:00 - 08:59:59 80 1.9% 0.02970.2 KB 3.5% 0.27
Dec 18 09:00:00 - 09:59:59 115 2.7% 0.03295.3 KB 1.1% 0.08
Dec 18 10:00:00 - 10:59:59 109 2.5% 0.03436.0 KB 1.6% 0.12
Dec 18 11:00:00 - 11:59:59 157 3.6% 0.04484.4 KB 1.8% 0.13
Dec 18 12:00:00 - 12:59:59 165 3.8% 0.051.1 MB 4.0% 0.31
Dec 18 13:00:00 - 13:59:59 119 2.8% 0.03460.2 KB 1.7% 0.13
Dec 18 14:00:00 - 14:59:59 173 4.0% 0.05866.2 KB 3.2% 0.24
Dec 18 15:00:00 - 15:59:59 218 5.0% 0.06596.7 KB 2.2% 0.17
Dec 18 16:00:00 - 16:59:59 230 5.3% 0.06695.4 KB 2.5% 0.19
Dec 18 17:00:00 - 17:59:59 250 5.8% 0.07775.3 KB 2.8% 0.22
Dec 18 18:00:00 - 18:59:59 303 7.0% 0.081.3 MB 4.9% 0.37
Dec 18 19:00:00 - 19:59:59 293 6.8% 0.082.1 MB 8.0% 0.61
Dec 18 20:00:00 - 20:59:59 273 6.3% 0.081.7 MB 6.3% 0.48
Dec 18 21:00:00 - 21:59:59 280 6.5% 0.08997.0 KB 3.6% 0.28
Dec 18 22:00:00 - 22:59:59 244 5.6% 0.072.7 MB 9.9% 0.75
Dec 18 23:00:00 - 23:59:59 221 5.1% 0.062.5 MB 9.2% 0.70
Dec 19 00:00:00 - 00:59:59 208 4.8% 0.062.0 MB 7.6% 0.58
Dec 19 01:00:00 - 01:59:59 179 4.1% 0.052.0 MB 7.6% 0.58
Dec 19 02:00:00 - 02:59:59 133 3.1% 0.041.6 MB 5.9% 0.45
Dec 19 03:00:00 - 03:59:59 148 3.4% 0.041.6 MB 6.1% 0.46
Dec 19 04:00:00 - 04:15:01 41 0.9% 0.05261.3 KB 1.0% 0.29
TOTAL: 24:00:00 4321 100.0% 0.0526.8 MB 100.0% 0.32
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 251 0 0 0 0 0 0 0 251
2news.nntp4.net 169 0 0 0 0 0 0 0 169
3i2pn.org 99 0 0 0 0 0 0 0 99
4news-out.aioe.org 68 1 0 0 0 0 0 0 67
5gegeweb-out.news.tnetconsulting.net 13 0 0 0 0 0 0 0 13
6usenet.pasdenom.info 2 0 0 0 0 0 0 0 2
7feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 603 1 0 0 0 0 0 0 602

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 187
EMP (phn nph) 131
Bad path (news.giganews.com.POSTED) 124
EMP (md5) 113
User-issued spam cancel 20
Too many newsgroups (low_xpost) 1
Cancel of non-existing ID <snsj3l$dvr$1@shakotay.alphanet.ch> 1
Cancel of non-existing ID <sna4fl$n83$1@shakotay.alphanet.ch> 1
Cancel with broken target ID 1
TOTAL: 9 579

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 19
news.nntp4.net 4
TOTAL: 2 23
TOTAL: 1 23

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 4089 68 3594 276 0 0 1%23:59:56
2news.pasdenom.info 5657 37 3647 49 0 5 0%23:59:56
3news.tnetconsulting.net 7225 22 4293 2 0 36 0%23:59:52
4i2pn.org 5840 12 2973 31 0 45 0%23:57:28
5news.nntp4.net 3997 3 3668 0 0 0 0%23:59:36
6nntp.terraraq.uk 2895 3 2787 0 0 0 0%23:59:54
7news.aioe.org 2040 0 1902 0 0 0 0%23:58:14
TOTAL: 7 31743 145 22864 358 0 86 0%167:54:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org311.9 KB1.1 MB1.4 MB0.0 KB/s4.3 KB23:59:56
2news.tnetconsulting.net182.8 KB3.5 KB186.4 KB0.0 KB/s7.8 KB23:59:52
3news.pasdenom.info152.6 KB3.1 MB3.2 MB0.0 KB/s38.5 KB23:59:56
4i2pn.org45.6 KB65.5 KB111.1 KB0.0 KB/s2.6 KB23:57:28
5nntp.terraraq.uk23.1 KB0.0 KB23.1 KB0.0 KB/s7.7 KB23:59:54
6news.nntp4.net7.1 KB0.0 KB7.1 KB0.0 KB/s2.4 KB23:59:36
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:14
TOTAL: 7723.2 KB4.3 MB5.0 MB0.0 KB/s10.1 KB167:54:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 1 615.6 KB 1 0 000:00:15
TOTAL: 1 1 615.6 KB 1 0 000:02:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 1 615.6 KB 1 0 000:00:15
2unresolved 13 00.0 KB 0 0 000:00:22
3*.gegeweb.eu 288 00.0 KB 0 0 000:02:04
TOTAL: 3 302 615.6 KB 1 0 000:02:42

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 8.182 8.952 3.03500:02:04
23.224.186.36 0.081 0.038 0.00000:00:15
108b-gniel 0.030 0.050 0.00000:00:15
172.104.238.162 0.037 0.028 0.00000:00:02
178.128.38.105 0.020 0.039 0.00000:00:02
167.71.233.191 0.239 0.213 0.00000:00:02
158.255.7.151 0.043 0.043 0.00000:00:00
TOTAL: 7 8.632 9.363 3.03500:02:42

Curious NNRP server explorers [Top 20]:

SystemConn
sys.gegeweb.eu 288
167.71.233.191 8
23.224.186.36 2
172.104.238.162 1
178.128.38.105 1
158.255.7.151 1
TOTAL: 6 301

NNRP unrecognized commands (by host):

SystemConn
167.71.233.191 42
23.224.186.36 2
TOTAL: 2 44

NNRP unrecognized commands (by command):

CommandCount
Accept: */* 7
Host: 185.73.232.189:119 7
Accept-Encoding: gzip, deflate 7
Connection: keep-alive 7
User-Agent: Mozilla/5.0 (Windows NT 10.0... 6
GET /c/version.js HTTP/1.1 1
User-Agent: AlexaMediaPlayer/2.1.4676.0 ... 1
GET /system_api.php HTTP/1.1 1
GET /stalker_portal/c/version.js HTTP/1.... 1
#026#003#001 1
GET / HTTP/1.1 1
GET /flu/403.html HTTP/1.1 1
GET /stream/live.php HTTP/1.1 1
GET /streaming/clients_live.php HTTP/1.1 1
#001 1
TOTAL: 15 44

NNRP client timeouts [Top 20]:

SystemConnPeer
23.224.186.36 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1fr 6100.0%
TOTAL: 1 6100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 6
TOTAL: 1 6