Daily Usenet report: Jan 11 04:15:02

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Jan 11 08:16:34 newsfeed nnrpd[19554]: SERVER perl filter not defined
Jan 11 08:18:58 newsfeed nnrpd[19601]: SERVER perl filter not defined
Jan 11 08:21:58 newsfeed nnrpd[19650]: SERVER perl filter not defined
Jan 11 09:27:33 newsfeed nnrpd[21909]: SERVER perl filter not defined
Jan 11 09:59:55 newsfeed nnrpd[22898]: SERVER perl filter not defined
Jan 11 23:01:49 newsfeed nnrpd[16403]: SERVER perl filter not defined
Jan 11 23:53:59 newsfeed nnrpd[18137]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1216909	97.9%	136.7 MB	97.3%
innd	12615	1.0%	2.1 MB	1.5%
nnrpd	7191	0.6%	751.8 KB	0.5%
innfeed	6507	0.5%	944.5 KB	0.7%
TOTAL: 4	1243222	100.0%	140.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1212073	94.7%
Negative hits	39416	3.1%
Positive hits	28163	2.2%
Cache misses	582	0.0%
TOTAL: 4	1280234	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:07.804	0.0%	408	0.000	19.127	566.000
article cleanup	00:00:17.448	0.0%	1216421	0.000	0.014	0.039
article logging	00:00:35.266	0.0%	1216547	0.004	0.029	0.420
article parse	00:37:24.162	2.6%	68516405	0.007	0.033	0.058
article write	00:11:33.896	0.8%	1212512	0.177	0.572	7.999
artlog/artcncl	00:00:00.004	0.0%	345	0.000	0.012	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:01:22.467	0.1%	75373014	0.000	0.001	0.013
hisgrep/artcncl	00:00:01.410	0.0%	316	0.000	4.462	249.000
hishave/artcncl	00:00:00.236	0.0%	408	0.000	0.578	26.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:57:54.627	4.0%	1281284	0.314	2.712	7.557
history sync	00:00:00.019	0.0%	374	0.000	0.051	1.000
history write	03:18:08.893	13.8%	1213288	4.217	9.799	19.130
hiswrite/artcncl	00:00:00.310	0.0%	92	0.000	3.370	20.000
idle	15:21:48.180	64.0%	44562946	0.283	1.241	8.941
nntp read	00:30:02.513	2.1%	67572221	0.011	0.027	0.041
overview write	00:00:07.910	0.0%	1212512	0.000	0.007	0.026
perl filter	02:34:47.087	10.7%	1213287	3.856	7.654	12.613
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:22.696	0.2%	2469740	0.022	0.058	0.125
TOTAL: 23:59:57.212	23:36:34.928	98.4%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.166	0.0%	49436	0.000	0.003	0.167
article prepare	00:00:00.007	0.0%	19320	0.000	0.000	0.083
article read	00:00:00.954	0.0%	4711	0.000	0.203	2.000
backlog stats	00:00:00.178	0.0%	295650	0.000	0.001	0.022
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.817	0.0%	173126	0.000	0.010	0.094
data write	00:00:06.521	0.0%	154089	0.000	0.042	21.000
idle	23:59:00.574	100.0%	295650	0.000	292.036	18347.000
status file	00:00:00.770	0.0%	203	0.000	3.793	187.500
TOTAL: 23:59:17.020	23:59:10.987	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	02:35:03.491	99.7%	36424	0.000	255.422	228958.143
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.220	0.0%	74838	0.000	0.016	1.000
readart	00:00:01.283	0.0%	497	0.000	2.581	31.000
TOTAL: 02:35:28.213	02:35:05.994	99.8%	-	-	-	-

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	571	1212566	1207473	2021	3072	99%	275:55:54
2	news.nask.pl	4	22454	3254	18479	721	14%	23:58:08
3	news.icm.edu.pl	46	6293	1603	4598	92	25%	18:03:02
4	localhost	8	7	7	0	0	100%	00:00:00
TOTAL: 4		629	1241320	1212337	25098	3885	97%	317:57:04

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	317.4 GB	90.7 MB	135.7 MB	317.6 GB	99%	275.1 KB
2	news.icm.edu.pl	451.6 MB	6.2 MB	10.5 MB	468.4 MB	96%	283.0 KB
3	news.nask.pl	12.5 MB	2.1 MB	2.1 MB	16.7 MB	74%	4.3 KB
4	localhost	10.0 KB	0.0 KB	0.0 KB	10.0 KB	100%	1.4 KB
TOTAL: 4		317.8 GB	99.0 MB	148.3 MB	318.1 GB	99%	274.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 11 04:15:02 - 04:59:59	59113	4.9%	21.91	18.6 GB	5.8%	7222.83
Jan 11 05:00:00 - 05:59:59	57138	4.7%	15.87	17.6 GB	5.5%	5121.31
Jan 11 06:00:00 - 06:59:59	52303	4.3%	14.53	15.5 GB	4.9%	4507.79
Jan 11 07:00:00 - 07:59:59	90703	7.5%	25.20	28.3 GB	8.9%	8240.85
Jan 11 08:00:00 - 08:59:59	92816	7.7%	25.78	29.9 GB	9.4%	8719.17
Jan 11 09:00:00 - 09:59:59	94856	7.8%	26.35	30.2 GB	9.5%	8802.16
Jan 11 10:00:00 - 10:59:59	95459	7.9%	26.52	30.2 GB	9.5%	8784.08
Jan 11 11:00:00 - 11:59:59	57867	4.8%	16.07	13.0 GB	4.1%	3782.68
Jan 11 12:00:00 - 12:59:59	42248	3.5%	11.74	5.6 GB	1.8%	1628.78
Jan 11 13:00:00 - 13:59:59	34477	2.8%	9.58	4.5 GB	1.4%	1305.79
Jan 11 14:00:00 - 14:59:59	33108	2.7%	9.20	4.2 GB	1.3%	1227.04
Jan 11 15:00:00 - 15:59:59	17495	1.4%	4.86	2.3 GB	0.7%	665.93
Jan 11 16:00:00 - 16:59:59	11181	0.9%	3.11	1.8 GB	0.6%	517.24
Jan 11 17:00:00 - 17:59:59	16426	1.4%	4.56	3.1 GB	1.0%	917.39
Jan 11 18:00:00 - 18:59:59	17071	1.4%	4.74	2.4 GB	0.7%	691.08
Jan 11 19:00:00 - 19:59:59	15721	1.3%	4.37	2.2 GB	0.7%	636.35
Jan 11 20:00:00 - 20:59:59	23293	1.9%	6.47	3.8 GB	1.2%	1109.27
Jan 11 21:00:00 - 21:59:59	18594	1.5%	5.17	3.3 GB	1.0%	957.88
Jan 11 22:00:00 - 22:59:59	14759	1.2%	4.10	2.4 GB	0.8%	713.04
Jan 11 23:00:00 - 23:59:59	13856	1.1%	3.85	2.2 GB	0.7%	641.41
Jan 12 00:00:00 - 00:59:59	75362	6.2%	20.93	19.4 GB	6.1%	5652.28
Jan 12 01:00:00 - 01:59:59	100359	8.3%	27.88	26.4 GB	8.3%	7676.98
Jan 12 02:00:00 - 02:59:59	92840	7.7%	25.79	24.1 GB	7.6%	7020.41
Jan 12 03:00:00 - 03:59:59	68913	5.7%	19.14	21.7 GB	6.8%	6321.67
Jan 12 04:00:00 - 04:15:02	16568	1.4%	18.37	5.3 GB	1.7%	6182.98
TOTAL: 24:00:00	1212526	100.0%	14.03	317.9 GB	100.0%	3858.45

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3189	237	2370	1	581
2	news.nask.pl	757	12	734	1	10
3	news.icm.edu.pl	92	0	30	0	62
TOTAL: 3		4038	249	3134	2	653

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	128
comp.mobile.android	31
it.tlc.cellulari.android	28
comp.sys.raspberry-pi	14
comp.mobile.ipad	10
it.comp.os.win.windows8	8
de.comp.office-pakete.ms-office.excel	7
uk.current-events.charlie-hebdo	5
hr.alt.cellular.gsm.android	4
hr.ponuda.hardver.komponente	3
it.comp.os.linux.ubuntu	2
uk.rec.cycling.moderated	2
hr.alt.cellular.gsm.iphone	2
alt.sex.telephones	1
de.comp.lang.vbclassic	1
uk.net.providers.gradwell	1
nl.comp.sys.android	1
it.discussioni.energia	1
TOTAL: 18	249

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

Groups	Count
pl.sci.matematyka	1
pl.sci.historia	1
TOTAL: 2	2

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	462
EMP (md5)	61
Attached HTML file	2
HTML post	1
TOTAL: 4	526

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	45389	1173	43474	158	0	2%	24:05:22
2	nask	36056	1093	22406	952	3721	3%	24:09:39
3	icm	48620	486	37544	946	1006	0%	24:08:36
4	poznan	4900	29	3653	19	0	0%	24:03:28
5	okapi	0	0	0	0	1872	0%	24:00:00
TOTAL: 5		134965	2781	107077	2075	6599	2%	120:27:05

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nask	297.7 MB	386.0 MB	683.7 MB	8.0 KB/s	342.4 KB	24:09:39
2	icm	99.3 MB	176.6 MB	275.9 MB	3.3 KB/s	197.3 KB	24:08:36
3	panorama	5.0 MB	1.0 MB	6.0 MB	0.1 KB/s	4.6 KB	24:05:22
4	poznan	1.3 MB	1.5 MB	2.7 MB	0.0 KB/s	57.8 KB	24:03:28
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		403.3 MB	565.1 MB	968.4 MB	2.3 KB/s	204.2 KB	120:27:05

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	362	543.0 KB	288	0	0	00:00:07
2	web.man.lodz.pl	288	80	75.1 KB	34	0	0	00:00:21
3	staticline-31-183-50-219.toya.net.pl	20	52	53.4 KB	10	0	11	00:22:26
4	wireless.ics.p.lodz.pl	1	3	3.0 KB	1	0	0	00:26:42
5	isvcs01.man.lodz.pl	7	0	0.0 KB	0	7	0	00:00:00
6	abgy160.neoplus.adsl.tpnet.pl	1	0	0.0 KB	0	0	1	00:03:37
TOTAL: 6		605	497	674.5 KB	333	7	12	02:35:27

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.cm.p.lodz.pl	288	362	543.0 KB	288	0	0	00:00:07
2	*.man.lodz.pl	679	80	75.1 KB	34	7	0	00:00:27
3	*.toya.net.pl	54	52	53.4 KB	10	0	11	00:23:09
4	*.ics.p.lodz.pl	1	3	3.0 KB	1	0	0	00:26:42
5	unresolved	4	0	0.0 KB	0	0	0	01:34:02
6	*.30.11.18.nat.umts.dynamic.t-mobile.pl	1	0	0.0 KB	0	0	0	00:07:05
7	*.elsnet.pl	4	0	0.0 KB	0	0	0	00:00:16
8	*.neoplus.adsl.tpnet.pl	1	0	0.0 KB	0	0	1	00:03:37
TOTAL: 8		1032	497	674.5 KB	333	7	12	02:35:27

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
89.38.40.201	1.449	1.986	01:34:02
wireless.ics.p.lodz.pl	0.009	0.017	00:26:42
staticline-31-183-50-219.toya.net.pl	0.177	0.469	00:22:26
37.30.11.18.nat.umts.dynamic.t-mobile.pl	0.030	0.025	00:07:05
abgy160.neoplus.adsl.tpnet.pl	0.033	0.022	00:03:37
staticline41435.toya.net.pl	0.147	0.664	00:00:42
web.man.lodz.pl	1.013	5.535	00:00:21
host227.elsnet.pl	0.012	0.073	00:00:16
pc-skrzep2.cm.p.lodz.pl	1.000	5.569	00:00:07
mon.man.lodz.pl	0.957	5.654	00:00:04
david.man.lodz.pl	0.349	1.848	00:00:01
isvcs01.man.lodz.pl	0.054	0.146	00:00:00
TOTAL: 12	5.230	22.008	02:35:27

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	34
host227.elsnet.pl	4
89.38.40.201	4
37.30.11.18.nat.umts.dynamic.t-mobile.pl	1
TOTAL: 6	427

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	381	76.7%
2	pl	83	16.7%
3	lodz	31	6.2%
4	lodzman	2	0.4%
TOTAL: 4		497	100.0%

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

Newsgroup		Count
1	lodman.info	362
2	pl.comp.pecet	62
3	lodz.test	31
4	lodman.test	19
5	pl.comp.os.ms-windows.winnt	18
6	pl.test	3
7	lodzman.test	2
TOTAL: 7		497

Daily Usenet report

Jan 11 04:15:02 -- Jan 12 04:15:02