Daily Usenet report for news.niel.me

Jan 15 04:15:01 -- Jan 16 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jan 15 17:00:09 rpi-studio pgpverify[5058]: pgpverify: verification failed
Jan 15 17:00:20 rpi-studio pgpverify[5077]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 2471 29.5%464.4 KB 34.6%
innd 2208 26.4%383.5 KB 28.6%
nnrpd 1842 22.0%211.7 KB 15.8%
innfeed 1831 21.9%280.5 KB 20.9%
controlchan 13 0.2%2.2 KB 0.2%
pgpverify 2 0.0%0.5 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 7 8368 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 12797 55.5%
Negative hits 7805 33.9%
Do not exist 2429 10.5%
Cache misses 10 0.0%
TOTAL: 4 23041 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.016 0.0%13 0.000 1.231 2.000
article cancel00:00:00.002 0.0%13 0.000 0.154 1.000
article cleanup00:00:00.043 0.0%2442 0.000 0.018 0.250
article logging00:00:00.163 0.0%2444 0.000 0.067 0.333
article parse00:00:00.317 0.0%6008 0.000 0.053 0.250
article write00:00:01.073 0.0%2199 0.000 0.488 1.167
artlog/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%13 0.000 0.077 1.000
data move00:00:00.140 0.0%24074 0.000 0.006 0.050
hisgrep/artcncl00:00:00.001 0.0%13 0.000 0.077 1.000
hisgrep/artcncl/perl00:00:00.001 0.0%13 0.000 0.077 0.500
hisgrep/perl00:00:00.001 0.0%17 0.000 0.059 1.000
hishave/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%13 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.295 0.0%23146 0.000 0.013 0.061
history sync00:00:00.043 0.0%348 0.000 0.124 1.000
history write00:00:00.360 0.0%2442 0.000 0.147 0.545
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:41.769100.0%26544 1426.717 3256.546 21465.143
nntp read00:00:00.671 0.0%25735 0.000 0.026 0.093
overview write00:00:00.614 0.0%2199 0.000 0.279 3.273
perl filter00:00:07.697 0.0%2442 1.250 3.152 9.000
python filter00:00:00.006 0.0%2442 0.000 0.002 0.077
site send00:00:00.847 0.0%4466 0.000 0.190 0.500
TOTAL: 24:01:00.79624:00:54.060100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.020 0.0%2783 0.000 0.007 0.167
article prepare00:00:00.002 0.0%444 0.000 0.005 0.250
article read00:00:00.012 0.0%107 0.000 0.112 3.000
backlog stats00:00:00.182 0.0%28723 0.000 0.006 0.023
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.373 0.0%15817 0.000 0.024 0.133
data write00:00:00.704 0.0%13914 0.000 0.051 0.111
idle23:58:52.088100.0%28723 1385.970 3005.678 8450.535
status file00:00:00.490 0.0%258 0.500 1.899 8.000
TOTAL: 23:58:58.80223:58:53.871100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:51.455 29.5%1454 9.000 35.389 10051.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.109 0.1%3249 0.000 0.034 0.500
TOTAL: 00:02:54.32800:00:51.564 29.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org002202
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1gegeweb-out.news.tnetconsulting.net 3 2294 890 1374 30 38%28:42:48
2feed-out.gegeweb.org 2 2150 533 1615 2 24%23:58:28
3news.samoylyk.net 6 1927 338 1588 1 17%19:50:49
4i2pn.org 2 2326 184 2142 0 7%27:24:55
5usenet.pasdenom.info 5 1202 142 1054 6 11%26:32:51
6news.nntp4.net 2 1380 106 1158 116 7%15:43:56
7news.glou.org 3 1483 38 1423 22 2%23:48:23
8nntp.terraraq.uk 4 3040 16 3023 1 0%35:48:28
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 52 15802 2247 13377 178 14%201:50:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1gegeweb-out.news.tnetconsulting.net2.7 MB0.0 KB128.9 KB2.8 MB 95%3.2 KB
2news.samoylyk.net2.6 MB0.0 KB20.6 KB2.6 MB 99%7.8 KB
3feed-out.gegeweb.org2.1 MB0.0 KB4.0 KB2.1 MB 99%4.1 KB
4news.nntp4.net601.4 KB0.0 KB456.8 KB1.0 MB 56%4.8 KB
5i2pn.org428.4 KB0.0 KB0.0 KB428.4 KB100%2.3 KB
6usenet.pasdenom.info360.9 KB0.0 KB7.0 KB367.9 KB 98%2.5 KB
7nntp.terraraq.uk277.4 KB0.0 KB1.5 KB278.9 KB 99%16.4 KB
8news.glou.org148.5 KB0.0 KB99.4 KB248.0 KB 59%4.1 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 99.2 MB0.0 KB718.2 KB9.9 MB 92%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 15 04:15:01 - 04:59:59 38 1.7% 0.01151.7 KB 1.6% 0.06
Jan 15 05:00:00 - 05:59:59 35 1.6% 0.01162.2 KB 1.7% 0.05
Jan 15 06:00:00 - 06:59:59 43 2.0% 0.01164.0 KB 1.7% 0.05
Jan 15 07:00:00 - 07:59:59 59 2.7% 0.02201.1 KB 2.1% 0.06
Jan 15 08:00:00 - 08:59:59 47 2.1% 0.01166.9 KB 1.7% 0.05
Jan 15 09:00:00 - 09:59:59 63 2.9% 0.02288.9 KB 3.0% 0.08
Jan 15 10:00:00 - 10:59:59 95 4.3% 0.03617.1 KB 6.4% 0.17
Jan 15 11:00:00 - 11:59:59 82 3.7% 0.02423.0 KB 4.4% 0.12
Jan 15 12:00:00 - 12:59:59 89 4.0% 0.02441.9 KB 4.6% 0.12
Jan 15 13:00:00 - 13:59:59 118 5.4% 0.03355.1 KB 3.7% 0.10
Jan 15 14:00:00 - 14:59:59 117 5.3% 0.03424.1 KB 4.4% 0.12
Jan 15 15:00:00 - 15:59:59 107 4.9% 0.03348.8 KB 3.6% 0.10
Jan 15 16:00:00 - 16:59:59 147 6.7% 0.04896.3 KB 9.3% 0.25
Jan 15 17:00:00 - 17:59:59 124 5.6% 0.031.1 MB 11.6% 0.31
Jan 15 18:00:00 - 18:59:59 125 5.7% 0.03457.6 KB 4.8% 0.13
Jan 15 19:00:00 - 19:59:59 164 7.5% 0.05589.4 KB 6.1% 0.16
Jan 15 20:00:00 - 20:59:59 119 5.4% 0.03429.1 KB 4.5% 0.12
Jan 15 21:00:00 - 21:59:59 88 4.0% 0.02269.0 KB 2.8% 0.07
Jan 15 22:00:00 - 22:59:59 116 5.3% 0.03376.7 KB 3.9% 0.10
Jan 15 23:00:00 - 23:59:59 66 3.0% 0.02235.5 KB 2.4% 0.07
Jan 16 00:00:00 - 00:59:59 133 6.0% 0.04586.8 KB 6.1% 0.16
Jan 16 01:00:00 - 01:59:59 80 3.6% 0.02395.1 KB 4.1% 0.11
Jan 16 02:00:00 - 02:59:59 60 2.7% 0.02216.2 KB 2.2% 0.06
Jan 16 03:00:00 - 03:59:59 70 3.2% 0.02264.2 KB 2.7% 0.07
Jan 16 04:00:00 - 04:15:01 14 0.6% 0.0243.8 KB 0.5% 0.05
TOTAL: 24:00:00 2199 100.0% 0.039.4 MB 100.0% 0.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 186 0 0 0 0 0 0 0 186
2news.glou.org 22 0 0 0 0 0 0 0 22
3gegeweb-out.news.tnetconsulting.net 22 1 0 0 0 0 0 0 21
4usenet.pasdenom.info 5 0 0 0 0 0 0 0 5
5nntp.terraraq.uk 5 0 0 0 0 0 0 0 5
6news.samoylyk.net 4 0 0 0 0 0 0 0 4
7feed-out.gegeweb.org 2 0 0 0 0 0 0 0 2
TOTAL: 7 246 1 0 0 0 0 0 0 245

Unwanted newsgroups [Top 20]:

NewsgroupCount
soc.culture.iran 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 174
Bad path (news.giganews.com.POSTED) 36
EMP (phn path) 15
EMP (md5) 6
Too many newsgroups (meow) 5
Cancels abusifs 3
Cancel of non-existing ID <vm88mo$2uljq$1@dont-email.me> 2
Cancel of <6787cdd1$0$16848$426a74cc@news.free.fr> without Cancel-Key 1
Cancel of <6787ccbd$0$16848$426a74cc@news.free.fr> without Cancel-Key 1
TOTAL: 9 243

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.nntp4.net 2
TOTAL: 1 2
TOTAL: 1 2

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 2973 57 1967 7 0 67 1%23:59:57
2news.gegeweb.org 1816 31 1631 0 0 0 1%23:54:54
3news.tnetconsulting.net 3075 10 2184 4 0 42 0%23:59:57
4news.samoylyk.net 1962 1 1750 0 0 472 0%23:51:09
5news.pasdenom.info 1560 1 1479 0 0 0 0%23:48:13
6news.nntp4.net 2124 0 1960 0 0 0 0%23:59:55
7nntp.terraraq.uk 1128 0 1087 0 0 4 0%23:35:39
8news.aioe.org 0 0 0 0 0 1850 0%24:00:00
TOTAL: 8 14638 100 12058 11 0 2435 0%191:09:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org250.9 KB36.5 KB287.5 KB0.0 KB/s4.5 KB23:59:57
2news.gegeweb.org96.6 KB0.0 KB96.6 KB0.0 KB/s3.1 KB23:54:54
3news.tnetconsulting.net29.3 KB24.3 KB53.6 KB0.0 KB/s3.8 KB23:59:57
4news.samoylyk.net4.0 KB0.0 KB4.0 KB0.0 KB/s4.0 KB23:51:09
5news.pasdenom.info1.7 KB0.0 KB1.7 KB0.0 KB/s1.7 KB23:48:13
6news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:35:39
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 8382.4 KB60.8 KB443.3 KB0.0 KB/s4.0 KB191:09:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1194.165.16.10 1 00.0 KB 0 0 000:00:17
2illuminating.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
3cultured.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
4shining.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
5185.242.226.41 1 00.0 KB 0 0 000:00:00
6147.185.132.206 1 00.0 KB 0 0 000:00:00
7147.45.112.158 1 00.0 KB 0 0 000:00:01
8mail.gegeweb.eu 288 00.0 KB 0 0 000:01:34
9249.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
10azpdcsb21.stretchoid.com 1 00.0 KB 0 0 000:00:09
11147.185.132.150 1 00.0 KB 0 0 000:00:10
12206.168.34.222 1 00.0 KB 0 0 000:00:14
13ample.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
14198.235.24.249 1 00.0 KB 0 0 000:00:10
15brilliant.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
16147.185.132.121 1 00.0 KB 0 0 000:00:00
17cheery.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
182a06:4883:1000::16 1 00.0 KB 0 0 000:00:01
19yaseen.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
20estrada.probe.onyphe.net 1 00.0 KB 0 0 000:00:01
TOTAL: 20 307 00.0 KB 0 0 000:02:53

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.probe.onyphe.net 2 00.0 KB 0 0 000:00:04
2*.gegeweb.eu 288 00.0 KB 0 0 000:01:34
3? 1 00.0 KB 0 0 000:00:01
4unresolved 8 00.0 KB 0 0 000:00:56
5*.monitoring.internet-measurement.com 6 00.0 KB 0 0 000:00:05
6*.stretchoid.com 1 00.0 KB 0 0 000:00:09
7*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
TOTAL: 7 307 00.0 KB 0 0 000:02:53

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 4.329 3.714 1.52100:01:34
194.165.16.10 0.012 0.012 0.00000:00:17
206.168.34.222 0.019 0.019 0.00000:00:14
198.235.24.249 0.019 0.030 0.00000:00:10
147.185.132.150 0.019 0.030 0.00000:00:10
azpdcsb21.stretchoid.com 0.017 0.004 0.00000:00:09
shining.monitoring.internet-measurement.com 0.048 0.024 0.00000:00:03
yaseen.probe.onyphe.net 0.013 0.009 0.00000:00:03
cheery.monitoring.internet-measurement.com 0.032 0.018 0.00000:00:02
2a06:4883:1000::16 0.014 0.009 0.00000:00:01
147.45.112.158 0.025 0.033 0.00000:00:01
estrada.probe.onyphe.net 0.024 0.026 0.00000:00:01
249.211.203.35.bc.googleusercontent.com 0.022 0.017 0.00000:00:00
147.185.132.206 0.023 0.015 0.00000:00:00
147.185.132.121 0.061 0.015 0.00000:00:00
185.242.226.41 0.035 0.019 0.00000:00:00
illuminating.monitoring.internet-measurement.com 0.044 0.020 0.00000:00:00
cultured.monitoring.internet-measurement.com 0.017 0.010 0.00000:00:00
ample.monitoring.internet-measurement.com 0.033 0.029 0.00000:00:00
TOTAL: 19 4.806 4.053 1.52100:02:53

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
185.242.226.41 5
249.211.203.35.bc.googleusercontent.com 4
147.185.132.206 4
147.185.132.121 4
estrada.probe.onyphe.net 2
206.168.34.222 1
194.165.16.10 1
TOTAL: 7 21

NNRP unrecognized commands (by command):

CommandCount
Accept-Encoding: gzip 4
GET / HTTP/1.1 4
User-Agent: Expanse, a Palo Alto Network... 3
Host: 45.13.105.36:563 3
#003 1
Accept: */* 1
EHLO www.censys.io 1
Host: 45.13.105.36:119 1
#026#003#003#001¥#001 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
À$À­À¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa... 1
TOTAL: 11 21

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.10 1 1
TOTAL: 1 1 1