Daily Usenet report for news.niel.me: Dec 29 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
innd	2091	25.8%	345.0 KB	28.2%
innfeed	2086	25.8%	323.3 KB	26.4%
nnrpd	2036	25.1%	224.9 KB	18.4%
inn	1883	23.3%	330.5 KB	27.0%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	8098	100.0%	1.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	7327	50.5%
Negative hits	5297	36.5%
Do not exist	1871	12.9%
Cache misses	2	0.0%
TOTAL: 4	14497	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.003	0.0%	3	1.000	1.000	1.000
article cancel	00:00:00.000	0.0%	3	0.000	0.000	0.000
article cleanup	00:00:00.047	0.0%	1886	0.000	0.025	0.167
article logging	00:00:00.130	0.0%	1886	0.000	0.069	0.333
article parse	00:00:00.423	0.0%	5899	0.000	0.072	0.400
article write	00:00:00.865	0.0%	1610	0.000	0.537	1.333
artlog/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:00:00.084	0.0%	17064	0.000	0.005	0.043
hisgrep/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hisgrep/perl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	3	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.254	0.0%	14612	0.000	0.017	0.111
history sync	00:00:00.057	0.0%	394	0.000	0.145	1.000
history write	00:00:00.333	0.0%	1886	0.000	0.177	0.444
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:54.511	100.0%	19136	1292.416	4517.899	46188.692
nntp read	00:00:00.597	0.0%	18311	0.000	0.033	0.182
overview write	00:00:00.554	0.0%	1610	0.000	0.344	2.000
perl filter	00:00:10.416	0.0%	1886	1.556	5.523	20.333
python filter	00:00:00.015	0.0%	1886	0.000	0.008	0.200
site send	00:00:00.706	0.0%	3288	0.000	0.215	0.600
TOTAL: 24:01:17.393	24:01:08.995	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.017	0.0%	1616	0.000	0.011	0.500
article prepare	00:00:00.001	0.0%	56	0.000	0.018	0.250
article read	00:00:00.006	0.0%	13	0.000	0.462	3.000
backlog stats	00:00:00.116	0.0%	20987	0.000	0.006	0.037
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.288	0.0%	9940	0.000	0.029	0.103
data write	00:00:00.474	0.0%	8409	0.000	0.056	0.136
idle	23:50:24.443	100.0%	20987	2152.333	4089.410	11777.471
status file	00:00:08.860	0.0%	354	0.000	25.028	92.000
TOTAL: 23:50:38.577	23:50:34.205	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:57.873	25.0%	1493	21.200	38.763	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.127	0.1%	3478	0.000	0.037	1.000
TOTAL: 00:03:51.784	00:00:58.000	25.0%	-	-	-	-

Control commands to INND:

Command	Number
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):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news.nntp4.net	4	2085	893	927	265	42%	27:49:08
2	feed-out.gegeweb.org	6	1589	423	1166	0	26%	23:33:38
3	news.samoylyk.net	5	1765	237	1528	0	13%	26:14:11
4	news.glou.org	5	1208	92	1087	29	7%	23:46:38
5	gegeweb-out.news.tnetconsulting.net	6	2016	48	1968	0	2%	38:38:54
6	nntp.terraraq.uk	6	1333	41	1292	0	3%	26:57:37
7	usenet.pasdenom.info	13	702	21	681	0	2%	23:09:22
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		70	10698	1755	8649	294	16%	190:09:28

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	4.5 MB	5.3 MB	9.7 MB	45%	8.6 KB
2	news.samoylyk.net	1.8 MB	0.0 KB	1.8 MB	100%	7.7 KB
3	feed-out.gegeweb.org	1.3 MB	0.0 KB	1.3 MB	100%	3.2 KB
4	news.glou.org	275.0 KB	142.6 KB	417.6 KB	65%	3.5 KB
5	gegeweb-out.news.tnetconsulting.net	145.4 KB	0.0 KB	145.4 KB	100%	3.0 KB
6	nntp.terraraq.uk	111.9 KB	0.0 KB	111.9 KB	100%	2.7 KB
7	usenet.pasdenom.info	44.8 KB	0.0 KB	44.8 KB	100%	2.1 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		8.1 MB	5.4 MB	13.5 MB	59%	6.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 29 04:15:01 - 04:59:59	53	3.3%	0.02	245.6 KB	3.3%	0.09
Dec 29 05:00:00 - 05:59:59	35	2.2%	0.01	219.5 KB	2.9%	0.06
Dec 29 06:00:00 - 06:59:59	30	1.9%	0.01	99.0 KB	1.3%	0.03
Dec 29 07:00:00 - 07:59:59	27	1.7%	0.01	87.9 KB	1.2%	0.02
Dec 29 08:00:00 - 08:59:59	32	2.0%	0.01	233.1 KB	3.1%	0.06
Dec 29 09:00:00 - 09:59:59	24	1.5%	0.01	70.0 KB	0.9%	0.02
Dec 29 10:00:00 - 10:59:59	43	2.7%	0.01	342.9 KB	4.5%	0.10
Dec 29 11:00:00 - 11:59:59	70	4.4%	0.02	324.6 KB	4.3%	0.09
Dec 29 12:00:00 - 12:59:59	59	3.7%	0.02	259.1 KB	3.4%	0.07
Dec 29 13:00:00 - 13:59:59	60	3.7%	0.02	194.4 KB	2.6%	0.05
Dec 29 14:00:00 - 14:59:59	75	4.7%	0.02	276.7 KB	3.7%	0.08
Dec 29 15:00:00 - 15:59:59	68	4.2%	0.02	182.2 KB	2.4%	0.05
Dec 29 16:00:00 - 16:59:59	97	6.1%	0.03	367.8 KB	4.9%	0.10
Dec 29 17:00:00 - 17:59:59	104	6.5%	0.03	550.9 KB	7.3%	0.15
Dec 29 18:00:00 - 18:59:59	99	6.2%	0.03	404.3 KB	5.4%	0.11
Dec 29 19:00:00 - 19:59:59	120	7.5%	0.03	372.8 KB	4.9%	0.10
Dec 29 20:00:00 - 20:59:59	81	5.1%	0.02	458.5 KB	6.1%	0.13
Dec 29 21:00:00 - 21:59:59	89	5.6%	0.02	275.5 KB	3.7%	0.08
Dec 29 22:00:00 - 22:59:59	94	5.9%	0.03	801.5 KB	10.6%	0.22
Dec 29 23:00:00 - 23:59:59	67	4.2%	0.02	468.2 KB	6.2%	0.13
Dec 30 00:00:00 - 00:59:59	81	5.1%	0.02	476.7 KB	6.3%	0.13
Dec 30 01:00:00 - 01:59:59	68	4.2%	0.02	281.0 KB	3.7%	0.08
Dec 30 02:00:00 - 02:59:59	81	5.1%	0.02	328.4 KB	4.4%	0.09
Dec 30 03:00:00 - 03:59:59	38	2.4%	0.01	202.0 KB	2.7%	0.06
Dec 30 04:00:00 - 04:15:01	8	0.5%	0.01	25.0 KB	0.3%	0.03
TOTAL: 24:00:00	1603	100.0%	0.02	7.4 MB	100.0%	0.09

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	245	66	179
2	news.glou.org	29	0	29
TOTAL: 2		274	66	208

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	53
linux.kernel.git	12
news.test	1
TOTAL: 3	66

INND Perl filter [Top 20]:

Reason	Count
Binary: misplaced binary	151
Bad path (news.giganews.com.POSTED)	45
EMP (phn path)	9
Cancels abusifs	2
EMP (md5)	1
TOTAL: 5	208

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	2892	2	1582	11	20	0%	23:43:59
2	news.samoylyk.net	1479	1	1333	0	1	0%	23:34:51
3	news.pasdenom.info	1139	0	1118	0	0	0%	23:20:07
4	news.nntp4.net	837	0	817	0	0	0%	22:44:14
5	i2pn.org	0	0	0	0	1597	0%	23:57:47
6	nntp.terraraq.uk	876	0	853	0	0	0%	23:09:25
7	news.aioe.org	0	0	0	0	1267	0%	24:00:00
8	news.gegeweb.org	1218	0	1182	0	0	0%	23:43:12
TOTAL: 8		8441	3	6885	11	2885	0%	188:13:35

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	9.0 KB	59.5 KB	68.4 KB	5.3 KB	23:43:59
2	news.samoylyk.net	4.2 KB	0.0 KB	4.2 KB	4.2 KB	23:34:51
3	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:20:07
4	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	22:44:14
5	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	23:57:47
6	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:09:25
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
8	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:43:12
TOTAL: 8		13.1 KB	59.5 KB	72.6 KB	5.2 KB	188:13:35

NNRP readership statistics:

System		Conn	Elapsed
1	bowers.probe.onyphe.net	1	00:00:01
2	2603:6010:6800:36:1a03:73ff:fe28:be0f	6	00:00:04
3	194.165.16.163	1	00:00:00
4	147.185.133.238	2	00:00:52
5	26.149.216.162.bc.googleusercontent.com	1	00:00:00
6	106.75.75.129	1	00:00:01
7	66.61.98.95	4	00:00:03
8	o312.scanner.modat.io	4	00:00:00
9	azpdesytaazg.stretchoid.com	2	00:00:10
10	194.180.49.53	2	00:00:00
11	2a06:4882:9000::94	1	00:00:02
12	199.45.154.152	3	00:00:04
13	82.210.203.35.bc.googleusercontent.com	1	00:00:00
14	147.185.133.70	4	00:02:23
15	207.90.244.28	1	00:00:03
16	mail.gegeweb.eu	288	00:01:19
17	mccall.probe.onyphe.net	1	00:00:03
18	194.180.49.51	1	00:00:00
19	147.185.132.16	1	00:00:01
20	66.132.153.131	7	00:00:05
TOTAL: 20		332	00:05:19

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.stretchoid.com	2	00:00:10
2	*.probe.onyphe.net	2	00:00:04
3	*.149.216.162.bc.googleusercontent.com	1	00:00:00
4	*.210.203.35.bc.googleusercontent.com	1	00:00:00
5	*.scanner.modat.io	4	00:00:00
6	*.gegeweb.eu	288	00:01:19
7	?	7	00:00:07
8	unresolved	27	00:03:35
TOTAL: 8		332	00:05:19

NNRP auth users [Top 20]:

User	Conn
mailman	288
TOTAL: 1	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
147.185.133.70	0.413	0.148	0.000	00:02:23
mail.gegeweb.eu	4.619	4.050	1.688	00:01:19
147.185.133.238	0.304	0.080	0.000	00:00:52
azpdesytaazg.stretchoid.com	0.042	0.024	0.000	00:00:10
66.132.153.131	0.262	0.097	0.000	00:00:05
2603:6010:6800:36:1a03:73ff:fe28:be0f	0.189	0.095	0.000	00:00:04
199.45.154.152	0.086	0.049	0.000	00:00:04
207.90.244.28	0.016	0.028	0.000	00:00:03
66.61.98.95	0.089	0.088	0.000	00:00:03
mccall.probe.onyphe.net	0.052	0.028	0.000	00:00:03
2a06:4882:9000::94	0.027	0.023	0.000	00:00:02
bowers.probe.onyphe.net	0.071	0.021	0.000	00:00:01
147.185.132.16	0.030	0.015	0.000	00:00:01
106.75.75.129	0.013	0.009	0.000	00:00:01
26.149.216.162.bc.googleusercontent.com	0.034	0.013	0.000	00:00:00
82.210.203.35.bc.googleusercontent.com	0.089	0.016	0.000	00:00:00
194.165.16.163	0.010	0.017	0.000	00:00:00
o312.scanner.modat.io	0.097	0.029	0.000	00:00:00
194.180.49.53	0.084	0.040	0.000	00:00:00
194.180.49.51	0.038	0.023	0.000	00:00:00
TOTAL: 20	6.565	4.893	1.688	00:05:19

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	12
TOTAL: 1	12

NNRP unrecognized commands (by host):

System	Conn
147.185.133.70	6
82.210.203.35.bc.googleusercontent.com	4
147.185.133.238	4
26.149.216.162.bc.googleusercontent.com	4
199.45.154.152	1
azpdesytaazg.stretchoid.com	1
o312.scanner.modat.io	1
66.132.153.131	1
TOTAL: 8	22

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	5
Host: 45.13.105.36:563	5
Accept: /	2
EHLO www.censys.io	2
Accept-Encoding: gzip	2
User-Agent: Hello from Palo Alto Network...	2
User-Agent: curl/7.68.0	2
MGLNDD_45.13.105.36_119	1
HELO	1
TOTAL: 9	22

NNRP client timeouts [Top 20]:

System	Conn	Peer
147.185.133.70	1	3
147.185.133.238	1	2
199.45.154.152	1	2
TOTAL: 3	3	8

Daily Usenet report for news.niel.me

Dec 29 04:15:01 -- Dec 30 04:15:01