Daily Usenet report for news.niel.me

Sep 15 04:15:01 -- Sep 16 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Sep 15 17:00:08 rpi-studio pgpverify[20525]: pgpverify: verification failed
Sep 15 17:00:19 rpi-studio pgpverify[20542]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 2290 27.5%435.1 KB 32.6%
nnrpd 2119 25.4%235.7 KB 17.7%
innd 2115 25.4%382.2 KB 28.6%
innfeed 1792 21.5%278.7 KB 20.9%
controlchan 13 0.2%2.3 KB 0.2%
pgpverify 2 0.0%0.3 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 7 8332 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 12635 60.3%
Negative hits 6069 28.9%
Do not exist 2260 10.8%
Cache misses 6 0.0%
TOTAL: 4 20970 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.020 0.0%14 0.000 1.429 2.500
article cancel00:00:00.003 0.0%14 0.000 0.214 1.000
article cleanup00:00:00.046 0.0%2262 0.000 0.020 0.222
article logging00:00:00.166 0.0%2262 0.000 0.073 0.500
article parse00:00:00.436 0.0%5753 0.000 0.076 0.400
article write00:00:01.098 0.0%2090 0.000 0.525 1.000
artlog/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%14 0.000 0.071 1.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.135 0.0%23119 0.000 0.006 0.056
hisgrep/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.001 0.0%14 0.000 0.071 0.500
hisgrep/perl00:00:00.002 0.0%17 0.000 0.118 1.000
hishave/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.001 0.0%14 0.000 0.071 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.341 0.0%20959 0.000 0.016 0.077
history sync00:00:00.073 0.0%404 0.000 0.181 1.000
history write00:00:00.443 0.0%2262 0.000 0.196 0.526
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:59.150100.0%24824 571.398 3482.886 26130.652
nntp read00:00:00.639 0.0%23998 0.000 0.027 0.098
overview write00:00:00.720 0.0%2090 0.000 0.344 3.857
perl filter00:00:10.386 0.0%2262 2.143 4.592 15.500
python filter00:00:00.010 0.0%2262 0.000 0.004 0.077
site send00:00:00.727 0.0%4218 0.000 0.172 0.514
TOTAL: 24:01:22.53224:01:14.398100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.015 0.0%2125 0.000 0.007 0.250
article prepare00:00:00.005 0.0%808 0.000 0.006 0.250
article read00:00:00.043 0.0%198 0.000 0.217 3.000
backlog stats00:00:00.169 0.0%32195 0.000 0.005 0.029
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.454 0.0%16783 0.000 0.027 0.081
data write00:00:00.885 0.0%15077 0.000 0.059 0.121
idle23:50:15.953100.0%32195 831.021 2665.506 7074.353
status file00:00:02.608 0.0%227 1.000 11.489 67.000
TOTAL: 23:50:26.03323:50:20.132100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:07:33.549 99.1%24380 0.000 609.251 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:07.220 0.0%93529 0.000 0.077 0.333
readart00:00:03.579 0.0%22208 0.155 0.161 8.000
TOTAL: 04:09:49.24704:07:44.348 99.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org002202
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feed-out.gegeweb.org 2 2049 1073 974 2 52%23:57:19
2gegeweb-out.news.tnetconsulting.net 1 2275 353 1858 64 15%26:14:05
3news.nntp4.net 2 2342 333 1916 93 14%26:19:44
4i2pn.org 2 3129 160 2968 1 5%33:53:27
5news.samoylyk.net 2 2149 133 2016 0 6%23:54:15
6usenet.pasdenom.info 6 1494 112 1368 14 7%32:06:00
7news.glou.org 2 2047 76 1924 47 3%29:33:32
8nntp.terraraq.uk 3 3575 57 3517 1 1%41:20:31
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 45 19060 2297 16541 222 12%237:18:53
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org4.2 MB0.0 KB4.4 KB4.2 MB 99%4.0 KB
2news.nntp4.net2.5 MB0.0 KB441.6 KB3.0 MB 85%7.1 KB
3gegeweb-out.news.tnetconsulting.net1.4 MB0.0 KB258.2 KB1.6 MB 84%4.0 KB
4news.samoylyk.net774.2 KB0.0 KB0.0 KB774.2 KB100%5.8 KB
5i2pn.org450.4 KB0.0 KB2.0 KB452.4 KB 99%2.8 KB
6news.glou.org362.7 KB0.0 KB119.4 KB482.1 KB 75%3.9 KB
7nntp.terraraq.uk339.1 KB0.0 KB1.2 KB340.4 KB 99%5.9 KB
8usenet.pasdenom.info252.0 KB0.0 KB19.7 KB271.7 KB 92%2.2 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 910.3 MB0.0 KB846.6 KB11.1 MB 92%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 15 04:15:01 - 04:59:59 58 2.8% 0.02268.4 KB 2.8% 0.10
Sep 15 05:00:00 - 05:59:59 49 2.3% 0.01223.1 KB 2.4% 0.06
Sep 15 06:00:00 - 06:59:59 36 1.7% 0.01133.7 KB 1.4% 0.04
Sep 15 07:00:00 - 07:59:59 60 2.9% 0.02194.3 KB 2.1% 0.05
Sep 15 08:00:00 - 08:59:59 61 2.9% 0.02262.5 KB 2.8% 0.07
Sep 15 09:00:00 - 09:59:59 77 3.7% 0.02310.9 KB 3.3% 0.09
Sep 15 10:00:00 - 10:59:59 77 3.7% 0.02250.1 KB 2.6% 0.07
Sep 15 11:00:00 - 11:59:59 86 4.1% 0.02277.4 KB 2.9% 0.08
Sep 15 12:00:00 - 12:59:59 58 2.8% 0.02277.3 KB 2.9% 0.08
Sep 15 13:00:00 - 13:59:59 58 2.8% 0.02180.5 KB 1.9% 0.05
Sep 15 14:00:00 - 14:59:59 73 3.5% 0.02343.4 KB 3.6% 0.10
Sep 15 15:00:00 - 15:59:59 69 3.3% 0.02253.1 KB 2.7% 0.07
Sep 15 16:00:00 - 16:59:59 108 5.2% 0.03283.9 KB 3.0% 0.08
Sep 15 17:00:00 - 17:59:59 139 6.7% 0.04807.6 KB 8.5% 0.22
Sep 15 18:00:00 - 18:59:59 125 6.0% 0.03370.2 KB 3.9% 0.10
Sep 15 19:00:00 - 19:59:59 144 6.9% 0.041.8 MB 19.0% 0.50
Sep 15 20:00:00 - 20:59:59 127 6.1% 0.04440.5 KB 4.7% 0.12
Sep 15 21:00:00 - 21:59:59 122 5.8% 0.03425.6 KB 4.5% 0.12
Sep 15 22:00:00 - 22:59:59 137 6.6% 0.04618.2 KB 6.5% 0.17
Sep 15 23:00:00 - 23:59:59 108 5.2% 0.03432.7 KB 4.6% 0.12
Sep 16 00:00:00 - 00:59:59 77 3.7% 0.02411.1 KB 4.3% 0.11
Sep 16 01:00:00 - 01:59:59 72 3.4% 0.02275.8 KB 2.9% 0.08
Sep 16 02:00:00 - 02:59:59 88 4.2% 0.02312.8 KB 3.3% 0.09
Sep 16 03:00:00 - 03:59:59 61 2.9% 0.02245.4 KB 2.6% 0.07
Sep 16 04:00:00 - 04:15:01 20 1.0% 0.0262.5 KB 0.7% 0.07
TOTAL: 24:00:00 2090 100.0% 0.029.2 MB 100.0% 0.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 83 0 0 0 0 0 0 0 83
2gegeweb-out.news.tnetconsulting.net 76 0 0 0 0 0 0 0 76
3news.glou.org 10 0 0 0 0 0 0 0 10
4feed-out.gegeweb.org 2 0 0 0 0 0 0 0 2
5usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
TOTAL: 5 172 0 0 0 0 0 0 0 172

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 80
Bad path (news.giganews.com.POSTED) 77
EMP (phn path) 9
Cancel of non-existing ID <vc6bki$240e6$1@dont-email.me> 2
EMP (md5) 1
Too many newsgroups (meow) 1
Cancel of non-existing ID <66e686c3$0$1310$426a74cc@news.free.fr> 1
HTML Multipart 1
TOTAL: 8 172

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 1063 71 966 0 0 0 6%23:15:02
2i2pn.org 3133 23 1882 17 0 3 0%23:59:56
3news.samoylyk.net 2764 9 1873 75 0 32 0%23:59:56
4news.tnetconsulting.net 3423 5 2082 0 0 11 0%23:59:23
5news.pasdenom.info 1782 1 1620 1 0 0 0%23:58:20
6nntp.terraraq.uk 1363 0 1278 0 0 0 0%23:43:48
7news.aioe.org 0 0 0 0 0 1687 0%24:00:00
8news.nntp4.net 1844 0 1761 1 0 0 0%23:59:42
TOTAL: 8 15372 109 11462 94 0 1733 0%190:56:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org188.0 KB0.0 KB188.0 KB0.0 KB/s2.6 KB23:15:02
2i2pn.org106.4 KB279.7 KB386.1 KB0.0 KB/s9.7 KB23:59:56
3news.samoylyk.net26.2 KB383.9 KB410.1 KB0.0 KB/s4.9 KB23:59:56
4news.tnetconsulting.net16.8 KB0.0 KB16.8 KB0.0 KB/s3.4 KB23:59:23
5news.pasdenom.info2.0 KB6.5 KB8.5 KB0.0 KB/s4.2 KB23:58:20
6nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:43:48
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8news.nntp4.net0.0 KB7.8 KB7.8 KB0.0 KB/s7.8 KB23:59:42
TOTAL: 8339.5 KB677.9 KB1017.4 KB0.0 KB/s5.0 KB190:56:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
169.10.48.174 22 2220876.5 MB 20 0 004:06:44
TOTAL: 1 22 2220876.5 MB 20 0 004:09:48

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 32 2220876.5 MB 20 0 004:07:32
2*.gegeweb.eu 288 00.0 KB 0 0 000:01:57
3*.ip.linodeusercontent.com 24 00.0 KB 0 0 000:00:06
4*.stretchoid.com 1 00.0 KB 0 0 000:00:00
5*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
6*.survey.inspici.com 1 00.0 KB 0 0 000:00:03
7*.monitoring.internet-measurement.com 4 00.0 KB 0 0 000:00:05
TOTAL: 7 351 2220876.5 MB 20 0 004:09:48

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 4.132 11.010 0.00004:06:44
mail.gegeweb.eu 5.163 4.334 1.73600:01:57
147.185.133.183 0.031 0.012 0.00000:00:11
104.152.52.143 0.028 0.024 0.00000:00:10
198.235.24.239 0.035 0.017 0.00000:00:10
205.210.31.76 0.019 0.031 0.00000:00:10
172-104-137-47.ip.linodeusercontent.com 0.618 0.348 0.00000:00:06
gracious.monitoring.internet-measurement.com 0.048 0.026 0.00000:00:04
server-0-3.survey.inspici.com 0.023 0.027 0.00000:00:03
254.150.216.162.bc.googleusercontent.com 0.008 0.015 0.00000:00:01
azpdwgb56.stretchoid.com 0.023 0.027 0.00000:00:00
179.60.149.54 0.034 0.015 0.00000:00:00
147.185.132.217 0.059 0.027 0.00000:00:00
91.238.181.22 0.039 0.023 0.00000:00:00
91.238.181.32 0.024 0.028 0.00000:00:00
fetching.monitoring.internet-measurement.com 0.034 0.023 0.00000:00:00
104.152.52.124 0.008 0.015 0.00000:00:00
179.60.147.144 0.019 0.008 0.00000:00:00
harmonious.monitoring.internet-measurement.com 0.036 0.028 0.00000:00:00
magnanimous.monitoring.internet-measurement.com 0.048 0.016 0.00000:00:00
TOTAL: 20 10.429 16.054 1.73604:09:48

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
172-104-137-47.ip.linodeusercontent.com 24
magnanimous.monitoring.internet-measurement.com 1
gracious.monitoring.internet-measurement.com 1
254.150.216.162.bc.googleusercontent.com 1
azpdwgb56.stretchoid.com 1
91.238.181.32 1
104.152.52.143 1
harmonious.monitoring.internet-measurement.com 1
205.210.31.76 1
147.185.133.183 1
179.60.147.144 1
server-0-3.survey.inspici.com 1
198.235.24.239 1
104.152.52.124 1
fetching.monitoring.internet-measurement.com 1
91.238.181.22 1
179.60.149.54 1
147.185.132.217 1
TOTAL: 19 329

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
147.185.132.217 4
147.185.133.183 4
254.150.216.162.bc.googleusercontent.com 4
91.238.181.32 1
179.60.149.54 1
azpdwgb56.stretchoid.com 1
TOTAL: 6 15

NNRP unrecognized commands (by command):

CommandCount
User-Agent: Expanse, a Palo Alto Network... 3
Accept-Encoding: gzip 3
GET / HTTP/1.1 3
#003 2
Host: 45.13.105.36:563 2
MGLNDD_45.13.105.36_119 1
Host: 45.13.105.36:119 1
TOTAL: 7 15

NNRP client timeouts [Top 20]:

SystemConnPeer
179.60.149.54 1 1
91.238.181.32 1 1
TOTAL: 2 2 2

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 20113 90.6%
2local 2095 9.4%
TOTAL: 2 22208100.0%

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

NewsgroupCount
1grisbi.bugsreports 9084
2grisbi.test 4200
3grisbi.user.french 3987
4grisbi.devel 2597
5local.test 1971
6grisbi.cvs 192
7local.gegeweb.support 124
8grisbi.user 51
9grisbi.admin 2
TOTAL: 9 22208