Daily Usenet report: Jan 2 04:15:03

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Jan 2 06:59:30 newsfeed pgpverify[5019]: pgpverify: verification failed
Jan 2 10:46:08 newsfeed nnrpd[13177]: SERVER perl filter not defined
Jan 2 13:41:59 newsfeed nnrpd[19579]: SERVER perl filter not defined
Jan 2 17:14:17 newsfeed overchan[30784]: input line too long, skipping
Jan 2 18:27:56 newsfeed overchan[30784]: input line too long, skipping
Jan 2 18:30:05 newsfeed overchan[30784]: input line too long, skipping
Jan 2 18:37:14 newsfeed overchan[30784]: input line too long, skipping
Jan 2 19:04:19 newsfeed overchan[30784]: input line too long, skipping
Jan 3 00:08:52 newsfeed nnrpd[10080]: SERVER perl filter not defined
Jan 3 01:33:36 newsfeed nnrpd[13225]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2912357	97.4%	329.4 MB	97.0%
innfeed	46956	1.6%	5.5 MB	1.6%
innd	27053	0.9%	4.2 MB	1.2%
nnrpd	4780	0.2%	500.4 KB	0.1%
overchan	6	0.0%	1.0 KB	0.0%
controlchan	4	0.0%	0.5 KB	0.0%
pgpverify	1	0.0%	0.2 KB	0.0%
TOTAL: 7	2991157	100.0%	339.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2866035	94.9%
Negative hits	138649	4.6%
Positive hits	15076	0.5%
Cache misses	431	0.0%
TOTAL: 4	3020191	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:13.414	0.0%	459	0.000	29.224	164.833
article cleanup	00:00:33.285	0.0%	2904371	0.008	0.011	0.015
article logging	00:01:48.166	0.1%	2905352	0.027	0.037	0.078
article parse	00:37:53.594	2.6%	80653236	0.019	0.028	0.058
article write	00:15:17.483	1.1%	2890126	0.179	0.317	0.651
artlog/artcncl	00:00:00.014	0.0%	453	0.000	0.031	0.053
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:02:03.932	0.1%	93879965	0.001	0.001	0.004
hisgrep/artcncl	00:00:04.033	0.0%	454	0.000	8.883	31.000
hishave/artcncl	00:00:01.425	0.0%	459	0.000	3.105	19.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:38:25.660	11.0%	3055889	0.388	3.111	10.498
history sync	00:00:00.014	0.0%	290	0.000	0.048	0.500
history write	06:41:10.149	27.9%	2899929	1.516	8.300	14.930
hiswrite/artcncl	00:00:00.091	0.0%	5	9.000	18.200	27.000
idle	08:15:33.420	34.4%	54022987	0.069	0.550	1.442
nntp read	00:39:49.755	2.8%	78356994	0.023	0.030	0.042
overview write	00:00:14.058	0.0%	2890126	0.004	0.005	0.006
perl filter	04:21:01.278	18.1%	2899928	4.030	5.401	7.178
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:27.482	0.3%	5801002	0.036	0.046	0.065
TOTAL: 24:00:06.878	23:38:37.253	98.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.164	0.0%	62939	0.000	0.003	0.014
article prepare	00:00:00.001	0.0%	17250	0.000	0.000	0.013
article read	00:01:31.147	0.1%	4284	0.000	21.276	1054.043
backlog stats	00:00:00.157	0.0%	172733	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:01.433	0.0%	90957	0.005	0.016	0.036
data write	00:00:06.318	0.0%	76119	0.024	0.083	0.351
idle	23:51:26.915	99.8%	172733	73.192	497.224	1156.950
status file	00:01:21.689	0.1%	16296	0.525	5.013	493.846
TOTAL: 23:54:47.448	23:54:27.824	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:20.744	59.1%	3061	0.000	6.777	1648.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.190	0.5%	6754	0.000	0.028	0.667
readart	00:00:00.001	0.0%	46	0.000	0.022	0.250
TOTAL: 00:00:35.074	00:00:20.935	59.7%	-	-	-	-

Control commands to INND:

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
hun-mnt@news.sztaki.hu	0	0	0	1	0	0
TOTAL	0	0	0	1	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	572	2899967	2884590	8321	7056	99%	530:55:00
2	news.nask.pl	2	20493	11067	2206	7220	54%	24:05:53
3	news.icm.edu.pl	39	209	32	173	4	15%	15:47:04
4	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 4		618	2920673	2895693	10700	14280	99%	570:47:57

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	601.7 GB	427.5 MB	945.9 MB	603.0 GB	99%	218.7 KB
2	news.nask.pl	65.1 MB	6.3 MB	450.5 MB	521.8 MB	12%	29.2 KB
3	news.icm.edu.pl	1.3 MB	8.1 KB	47.0 KB	1.3 MB	95%	37.7 KB
4	localhost	9.2 KB	0.0 KB	0.0 KB	9.2 KB	100%	2.3 KB
TOTAL: 4		601.7 GB	433.8 MB	1.4 GB	603.5 GB	99%	217.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 2 04:15:03 - 04:59:59	88366	3.1%	32.76	20.8 GB	3.4%	8071.54
Jan 2 05:00:00 - 05:59:59	114040	3.9%	31.68	29.9 GB	5.0%	8709.86
Jan 2 06:00:00 - 06:59:59	124855	4.3%	34.68	32.6 GB	5.4%	9502.67
Jan 2 07:00:00 - 07:59:59	130530	4.5%	36.26	33.1 GB	5.5%	9635.87
Jan 2 08:00:00 - 08:59:59	126090	4.4%	35.02	29.4 GB	4.9%	8568.81
Jan 2 09:00:00 - 09:59:59	113397	3.9%	31.50	25.8 GB	4.3%	7502.05
Jan 2 10:00:00 - 10:59:59	108982	3.8%	30.27	24.8 GB	4.1%	7224.92
Jan 2 11:00:00 - 11:59:59	95330	3.3%	26.48	22.1 GB	3.7%	6429.11
Jan 2 12:00:00 - 12:59:59	94031	3.2%	26.12	19.4 GB	3.2%	5663.46
Jan 2 13:00:00 - 13:59:59	92427	3.2%	25.67	18.8 GB	3.1%	5461.89
Jan 2 14:00:00 - 14:59:59	122470	4.2%	34.02	25.8 GB	4.3%	7520.60
Jan 2 15:00:00 - 15:59:59	125344	4.3%	34.82	26.6 GB	4.4%	7739.08
Jan 2 16:00:00 - 16:59:59	102642	3.5%	28.51	24.0 GB	4.0%	6977.20
Jan 2 17:00:00 - 17:59:59	110654	3.8%	30.74	26.7 GB	4.4%	7773.04
Jan 2 18:00:00 - 18:59:59	120809	4.2%	33.56	30.1 GB	5.0%	8760.02
Jan 2 19:00:00 - 19:59:59	101590	3.5%	28.22	21.3 GB	3.5%	6194.82
Jan 2 20:00:00 - 20:59:59	98004	3.4%	27.22	21.9 GB	3.6%	6381.93
Jan 2 21:00:00 - 21:59:59	85167	2.9%	23.66	19.9 GB	3.3%	5794.06
Jan 2 22:00:00 - 22:59:59	128674	4.4%	35.74	22.8 GB	3.8%	6636.46
Jan 2 23:00:00 - 23:59:59	123569	4.3%	34.32	28.0 GB	4.6%	8149.55
Jan 3 00:00:00 - 00:59:59	117871	4.1%	32.74	20.1 GB	3.3%	5867.74
Jan 3 01:00:00 - 01:59:59	191094	6.6%	53.08	26.2 GB	4.3%	7622.49
Jan 3 02:00:00 - 02:59:59	162493	5.6%	45.14	22.5 GB	3.7%	6549.63
Jan 3 03:00:00 - 03:59:59	173029	6.0%	48.06	23.9 GB	4.0%	6963.35
Jan 3 04:00:00 - 04:15:02	45162	1.6%	50.07	5.9 GB	1.0%	6845.07
TOTAL: 23:59:59	2896620	100.0%	33.53	602.2 GB	100.0%	7308.03

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	7695	13	455	2	7225
2	newsfeed.pionier.net.pl	7577	167	3985	0	3425
3	news.icm.edu.pl	4	0	1	0	3
TOTAL: 3		15276	180	4441	2	10653

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	129
it.tlc.cellulari.android	18
it.comp.os.win.windows10	12
comp.sys.raspberry-pi	7
comp.mobile.android	6
it.comp.os.linux.ubuntu	4
it.comp.os.win.windows7	1
it.politica.m5s	1
nl.comp.sys.android	1
it.discussioni.energia	1
TOTAL: 10	180

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

Groups	Count
pl.sci.matematyka	1
bit.listserv.catholic	1
TOTAL: 2	2

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	5480
EMP (md5)	4041
Scoring filter (9)	111
Scoring filter (10)	15
Scoring filter (8)	12
HTML post	5
Scoring filter (16)	2
Scoring filter (11)	1
Scoring filter (12)	1
Excessively crossposted test article	1
Too many newsgroups (low_xpost)	1
TOTAL: 11	9670

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	519
	news.nask.pl	463
	TOTAL: 2	982
TOTAL: 1		982

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	46388	1097	17980	207	3	43792	2%	23:59:57
2	poznan	16238	556	10316	66	0	1	3%	23:59:55
3	icm	22718	53	18972	360	0	1	0%	23:59:57
4	nask	3838	4	2090	1195	0	0	0%	23:56:57
5	okapi	0	0	0	0	0	1551	0%	23:57:49
TOTAL: 5		89182	1710	49358	1828	3	45345	1%	119:54:35

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	20.3 MB	87.9 MB	108.2 MB	1.3 KB/s	268.2 KB	23:59:57
2	panorama	12.7 MB	830.5 KB	13.5 MB	0.2 KB/s	10.6 KB	23:59:57
3	poznan	2.4 MB	1.8 MB	4.2 MB	0.0 KB/s	6.9 KB	23:59:55
4	nask	7.4 KB	836.5 MB	836.5 MB	9.9 KB/s	714.4 KB	23:56:57
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:49
TOTAL: 5		35.4 MB	927.0 MB	962.5 MB	2.3 KB/s	278.6 KB	119:54:35

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	46	45.6 KB	21	0	00:00:24
2	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:04
TOTAL: 2		292	46	45.6 KB	21	4	00:00:34

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	676	46	45.6 KB	21	4	00:00:32
2	*.members.linode.com	1	0	0.0 KB	0	0	00:00:01
TOTAL: 2		677	46	45.6 KB	21	4	00:00:34

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.152	7.120	00:00:24
isvcs01.man.lodz.pl	0.024	0.092	00:00:04
mon.man.lodz.pl	0.948	6.720	00:00:03
li922-80.members.linode.com	0.004	0.036	00:00:01
david.man.lodz.pl	0.312	2.160	00:00:00
TOTAL: 5	2.440	16.128	00:00:34

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
li922-80.members.linode.com	1
TOTAL: 3	385

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	38
2	pl.comp.os.ms-windows.winnt	8
TOTAL: 2		46

Daily Usenet report

Jan 2 04:15:03 -- Jan 3 04:15:02