Daily Usenet report for news.niel.me: Feb 20 04:15:02

Unknown entries from news log file:

First 27 / 27 lines (100.0%)

Feb 20 17:52:52 rpi-studio nnrpd[16507]: 2001:41d0:700:1273:: noperm ihave without permission
Feb 20 17:53:28 rpi-studio nnrpd[16518]: 2001:41d0:700:1273:: noperm ihave without permission
Feb 21 04:00:49 rpi-studio nnrpd[6112]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:01:19 rpi-studio nnrpd[6121]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:01:50 rpi-studio nnrpd[6137]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:02:21 rpi-studio nnrpd[6156]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:02:51 rpi-studio nnrpd[6174]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:05:23 rpi-studio nnrpd[6183]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:05:54 rpi-studio nnrpd[6389]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:06:24 rpi-studio nnrpd[6399]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:06:54 rpi-studio nnrpd[6408]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:07:24 rpi-studio nnrpd[6417]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:07:54 rpi-studio nnrpd[6424]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:08:24 rpi-studio nnrpd[6433]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:08:54 rpi-studio nnrpd[6440]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:09:24 rpi-studio nnrpd[6449]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:09:54 rpi-studio nnrpd[6467]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:10:24 rpi-studio nnrpd[6482]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:10:54 rpi-studio nnrpd[6496]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:11:24 rpi-studio nnrpd[6516]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:11:54 rpi-studio nnrpd[6524]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:12:24 rpi-studio nnrpd[6533]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:12:54 rpi-studio nnrpd[6545]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:13:24 rpi-studio nnrpd[6559]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:13:55 rpi-studio nnrpd[6571]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:14:25 rpi-studio nnrpd[6587]: 2001:41d0:a:280::1 noperm ihave without permission
Feb 21 04:14:55 rpi-studio nnrpd[6594]: 2001:41d0:a:280::1 noperm ihave without permission

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2619	30.0%	482.6 KB	34.8%
nnrpd	2307	26.4%	254.8 KB	18.4%
innd	2077	23.8%	381.6 KB	27.5%
innfeed	1734	19.8%	267.9 KB	19.3%
controlchan	1	0.0%	0.0 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8739	100.0%	1.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	12483	54.9%
Negative hits	7658	33.7%
Do not exist	2602	11.4%
Cache misses	2	0.0%
TOTAL: 4	22745	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.008	0.0%	5	0.000	1.600	5.000
article cancel	00:00:00.000	0.0%	5	0.000	0.000	0.000
article cleanup	00:00:00.050	0.0%	2612	0.000	0.019	0.182
article logging	00:00:00.196	0.0%	2612	0.000	0.075	0.667
article parse	00:00:00.724	0.0%	12993	0.000	0.056	0.211
article write	00:00:01.324	0.0%	2459	0.000	0.538	1.556
artlog/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.001	0.0%	5	0.000	0.200	1.000
data move	00:00:00.153	0.0%	32029	0.000	0.005	0.026
hisgrep/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hisgrep/perl	00:00:00.001	0.0%	5	0.000	0.200	1.000
hishave/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	5	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.295	0.0%	22834	0.000	0.013	0.059
history sync	00:00:00.055	0.0%	405	0.000	0.136	1.000
history write	00:00:00.409	0.0%	2612	0.000	0.157	0.571
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:54.523	100.0%	33031	513.901	2617.375	12775.064
nntp read	00:00:00.808	0.0%	32161	0.000	0.025	0.054
overview write	00:00:00.690	0.0%	2459	0.000	0.281	2.000
perl filter	00:00:09.231	0.0%	2612	1.176	3.534	16.000
python filter	00:00:00.014	0.0%	2612	0.000	0.005	0.111
site send	00:00:00.993	0.0%	4953	0.000	0.200	0.591
TOTAL: 24:01:18.180	24:01:09.475	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.016	0.0%	2788	0.000	0.006	0.200
article prepare	00:00:00.002	0.0%	1208	0.000	0.002	0.083
article read	00:00:00.059	0.0%	248	0.000	0.238	8.000
backlog stats	00:00:00.167	0.0%	32468	0.000	0.005	0.021
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.405	0.0%	17871	0.000	0.023	0.071
data write	00:00:00.797	0.0%	15921	0.000	0.050	0.107
idle	23:59:00.789	100.0%	32468	1304.384	2659.258	6424.862
status file	00:00:02.485	0.0%	218	1.000	11.399	83.000
TOTAL: 23:59:09.331	23:59:04.720	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:31:51.071	97.3%	18317	9.600	300.872	40709.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:03.746	0.1%	69121	0.000	0.054	0.691
readart	00:00:03.081	0.1%	27504	0.051	0.112	0.450
TOTAL: 01:34:24.187	01:31:57.898	97.4%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feed-out.gegeweb.org	3	2387	677	1710	0	28%	23:59:13
2	news.samoylyk.net	1	2394	626	1767	1	26%	22:04:20
3	gegeweb-out.news.tnetconsulting.net	1	1554	475	1037	42	30%	25:48:32
4	i2pn.org	1	2421	219	2192	10	9%	24:31:55
5	news.nntp4.net	1	1005	161	805	39	16%	10:25:00
6	2001:41d0:a:280::1	0	1420	86	1284	50	6%	13:20:41
7	nntp.terraraq.uk	5	2418	84	2333	1	3%	36:38:22
8	usenet.pasdenom.info	5	309	38	270	1	12%	09:47:35
9	news.glou.org	2	376	14	357	5	3%	07:52:40
10	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 10		44	14284	2380	11755	149	16%	174:28:18

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.samoylyk.net	12.1 MB	0.0 KB	1.7 KB	12.1 MB	99%	19.8 KB
2	news.nntp4.net	4.2 MB	0.0 KB	66.7 KB	4.3 MB	98%	21.8 KB
3	feed-out.gegeweb.org	3.2 MB	0.0 KB	0.0 KB	3.2 MB	100%	4.8 KB
4	gegeweb-out.news.tnetconsulting.net	1.4 MB	0.0 KB	118.4 KB	1.5 MB	92%	3.0 KB
5	2001:41d0:a:280::1	823.0 KB	0.0 KB	100.2 KB	923.2 KB	89%	6.8 KB
6	i2pn.org	554.1 KB	9.2 KB	21.5 KB	584.8 KB	94%	2.6 KB
7	nntp.terraraq.uk	469.9 KB	0.0 KB	3.3 KB	473.2 KB	99%	5.6 KB
8	usenet.pasdenom.info	70.0 KB	0.0 KB	1.2 KB	71.2 KB	98%	1.8 KB
9	news.glou.org	48.6 KB	0.0 KB	15.5 KB	64.1 KB	75%	3.4 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		22.8 MB	9.2 KB	328.5 KB	23.1 MB	98%	9.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 20 04:15:02 - 04:59:59	54	2.2%	0.02	210.9 KB	0.9%	0.08
Feb 20 05:00:00 - 05:59:59	63	2.6%	0.02	297.3 KB	1.3%	0.08
Feb 20 06:00:00 - 06:59:59	52	2.1%	0.01	168.5 KB	0.7%	0.05
Feb 20 07:00:00 - 07:59:59	60	2.4%	0.02	248.6 KB	1.1%	0.07
Feb 20 08:00:00 - 08:59:59	40	1.6%	0.01	159.9 KB	0.7%	0.04
Feb 20 09:00:00 - 09:59:59	54	2.2%	0.01	160.4 KB	0.7%	0.04
Feb 20 10:00:00 - 10:59:59	102	4.2%	0.03	389.0 KB	1.7%	0.11
Feb 20 11:00:00 - 11:59:59	107	4.4%	0.03	422.9 KB	1.8%	0.12
Feb 20 12:00:00 - 12:59:59	125	5.1%	0.03	2.1 MB	9.2%	0.60
Feb 20 13:00:00 - 13:59:59	214	8.7%	0.06	6.4 MB	28.2%	1.83
Feb 20 14:00:00 - 14:59:59	163	6.6%	0.05	2.8 MB	12.1%	0.78
Feb 20 15:00:00 - 15:59:59	202	8.2%	0.06	4.9 MB	21.5%	1.39
Feb 20 16:00:00 - 16:59:59	87	3.5%	0.02	511.0 KB	2.2%	0.14
Feb 20 17:00:00 - 17:59:59	110	4.5%	0.03	426.5 KB	1.8%	0.12
Feb 20 18:00:00 - 18:59:59	110	4.5%	0.03	352.9 KB	1.5%	0.10
Feb 20 19:00:00 - 19:59:59	94	3.8%	0.03	310.4 KB	1.3%	0.09
Feb 20 20:00:00 - 20:59:59	108	4.4%	0.03	507.5 KB	2.2%	0.14
Feb 20 21:00:00 - 21:59:59	128	5.2%	0.04	443.1 KB	1.9%	0.12
Feb 20 22:00:00 - 22:59:59	177	7.2%	0.05	693.3 KB	3.0%	0.19
Feb 20 23:00:00 - 23:59:59	133	5.4%	0.04	471.3 KB	2.0%	0.13
Feb 21 00:00:00 - 00:59:59	70	2.8%	0.02	286.5 KB	1.2%	0.08
Feb 21 01:00:00 - 01:59:59	58	2.4%	0.02	199.4 KB	0.9%	0.06
Feb 21 02:00:00 - 02:59:59	80	3.3%	0.02	293.7 KB	1.3%	0.08
Feb 21 03:00:00 - 03:59:59	50	2.0%	0.01	152.2 KB	0.7%	0.04
Feb 21 04:00:00 - 04:15:01	16	0.7%	0.02	68.3 KB	0.3%	0.08
TOTAL: 23:59:59	2457	100.0%	0.03	22.8 MB	100.0%	0.27

Sites sending bad articles:

Server		Total	Other
1	news.nntp4.net	89	89
2	gegeweb-out.news.tnetconsulting.net	37	37
3	news.glou.org	18	18
4	i2pn.org	5	5
5	usenet.pasdenom.info	2	2
6	news.samoylyk.net	1	1
TOTAL: 6		152	152

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	89
Bad path (news.giganews.com.POSTED)	61
Cancels abusifs	2
TOTAL: 3	152

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.nntp4.net	2495	93	2078	1	0	3%	23:59:57
2	i2pn.org	3436	89	2075	26	151	2%	23:59:14
3	news.gegeweb.org	1972	55	1729	0	0	2%	23:56:34
4	news.tnetconsulting.net	3674	12	2413	10	119	0%	23:57:54
5	news.samoylyk.net	2184	3	1735	12	58	0%	23:59:29
6	nntp.terraraq.uk	1208	1	1155	0	1	0%	23:53:41
7	news.aioe.org	0	0	0	0	2000	0%	23:59:59
8	news.pasdenom.info	1607	0	1477	0	0	0%	23:59:31
TOTAL: 8		16576	253	12662	49	2329	1%	191:46:19

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	i2pn.org	1018.5 KB	597.8 KB	1.6 MB	14.1 KB	23:59:14
2	news.nntp4.net	298.0 KB	2.3 KB	300.2 KB	3.2 KB	23:59:57
3	news.gegeweb.org	124.8 KB	0.0 KB	124.8 KB	2.3 KB	23:56:34
4	news.tnetconsulting.net	26.9 KB	40.2 KB	67.1 KB	3.1 KB	23:57:54
5	news.samoylyk.net	17.8 KB	716.9 KB	734.6 KB	49.0 KB	23:59:29
6	nntp.terraraq.uk	2.9 KB	0.0 KB	2.9 KB	2.9 KB	23:53:41
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:59
8	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:59:31
TOTAL: 8		1.5 MB	1.3 MB	2.8 MB	9.4 KB	191:46:19

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	syn-066-061-096-239.res.spectrum.com	50	15974	53.6 MB	114	0	0	01:28:43
TOTAL: 1		50	15974	53.6 MB	114	0	0	01:34:23

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.res.spectrum.com	50	15974	53.6 MB	114	01:28:43
2	?	27	0	0.0 KB	0	00:02:24
3	*.150.216.162.bc.googleusercontent.com	1	0	0.0 KB	0	00:00:00
4	*.stretchoid.com	2	0	0.0 KB	0	00:00:10
5	*.subs.proxad.net	1	0	0.0 KB	0	00:00:00
6	unresolved	8	0	0.0 KB	0	00:00:46
7	*.nycmny.fios.verizon.net	1	0	0.0 KB	0	00:00:13
8	*.211.203.35.bc.googleusercontent.com	1	0	0.0 KB	0	00:00:00
9	*.gegeweb.eu	288	0	0.0 KB	0	00:01:58
10	*.probe.onyphe.net	1	0	0.0 KB	0	00:00:04
TOTAL: 10		380	15974	53.6 MB	114	01:34:23

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
syn-066-061-096-239.res.spectrum.com	3.636	7.351	0.000	01:28:43
2001:41d0:a:280::1	0.452	0.406	0.000	00:02:06
mail.gegeweb.eu	4.436	3.969	1.614	00:01:58
2001:41d0:700:1273::	0.038	0.029	0.000	00:00:18
pool-100-38-239-226.nycmny.fios.verizon.net	0.342	0.716	0.000	00:00:13
147.185.133.102	0.034	0.008	0.000	00:00:13
206.168.34.115	0.079	0.054	0.000	00:00:11
205.210.31.55	0.031	0.019	0.000	00:00:10
147.185.132.72	0.017	0.030	0.000	00:00:10
azpdssc1.stretchoid.com	0.018	0.004	0.000	00:00:09
oconnor.probe.onyphe.net	0.019	0.005	0.000	00:00:04
161.150.216.162.bc.googleusercontent.com	0.055	0.023	0.000	00:00:00
88-165-5-23.subs.proxad.net	0.011	0.014	0.000	00:00:00
203.55.131.3	0.024	0.020	0.000	00:00:00
azpdegb71.stretchoid.com	0.030	0.017	0.000	00:00:00
26.211.203.35.bc.googleusercontent.com	0.032	0.020	0.000	00:00:00
205.210.31.45	0.026	0.026	0.000	00:00:00
TOTAL: 17	9.280	12.711	1.614	01:34:23

Curious NNRP server explorers [Top 20]:

System	Conn
mail.gegeweb.eu	288
2001:41d0:a:280::1	25
206.168.34.115	3
2001:41d0:700:1273::	2
26.211.203.35.bc.googleusercontent.com	1
88-165-5-23.subs.proxad.net	1
205.210.31.45	1
147.185.132.72	1
pool-100-38-239-226.nycmny.fios.verizon.net	1
205.210.31.55	1
azpdegb71.stretchoid.com	1
161.150.216.162.bc.googleusercontent.com	1
azpdssc1.stretchoid.com	1
147.185.133.102	1
203.55.131.3	1
oconnor.probe.onyphe.net	1
TOTAL: 16	330

NNRP unrecognized commands (by host):

System	Conn
161.150.216.162.bc.googleusercontent.com	4
26.211.203.35.bc.googleusercontent.com	4
147.185.133.102	4
206.168.34.115	1
azpdegb71.stretchoid.com	1
TOTAL: 5	14

NNRP unrecognized commands (by command):

Command	Count
User-Agent: Expanse, a Palo Alto Network...	3
Accept-Encoding: gzip	3
GET / HTTP/1.1	3
Host: 45.13.105.36:563	2
EHLO www.censys.io	1
MGLNDD_45.13.105.36_119	1
Host: 45.13.105.36:119	1
TOTAL: 7	14

NNRP client timeouts [Top 20]:

System	Conn	Peer
206.168.34.115	1	2
TOTAL: 1	1	3

Newsgroup request counts (by category):

Category		Count	Pct
1	grisbi	13662	85.5%
2	local	2312	14.5%
TOTAL: 2		15974	100.0%

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

Newsgroup		Count
1	grisbi.devel	3669
2	grisbi.test	3479
3	grisbi.user.french	3478
4	grisbi.bugsreports	2582
5	local.test	2156
6	grisbi.cvs	258
7	grisbi.user	194
8	local.gegeweb.support	156
9	grisbi.admin	2
TOTAL: 9		15974

Daily Usenet report for news.niel.me

Feb 20 04:15:02 -- Feb 21 04:15:01