Daily Usenet report for news.niel.me: Jul 25 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
innd	2329	27.4%	384.7 KB	30.4%
inn	2269	26.7%	374.5 KB	29.6%
nnrpd	2055	24.2%	237.0 KB	18.7%
innfeed	1832	21.6%	269.2 KB	21.3%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	8487	100.0%	1.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	7390	50.1%
Negative hits	5106	34.6%
Do not exist	2239	15.2%
Cache misses	2	0.0%
TOTAL: 4	14737	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.016	0.0%	12	0.000	1.333	6.000
article cancel	00:00:00.003	0.0%	12	0.000	0.250	1.000
article cleanup	00:00:00.053	0.0%	2247	0.000	0.024	0.286
article logging	00:00:00.164	0.0%	2247	0.000	0.073	0.273
article parse	00:00:00.534	0.0%	7394	0.000	0.072	0.500
article write	00:00:00.742	0.0%	1429	0.000	0.519	2.000
artlog/artcncl	00:00:00.002	0.0%	12	0.000	0.167	1.000
artlog/artcncl/perl	00:00:00.001	0.0%	12	0.000	0.083	0.500
data move	00:00:00.108	0.0%	18033	0.000	0.006	0.061
hisgrep/artcncl	00:00:00.000	0.0%	12	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	12	0.000	0.000	0.000
hisgrep/perl	00:00:00.001	0.0%	19	0.000	0.053	0.500
hishave/artcncl	00:00:00.000	0.0%	12	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	12	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.263	0.0%	14762	0.000	0.018	0.073
history sync	00:00:00.055	0.0%	342	0.000	0.161	1.000
history write	00:00:00.479	0.0%	2247	0.000	0.213	1.500
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:35.039	100.0%	20617	692.337	4192.416	46191.769
nntp read	00:00:00.616	0.0%	19871	0.000	0.031	0.098
overview write	00:00:00.542	0.0%	1429	0.000	0.379	5.333
perl filter	00:00:13.349	0.0%	2247	1.931	5.941	35.500
python filter	00:00:00.013	0.0%	2247	0.000	0.006	0.200
site send	00:00:00.514	0.0%	2904	0.000	0.177	0.500
TOTAL: 24:01:02.503	24:00:52.494	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.016	0.0%	1436	0.000	0.011	0.250
article prepare	00:00:00.002	0.0%	124	0.000	0.016	0.250
article read	00:00:00.012	0.0%	25	0.000	0.480	7.000
backlog stats	00:00:00.121	0.0%	20199	0.000	0.006	0.032
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.254	0.0%	9400	0.000	0.027	0.125
data write	00:00:00.484	0.0%	7990	0.000	0.061	0.200
idle	23:52:40.101	100.0%	20199	2179.296	4255.661	10005.450
status file	00:00:10.203	0.0%	285	1.000	35.800	99.000
TOTAL: 23:52:56.867	23:52:51.193	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:53.531	13.5%	1470	3.000	36.416	5028.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.125	0.0%	3368	0.000	0.037	1.000
TOTAL: 00:06:37.652	00:00:53.656	13.5%	-	-	-	-

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	3	2037	543	793	701	26%	21:07:15
2	feed-out.gegeweb.org	4	1366	389	977	0	28%	23:52:54
3	news.samoylyk.net	3	1402	190	1207	5	13%	23:35:01
4	gegeweb-out.news.tnetconsulting.net	3	1125	76	1048	1	6%	23:52:54
5	nntp.terraraq.uk	3	173	19	153	1	10%	04:25:27
6	news.glou.org	4	166	5	147	14	3%	04:10:47
7	usenet.pasdenom.info	7	387	0	387	0	0%	13:15:40
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		52	6656	1222	4712	722	18%	114:19:58

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	1.5 MB	9.5 MB	11.0 MB	13%	9.0 KB
2	news.samoylyk.net	1.4 MB	8.6 KB	1.4 MB	99%	7.3 KB
3	feed-out.gegeweb.org	1.3 MB	0.0 KB	1.3 MB	100%	3.4 KB
4	gegeweb-out.news.tnetconsulting.net	294.8 KB	3.7 KB	298.6 KB	98%	3.9 KB
5	nntp.terraraq.uk	41.5 KB	2.8 KB	44.4 KB	93%	2.2 KB
6	news.glou.org	20.1 KB	38.7 KB	58.8 KB	34%	3.1 KB
7	usenet.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0%	0
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		4.5 MB	9.5 MB	14.0 MB	32%	7.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 25 04:15:01 - 04:59:59	42	2.9%	0.02	191.6 KB	3.6%	0.07
Jul 25 05:00:00 - 05:59:59	26	1.8%	0.01	106.0 KB	2.0%	0.03
Jul 25 06:00:00 - 06:59:59	43	3.0%	0.01	195.9 KB	3.7%	0.05
Jul 25 07:00:00 - 07:59:59	22	1.5%	0.01	97.4 KB	1.8%	0.03
Jul 25 08:00:00 - 08:59:59	39	2.7%	0.01	162.0 KB	3.1%	0.05
Jul 25 09:00:00 - 09:59:59	32	2.2%	0.01	122.6 KB	2.3%	0.03
Jul 25 10:00:00 - 10:59:59	64	4.5%	0.02	200.8 KB	3.8%	0.06
Jul 25 11:00:00 - 11:59:59	61	4.3%	0.02	304.6 KB	5.8%	0.08
Jul 25 12:00:00 - 12:59:59	62	4.3%	0.02	218.8 KB	4.1%	0.06
Jul 25 13:00:00 - 13:59:59	92	6.4%	0.03	270.5 KB	5.1%	0.08
Jul 25 14:00:00 - 14:59:59	82	5.7%	0.02	310.3 KB	5.9%	0.09
Jul 25 15:00:00 - 15:59:59	60	4.2%	0.02	218.1 KB	4.1%	0.06
Jul 25 16:00:00 - 16:59:59	55	3.8%	0.02	157.5 KB	3.0%	0.04
Jul 25 17:00:00 - 17:59:59	83	5.8%	0.02	173.8 KB	3.3%	0.05
Jul 25 18:00:00 - 18:59:59	66	4.6%	0.02	198.5 KB	3.8%	0.06
Jul 25 19:00:00 - 19:59:59	70	4.9%	0.02	295.9 KB	5.6%	0.08
Jul 25 20:00:00 - 20:59:59	55	3.8%	0.02	150.3 KB	2.8%	0.04
Jul 25 21:00:00 - 21:59:59	61	4.3%	0.02	187.0 KB	3.5%	0.05
Jul 25 22:00:00 - 22:59:59	70	4.9%	0.02	467.9 KB	8.9%	0.13
Jul 25 23:00:00 - 23:59:59	114	8.0%	0.03	448.9 KB	8.5%	0.12
Jul 26 00:00:00 - 00:59:59	93	6.5%	0.03	312.6 KB	5.9%	0.09
Jul 26 01:00:00 - 01:59:59	49	3.4%	0.01	160.5 KB	3.0%	0.04
Jul 26 02:00:00 - 02:59:59	34	2.4%	0.01	123.3 KB	2.3%	0.03
Jul 26 03:00:00 - 03:59:59	48	3.4%	0.01	183.0 KB	3.5%	0.05
Jul 26 04:00:00 - 04:15:01	8	0.6%	0.01	21.7 KB	0.4%	0.02
TOTAL: 24:00:00	1431	100.0%	0.02	5.2 MB	100.0%	0.06

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	755	299	456
2	news.glou.org	52	0	52
3	news.samoylyk.net	5	0	5
4	gegeweb-out.news.tnetconsulting.net	1	0	1
5	nntp.terraraq.uk	1	0	1
TOTAL: 5		814	299	515

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	250
linux.kernel.git	45
alt.computer.workshop	3
news.test	1
TOTAL: 4	299

INND Perl filter [Top 20]:

Reason	Count
Binary: misplaced binary	249
EMP (md5)	114
Too many newsgroups	85
Bad path (news.giganews.com.POSTED)	58
Cancel of non-existing ID <105vkpe$118oa$1@dont-email.me>	1
Cancel of <105vgvb$10lr9$1@dont-email.me> without Cancel-Key	1
Cancels abusifs	1
Cancel of <10601q9$137sb$1@dont-email.me> without Cancel-Key	1
Cancel of <105ve45$c68$2@news.chmurka.net> without Cancel-Key	1
Cancel of <105vg8l$10i3c$1@dont-email.me> without Cancel-Key	1
Cancel of non-existing ID <meh7gsFlaiaU1@mid.individual.net>	1
HTML Multipart	1
Cancel of <105vgqq$10l39$1@dont-email.me> without Cancel-Key	1
TOTAL: 13	515

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	2122	4	1418	5	0	0%	23:53:46
2	news.nntp4.net	925	3	835	0	0	0%	23:19:13
3	news.samoylyk.net	1539	2	1229	0	11	0%	23:45:33
4	news.pasdenom.info	1323	1	1170	12	0	0%	23:47:13
5	news.aioe.org	0	0	0	0	1163	0%	24:00:00
6	news.gegeweb.org	1056	0	1037	0	0	0%	23:52:09
7	i2pn.org	0	0	0	0	1427	0%	23:57:46
8	nntp.terraraq.uk	967	0	892	4	0	0%	23:33:08
TOTAL: 8		7932	10	6581	21	2601	0%	190:08:48

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	13.0 KB	11.0 KB	23.9 KB	2.7 KB	23:53:46
2	news.samoylyk.net	8.5 KB	0.0 KB	8.5 KB	4.2 KB	23:45:33
3	news.nntp4.net	3.2 KB	0.0 KB	3.2 KB	1.1 KB	23:19:13
4	news.pasdenom.info	2.9 KB	15.7 KB	18.7 KB	1.4 KB	23:47:13
5	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
6	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:52:09
7	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	23:57:46
8	nntp.terraraq.uk	0.0 KB	4.0 KB	4.0 KB	1.0 KB	23:33:08
TOTAL: 8		27.6 KB	30.7 KB	58.4 KB	1.9 KB	190:08:48

NNRP readership statistics:

System		Conn	Elapsed
1	17.39.38.34.bc.googleusercontent.com	2	00:00:10
2	205.210.31.160	3	00:00:11
3	198.235.24.174	1	00:00:00
4	mail.gegeweb.eu	288	00:02:01
5	2a06:4882:b000::bf	1	00:00:03
6	147.185.132.96	1	00:00:00
7	206.168.34.58	1	00:00:31
8	2a06:4882:b000::c7	1	00:00:00
9	2a06:4883:b000::be	1	00:00:00
10	2a06:4883:b000::c4	1	00:00:04
11	206.168.34.34	1	00:00:32
12	206.168.34.63	1	00:00:05
13	154.211.203.35.bc.googleusercontent.com	2	00:00:02
14	185.211.203.35.bc.googleusercontent.com	1	00:00:00
15	168.150.216.162.bc.googleusercontent.com	1	00:00:00
16	199.45.154.113	3	00:00:04
17	206.168.34.67	1	00:00:30
18	188.150.216.162.bc.googleusercontent.com	2	00:00:04
19	172-236-228-86.ip.linodeusercontent.com	2	00:00:01
20	206.168.34.115	1	00:00:31
21	88.214.25.124	1	00:00:00
22	206.168.34.199	1	00:00:45
23	2a06:4883:b000::c9	1	00:00:00
24	206.168.34.43	1	00:00:31
25	205.210.31.205	1	00:00:01
26	165.154.118.9	13	00:00:12
27	205.210.31.7	3	00:00:08
28	91.238.181.96	1	00:00:02
TOTAL: 28		337	00:06:40

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	?	5	00:00:07
2	*.150.216.162.bc.googleusercontent.com	3	00:00:04
3	*.ip.linodeusercontent.com	2	00:00:01
4	*.211.203.35.bc.googleusercontent.com	3	00:00:02
5	*.39.38.34.bc.googleusercontent.com	2	00:00:10
6	unresolved	34	00:04:11
7	*.gegeweb.eu	288	00:02:01
TOTAL: 7		337	00:06:40

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
mail.gegeweb.eu	4.957	4.335	1.870	00:02:01
206.168.34.199	0.013	0.017	0.000	00:00:45
206.168.34.34	0.021	0.008	0.000	00:00:32
206.168.34.43	0.019	0.009	0.000	00:00:31
206.168.34.58	0.035	0.029	0.000	00:00:31
206.168.34.115	0.045	0.019	0.000	00:00:31
206.168.34.67	0.038	0.026	0.000	00:00:30
165.154.118.9	0.401	0.153	0.000	00:00:12
205.210.31.160	0.054	0.035	0.000	00:00:11
17.39.38.34.bc.googleusercontent.com	0.038	0.037	0.000	00:00:10
205.210.31.7	0.054	0.041	0.000	00:00:08
206.168.34.63	0.036	0.022	0.000	00:00:05
199.45.154.113	0.063	0.064	0.000	00:00:04
188.150.216.162.bc.googleusercontent.com	0.192	0.062	0.000	00:00:04
2a06:4883:b000::c4	0.034	0.004	0.000	00:00:04
2a06:4882:b000::bf	0.043	0.019	0.000	00:00:03
91.238.181.96	0.014	0.018	0.000	00:00:02
154.211.203.35.bc.googleusercontent.com	0.102	0.059	0.000	00:00:02
205.210.31.205	0.029	0.022	0.000	00:00:01
172-236-228-86.ip.linodeusercontent.com	0.014	0.033	0.000	00:00:01
TOTAL: 28	6.436	5.148	1.870	00:06:40

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
172-236-228-86.ip.linodeusercontent.com	7
168.150.216.162.bc.googleusercontent.com	4
188.150.216.162.bc.googleusercontent.com	4
154.211.203.35.bc.googleusercontent.com	4
185.211.203.35.bc.googleusercontent.com	4
17.39.38.34.bc.googleusercontent.com	3
205.210.31.160	1
199.45.154.113	1
91.238.181.96	1
205.210.31.7	1
206.168.34.63	1
TOTAL: 11	31

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	5
Host: 45.13.105.36:563	4
Accept-Encoding: gzip	3
Accept: /	3
User-Agent: curl/7.68.0	2
#026#003#001	2
#026#003	2
User-Agent: Hello from Palo Alto Network...	2
EHLO www.censys.io	2
À#024	1
À#À'	1
Host: 45.13.105.36:119	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
#003	1
#001	1
TOTAL: 15	31

NNRP client timeouts [Top 20]:

System	Conn	Peer
205.210.31.7	2	3
205.210.31.160	2	3
154.211.203.35.bc.googleusercontent.com	1	2
91.238.181.96	1	1
188.150.216.162.bc.googleusercontent.com	1	2
199.45.154.113	1	2
TOTAL: 6	8	16

Daily Usenet report for news.niel.me

Jul 25 04:15:01 -- Jul 26 04:15:01