Daily Usenet report: Mar 19 04:15:02

Unknown entries from news log file:

First 17 / 17 lines (100.0%)

Mar 19 07:15:17 newsfeed overchan[10768]: input line too long, skipping
Mar 19 07:55:15 newsfeed overchan[10768]: input line too long, skipping
Mar 19 07:55:34 newsfeed overchan[10768]: input line too long, skipping
Mar 19 08:15:53 newsfeed overchan[10768]: input line too long, skipping
Mar 19 09:20:58 newsfeed nnrpd[22658]: SERVER perl filter not defined
Mar 19 09:21:18 newsfeed nnrpd[22664]: SERVER perl filter not defined
Mar 19 09:21:27 newsfeed nnrpd[22665]: SERVER perl filter not defined
Mar 19 09:33:12 newsfeed overchan[10768]: input line too long, skipping
Mar 19 10:23:48 newsfeed overchan[10768]: input line too long, skipping
Mar 19 13:00:18 newsfeed nnrpd[30747]: SERVER perl filter not defined
Mar 19 13:03:32 newsfeed nnrpd[30794]: SERVER perl filter not defined
Mar 19 15:05:08 newsfeed overchan[10768]: input line too long, skipping
Mar 19 15:05:23 newsfeed overchan[10768]: input line too long, skipping
Mar 19 18:05:45 newsfeed nnrpd[9444]: SERVER perl filter not defined
Mar 19 19:17:02 newsfeed nnrpd[12027]: SERVER perl filter not defined
Mar 19 21:38:28 newsfeed overchan[10768]: input line too long, skipping
Mar 19 21:38:44 newsfeed overchan[10768]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2893059	97.4%	323.1 MB	97.0%
innfeed	48159	1.6%	5.7 MB	1.7%
innd	23506	0.8%	3.7 MB	1.1%
nnrpd	5507	0.2%	588.2 KB	0.2%
overchan	11	0.0%	2.0 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2970243	100.0%	333.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2861627	96.2%
Negative hits	99755	3.4%
Positive hits	11707	0.4%
Cache misses	280	0.0%
TOTAL: 4	2973369	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:07.696	0.0%	342	0.000	22.503	39.333
article cleanup	00:00:28.568	0.0%	2881419	0.007	0.010	0.020
article logging	00:01:44.169	0.1%	2882182	0.023	0.036	0.095
article parse	00:35:25.904	2.5%	92280637	0.016	0.023	0.054
article write	00:15:42.917	1.1%	2875564	0.119	0.328	0.689
artlog/artcncl	00:00:00.010	0.0%	339	0.000	0.029	0.333
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:01:18.669	0.1%	107834709	0.000	0.001	0.001
hisgrep/artcncl	00:00:01.629	0.0%	340	0.000	4.791	10.500
hishave/artcncl	00:00:00.106	0.0%	342	0.000	0.310	3.714
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:43:34.495	3.0%	2991527	0.042	0.874	5.086
history sync	00:00:00.012	0.0%	290	0.000	0.041	0.500
history write	02:05:21.295	8.7%	2879216	0.194	2.612	7.770
hiswrite/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
idle	15:30:30.697	64.6%	74430244	0.484	0.750	1.634
nntp read	00:42:35.675	3.0%	90149738	0.020	0.028	0.068
overview write	00:00:12.053	0.0%	2875564	0.003	0.004	0.008
perl filter	03:36:00.546	15.0%	2879216	2.131	4.501	9.323
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:37.095	0.3%	5772194	0.033	0.048	0.099
TOTAL: 24:00:02.273	23:37:41.536	98.4%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.123	0.0%	59770	0.000	0.002	0.025
article prepare	00:00:00.003	0.0%	11386	0.000	0.000	0.025
article read	00:00:47.436	0.1%	2837	0.000	16.720	810.500
backlog stats	00:00:00.110	0.0%	180701	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.170	0.0%	94184	0.005	0.012	0.039
data write	00:00:05.181	0.0%	74897	0.006	0.069	0.217
idle	23:52:25.380	99.9%	180701	254.153	475.622	926.764
status file	00:00:14.426	0.0%	16584	0.500	0.870	6.550
TOTAL: 23:53:41.963	23:53:33.829	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	24:53:27.546	99.9%	776714	0.000	115.367	156864.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:36.265	0.0%	1554153	0.000	0.023	2.333
readart	00:00:00.003	0.0%	36	0.000	0.083	0.500
TOTAL: 24:54:54.928	24:54:03.814	99.9%	-	-	-	-

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1238	2887048	2876515	7298	3235	99%	426:12:25
2	news.nask.pl	2	13862	9340	1972	2550	67%	23:49:40
3	news.icm.edu.pl	48	322	18	290	14	5%	17:37:00
4	localhost	8	7	7	0	0	100%	00:00:00
TOTAL: 4		1296	2901239	2885880	9560	5799	99%	467:39:05

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	714.5 GB	25.8 MB	206.5 MB	714.8 GB	99%	260.3 KB
2	news.nask.pl	45.3 MB	402.7 KB	24.1 MB	69.7 MB	64%	6.0 KB
3	news.icm.edu.pl	354.9 KB	0.0 KB	576.3 KB	931.2 KB	38%	29.1 KB
4	localhost	11.3 KB	0.0 KB	0.0 KB	11.3 KB	100%	1.6 KB
TOTAL: 4		714.6 GB	26.2 MB	231.1 MB	714.8 GB	99%	259.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 19 04:15:02 - 04:59:59	90888	3.1%	33.69	21.6 GB	3.0%	8389.90
Mar 19 05:00:00 - 05:59:59	105533	3.7%	29.31	31.3 GB	4.4%	9119.18
Mar 19 06:00:00 - 06:59:59	90916	3.2%	25.25	30.2 GB	4.2%	8799.19
Mar 19 07:00:00 - 07:59:59	97647	3.4%	27.12	31.4 GB	4.4%	9153.24
Mar 19 08:00:00 - 08:59:59	110511	3.8%	30.70	33.5 GB	4.7%	9751.41
Mar 19 09:00:00 - 09:59:59	113590	3.9%	31.55	34.3 GB	4.8%	9990.42
Mar 19 10:00:00 - 10:59:59	138975	4.8%	38.60	36.7 GB	5.1%	10686.26
Mar 19 11:00:00 - 11:59:59	130047	4.5%	36.12	37.7 GB	5.3%	10995.22
Mar 19 12:00:00 - 12:59:59	120182	4.2%	33.38	34.4 GB	4.8%	10033.02
Mar 19 13:00:00 - 13:59:59	105871	3.7%	29.41	27.4 GB	3.8%	7978.63
Mar 19 14:00:00 - 14:59:59	115959	4.0%	32.21	28.8 GB	4.0%	8399.35
Mar 19 15:00:00 - 15:59:59	131684	4.6%	36.58	32.7 GB	4.6%	9539.10
Mar 19 16:00:00 - 16:59:59	129402	4.5%	35.95	34.3 GB	4.8%	9982.88
Mar 19 17:00:00 - 17:59:59	114463	4.0%	31.80	28.3 GB	4.0%	8247.97
Mar 19 18:00:00 - 18:59:59	75359	2.6%	20.93	20.5 GB	2.9%	5957.17
Mar 19 19:00:00 - 19:59:59	120904	4.2%	33.58	26.3 GB	3.7%	7647.77
Mar 19 20:00:00 - 20:59:59	97252	3.4%	27.01	21.3 GB	3.0%	6209.42
Mar 19 21:00:00 - 21:59:59	140801	4.9%	39.11	28.0 GB	3.9%	8159.40
Mar 19 22:00:00 - 22:59:59	151813	5.3%	42.17	33.0 GB	4.6%	9599.75
Mar 19 23:00:00 - 23:59:59	194864	6.8%	54.13	36.0 GB	5.0%	10488.32
Mar 20 00:00:00 - 00:59:59	123304	4.3%	34.25	23.7 GB	3.3%	6916.56
Mar 20 01:00:00 - 01:59:59	168885	5.9%	46.91	26.5 GB	3.7%	7712.04
Mar 20 02:00:00 - 02:59:59	86449	3.0%	24.01	24.0 GB	3.4%	6991.90
Mar 20 03:00:00 - 03:59:59	97008	3.4%	26.95	26.3 GB	3.7%	7667.43
Mar 20 04:00:00 - 04:15:03	33812	1.2%	37.44	6.1 GB	0.9%	7131.00
TOTAL: 24:00:01	2886119	100.0%	33.40	714.5 GB	100.0%	8670.82

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3768	146	2021	1	1600
2	news.nask.pl	2819	63	164	11	2581
3	news.icm.edu.pl	14	0	0	0	14
TOTAL: 3		6601	209	2185	12	4195

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	79
comp.mobile.android	53
it.tlc.cellulari.android	25
comp.sys.raspberry-pi	18
it.comp.os.win.windows10	11
de.rec.sf.startrek	10
it.comp.os.win.windows7	7
comp.mobile.ipad	3
uk.rec.cycling.moderated	2
hr.ponuda.hardver.komponente	1
TOTAL: 10	209

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

Groups	Count
pl.sci.matematyka	10
bit.listserv.catholic	1
pl.praca.oferowana	1
TOTAL: 3	12

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2131
Binary in non-binary group	1178
EMP (phl)	51
Poison newsgroup	22
Scoring filter (9)	16
Scoring filter (8)	10
Scoring filter (10)	7
HTML post	5
Scoring filter (16)	5
Scoring filter (11)	3
Attached HTML file	2
Angle-bracket bot	1
TOTAL: 12	3431

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	537
	news.nask.pl	226
	news.icm.edu.pl	1
	TOTAL: 3	764
TOTAL: 1		764

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	42124	461	13900	117	1	45486	1%	23:59:59
2	icm	28569	62	19069	1750	0	2	0%	23:59:59
3	poznan	15691	52	9380	4	0	0	0%	23:59:59
4	nask	4141	3	3013	0	0	0	0%	23:50:59
5	okapi	0	0	0	0	0	1199	0%	23:57:51
TOTAL: 5		90525	578	45362	1871	1	46687	0%	119:48:47

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	8.5 MB	653.7 MB	662.2 MB	7.8 KB/s	374.2 KB	23:59:59
2	panorama	3.2 MB	503.3 KB	3.7 MB	0.0 KB/s	6.5 KB	23:59:59
3	poznan	417.0 KB	15.8 KB	432.8 KB	0.0 KB/s	7.7 KB	23:59:59
4	nask	5.9 KB	0.0 KB	5.9 KB	0.0 KB/s	2.0 KB	23:50:59
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:51
TOTAL: 5		12.1 MB	654.2 MB	666.3 MB	1.6 KB/s	278.6 KB	119:48:47

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	36	34.3 KB	15	0	00:00:19
2	isvcs01.man.lodz.pl	7	0	0.0 KB	0	7	00:00:00
TOTAL: 2		295	36	34.3 KB	15	7	24:54:54

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	679	36	34.3 KB	15	7	00:00:23
2	unresolved	2	0	0.0 KB	0	0	24:54:23
3	*.versanet.de	176	0	0.0 KB	0	0	00:00:07
TOTAL: 3		857	36	34.3 KB	15	7	24:54:54

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.193.99	38.360	55.852	24:46:24
81.15.225.155	0.040	0.060	00:07:58
web.man.lodz.pl	1.160	5.188	00:00:19
i577b5e5b.versanet.de	0.476	1.948	00:00:07
mon.man.lodz.pl	1.072	5.132	00:00:02
david.man.lodz.pl	0.312	1.720	00:00:00
isvcs01.man.lodz.pl	0.048	0.124	00:00:00
TOTAL: 7	41.468	70.024	24:54:54

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
i577b5e5b.versanet.de	176
david.man.lodz.pl	96
81.15.225.155	2
TOTAL: 4	562

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Mar 19 04:15:02 -- Mar 20 04:15:03