Daily Usenet report: Jan 5 04:15:02

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Jan 5 08:10:12 newsfeed nnrpd[2142622]: SERVER perl filter not defined
Jan 5 08:47:52 newsfeed overchan[2130941]: input line too long, skipping
Jan 5 09:55:30 newsfeed overchan[2130941]: input line too long, skipping
Jan 5 16:20:18 newsfeed overchan[2130941]: input line too long, skipping
Jan 5 18:09:33 newsfeed overchan[2130941]: input line too long, skipping
Jan 5 19:09:02 newsfeed overchan[2130941]: input line too long, skipping
Jan 5 21:11:27 newsfeed overchan[2130941]: input line too long, skipping
Jan 5 21:25:13 newsfeed overchan[2130941]: input line too long, skipping
Jan 5 22:35:52 newsfeed overchan[2130941]: input line too long, skipping
Jan 5 23:47:29 newsfeed overchan[2130941]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1009647	96.2%	110.1 MB	95.6%
innfeed	25810	2.5%	3.1 MB	2.7%
innd	10513	1.0%	1.6 MB	1.4%
nnrpd	3344	0.3%	319.4 KB	0.3%
overchan	10	0.0%	1.9 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	1049325	100.0%	115.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1004807	99.7%
Negative hits	2811	0.3%
Positive hits	239	0.0%
Cache misses	31	0.0%
TOTAL: 4	1007888	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.864	0.0%	53	0.000	16.302	81.000
article cleanup	00:00:04.019	0.0%	1010802	0.002	0.004	0.008
article logging	00:00:15.736	0.0%	1011207	0.011	0.016	0.023
article parse	00:07:05.871	0.5%	191564334	0.002	0.002	0.003
article write	00:05:10.616	0.4%	1010632	0.153	0.307	0.591
artlog/artcncl	00:00:00.000	0.0%	53	0.000	0.000	0.000
data move	00:00:27.627	0.0%	198957844	0.000	0.000	0.000
hisgrep/artcncl	00:00:00.155	0.0%	53	0.000	2.925	24.000
hishave/artcncl	00:00:00.006	0.0%	53	0.000	0.113	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:07:04.142	0.5%	1014465	0.117	0.418	7.866
history sync	00:00:00.023	0.0%	290	0.000	0.079	8.000
history write	00:20:03.191	1.4%	1010781	0.153	1.190	16.019
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	22:20:44.129	93.1%	190646213	0.304	0.422	0.677
nntp read	00:17:40.426	1.2%	190924761	0.005	0.006	0.006
overview write	00:00:02.174	0.0%	1010632	0.001	0.002	0.004
perl filter	00:29:16.956	2.0%	1010781	1.377	1.738	2.203
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:16.811	0.0%	2031587	0.006	0.008	0.010
TOTAL: 24:00:00.808	23:48:12.746	99.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.037	0.0%	33291	0.000	0.001	0.015
article prepare	00:00:00.003	0.0%	9496	0.000	0.000	0.029
article read	00:00:14.056	0.0%	2407	0.000	5.840	52.500
backlog stats	00:00:00.042	0.0%	89847	0.000	0.000	0.005
callbacks	00:00:00.000	0.0%	30	0.000	0.000	0.000
data read	00:00:00.289	0.0%	42505	0.000	0.007	0.024
data write	00:00:00.603	0.0%	33323	0.000	0.018	0.056
idle	23:55:22.577	100.0%	89847	521.730	958.547	2265.989
status file	00:00:06.009	0.0%	8509	0.183	0.706	30.459
TOTAL: 23:55:46.526	23:55:43.616	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:00:08.866	99.9%	2762	0.000	1306.613	360092.200
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.061	0.0%	5882	0.000	0.010	0.500
readart	00:00:00.000	0.0%	26	0.000	0.000	0.000
TOTAL: 01:00:14.031	01:00:08.927	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	77	1009139	1008998	0	141	99%	61:04:58
2	news.icm.edu.pl	44	253	21	202	30	8%	15:27:18
3	localhost	1442	1	1	0	0	100%	00:00:00
TOTAL: 3		1563	1009393	1009020	202	171	99%	76:32:16

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	379.2 GB	1.8 MB	2.1 MB	379.2 GB	99%	394.0 KB
2	news.icm.edu.pl	1.9 MB	0.0 KB	416.9 KB	2.3 MB	82%	45.8 KB
3	localhost	1.3 KB	0.0 KB	0.0 KB	1.3 KB	100%	1.3 KB
TOTAL: 3		379.2 GB	1.8 MB	2.5 MB	379.2 GB	99%	394.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 5 04:15:02 - 04:59:59	31311	3.1%	11.61	13.5 GB	3.6%	5235.11
Jan 5 05:00:00 - 05:59:59	36748	3.6%	10.21	18.3 GB	4.8%	5334.79
Jan 5 06:00:00 - 06:59:59	38749	3.8%	10.76	19.3 GB	5.1%	5626.88
Jan 5 07:00:00 - 07:59:59	37164	3.7%	10.32	17.6 GB	4.6%	5125.04
Jan 5 08:00:00 - 08:59:59	31884	3.2%	8.86	16.4 GB	4.3%	4774.50
Jan 5 09:00:00 - 09:59:59	34875	3.5%	9.69	16.4 GB	4.3%	4790.57
Jan 5 10:00:00 - 10:59:59	36292	3.6%	10.08	16.5 GB	4.4%	4806.09
Jan 5 11:00:00 - 11:59:59	37283	3.7%	10.36	17.9 GB	4.7%	5203.61
Jan 5 12:00:00 - 12:59:59	41450	4.1%	11.51	18.1 GB	4.8%	5270.67
Jan 5 13:00:00 - 13:59:59	38152	3.8%	10.60	16.5 GB	4.4%	4810.41
Jan 5 14:00:00 - 14:59:59	36031	3.6%	10.01	15.5 GB	4.1%	4520.11
Jan 5 15:00:00 - 15:59:59	64603	6.4%	17.95	15.2 GB	4.0%	4414.93
Jan 5 16:00:00 - 16:59:59	59083	5.9%	16.41	15.5 GB	4.1%	4522.78
Jan 5 17:00:00 - 17:59:59	53806	5.3%	14.95	13.2 GB	3.5%	3836.57
Jan 5 18:00:00 - 18:59:59	60290	6.0%	16.75	12.6 GB	3.3%	3665.11
Jan 5 19:00:00 - 19:59:59	52772	5.2%	14.66	13.2 GB	3.5%	3849.60
Jan 5 20:00:00 - 20:59:59	64511	6.4%	17.92	13.6 GB	3.6%	3969.20
Jan 5 21:00:00 - 21:59:59	32591	3.2%	9.05	14.5 GB	3.8%	4220.21
Jan 5 22:00:00 - 22:59:59	31607	3.1%	8.78	14.8 GB	3.9%	4302.16
Jan 5 23:00:00 - 23:59:59	35983	3.6%	10.00	14.8 GB	3.9%	4297.33
Jan 6 00:00:00 - 00:59:59	41605	4.1%	11.56	14.8 GB	3.9%	4307.37
Jan 6 01:00:00 - 01:59:59	33057	3.3%	9.18	15.9 GB	4.2%	4626.74
Jan 6 02:00:00 - 02:59:59	38406	3.8%	10.67	17.0 GB	4.5%	4942.94
Jan 6 03:00:00 - 03:59:59	32975	3.3%	9.16	14.5 GB	3.8%	4224.62
Jan 6 04:00:00 - 04:15:02	7792	0.8%	8.64	3.7 GB	1.0%	4258.80
TOTAL: 24:00:00	1009020	100.0%	11.68	379.1 GB	100.0%	4601.36

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	544	116	21	3	404
2	news.icm.edu.pl	30	0	0	0	30
TOTAL: 2		574	116	21	3	434

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	99
comp.mobile.android	12
it.tlc.cellulari.android	2
it.comp.os.win.windows8	1
comp.sys.raspberry-pi	1
alt.comp.software.firefox	1
TOTAL: 6	116

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

Groups	Count
pl.praca.oferowana	3
TOTAL: 1	3

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	26
EMP (fsl)	1
Binary in non-binary group	1
Scoring filter (8)	1
TOTAL: 4	29

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	403
	news.icm.edu.pl	2
	TOTAL: 2	405
TOTAL: 1		405

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	17939	1301	8436	281	0	0	7%	23:59:32
2	panorama	23594	196	9189	193	68	23713	0%	23:59:30
3	poznan	5	0	5	0	0	0	0%	01:00:00
4	nask	0	0	0	0	0	7408	0%	23:57:47
5	okapi	0	0	0	0	0	977	0%	23:57:49
TOTAL: 5		41538	1497	17630	474	68	32098	3%	96:54:38

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	6.6 MB	63.7 MB	70.3 MB	0.8 KB/s	45.5 KB	23:59:32
2	panorama	1.1 MB	2.6 MB	3.7 MB	0.0 KB/s	9.7 KB	23:59:30
3	poznan	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	01:00:00
4	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:47
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:49
TOTAL: 5		7.7 MB	66.3 MB	74.0 MB	0.2 KB/s	38.4 KB	96:54:38

Backlog files shrunk by innfeed:

Server	Size
okapi	488.4 KB
TOTAL: 1	488.4 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	26	28.1 KB	13	0	00:00:08
2	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 2		289	26	28.1 KB	13	1	01:00:14

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	291	26	28.1 KB	13	1	01:00:09
2	unresolved	102	0	0.0 KB	0	0	00:00:03
3	*.ch1.censys-scanner.com	1	0	0.0 KB	0	0	00:00:00
TOTAL: 3		394	26	28.1 KB	13	1	01:00:14

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-tom.man.lodz.pl	0.009	0.005	01:00:01
web.man.lodz.pl	0.575	1.792	00:00:08
80.111.142.213	0.000	0.035	00:00:01
212.51.192.185	0.149	0.550	00:00:01
scanner-05.ch1.censys-scanner.com	0.004	0.004	00:00:00
150.129.136.38	0.004	0.004	00:00:00
94.102.61.41	0.004	0.004	00:00:00
isvcs01.man.lodz.pl	0.000	0.010	00:00:00
TOTAL: 8	0.745	2.404	01:00:14

Curious NNRP server explorers [Top 20]:

System	Conn
212.51.192.185	96
80.111.142.213	4
pc-tom.man.lodz.pl	2
94.102.61.41	1
150.129.136.38	1
scanner-05.ch1.censys-scanner.com	1
TOTAL: 6	105

NNRP unrecognized commands (by host):

System	Conn
94.102.61.41	5
scanner-05.ch1.censys-scanner.com	1
TOTAL: 2	6

NNRP unrecognized commands (by command):

Command	Count
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
Accept-Encoding: gzip	1
EHLO www.censys.io	1
Host: 212.191.2.21:119	1
Accept: /	1
GET / HTTP/1.1	1
TOTAL: 6	6

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-tom.man.lodz.pl	2	0
TOTAL: 1	2	0

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	26	100.0%
TOTAL: 1		26	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	16
2	pl.comp.os.ms-windows.winnt	10
TOTAL: 2		26

Daily Usenet report

Jan 5 04:15:02 -- Jan 6 04:15:02