Daily Usenet report: Oct 9 04:15:01

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Oct 9 06:40:08 newsfeed nnrpd[1359506]: SERVER perl filter not defined
Oct 9 07:30:29 newsfeed nnrpd[1361696]: SERVER perl filter not defined
Oct 9 11:17:37 newsfeed nnrpd[1371592]: SERVER perl filter not defined
Oct 9 14:11:57 newsfeed nnrpd[1379285]: SERVER perl filter not defined
Oct 9 14:16:51 newsfeed nnrpd[1379436]: SERVER perl filter not defined
Oct 9 16:57:31 newsfeed nnrpd[1386913]: SERVER perl filter not defined
Oct 9 18:17:34 newsfeed nnrpd[1390426]: SERVER perl filter not defined
Oct 10 01:31:57 newsfeed nnrpd[1410189]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	195244	94.3%	22.4 MB	94.9%
nnrpd	7915	3.8%	796.8 KB	3.3%
innd	2633	1.3%	299.3 KB	1.2%
innfeed	1258	0.6%	146.2 KB	0.6%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	207051	100.0%	23.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	193158	99.3%
Negative hits	1211	0.6%
Positive hits	110	0.1%
Cache misses	36	0.0%
TOTAL: 4	194515	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.612	0.0%	85	0.000	18.965	54.500
article cleanup	00:00:01.061	0.0%	195148	0.000	0.005	0.015
article logging	00:00:04.081	0.0%	195192	0.013	0.021	0.044
article parse	00:00:04.951	0.0%	583677	0.003	0.008	0.014
article write	00:00:15.661	0.0%	194970	0.040	0.080	0.522
artlog/artcncl	00:00:00.001	0.0%	85	0.000	0.012	0.167
data move	00:00:00.636	0.0%	733021	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.612	0.0%	85	0.000	7.200	25.000
hishave/artcncl	00:00:00.388	0.0%	85	0.000	4.565	19.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:30:28.113	2.1%	196631	4.984	9.297	22.943
history sync	00:00:00.018	0.0%	395	0.000	0.046	1.000
history write	00:29:40.382	2.1%	195141	5.908	9.124	20.778
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	22:56:35.894	95.5%	555470	9.902	148.696	352.080
nntp read	00:00:07.552	0.0%	487575	0.007	0.015	0.025
overview write	00:00:00.506	0.0%	194970	0.000	0.003	0.008
perl filter	00:02:55.751	0.2%	195141	0.581	0.901	1.363
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:05.902	0.0%	442524	0.006	0.013	0.020
TOTAL: 24:00:55.251	24:00:23.121	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.078	0.0%	52128	0.000	0.001	0.010
article prepare	00:00:00.000	0.0%	156	0.000	0.000	0.000
article read	00:00:00.001	0.0%	39	0.000	0.026	1.000
backlog stats	00:00:00.038	0.0%	72084	0.000	0.001	0.008
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.543	0.0%	59251	0.000	0.009	0.030
data write	00:00:00.309	0.0%	7311	0.000	0.042	0.150
idle	23:49:52.813	100.0%	72084	59.458	1190.178	5204.293
status file	00:00:00.203	0.0%	328	0.000	0.619	8.000
TOTAL: 23:49:57.988	23:49:53.985	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	06:49:11.311	99.9%	5026	0.000	4884.861	600056.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.175	0.0%	13282	0.000	0.013	0.500
readart	00:00:04.550	0.0%	667	0.000	6.822	7.029
TOTAL: 06:49:35.199	06:49:16.036	99.9%	-	-	-	-

Control commands to INND:

Command	Number
flush	27
flushlogs	2
go	2
logmode	2
lowmark	1
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	192

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	107	195097	194924	1	172	99%	41:02:08
2	localhost	9	8	8	0	0	100%	00:00:00
3	news.icm.edu.pl	34	65	6	53	6	9%	07:16:57
TOTAL: 3		150	195170	194938	54	178	99%	48:19:05

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	1.8 GB	20.5 KB	593.0 KB	1.8 GB	99%	9.5 KB
2	news.icm.edu.pl	141.0 KB	37.6 KB	57.3 KB	235.9 KB	59%	19.7 KB
3	localhost	14.5 KB	0.0 KB	0.0 KB	14.5 KB	100%	1.8 KB
TOTAL: 3		1.8 GB	58.1 KB	650.3 KB	1.8 GB	99%	9.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 9 04:15:01 - 04:59:59	4583	2.4%	1.70	30.2 MB	1.7%	11.44
Oct 9 05:00:00 - 05:59:59	6490	3.3%	1.80	51.7 MB	2.9%	14.70
Oct 9 06:00:00 - 06:59:59	4673	2.4%	1.30	45.2 MB	2.5%	12.85
Oct 9 07:00:00 - 07:59:59	7813	4.0%	2.17	59.6 MB	3.3%	16.97
Oct 9 08:00:00 - 08:59:59	4963	2.5%	1.38	51.5 MB	2.8%	14.65
Oct 9 09:00:00 - 09:59:59	5009	2.6%	1.39	51.6 MB	2.8%	14.67
Oct 9 10:00:00 - 10:59:59	12586	6.5%	3.50	105.6 MB	5.8%	30.04
Oct 9 11:00:00 - 11:59:59	7088	3.6%	1.97	67.2 MB	3.7%	19.11
Oct 9 12:00:00 - 12:59:59	7688	3.9%	2.14	60.9 MB	3.4%	17.33
Oct 9 13:00:00 - 13:59:59	5625	2.9%	1.56	55.8 MB	3.1%	15.87
Oct 9 14:00:00 - 14:59:59	9239	4.7%	2.57	68.7 MB	3.8%	19.55
Oct 9 15:00:00 - 15:59:59	8097	4.2%	2.25	64.5 MB	3.6%	18.34
Oct 9 16:00:00 - 16:59:59	7093	3.6%	1.97	63.7 MB	3.5%	18.11
Oct 9 17:00:00 - 17:59:59	8235	4.2%	2.29	81.9 MB	4.5%	23.31
Oct 9 18:00:00 - 18:59:59	19275	9.9%	5.35	270.5 MB	14.9%	76.93
Oct 9 19:00:00 - 19:59:59	5323	2.7%	1.48	55.7 MB	3.1%	15.85
Oct 9 20:00:00 - 20:59:59	19413	10.0%	5.39	147.4 MB	8.1%	41.93
Oct 9 21:00:00 - 21:59:59	5469	2.8%	1.52	54.5 MB	3.0%	15.49
Oct 9 22:00:00 - 22:59:59	7368	3.8%	2.05	60.9 MB	3.4%	17.33
Oct 9 23:00:00 - 23:59:59	5546	2.8%	1.54	64.5 MB	3.6%	18.35
Oct 10 00:00:00 - 00:59:59	7844	4.0%	2.18	75.6 MB	4.2%	21.51
Oct 10 01:00:00 - 01:59:59	9843	5.0%	2.73	86.9 MB	4.8%	24.72
Oct 10 02:00:00 - 02:59:59	7808	4.0%	2.17	70.2 MB	3.9%	19.98
Oct 10 03:00:00 - 03:59:59	5936	3.0%	1.65	51.4 MB	2.8%	14.63
Oct 10 04:00:00 - 04:15:01	1931	1.0%	2.14	16.3 MB	0.9%	18.55
TOTAL: 24:00:00	194938	100.0%	2.26	1.8 GB	100.0%	21.48

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	215	154	3	15	43
2	news.icm.edu.pl	6	0	4	0	2
TOTAL: 2		221	154	7	15	45

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	87
it.comp.os.win.windows10	23
alt.comp.software.firefox	11
alt.comp.software.seamonkey	8
eternal-september.test	5
rocksolid.nodes.help	5
eternal-september.support	4
it.tlc.cellulari.android	2
rocksolid.shared.test	2
comp.mobile.android	1
nl.comp.os.linux.techniek	1
it.discussioni.energia	1
grisbi.test	1
it.comp.virtualizzazione	1
rocksolid.nodes.announce	1
it.comp.os.linux.ubuntu	1
TOTAL: 16	154

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
christnet.bible	15
TOTAL: 1	15

INND Perl filter [Top 20]:

Reason	Count
Scoring filter (10)	1
Binary in non-binary group	1
TOTAL: 2	2

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	43
	TOTAL: 1	43
TOTAL: 1		43

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	7090	33	6238	3	0	0%	23:50:01
2	poznan	7	3	3	0	0	42%	01:10:05
3	panorama	0	0	0	0	52169	0%	23:50:01
4	nask	0	0	0	0	49621	0%	23:50:01
5	okapi	0	0	0	0	743	0%	23:50:01
TOTAL: 5		7097	36	6241	3	102533	0%	96:30:09

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	107.9 KB	32.5 KB	140.4 KB	3.9 KB	23:50:01
2	poznan	24.9 KB	0.0 KB	24.9 KB	8.3 KB	01:10:05
3	panorama	0.0 KB	0.0 KB	0.0 KB	0	23:50:01
4	nask	0.0 KB	0.0 KB	0.0 KB	0	23:50:01
5	okapi	0.0 KB	0.0 KB	0.0 KB	0	23:50:01
TOTAL: 5		132.8 KB	32.5 KB	165.2 KB	4.2 KB	96:30:09

Backlog files shrunk by innfeed:

Server	Size
panorama	4.3 MB
TOTAL: 1	4.3 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	69.10.48.174	8	663	448.6 KB	4	0	00:02:56
2	web.man.lodz.pl	289	4	11.2 KB	2	0	00:00:08
3	isvcs01.man.lodz.pl	8	0	0.0 KB	0	8	00:00:00
TOTAL: 3		305	667	459.8 KB	6	8	06:49:35

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	unresolved	123	663	448.6 KB	4	0	00:04:10
2	*.man.lodz.pl	1747	4	11.2 KB	2	8	06:37:49
3	*.survey.inspici.com	1	0	0.0 KB	0	0	00:00:03
4	*.air-net.gda.pl	1	0	0.0 KB	0	0	00:07:11
5	*.stretchoid.com	2	0	0.0 KB	0	0	00:00:10
6	*.233.111.227.socradar-curiosity-wide-scan-project.socradar.com	1	0	0.0 KB	0	0	00:00:10
TOTAL: 6		1875	667	459.8 KB	6	8	06:49:35

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-tom.man.lodz.pl	0.024	0.067	06:37:27
ip-91-232-51-30.air-net.gda.pl	0.057	0.008	00:07:11
69.10.48.174	0.072	0.116	00:02:56
222.186.13.132	0.000	0.006	00:00:24
165.154.12.38	0.009	0.016	00:00:10
172.233.111.227.socradar-curiosity-wide-scan-project.socradar.com	0.005	0.002	00:00:10
147.185.132.81	0.004	0.007	00:00:10
205.210.31.107	0.003	0.003	00:00:10
azpdcsb26.stretchoid.com	0.004	0.004	00:00:09
web.man.lodz.pl	0.774	1.779	00:00:08
nms2.man.lodz.pl	2.494	5.935	00:00:08
167.94.138.53	0.012	0.021	00:00:05
199.45.154.124	0.010	0.021	00:00:04
80.111.142.213	0.007	0.024	00:00:03
nms1.man.lodz.pl	0.927	2.166	00:00:03
167.94.145.99	0.016	0.023	00:00:03
server-0-3.survey.inspici.com	0.000	0.006	00:00:03
212.51.192.185	0.219	0.600	00:00:00
isvcs01.man.lodz.pl	0.036	0.065	00:00:00
azpdsgc58.stretchoid.com	0.000	0.008	00:00:00
TOTAL: 20	4.673	10.877	06:49:35

Curious NNRP server explorers [Top 20]:

System	Conn
nms2.man.lodz.pl	1012
nms1.man.lodz.pl	428
212.51.192.185	96
pc-tom.man.lodz.pl	10
80.111.142.213	4
165.154.12.38	3
199.45.154.124	3
167.94.145.99	3
167.94.138.53	3
azpdcsb26.stretchoid.com	1
147.185.132.81	1
222.186.13.132	1
205.210.31.107	1
azpdsgc58.stretchoid.com	1
server-0-3.survey.inspici.com	1
ip-91-232-51-30.air-net.gda.pl	1
172.233.111.227.socradar-curiosity-wide-scan-project.socradar.com	1
TOTAL: 17	1570

NNRP unrecognized commands (by host):

System	Conn
165.154.12.38	2
199.45.154.124	1
azpdsgc58.stretchoid.com	1
167.94.138.53	1
167.94.145.99	1
TOTAL: 5	6

NNRP unrecognized commands (by command):

Command	Count
EHLO www.censys.io	3
#026#003#001#001#027#001	1
À#024	1
MGLNDD_212.191.2.21_119	1
TOTAL: 4	6

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-tom.man.lodz.pl	10	0
199.45.154.124	1	2
167.94.138.53	1	2
167.94.145.99	1	2
TOTAL: 4	13	6

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	663	99.4%
2	pl	4	0.6%
TOTAL: 2		667	100.0%

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

Newsgroup		Count
1	lodman.info	663
2	pl.comp.pecet	2
3	pl.comp.os.ms-windows.winnt	2
TOTAL: 3		667

Daily Usenet report

Oct 9 04:15:01 -- Oct 10 04:15:01