Daily Usenet report: Jun 3 04:15:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Jun 3 10:23:13 newsfeed nnrpd[3737]: SERVER perl filter not defined
Jun 3 10:24:05 newsfeed nnrpd[3754]: SERVER perl filter not defined
Jun 3 10:31:43 newsfeed nnrpd[4055]: SERVER perl filter not defined
Jun 3 14:51:25 newsfeed nnrpd[13036]: SERVER perl filter not defined
Jun 3 14:53:51 newsfeed nnrpd[13079]: SERVER perl filter not defined
Jun 3 14:54:30 newsfeed nnrpd[13081]: SERVER perl filter not defined
Jun 3 14:55:02 newsfeed nnrpd[13110]: SERVER perl filter not defined
Jun 3 14:59:44 newsfeed nnrpd[13323]: SERVER perl filter not defined
Jun 3 15:39:59 newsfeed nnrpd[14711]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2224799	98.8%	254.6 MB	98.4%
innd	18468	0.8%	3.1 MB	1.2%
nnrpd	6982	0.3%	748.9 KB	0.3%
innfeed	2544	0.1%	381.0 KB	0.1%
TOTAL: 4	2252793	100.0%	258.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2218157	97.8%
Negative hits	34157	1.5%
Positive hits	15939	0.7%
Cache misses	220	0.0%
TOTAL: 4	2268473	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.377	0.0%	593	0.000	9.067	148.000
article cleanup	00:00:28.659	0.0%	2224490	0.004	0.013	0.044
article logging	00:01:09.217	0.1%	2224684	0.019	0.031	0.061
article parse	00:58:05.203	4.0%	112349473	0.018	0.031	0.093
article write	00:21:58.708	1.5%	2220244	0.384	0.594	1.899
artlog/artcncl	00:00:00.013	0.0%	582	0.000	0.022	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:01:49.918	0.1%	126587326	0.001	0.001	0.008
hisgrep/artcncl	00:00:02.268	0.0%	271	0.000	8.369	95.000
hishave/artcncl	00:00:00.056	0.0%	593	0.000	0.094	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:09:06.585	0.6%	2271019	0.056	0.241	7.864
history sync	00:00:00.011	0.0%	291	0.000	0.038	2.000
history write	00:18:31.525	1.3%	2220847	0.182	0.500	9.248
hiswrite/artcncl	00:00:00.087	0.0%	322	0.000	0.270	16.000
idle	15:18:29.778	63.8%	89263562	0.238	0.617	1.917
nntp read	00:49:43.082	3.5%	110652592	0.018	0.027	0.045
overview write	00:00:13.992	0.0%	2220244	0.000	0.006	0.095
perl filter	05:19:44.669	22.2%	2220847	6.500	8.638	11.702
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:21.571	0.3%	4485931	0.009	0.058	0.166
TOTAL: 24:00:08.945	23:23:50.719	97.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.200	0.0%	45446	0.000	0.004	0.167
article prepare	00:00:00.006	0.0%	19612	0.000	0.000	0.125
article read	00:00:00.305	0.0%	4651	0.000	0.066	4.000
backlog stats	00:00:00.201	0.0%	264472	0.000	0.001	0.027
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.564	0.0%	157565	0.000	0.016	19.000
data write	00:00:03.944	0.0%	112783	0.000	0.035	3.036
idle	23:59:32.244	100.0%	264472	36.718	326.584	4455.600
status file	00:00:01.604	0.0%	233	0.000	6.884	550.000
TOTAL: 23:59:47.332	23:59:41.068	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.028	0.0%	45	0.622	0.622	0.622
idle	15:23:24.636	99.9%	484870	0.000	114.267	87738.143
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:17.973	0.0%	971567	0.000	0.018	3.444
readart	00:00:01.199	0.0%	477	0.000	2.514	15.068
TOTAL: 15:24:26.155	15:23:43.836	99.9%	-	-	-	-

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	920	2219592	2214551	1191	3850	99%	237:28:35
2	news.nask.pl	2	16450	5245	10947	258	31%	24:17:04
3	news.icm.edu.pl	34	375	27	209	139	7%	16:58:54
4	localhost	10	9	9	0	0	100%	00:00:00
TOTAL: 4		966	2236426	2219832	12347	4247	99%	278:44:33

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	737.1 GB	19.5 MB	29.1 MB	737.2 GB	99%	348.4 KB
2	news.nask.pl	31.4 MB	656.6 KB	723.5 KB	32.8 MB	95%	6.1 KB
3	news.icm.edu.pl	732.3 KB	59.5 KB	1.7 MB	2.5 MB	28%	15.2 KB
4	localhost	16.2 KB	0.0 KB	0.0 KB	16.2 KB	100%	1.8 KB
TOTAL: 4		737.2 GB	20.2 MB	31.5 MB	737.2 GB	99%	347.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 3 04:15:02 - 04:59:59	76425	3.4%	28.33	24.9 GB	3.4%	9670.07
Jun 3 05:00:00 - 05:59:59	88139	4.0%	24.48	32.5 GB	4.4%	9452.01
Jun 3 06:00:00 - 06:59:59	84938	3.8%	23.59	31.7 GB	4.3%	9236.24
Jun 3 07:00:00 - 07:59:59	86603	3.9%	24.06	31.1 GB	4.2%	9052.13
Jun 3 08:00:00 - 08:59:59	105143	4.7%	29.21	35.8 GB	4.9%	10432.57
Jun 3 09:00:00 - 09:59:59	107541	4.8%	29.87	37.4 GB	5.1%	10892.77
Jun 3 10:00:00 - 10:59:59	76476	3.4%	21.24	26.9 GB	3.6%	7824.16
Jun 3 11:00:00 - 11:59:59	68328	3.1%	18.98	25.1 GB	3.4%	7317.39
Jun 3 12:00:00 - 12:59:59	100473	4.5%	27.91	32.2 GB	4.4%	9373.64
Jun 3 13:00:00 - 13:59:59	107778	4.9%	29.94	34.1 GB	4.6%	9944.21
Jun 3 14:00:00 - 14:59:59	102429	4.6%	28.45	33.7 GB	4.6%	9806.31
Jun 3 15:00:00 - 15:59:59	84910	3.8%	23.59	30.4 GB	4.1%	8864.56
Jun 3 16:00:00 - 16:59:59	89441	4.0%	24.84	32.8 GB	4.5%	9556.18
Jun 3 17:00:00 - 17:59:59	101112	4.6%	28.09	34.1 GB	4.6%	9927.07
Jun 3 18:00:00 - 18:59:59	106570	4.8%	29.60	33.2 GB	4.5%	9684.45
Jun 3 19:00:00 - 19:59:59	78028	3.5%	21.67	25.3 GB	3.4%	7362.29
Jun 3 20:00:00 - 20:59:59	77838	3.5%	21.62	25.5 GB	3.5%	7436.00
Jun 3 21:00:00 - 21:59:59	84639	3.8%	23.51	26.5 GB	3.6%	7712.42
Jun 3 22:00:00 - 22:59:59	109440	4.9%	30.40	32.4 GB	4.4%	9446.07
Jun 3 23:00:00 - 23:59:59	112930	5.1%	31.37	33.5 GB	4.5%	9745.63
Jun 4 00:00:00 - 00:59:59	97256	4.4%	27.02	28.7 GB	3.9%	8364.48
Jun 4 01:00:00 - 01:59:59	106988	4.8%	29.72	32.1 GB	4.4%	9364.15
Jun 4 02:00:00 - 02:59:59	76419	3.4%	21.23	24.9 GB	3.4%	7238.33
Jun 4 03:00:00 - 03:59:59	67911	3.1%	18.86	24.2 GB	3.3%	7039.72
Jun 4 04:00:00 - 04:15:02	22022	1.0%	24.41	7.9 GB	1.1%	9158.39
TOTAL: 24:00:00	2219777	100.0%	25.69	736.8 GB	100.0%	8942.28

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4018	213	3408	2	395
2	news.nask.pl	283	13	232	3	35
3	news.icm.edu.pl	139	0	3	0	136
TOTAL: 3		4440	226	3643	5	566

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	102
it.tlc.cellulari.android	38
it.comp.os.win.windows8	26
nl.comp.os.linux.techniek	23
it.comp.os.win.windows7	9
alt.sex.telephone.alt.sex.services	7
comp.mobile.android	6
alt.sex.telephones	4
hr.ponuda.hardver.komponente	3
uk.rec.cycling.moderated	2
it.discussioni.energia	2
comp.sys.mac.vintage	1
hr.rec.glazba.hifi	1
hr.alt.cellular.gsm.android	1
it.comp.os.linux.ubuntu	1
TOTAL: 15	226

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

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

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	225
EMP (md5)	137
HTML post	6
Too many newsgroups	2
Scoring filter (12)	1
EMP (fsl)	1
TOTAL: 6	372

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	59006	3851	41097	490	0	6%	23:59:46
2	icm	42929	353	29359	87	9	0%	24:02:32
3	poznan	7478	93	5037	34	0	1%	23:56:35
4	okapi	0	0	0	0	2604	0%	24:00:01
5	nask	0	0	0	0	13578	0%	24:00:01
TOTAL: 5		109413	4297	75493	611	16191	3%	119:58:55

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	17.7 MB	8.6 MB	26.3 MB	0.3 KB/s	61.1 KB	24:02:32
2	panorama	14.6 MB	8.2 MB	22.9 MB	0.3 KB/s	5.4 KB	23:59:46
3	poznan	5.7 MB	1.4 MB	7.1 MB	0.1 KB/s	57.2 KB	23:56:35
4	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
5	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		38.0 MB	18.2 MB	56.2 MB	0.1 KB/s	11.7 KB	119:58:55

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	pc-skrzep2.cm.p.lodz.pl	288	366	593.4 KB	288	0	00:00:07
2	lze200.lze.lodz.pl	2	67	117.0 KB	7	0	00:41:55
3	web.man.lodz.pl	288	44	45.1 KB	22	0	00:00:30
4	isvcs01.man.lodz.pl	9	0	0.0 KB	0	9	00:00:00
TOTAL: 4		587	477	755.5 KB	317	9	15:24:25

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	366	593.4 KB	288	0	00:00:07
2	*.lze.lodz.pl	2	67	117.0 KB	7	0	00:41:55
3	*.man.lodz.pl	681	44	45.1 KB	22	9	00:00:34
4	*.toya.net.pl	25	0	0.0 KB	0	0	00:00:01
5	unresolved	2	0	0.0 KB	0	0	14:41:33
6	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:12
TOTAL: 6		1000	477	755.5 KB	317	9	15:24:25

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.195.96	26.018	36.550	14:41:33
lze200.lze.lodz.pl	0.028	0.194	00:41:55
web.man.lodz.pl	1.000	3.853	00:00:30
host227.elsnet.pl	0.012	0.019	00:00:12
pc-skrzep2.cm.p.lodz.pl	1.159	4.994	00:00:07
mon.man.lodz.pl	1.041	4.095	00:00:03
staticline41435.toya.net.pl	0.095	0.350	00:00:01
david.man.lodz.pl	0.320	1.400	00:00:00
isvcs01.man.lodz.pl	0.044	0.145	00:00:00
TOTAL: 9	29.717	51.600	15:24:25

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	25
host227.elsnet.pl	2
185.48.195.96	2
TOTAL: 5	413

NNRP client timeouts [Top 20]:

System	Conn	Peer
lze200.lze.lodz.pl	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	366	76.7%
2	pl	111	23.3%
TOTAL: 2		477	100.0%

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

Newsgroup		Count
1	lodman.info	366
2	pl.rec.kuchnia	36
3	pl.comp.os.ms-windows.winnt	30
4	pl.misc.telefonia.gsm	20
5	pl.comp.pecet	16
6	pl.rec.dom	5
7	pl.regionalne.lodz	2
8	pl.comp.os.linux.sieci	2
TOTAL: 8		477

Daily Usenet report

Jun 3 04:15:02 -- Jun 4 04:15:02