Daily Usenet report: Nov 10 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 10 15:20:50 newsfeed nnrpd[30273]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2970999	98.5%	345.4 MB	98.3%
innd	35422	1.2%	5.0 MB	1.4%
innfeed	4864	0.2%	686.3 KB	0.2%
nnrpd	4833	0.2%	497.0 KB	0.1%
TOTAL: 4	3016118	100.0%	351.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2965300	96.1%
Negative hits	104157	3.4%
Positive hits	14780	0.5%
Cache misses	132	0.0%
TOTAL: 4	3084369	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.126	0.0%	212	0.000	5.311	61.000
article cleanup	00:00:46.240	0.1%	2970740	0.000	0.016	0.088
article logging	00:01:37.748	0.1%	2971406	0.018	0.033	0.759
article parse	01:21:25.304	5.7%	165768916	0.000	0.029	0.060
article write	00:30:02.478	2.1%	2954050	0.000	0.610	4.014
artlog/artcncl	00:00:00.008	0.0%	202	0.000	0.040	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:03:31.219	0.2%	183297825	0.000	0.001	0.006
hisgrep/artcncl	00:00:00.189	0.0%	193	0.000	0.979	25.000
hishave/artcncl	00:00:00.058	0.0%	212	0.000	0.274	5.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:26:16.348	1.8%	3087183	0.040	0.511	8.589
history sync	00:00:00.016	0.0%	296	0.000	0.054	1.000
history write	00:38:48.420	2.7%	2968016	0.189	0.785	10.470
hiswrite/artcncl	00:00:00.004	0.0%	19	0.000	0.211	1.000
idle	12:48:34.891	53.4%	97044400	0.302	0.475	557.396
nntp read	01:07:01.538	4.7%	163248263	0.000	0.025	0.036
overview write	00:00:18.429	0.0%	2954050	0.000	0.006	0.071
perl filter	06:13:55.026	26.0%	2968016	1.710	7.559	26.812
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:06.656	0.4%	5951385	0.035	0.052	0.167
TOTAL: 24:00:19.867	23:17:25.698	97.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.203	0.0%	57930	0.000	0.004	0.154
article prepare	00:00:00.029	0.0%	79584	0.000	0.000	0.250
article read	00:00:18.913	0.0%	20062	0.000	0.943	720.000
backlog stats	00:00:00.259	0.0%	291736	0.000	0.001	0.069
callbacks	00:00:00.001	0.0%	122	0.000	0.008	0.200
data read	00:00:02.011	0.0%	143211	0.000	0.014	0.167
data write	00:00:14.895	0.0%	146919	0.000	0.101	0.293
idle	23:59:42.340	99.9%	291736	18.672	296.098	4324.857
status file	00:00:00.693	0.0%	943	0.000	0.735	3.000
TOTAL: 24:00:26.837	24:00:19.344	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:07:33.091	99.6%	3171	0.000	1278.174	137225.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.224	0.0%	7215	0.000	0.031	0.789
readart	00:00:03.582	0.1%	161	0.000	22.248	64.286
TOTAL: 01:07:49.157	01:07:36.897	99.7%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	865	2954392	2942894	8126	3372	99%	420:10:03
2	news.nask.pl	2	27764	10943	3583	13238	39%	24:11:25
3	news.icm.edu.pl	46	335	11	315	9	3%	17:51:53
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		915	2982492	2953849	12024	16619	99%	462:13:21

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	879.2 GB	33.6 MB	163.0 MB	879.4 GB	99%	313.0 KB
2	news.nask.pl	47.9 MB	1.2 MB	164.1 MB	213.1 MB	22%	9.0 KB
3	news.icm.edu.pl	348.7 KB	39.2 KB	180.5 KB	568.4 KB	61%	28.4 KB
4	localhost	1.3 KB	0.0 KB	0.0 KB	1.3 KB	100%	1.3 KB
TOTAL: 4		879.2 GB	34.8 MB	327.2 MB	879.6 GB	99%	310.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 10 04:15:02 - 04:59:59	81788	2.8%	30.31	25.9 GB	2.9%	10053.20
Nov 10 05:00:00 - 05:59:59	110439	3.7%	30.68	33.2 GB	3.8%	9677.07
Nov 10 06:00:00 - 06:59:59	125765	4.3%	34.93	36.2 GB	4.1%	10544.66
Nov 10 07:00:00 - 07:59:59	144936	4.9%	40.26	39.9 GB	4.5%	11621.86
Nov 10 08:00:00 - 08:59:59	131792	4.5%	36.61	34.4 GB	3.9%	10022.04
Nov 10 09:00:00 - 09:59:59	89906	3.0%	24.97	23.0 GB	2.6%	6688.51
Nov 10 10:00:00 - 10:59:59	133481	4.5%	37.08	34.0 GB	3.9%	9910.36
Nov 10 11:00:00 - 11:59:59	144543	4.9%	40.15	36.0 GB	4.1%	10491.57
Nov 10 12:00:00 - 12:59:59	134789	4.6%	37.44	35.5 GB	4.0%	10329.64
Nov 10 13:00:00 - 13:59:59	139492	4.7%	38.75	36.9 GB	4.2%	10740.56
Nov 10 14:00:00 - 14:59:59	123641	4.2%	34.34	37.0 GB	4.2%	10765.12
Nov 10 15:00:00 - 15:59:59	108120	3.7%	30.03	38.6 GB	4.4%	11246.76
Nov 10 16:00:00 - 16:59:59	109163	3.7%	30.32	37.3 GB	4.2%	10872.91
Nov 10 17:00:00 - 17:59:59	131113	4.4%	36.42	41.6 GB	4.7%	12112.62
Nov 10 18:00:00 - 18:59:59	122408	4.1%	34.00	40.5 GB	4.6%	11785.16
Nov 10 19:00:00 - 19:59:59	127045	4.3%	35.29	38.1 GB	4.3%	11098.00
Nov 10 20:00:00 - 20:59:59	126336	4.3%	35.09	36.0 GB	4.1%	10495.12
Nov 10 21:00:00 - 21:59:59	125727	4.3%	34.92	39.6 GB	4.5%	11533.59
Nov 10 22:00:00 - 22:59:59	140608	4.8%	39.06	40.2 GB	4.6%	11711.66
Nov 10 23:00:00 - 23:59:59	145839	4.9%	40.51	41.6 GB	4.7%	12125.73
Nov 11 00:00:00 - 00:59:59	111128	3.8%	30.87	36.0 GB	4.1%	10479.58
Nov 11 01:00:00 - 01:59:59	109706	3.7%	30.47	37.7 GB	4.3%	10977.73
Nov 11 02:00:00 - 02:59:59	113044	3.8%	31.40	39.7 GB	4.5%	11561.98
Nov 11 03:00:00 - 03:59:59	92643	3.1%	25.73	31.7 GB	3.6%	9221.35
Nov 11 04:00:00 - 04:15:02	29998	1.0%	33.26	9.3 GB	1.1%	10771.11
TOTAL: 24:00:00	2953450	100.0%	34.18	879.8 GB	100.0%	10676.94

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	13531	58	314	9	13150
2	newsfeed.pionier.net.pl	3807	162	2406	0	1239
3	news.icm.edu.pl	9	0	2	0	7
TOTAL: 3		17347	220	2722	9	14396

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	102
comp.mobile.android	56
it.tlc.cellulari.android	23
de.comp.office-pakete.ms-office.excel	8
it.comp.os.win.windows10	6
de.rec.sf.startrek	5
it.comp.os.win.windows7	5
uk.rec.cycling.moderated	4
uk.net.providers.gradwell	4
de.comp.office-pakete.ms-office.outlook	2
comp.mobile.ipad	2
hr.alt.cellular.gsm.android	1
nl.comp.os.linux.techniek	1
comp.sys.mac.vintage	1
TOTAL: 14	220

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

Groups	Count
pl.praca.oferowana	5
pl.sci.matematyka	2
christnet.theology	1
bit.listserv.catholic	1
TOTAL: 4	9

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	12544
Binary in non-binary group	996
Scoring filter (8)	77
EMP (phl)	53
Scoring filter (9)	21
Scoring filter (10)	11
Too many newsgroups	9
Scoring filter (13)	6
HTML post	5
Scoring filter (11)	3
Scoring filter (14)	2
Scoring filter (15)	1
Scoring filter (12)	1
Scoring filter (16)	1
Too many test groups in crosspost	1
TOTAL: 15	13731

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	16439	720	12878	1030	341	42927	4%	24:04:34
2	poznan	15432	124	10665	15	0	81	0%	23:53:01
3	icm	52189	113	24944	17626	0	0	0%	24:07:48
4	nask	8603	37	6271	0	0	0	0%	24:04:55
5	okapi	0	0	0	0	0	2220	0%	24:00:01
TOTAL: 5		92663	994	54758	18671	341	45228	1%	120:10:19

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	3.4 MB	4.5 GB	4.5 GB	54.5 KB/s	266.9 KB	24:07:48
2	panorama	2.6 MB	147.7 MB	150.2 MB	1.8 KB/s	87.9 KB	24:04:34
3	poznan	662.1 KB	66.0 KB	728.1 KB	0.0 KB/s	5.2 KB	23:53:01
4	nask	272.8 KB	0.0 KB	272.8 KB	0.0 KB/s	7.4 KB	24:04:55
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		6.8 MB	4.7 GB	4.7 GB	11.3 KB/s	248.6 KB	120:10:19

Backlog files shrunk by innfeed:

Server	Size
panorama	3.8 MB
okapi	488.3 KB
TOTAL: 2	4.3 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	78	69.5 KB	36	0	00:00:21
2	lze200.lze.lodz.pl	6	70	139.9 KB	3	0	01:07:19
3	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 3		295	148	209.4 KB	39	1	01:07:48

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	673	78	69.5 KB	36	1	00:00:26
2	*.lze.lodz.pl	6	70	139.9 KB	3	0	01:07:19
3	unresolved	1	0	0.0 KB	0	0	00:00:03
TOTAL: 3		680	148	209.4 KB	39	1	01:07:48

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
lze200.lze.lodz.pl	0.024	0.141	01:07:19
web.man.lodz.pl	0.925	5.740	00:00:21
mon.man.lodz.pl	0.877	5.233	00:00:03
196.52.20.44	0.000	0.028	00:00:03
david.man.lodz.pl	0.258	1.704	00:00:01
isvcs01.man.lodz.pl	0.000	0.018	00:00:00
TOTAL: 6	2.084	12.864	01:07:48

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
196.52.20.44	1
TOTAL: 3	385

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	90
2	pl.comp.pecet	58
TOTAL: 2		148

Daily Usenet report

Nov 10 04:15:02 -- Nov 11 04:15:02