Daily Usenet report for news.niel.me

Jun 25 04:15:02 -- Jun 26 04:15:02

Unknown entries from news log file:

First 50 / 180 lines (27.8%)

Jun 25 22:00:04 rpi-studio pgpverify[28471]: pgpverify: verification failed
Jun 25 22:00:09 rpi-studio pgpverify[28479]: pgpverify: verification failed
Jun 25 22:01:10 rpi-studio pgpverify[28515]: pgpverify: verification failed
Jun 25 22:01:14 rpi-studio pgpverify[28523]: pgpverify: verification failed
Jun 25 22:02:14 rpi-studio pgpverify[28548]: pgpverify: verification failed
Jun 25 22:02:16 rpi-studio pgpverify[28556]: pgpverify: verification failed
Jun 25 22:03:17 rpi-studio pgpverify[28578]: pgpverify: verification failed
Jun 25 22:03:18 rpi-studio pgpverify[28586]: pgpverify: verification failed
Jun 25 22:04:19 rpi-studio pgpverify[28608]: pgpverify: verification failed
Jun 25 22:04:20 rpi-studio pgpverify[28618]: pgpverify: verification failed
Jun 25 22:05:21 rpi-studio pgpverify[28652]: pgpverify: verification failed
Jun 25 22:05:22 rpi-studio pgpverify[28662]: pgpverify: verification failed
Jun 25 22:06:22 rpi-studio pgpverify[28684]: pgpverify: verification failed
Jun 25 22:06:24 rpi-studio pgpverify[28692]: pgpverify: verification failed
Jun 25 22:07:25 rpi-studio pgpverify[28858]: pgpverify: verification failed
Jun 25 22:07:26 rpi-studio pgpverify[28866]: pgpverify: verification failed
Jun 25 22:08:27 rpi-studio pgpverify[28891]: pgpverify: verification failed
Jun 25 22:08:29 rpi-studio pgpverify[28899]: pgpverify: verification failed
Jun 25 22:09:29 rpi-studio pgpverify[28921]: pgpverify: verification failed
Jun 25 22:09:32 rpi-studio pgpverify[28932]: pgpverify: verification failed
Jun 25 22:10:32 rpi-studio pgpverify[28972]: pgpverify: verification failed
Jun 25 22:10:34 rpi-studio pgpverify[28980]: pgpverify: verification failed
Jun 25 22:11:34 rpi-studio pgpverify[29010]: pgpverify: verification failed
Jun 25 22:11:36 rpi-studio pgpverify[29018]: pgpverify: verification failed
Jun 25 22:12:36 rpi-studio pgpverify[29045]: pgpverify: verification failed
Jun 25 22:12:38 rpi-studio pgpverify[29059]: pgpverify: verification failed
Jun 25 22:13:38 rpi-studio pgpverify[29084]: pgpverify: verification failed
Jun 25 22:13:40 rpi-studio pgpverify[29092]: pgpverify: verification failed
Jun 25 22:14:40 rpi-studio pgpverify[29124]: pgpverify: verification failed
Jun 25 22:14:42 rpi-studio pgpverify[29132]: pgpverify: verification failed
Jun 25 22:15:42 rpi-studio pgpverify[29161]: pgpverify: verification failed
Jun 25 22:15:44 rpi-studio pgpverify[29169]: pgpverify: verification failed
Jun 25 22:16:44 rpi-studio pgpverify[29333]: pgpverify: verification failed
Jun 25 22:16:46 rpi-studio pgpverify[29341]: pgpverify: verification failed
Jun 25 22:17:47 rpi-studio pgpverify[29376]: pgpverify: verification failed
Jun 25 22:17:48 rpi-studio pgpverify[29384]: pgpverify: verification failed
Jun 25 22:18:49 rpi-studio pgpverify[29414]: pgpverify: verification failed
Jun 25 22:18:50 rpi-studio pgpverify[29424]: pgpverify: verification failed
Jun 25 22:19:51 rpi-studio pgpverify[29448]: pgpverify: verification failed
Jun 25 22:19:53 rpi-studio pgpverify[29456]: pgpverify: verification failed
Jun 25 22:20:54 rpi-studio pgpverify[29482]: pgpverify: verification failed
Jun 25 22:20:55 rpi-studio pgpverify[29490]: pgpverify: verification failed
Jun 25 22:21:56 rpi-studio pgpverify[29514]: pgpverify: verification failed
Jun 25 22:21:58 rpi-studio pgpverify[29522]: pgpverify: verification failed
Jun 25 22:22:58 rpi-studio pgpverify[29560]: pgpverify: verification failed
Jun 25 22:23:00 rpi-studio pgpverify[29570]: pgpverify: verification failed
Jun 25 22:24:00 rpi-studio pgpverify[29604]: pgpverify: verification failed
Jun 25 22:24:02 rpi-studio pgpverify[29614]: pgpverify: verification failed
Jun 25 22:25:03 rpi-studio pgpverify[29638]: pgpverify: verification failed
Jun 25 22:25:06 rpi-studio pgpverify[29646]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 2640 29.1%449.3 KB 32.4%
innd 2274 25.0%383.3 KB 27.6%
nnrpd 1938 21.3%226.6 KB 16.3%
innfeed 1868 20.6%286.3 KB 20.6%
controlchan 181 2.0%13.5 KB 1.0%
pgpverify 180 2.0%27.4 KB 2.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 7 9082 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 10713 56.6%
Negative hits 5608 29.6%
Do not exist 2601 13.7%
Cache misses 10 0.1%
TOTAL: 4 18932 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.013 0.0%16 0.000 0.812 1.000
article cancel00:00:00.006 0.0%16 0.000 0.375 1.000
article cleanup00:00:00.048 0.0%2610 0.000 0.018 0.250
article logging00:00:00.189 0.0%2610 0.000 0.072 0.333
article parse00:00:00.440 0.0%6238 0.000 0.071 0.250
article write00:00:00.849 0.0%1824 0.000 0.465 1.875
artlog/artcncl00:00:00.002 0.0%16 0.000 0.125 0.500
artlog/artcncl/perl00:00:00.000 0.0%16 0.000 0.000 0.000
data move00:00:00.129 0.0%22381 0.000 0.006 0.034
hisgrep/artcncl00:00:00.003 0.0%16 0.000 0.188 1.000
hisgrep/artcncl/perl00:00:00.000 0.0%16 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%17 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%16 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.319 0.0%18952 0.000 0.017 0.059
history sync00:00:00.057 0.0%403 0.000 0.141 1.000
history write00:00:00.511 0.0%2610 0.000 0.196 0.667
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:43.501100.0%23244 1038.569 3718.960 22247.222
nntp read00:00:00.649 0.0%22497 0.000 0.029 0.095
overview write00:00:00.585 0.0%1824 0.000 0.321 5.333
perl filter00:00:12.641 0.0%2610 1.643 4.843 23.800
python filter00:00:00.007 0.0%2610 0.000 0.003 0.091
site send00:00:00.681 0.0%3891 0.000 0.175 0.500
TOTAL: 24:01:09.76724:01:00.630100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.016 0.0%1854 0.000 0.009 0.200
article prepare00:00:00.002 0.0%856 0.000 0.002 0.250
article read00:00:00.039 0.0%185 0.000 0.211 7.000
backlog stats00:00:00.118 0.0%28689 0.000 0.004 0.027
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.432 0.0%14625 0.000 0.030 0.087
data write00:00:00.750 0.0%13068 0.000 0.057 0.133
idle23:51:02.883100.0%28689 1054.179 2992.885 8007.587
status file00:00:08.724 0.0%260 0.000 33.554 93.000
TOTAL: 23:51:16.46523:51:12.964100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:58.926 29.8%1469 3.000 40.113 9006.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.128 0.1%3335 0.000 0.038 0.273
TOTAL: 00:03:17.43500:00:59.054 29.9%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 170

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org00018000
TOTAL00018000

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.nntp4.net 1 2561 786 1065 710 30%23:59:57
2feed-out.gegeweb.org 3 1746 670 1076 0 38%23:57:55
3i2pn.org 2 3261 144 3115 2 4%42:22:05
4news.glou.org 2 1523 94 1366 63 6%23:52:57
5gegeweb-out.news.tnetconsulting.net 4 2422 77 2344 1 3%21:28:51
6nntp.terraraq.uk 3 1209 72 1131 6 5%21:34:22
7news.samoylyk.net 3 1674 21 1653 0 1%21:35:36
8usenet.pasdenom.info 11 935 0 935 0 0%21:09:16
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 54 15331 1864 12685 782 12%200:00:59
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net3.7 MB0.0 KB5.7 MB9.4 MB 39%6.4 KB
2feed-out.gegeweb.org2.0 MB0.0 KB0.0 KB2.0 MB100%3.0 KB
3i2pn.org316.5 KB0.0 KB3.1 KB319.5 KB 99%2.2 KB
4news.glou.org312.6 KB0.0 KB156.2 KB468.7 KB 66%3.0 KB
5gegeweb-out.news.tnetconsulting.net291.7 KB0.0 KB1.8 KB293.5 KB 99%3.8 KB
6nntp.terraraq.uk158.6 KB0.0 KB18.3 KB176.9 KB 89%2.3 KB
7news.samoylyk.net103.2 KB0.0 KB0.0 KB103.2 KB100%4.9 KB
8usenet.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 96.9 MB0.0 KB5.8 MB12.7 MB 54%4.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 25 04:15:02 - 04:59:59 23 1.3% 0.0182.9 KB 1.2% 0.03
Jun 25 05:00:00 - 05:59:59 29 1.6% 0.01102.4 KB 1.5% 0.03
Jun 25 06:00:00 - 06:59:59 30 1.6% 0.01187.1 KB 2.7% 0.05
Jun 25 07:00:00 - 07:59:59 42 2.3% 0.01101.2 KB 1.4% 0.03
Jun 25 08:00:00 - 08:59:59 69 3.8% 0.02219.9 KB 3.1% 0.06
Jun 25 09:00:00 - 09:59:59 63 3.5% 0.02489.2 KB 7.0% 0.14
Jun 25 10:00:00 - 10:59:59 78 4.3% 0.02237.9 KB 3.4% 0.07
Jun 25 11:00:00 - 11:59:59 92 5.0% 0.03336.3 KB 4.8% 0.09
Jun 25 12:00:00 - 12:59:59 60 3.3% 0.02275.0 KB 3.9% 0.08
Jun 25 13:00:00 - 13:59:59 98 5.4% 0.03318.7 KB 4.6% 0.09
Jun 25 14:00:00 - 14:59:59 60 3.3% 0.02185.8 KB 2.7% 0.05
Jun 25 15:00:00 - 15:59:59 47 2.6% 0.01142.3 KB 2.0% 0.04
Jun 25 16:00:00 - 16:59:59 90 4.9% 0.03267.4 KB 3.8% 0.07
Jun 25 17:00:00 - 17:59:59 98 5.4% 0.03399.8 KB 5.7% 0.11
Jun 25 18:00:00 - 18:59:59 75 4.1% 0.02264.3 KB 3.8% 0.07
Jun 25 19:00:00 - 19:59:59 92 5.0% 0.03412.7 KB 5.9% 0.11
Jun 25 20:00:00 - 20:59:59 103 5.6% 0.03336.6 KB 4.8% 0.09
Jun 25 21:00:00 - 21:59:59 105 5.8% 0.03343.1 KB 4.9% 0.10
Jun 25 22:00:00 - 22:59:59 197 10.8% 0.05852.8 KB 12.2% 0.24
Jun 25 23:00:00 - 23:59:59 152 8.3% 0.04660.3 KB 9.4% 0.18
Jun 26 00:00:00 - 00:59:59 71 3.9% 0.02318.8 KB 4.6% 0.09
Jun 26 01:00:00 - 01:59:59 57 3.1% 0.02180.9 KB 2.6% 0.05
Jun 26 02:00:00 - 02:59:59 44 2.4% 0.01124.4 KB 1.8% 0.03
Jun 26 03:00:00 - 03:59:59 39 2.1% 0.01125.8 KB 1.8% 0.03
Jun 26 04:00:00 - 04:15:02 11 0.6% 0.0125.1 KB 0.4% 0.03
TOTAL: 24:00:00 1825 100.0% 0.026.8 MB 100.0% 0.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 710 475 0 0 0 0 0 0 235
2news.glou.org 63 0 0 0 0 0 0 0 63
3nntp.terraraq.uk 6 0 0 0 0 0 0 0 6
4gegeweb-out.news.tnetconsulting.net 3 0 0 0 0 0 0 0 3
5i2pn.org 1 0 0 0 0 0 0 0 1
TOTAL: 5 783 475 0 0 0 0 0 0 308

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 401
linux.kernel.git 69
alt.france 3
soc.culture.russia 1
news.test 1
TOTAL: 5 475

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 117
EMP (md5) 113
Bad path (news.giganews.com.POSTED) 67
Cancels abusifs 10
Cancel of non-existing ID <mc2g9vFdjvlU1@mid.individual.net> 1
TOTAL: 5 308

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 2635 26 1717 11 0 15 0%23:58:19
2news.tnetconsulting.net 2764 18 1795 10 0 15 0%23:59:57
3news.samoylyk.net 2707 13 1675 113 0 3 0%23:57:52
4news.nntp4.net 1104 5 1020 0 0 0 0%23:40:45
5news.gegeweb.org 1185 4 1135 0 0 0 0%23:34:13
6news.pasdenom.info 1519 2 1460 8 0 0 0%23:55:58
7news.aioe.org 0 0 0 0 0 1535 0%23:59:59
8nntp.terraraq.uk 1227 0 1182 4 0 0 0%23:44:59
TOTAL: 8 13141 68 9984 146 0 1568 0%190:52:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org171.3 KB21.7 KB193.0 KB0.0 KB/s5.2 KB23:58:19
2news.tnetconsulting.net125.3 KB34.4 KB159.7 KB0.0 KB/s5.7 KB23:59:57
3news.samoylyk.net38.3 KB624.6 KB662.9 KB0.0 KB/s5.3 KB23:57:52
4news.gegeweb.org8.5 KB0.0 KB8.5 KB0.0 KB/s2.1 KB23:34:13
5news.pasdenom.info7.2 KB9.0 KB16.2 KB0.0 KB/s1.6 KB23:55:58
6news.nntp4.net6.1 KB0.0 KB6.1 KB0.0 KB/s1.2 KB23:40:45
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
8nntp.terraraq.uk0.0 KB5.0 KB5.0 KB0.0 KB/s1.2 KB23:44:59
TOTAL: 8356.8 KB694.7 KB1.0 MB0.0 KB/s4.9 KB190:52:02
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1126.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
2205.210.31.42 1 00.0 KB 0 0 000:00:02
3azpdes9gsh00.stretchoid.com 1 00.0 KB 0 0 000:00:09
4azpdwgnu0xve.stretchoid.com 1 00.0 KB 0 0 000:00:00
5147.185.132.147 1 00.0 KB 0 0 000:00:02
691.238.181.91 1 00.0 KB 0 0 000:00:01
791.238.181.95 1 00.0 KB 0 0 000:00:01
8142.210.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:02
92a06:4883:1000::a 1 00.0 KB 0 0 000:00:02
1088.214.25.125 1 00.0 KB 0 0 000:00:00
11206.168.34.72 8 00.0 KB 0 0 000:00:16
1245-79-115-134.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:00
13mail.gegeweb.eu 289 00.0 KB 0 0 000:01:45
1453.210.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:04
1541.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
16198.235.24.160 3 00.0 KB 0 0 000:00:14
17passionate.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
18206.168.34.223 1 00.0 KB 0 0 000:00:15
19205.210.31.7 3 00.0 KB 0 0 000:00:14
TOTAL: 19 320 00.0 KB 0 0 000:03:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.stretchoid.com 2 00.0 KB 0 0 000:00:10
2*.149.216.162.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:01
3unresolved 20 00.0 KB 0 0 000:01:09
4*.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:00
5? 1 00.0 KB 0 0 000:00:02
6*.210.203.35.bc.googleusercontent.com 4 00.0 KB 0 0 000:00:06
7*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
8*.gegeweb.eu 289 00.0 KB 0 0 000:01:45
TOTAL: 8 320 00.0 KB 0 0 000:03:20

NNRP auth users [Top 20]:

UserConn
mailman 289
TOTAL: 1 289

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 5.130 4.386 1.93300:01:45
206.168.34.72 0.247 0.129 0.00000:00:16
206.168.34.223 0.022 0.019 0.00000:00:15
198.235.24.160 0.048 0.052 0.00000:00:14
205.210.31.7 0.073 0.054 0.00000:00:14
azpdes9gsh00.stretchoid.com 0.028 0.024 0.00000:00:09
53.210.203.35.bc.googleusercontent.com 0.110 0.052 0.00000:00:04
2a06:4883:1000::a 0.007 0.018 0.00000:00:02
147.185.132.147 0.013 0.017 0.00000:00:02
142.210.203.35.bc.googleusercontent.com 0.176 0.056 0.00000:00:02
205.210.31.42 0.027 0.020 0.00000:00:02
passionate.monitoring.internet-measurement.com 0.027 0.027 0.00000:00:01
91.238.181.95 0.018 0.005 0.00000:00:01
126.149.216.162.bc.googleusercontent.com 0.069 0.021 0.00000:00:01
91.238.181.91 0.029 0.020 0.00000:00:01
45-79-115-134.ip.linodeusercontent.com 0.008 0.016 0.00000:00:00
41.149.216.162.bc.googleusercontent.com 0.031 0.009 0.00000:00:00
azpdwgnu0xve.stretchoid.com 0.021 0.032 0.00000:00:00
88.214.25.125 0.012 0.016 0.00000:00:00
TOTAL: 19 6.096 4.973 1.93300:03:20

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
41.149.216.162.bc.googleusercontent.com 4
53.210.203.35.bc.googleusercontent.com 4
126.149.216.162.bc.googleusercontent.com 4
142.210.203.35.bc.googleusercontent.com 4
91.238.181.91 1
azpdwgnu0xve.stretchoid.com 1
206.168.34.223 1
205.210.31.7 1
198.235.24.160 1
91.238.181.95 1
TOTAL: 10 22

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:563 4
GET / HTTP/1.1 4
#026#003 2
Accept-Encoding: gzip 2
Accept: */* 2
User-Agent: Expanse, a Palo Alto Network... 2
User-Agent: curl/7.68.0 2
#003 2
MGLNDD_45.13.105.36_119 1
EHLO www.censys.io 1
TOTAL: 10 22

NNRP client timeouts [Top 20]:

SystemConnPeer
198.235.24.160 2 3
205.210.31.7 2 3
91.238.181.95 1 1
142.210.203.35.bc.googleusercontent.com 1 2
91.238.181.91 1 1
53.210.203.35.bc.googleusercontent.com 1 2
TOTAL: 6 8 15