Daily Usenet report: Jul 12 04:15:04

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Jul 12 08:23:34 newsfeed nnrpd[13686]: SERVER perl filter not defined
Jul 12 13:45:00 newsfeed nnrpd[24315]: SERVER perl filter not defined
Jul 12 22:00:16 newsfeed nnrpd[8523]: SERVER perl filter not defined
Jul 12 22:51:52 newsfeed nnrpd[10197]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1371945	97.8%	153.8 MB	97.2%
innd	15207	1.1%	2.5 MB	1.6%
nnrpd	9492	0.7%	1.0 MB	0.7%
innfeed	6670	0.5%	1004.4 KB	0.6%
TOTAL: 4	1403314	100.0%	158.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1368428	96.6%
Negative hits	33322	2.4%
Positive hits	15339	1.1%
Cache misses	120	0.0%
TOTAL: 4	1417209	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:11.403	0.0%	380	0.000	30.008	532.000
article cleanup	00:00:23.294	0.0%	1371966	0.002	0.017	0.036
article logging	00:00:39.333	0.0%	1372059	0.009	0.029	0.553
article parse	01:03:49.725	4.4%	115259909	0.011	0.033	0.063
article write	00:13:52.133	1.0%	1367150	0.341	0.609	1.796
artlog/artcncl	00:00:00.006	0.0%	376	0.000	0.016	1.000
artlog/artparse	00:00:00.000	0.0%	4	0.000	0.000	0.000
data move	00:03:40.856	0.3%	124302295	0.000	0.002	0.037
hisgrep/artcncl	00:00:01.163	0.0%	226	0.000	5.146	95.000
hishave/artcncl	00:00:00.670	0.0%	380	0.000	1.763	42.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:00:50.684	4.2%	1418068	0.158	2.574	5.693
history sync	00:00:00.093	0.0%	290	0.000	0.321	77.000
history write	02:43:25.121	11.3%	1369403	0.343	7.160	20.046
hiswrite/artcncl	00:00:01.487	0.0%	154	0.000	9.656	73.000
idle	13:45:15.880	57.3%	80113859	0.188	0.618	5.573
nntp read	00:52:33.488	3.6%	114130125	0.011	0.028	0.050
overview write	00:00:09.419	0.0%	1367150	0.000	0.007	0.032
perl filter	03:36:55.485	15.1%	1369399	5.774	9.505	12.083
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:56.393	0.2%	2759464	0.033	0.064	0.145
TOTAL: 24:00:19.816	23:24:46.633	97.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.074	0.0%	25161	0.000	0.003	0.143
article prepare	00:00:00.019	0.0%	17594	0.000	0.001	0.393
article read	00:00:01.707	0.0%	4248	0.000	0.402	249.000
backlog stats	00:00:00.131	0.0%	214020	0.000	0.001	1.000
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.241	0.0%	118846	0.000	0.010	0.095
data write	00:00:04.233	0.0%	104983	0.000	0.040	1.000
idle	23:59:38.769	100.0%	214020	0.000	403.601	27678.000
status file	00:00:01.638	0.0%	187	0.000	8.759	1294.000
TOTAL: 23:59:53.997	23:59:47.812	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	06:41:42.629	99.8%	90548	0.000	266.186	600073.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.849	0.0%	183315	0.000	0.016	1.111
readart	00:00:00.490	0.0%	359	0.000	1.365	42.000
TOTAL: 06:42:23.747	06:41:45.968	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	743	1368161	1363582	212	4367	99%	296:37:10
2	news.nask.pl	2	15900	3272	12275	353	20%	23:59:09
3	news.icm.edu.pl	43	277	10	173	94	3%	15:07:38
4	localhost	5	4	4	0	0	100%	00:00:01
TOTAL: 4		793	1384342	1366868	12660	4814	98%	335:43:58

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	505.8 GB	17.0 MB	311.5 MB	506.1 GB	99%	388.0 KB
2	news.nask.pl	20.1 MB	958.0 KB	985.6 KB	22.0 MB	91%	6.2 KB
3	news.icm.edu.pl	636.7 KB	10.2 KB	1.5 MB	2.2 MB	28%	21.5 KB
4	localhost	6.6 KB	0.0 KB	0.0 KB	6.6 KB	100%	1.6 KB
TOTAL: 4		505.8 GB	17.9 MB	314.0 MB	506.1 GB	99%	386.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 12 04:15:04 - 04:59:59	61393	4.5%	22.77	20.7 GB	4.1%	8066.22
Jul 12 05:00:00 - 05:59:59	84390	6.2%	23.44	31.1 GB	6.2%	9066.48
Jul 12 06:00:00 - 06:59:59	81935	6.0%	22.76	29.5 GB	5.8%	8597.42
Jul 12 07:00:00 - 07:59:59	85038	6.2%	23.62	30.9 GB	6.1%	8992.77
Jul 12 08:00:00 - 08:59:59	75626	5.5%	21.01	28.7 GB	5.7%	8354.10
Jul 12 09:00:00 - 09:59:59	76855	5.6%	21.35	28.0 GB	5.5%	8157.43
Jul 12 10:00:00 - 10:59:59	53007	3.9%	14.72	18.2 GB	3.6%	5302.86
Jul 12 11:00:00 - 11:59:59	37799	2.8%	10.50	13.2 GB	2.6%	3855.05
Jul 12 12:00:00 - 12:59:59	45879	3.4%	12.74	15.7 GB	3.1%	4576.12
Jul 12 13:00:00 - 13:59:59	42068	3.1%	11.69	14.3 GB	2.8%	4171.20
Jul 12 14:00:00 - 14:59:59	43185	3.2%	12.00	16.3 GB	3.2%	4758.78
Jul 12 15:00:00 - 15:59:59	36268	2.7%	10.07	13.6 GB	2.7%	3957.92
Jul 12 16:00:00 - 16:59:59	37572	2.7%	10.44	13.8 GB	2.7%	4028.28
Jul 12 17:00:00 - 17:59:59	38591	2.8%	10.72	15.7 GB	3.1%	4571.99
Jul 12 18:00:00 - 18:59:59	38136	2.8%	10.59	15.7 GB	3.1%	4571.52
Jul 12 19:00:00 - 19:59:59	40496	3.0%	11.25	16.0 GB	3.2%	4650.67
Jul 12 20:00:00 - 20:59:59	36123	2.6%	10.03	14.5 GB	2.9%	4214.61
Jul 12 21:00:00 - 21:59:59	34590	2.5%	9.61	14.0 GB	2.8%	4078.49
Jul 12 22:00:00 - 22:59:59	39797	2.9%	11.05	15.5 GB	3.1%	4527.71
Jul 12 23:00:00 - 23:59:59	40436	3.0%	11.23	15.5 GB	3.1%	4519.41
Jul 13 00:00:00 - 00:59:59	65843	4.8%	18.29	24.2 GB	4.8%	7050.66
Jul 13 01:00:00 - 01:59:59	83737	6.1%	23.26	30.7 GB	6.1%	8941.47
Jul 13 02:00:00 - 02:59:59	87936	6.4%	24.43	32.4 GB	6.4%	9445.02
Jul 13 03:00:00 - 03:59:59	77717	5.7%	21.59	29.1 GB	5.8%	8483.58
Jul 13 04:00:00 - 04:15:02	22241	1.6%	24.66	8.0 GB	1.6%	9303.10
TOTAL: 23:59:58	1366658	100.0%	15.82	505.5 GB	100.0%	6135.36

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4448	155	2217	0	2076
2	news.nask.pl	370	4	349	1	16
3	news.icm.edu.pl	93	0	0	0	93
TOTAL: 3		4911	159	2566	1	2185

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	70
it.tlc.cellulari.android	15
nl.comp.os.linux.techniek	12
comp.mobile.android	12
de.comp.lang.vbclassic	10
uk.rec.cycling.moderated	6
hr.ponuda.hardver.komponente	6
it.comp.os.win.windows8	6
de.comm.provider.telefonie	4
de.comp.office-pakete.ms-office.outlook	3
it.discussioni.energia	3
alt.sex.telephones	2
comp.mobile.ipad	2
it.comp.os.win.windows7	2
comp.sys.raspberry-pi	1
it.tlc.cellulari.iphone	1
hr.ponuda.hardver.periferije	1
nl.comp.sys.android	1
hr.ponuda.hardver.konfiguracije	1
hr.alt.cellular.gsm.iphone	1
TOTAL: 20	159

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

Groups	Count
bit.listserv.catholic	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	1974
EMP (md5)	97
Attached HTML file	13
HTML post	4
TOTAL: 4	2088

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	43678	1711	21704	1179	7	0	3%	24:06:42
2	panorama	26056	1152	23755	184	0	0	4%	23:53:28
3	nask	21628	108	13136	6	0	0	0%	23:59:28
4	poznan	4250	37	3140	6	0	0	0%	24:02:07
5	okapi	0	0	0	0	0	1592	0%	24:00:00
TOTAL: 5		95612	3008	61735	1375	7	1592	3%	120:01:45

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	39.7 MB	472.0 MB	511.7 MB	6.0 KB/s	181.3 KB	24:06:42
2	nask	19.0 MB	1.0 MB	20.0 MB	0.2 KB/s	179.7 KB	23:59:28
3	panorama	4.3 MB	786.0 KB	5.0 MB	0.1 KB/s	3.9 KB	23:53:28
4	poznan	229.8 KB	12.3 KB	242.1 KB	0.0 KB/s	5.6 KB	24:02:07
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		63.2 MB	473.8 MB	537.0 MB	1.3 KB/s	125.5 KB	120:01:45

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	336	585.9 KB	288	0	00:00:08
2	web.man.lodz.pl	288	18	19.2 KB	9	0	00:00:24
3	194.33.77.50	6	4	7.1 KB	3	0	00:59:57
4	pc-vicki.man.lodz.pl	1	1	2.2 KB	1	0	00:30:01
5	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:02
TOTAL: 5		587	359	614.5 KB	301	4	06:42:21

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	336	585.9 KB	288	0	00:00:08
2	*.man.lodz.pl	677	19	21.4 KB	10	4	00:30:34
3	unresolved	6	4	7.1 KB	3	0	00:59:57
4	*.dynamic.chello.pl	3	0	0.0 KB	0	0	00:27:20
5	*.pa.nsw.optusnet.com.au	651	0	0.0 KB	0	0	00:34:40
6	*.206.15.62.static.jazztel.es	10	0	0.0 KB	0	0	04:09:40
TOTAL: 6		1635	359	614.5 KB	301	4	06:42:21

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
229.206.15.62.static.jazztel.es	3.764	5.836	04:09:40
194.33.77.50	0.020	0.060	00:59:57
pa49-181-246-233.pa.nsw.optusnet.com.au	1.544	6.380	00:34:40
pc-vicki.man.lodz.pl	0.008	0.008	00:30:01
89-66-184-170.dynamic.chello.pl	0.036	0.036	00:27:20
web.man.lodz.pl	0.632	3.216	00:00:24
pc-skrzep2.cm.p.lodz.pl	0.532	3.072	00:00:08
mon.man.lodz.pl	0.560	2.816	00:00:04
isvcs01.man.lodz.pl	0.024	0.044	00:00:02
david.man.lodz.pl	0.204	1.044	00:00:01
TOTAL: 10	7.324	22.512	06:42:21

Curious NNRP server explorers [Top 20]:

System	Conn
pa49-181-246-233.pa.nsw.optusnet.com.au	651
mon.man.lodz.pl	288
david.man.lodz.pl	96
229.206.15.62.static.jazztel.es	10
89-66-184-170.dynamic.chello.pl	3
TOTAL: 5	1048

NNRP unrecognized commands (by host):

System	Conn
89-66-184-170.dynamic.chello.pl	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
exit	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
pa49-181-246-233.pa.nsw.optusnet.com.au	2	0
89-66-184-170.dynamic.chello.pl	1	1
pc-vicki.man.lodz.pl	1	0
194.33.77.50	1	0
TOTAL: 4	5	1

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	340	94.7%
2	pl	19	5.3%
TOTAL: 2		359	100.0%

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

Newsgroup		Count
1	lodman.info	340
2	pl.comp.pecet	12
3	pl.comp.os.ms-windows.winnt	6
4	pl.sci.medycyna	1
TOTAL: 4		359

Daily Usenet report

Jul 12 04:15:04 -- Jul 13 04:15:02