Daily Usenet report: Dec 14 04:15:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Dec 14 09:28:21 newsfeed nnrpd[5157]: SERVER perl filter not defined
Dec 14 13:53:29 newsfeed nnrpd[14928]: SERVER perl filter not defined
Dec 14 15:03:51 newsfeed nnrpd[17479]: SERVER perl filter not defined
Dec 14 15:04:26 newsfeed nnrpd[17492]: SERVER perl filter not defined
Dec 14 17:56:32 newsfeed overchan[25404]: input line too long, skipping
Dec 14 18:18:03 newsfeed overchan[25404]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3252257	98.2%	372.4 MB	97.9%
innfeed	31808	1.0%	3.8 MB	1.0%
innd	22592	0.7%	3.6 MB	1.0%
nnrpd	4813	0.1%	509.3 KB	0.1%
overchan	3	0.0%	0.6 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	3311474	100.0%	380.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3228202	98.0%
Negative hits	53107	1.6%
Positive hits	11274	0.3%
Cache misses	153	0.0%
TOTAL: 4	3292736	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.169	0.0%	228	0.000	22.671	302.000
article cleanup	00:00:36.571	0.0%	3251724	0.008	0.011	0.015
article logging	00:01:55.063	0.1%	3252538	0.021	0.035	0.070
article parse	00:59:13.691	4.1%	98325742	0.023	0.036	0.051
article write	00:22:01.814	1.5%	3238581	0.135	0.408	0.754
artlog/artcncl	00:00:00.006	0.0%	226	0.000	0.027	1.000
data move	00:03:39.363	0.3%	115876949	0.001	0.002	0.003
hisgrep/artcncl	00:00:01.228	0.0%	224	0.000	5.482	60.000
hishave/artcncl	00:00:00.515	0.0%	228	0.000	2.259	153.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:57:26.941	8.2%	3308422	0.396	2.130	7.134
history sync	00:00:00.011	0.0%	290	0.000	0.038	0.500
history write	05:18:03.980	22.1%	3243174	1.228	5.884	18.767
hiswrite/artcncl	00:00:00.009	0.0%	4	0.000	2.250	9.000
idle	08:33:12.319	35.6%	62362001	0.221	0.494	1.259
nntp read	00:53:50.262	3.7%	95836026	0.025	0.034	0.044
overview write	00:00:15.588	0.0%	3238581	0.003	0.005	0.007
perl filter	05:24:31.611	22.5%	3243165	3.501	6.004	8.319
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:08.996	0.4%	6497193	0.030	0.048	0.064
TOTAL: 24:00:07.898	23:40:03.137	98.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.166	0.0%	51196	0.000	0.003	0.022
article prepare	00:00:00.002	0.0%	12392	0.000	0.000	0.016
article read	00:02:19.691	0.2%	3091	0.000	45.193	3202.500
backlog stats	00:00:00.125	0.0%	151739	0.000	0.001	0.007
callbacks	00:00:00.000	0.0%	8	0.000	0.000	0.000
data read	00:00:01.139	0.0%	82243	0.000	0.014	0.029
data write	00:00:03.312	0.0%	62619	0.016	0.053	0.163
idle	23:51:52.736	99.8%	151739	368.718	566.188	1165.542
status file	00:00:31.500	0.0%	10684	0.593	2.948	124.875
TOTAL: 23:54:57.270	23:54:48.671	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:35:12.002	99.8%	3041	0.000	1878.330	619540.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.209	0.0%	6667	0.000	0.031	0.500
readart	00:00:00.051	0.0%	10	0.000	5.100	25.000
TOTAL: 01:35:24.368	01:35:12.262	99.8%	-	-	-	-

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	316	3240149	3229166	1257	9726	99%	521:47:14
2	news.nask.pl	2	14412	9817	1171	3424	68%	23:53:47
3	news.icm.edu.pl	39	293	10	278	5	3%	18:51:00
4	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 4		362	3254858	3238997	2706	13155	99%	564:32:01

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	938.4 GB	33.6 MB	345.1 MB	938.8 GB	99%	303.9 KB
2	news.nask.pl	43.5 MB	1.8 MB	19.4 MB	64.7 MB	67%	5.0 KB
3	news.icm.edu.pl	454.5 KB	19.6 KB	126.5 KB	600.6 KB	75%	40.0 KB
4	localhost	6.4 KB	0.0 KB	0.0 KB	6.4 KB	100%	1.6 KB
TOTAL: 4		938.4 GB	35.4 MB	364.6 MB	938.8 GB	99%	302.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 14 04:15:02 - 04:59:59	79262	2.4%	29.38	30.0 GB	3.2%	11662.15
Dec 14 05:00:00 - 05:59:59	105591	3.3%	29.33	40.1 GB	4.3%	11684.68
Dec 14 06:00:00 - 06:59:59	112321	3.5%	31.20	41.1 GB	4.4%	11980.34
Dec 14 07:00:00 - 07:59:59	113866	3.5%	31.63	41.2 GB	4.4%	12000.00
Dec 14 08:00:00 - 08:59:59	122734	3.8%	34.09	44.7 GB	4.8%	13006.55
Dec 14 09:00:00 - 09:59:59	119548	3.7%	33.21	43.8 GB	4.7%	12755.48
Dec 14 10:00:00 - 10:59:59	118498	3.7%	32.92	41.7 GB	4.4%	12155.19
Dec 14 11:00:00 - 11:59:59	124371	3.8%	34.55	42.2 GB	4.5%	12291.90
Dec 14 12:00:00 - 12:59:59	139481	4.3%	38.74	41.2 GB	4.4%	12003.31
Dec 14 13:00:00 - 13:59:59	127285	3.9%	35.36	42.5 GB	4.5%	12373.26
Dec 14 14:00:00 - 14:59:59	125406	3.9%	34.84	41.1 GB	4.4%	11978.44
Dec 14 15:00:00 - 15:59:59	130295	4.0%	36.19	41.1 GB	4.4%	11964.70
Dec 14 16:00:00 - 16:59:59	139658	4.3%	38.79	43.3 GB	4.6%	12616.09
Dec 14 17:00:00 - 17:59:59	140967	4.4%	39.16	42.4 GB	4.5%	12342.74
Dec 14 18:00:00 - 18:59:59	140546	4.3%	39.04	43.6 GB	4.6%	12691.82
Dec 14 19:00:00 - 19:59:59	141596	4.4%	39.33	45.6 GB	4.9%	13268.15
Dec 14 20:00:00 - 20:59:59	144687	4.5%	40.19	45.3 GB	4.8%	13201.04
Dec 14 21:00:00 - 21:59:59	233005	7.2%	64.72	35.8 GB	3.8%	10427.91
Dec 14 22:00:00 - 22:59:59	203346	6.3%	56.48	31.3 GB	3.3%	9118.90
Dec 14 23:00:00 - 23:59:59	93133	2.9%	25.87	20.8 GB	2.2%	6064.78
Dec 15 00:00:00 - 00:59:59	183744	5.7%	51.04	38.0 GB	4.1%	11071.54
Dec 15 01:00:00 - 01:59:59	161940	5.0%	44.98	40.5 GB	4.3%	11799.28
Dec 15 02:00:00 - 02:59:59	123536	3.8%	34.32	33.5 GB	3.6%	9745.76
Dec 15 03:00:00 - 03:59:59	88999	2.7%	24.72	22.3 GB	2.4%	6484.74
Dec 15 04:00:00 - 04:15:02	24241	0.7%	26.87	5.4 GB	0.6%	6232.19
TOTAL: 24:00:00	3238056	100.0%	37.48	938.4 GB	100.0%	11388.68

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	10321	177	7849	1	2294
2	news.nask.pl	3657	52	720	6	2879
3	news.icm.edu.pl	5	0	2	0	3
TOTAL: 3		13983	229	8571	7	5176

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	68
comp.mobile.android	45
it.comp.os.win.windows10	41
it.tlc.cellulari.android	21
it.comp.os.linux.ubuntu	16
comp.sys.raspberry-pi	14
it.discussioni.energia	9
nl.comp.os.linux.techniek	4
it.politica.m5s	3
de.comm.software.mailreader	3
comp.mobile.ipad	2
alt.sex.telephones	2
it.comp.os.win.windows7	1
TOTAL: 13	229

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

Groups	Count
pl.praca.oferowana	5
pl.sci.matematyka	1
bit.listserv.catholic	1
TOTAL: 3	7

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2481
Binary in non-binary group	1792
Scoring filter (9)	20
Scoring filter (8)	17
EMP (phl)	12
HTML post	11
Poison newsgroup	5
Scoring filter (13)	5
Scoring filter (10)	3
EMP (fsl)	2
Scoring filter (14)	2
Scoring filter (15)	1
Attached HTML file	1
Excessively crossposted test article	1
Scoring filter (11)	1
TOTAL: 15	4354

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	595
	news.nask.pl	218
	TOTAL: 2	813
TOTAL: 1		813

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	33578	1208	14317	312	26	35435	3%	23:59:28
2	poznan	15808	373	9395	23	0	0	2%	23:59:46
3	icm	24553	71	19334	266	0	0	0%	23:59:58
4	nask	2637	2	2206	0	0	0	0%	23:56:39
5	okapi	0	0	0	0	0	1344	0%	23:57:51
TOTAL: 5		76576	1654	45252	601	26	36779	2%	119:53:42

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	8.7 MB	1.3 MB	10.0 MB	0.1 KB/s	6.7 KB	23:59:28
2	icm	4.8 MB	85.4 MB	90.2 MB	1.1 KB/s	273.9 KB	23:59:58
3	poznan	1.2 MB	104.2 KB	1.3 MB	0.0 KB/s	3.5 KB	23:59:46
4	nask	3.9 KB	0.0 KB	3.9 KB	0.0 KB/s	1.9 KB	23:56:39
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:51
TOTAL: 5		14.7 MB	86.8 MB	101.5 MB	0.2 KB/s	46.1 KB	119:53:42

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	8	9.5 KB	4	0	00:00:23
2	193.107.222.155	10	2	3.5 KB	1	0	01:34:55
3	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 3		302	10	13.0 KB	5	4	01:35:23

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	676	8	9.5 KB	4	4	00:00:28
2	unresolved	10	2	3.5 KB	1	0	01:34:55
TOTAL: 2		686	10	13.0 KB	5	4	01:35:23

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
193.107.222.155	0.076	0.140	01:34:55
web.man.lodz.pl	1.144	3.932	00:00:23
mon.man.lodz.pl	1.036	3.548	00:00:03
david.man.lodz.pl	0.280	1.248	00:00:00
isvcs01.man.lodz.pl	0.028	0.064	00:00:00
TOTAL: 5	2.564	8.932	01:35:23

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
TOTAL: 2	384

NNRP client timeouts [Top 20]:

System	Conn	Peer
193.107.222.155	3	0
TOTAL: 1	3	0

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	8	80.0%
2	lodz	2	20.0%
TOTAL: 2		10	100.0%

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	4
2	pl.comp.pecet	4
3	lodz.ogloszenia	2
TOTAL: 3		10

Daily Usenet report

Dec 14 04:15:02 -- Dec 15 04:15:02