Daily Usenet report: Sep 29 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Sep 29 09:35:25 newsfeed nnrpd[17135]: SERVER perl filter not defined
Sep 29 10:45:09 newsfeed overchan[23940]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	801713	95.7%	93.7 MB	95.1%
innd	22667	2.7%	3.2 MB	3.2%
nnrpd	7289	0.9%	742.4 KB	0.7%
innfeed	6233	0.7%	888.2 KB	0.9%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	837903	100.0%	98.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	797076	89.7%
Negative hits	73856	8.3%
Positive hits	17701	2.0%
Cache misses	144	0.0%
TOTAL: 4	888777	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:09.692	0.0%	348	0.000	27.851	1621.000
article cleanup	00:00:18.578	0.0%	800436	0.000	0.023	0.070
article logging	00:00:33.092	0.0%	800586	0.007	0.041	0.254
article parse	00:20:58.778	1.5%	56318907	0.011	0.022	0.079
article write	00:08:04.932	0.6%	784121	0.227	0.618	5.636
artlog/artcncl	00:00:00.010	0.0%	340	0.000	0.029	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:01:13.609	0.1%	60892208	0.000	0.001	0.005
hisgrep/artcncl	00:00:01.260	0.0%	291	0.000	4.330	119.000
hishave/artcncl	00:00:01.240	0.0%	348	0.000	3.563	323.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:45:54.919	3.2%	889288	0.328	3.098	13.867
history sync	00:00:00.038	0.0%	405	0.000	0.094	1.000
history write	01:39:12.658	6.9%	797769	0.876	7.462	27.857
hiswrite/artcncl	00:00:00.544	0.0%	57	0.000	9.544	267.000
idle	18:52:36.104	78.7%	44896524	0.452	1.514	13.261
nntp read	00:21:45.709	1.5%	55775167	0.015	0.023	0.050
overview write	00:00:05.681	0.0%	784121	0.000	0.007	0.047
perl filter	01:28:28.533	6.1%	797767	3.632	6.654	12.288
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:16.900	0.2%	1605790	0.021	0.085	0.168
TOTAL: 23:59:30.211	23:41:42.277	98.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.145	0.0%	37548	0.000	0.004	0.111
article prepare	00:00:00.002	0.0%	12944	0.000	0.000	0.025
article read	00:00:00.359	0.0%	3061	0.000	0.117	2.000
backlog stats	00:00:00.159	0.0%	232128	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.909	0.0%	144816	0.000	0.013	1.000
data write	00:00:05.419	0.0%	114515	0.000	0.047	11.000
idle	23:59:02.812	100.0%	232128	0.000	371.962	15403.000
status file	00:00:00.354	0.0%	195	0.000	1.815	47.750
TOTAL: 23:59:17.172	23:59:11.159	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	23:25:10.364	99.9%	552224	0.000	152.674	128530.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:22.771	0.0%	1106656	0.000	0.021	0.778
readart	00:00:02.159	0.0%	570	0.000	3.788	82.000
TOTAL: 23:26:29.576	23:25:35.294	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	353	797380	781561	428	15391	98%	171:31:52
2	news.nask.pl	2	18452	2987	14524	941	16%	24:39:48
3	news.icm.edu.pl	46	207	10	188	9	4%	15:41:36
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		403	816040	784559	15140	16341	96%	211:53:16

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	169.3 GB	8.8 MB	1.7 GB	171.0 GB	98%	225.0 KB
2	news.nask.pl	13.1 MB	2.4 MB	2.9 MB	18.5 MB	71%	4.8 KB
3	news.icm.edu.pl	239.0 KB	99.0 KB	244.0 KB	581.9 KB	41%	30.6 KB
4	localhost	1.5 KB	0.0 KB	0.0 KB	1.5 KB	100%	1.5 KB
TOTAL: 4		169.3 GB	11.3 MB	1.7 GB	171.0 GB	98%	223.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 29 04:15:01 - 04:59:59	39556	5.0%	14.66	10.9 GB	6.4%	4223.10
Sep 29 05:00:00 - 05:59:59	28864	3.7%	8.02	7.9 GB	4.7%	2292.59
Sep 29 06:00:00 - 06:59:59	13790	1.8%	3.83	2.9 GB	1.7%	855.92
Sep 29 07:00:00 - 07:59:59	9653	1.2%	2.68	2.0 GB	1.2%	586.70
Sep 29 08:00:00 - 08:59:59	10373	1.3%	2.88	2.3 GB	1.3%	655.55
Sep 29 09:00:00 - 09:59:59	12533	1.6%	3.48	2.8 GB	1.6%	805.16
Sep 29 10:00:00 - 10:59:59	11235	1.4%	3.12	2.1 GB	1.2%	599.40
Sep 29 11:00:00 - 11:59:59	11421	1.5%	3.17	2.0 GB	1.2%	575.86
Sep 29 12:00:00 - 12:59:59	11940	1.5%	3.32	2.7 GB	1.6%	786.62
Sep 29 13:00:00 - 13:59:59	16305	2.1%	4.53	3.1 GB	1.8%	899.07
Sep 29 14:00:00 - 14:59:59	15594	2.0%	4.33	2.9 GB	1.7%	839.07
Sep 29 15:00:00 - 15:59:59	17021	2.2%	4.73	3.1 GB	1.8%	900.95
Sep 29 16:00:00 - 16:59:59	16549	2.1%	4.60	2.9 GB	1.7%	858.30
Sep 29 17:00:00 - 17:59:59	16720	2.1%	4.64	3.1 GB	1.8%	894.25
Sep 29 18:00:00 - 18:59:59	21516	2.7%	5.98	3.5 GB	2.1%	1012.80
Sep 29 19:00:00 - 19:59:59	37571	4.8%	10.44	5.1 GB	3.0%	1472.29
Sep 29 20:00:00 - 20:59:59	39946	5.1%	11.10	5.6 GB	3.3%	1628.79
Sep 29 21:00:00 - 21:59:59	38255	4.9%	10.63	6.0 GB	3.5%	1750.09
Sep 29 22:00:00 - 22:59:59	38589	4.9%	10.72	5.6 GB	3.3%	1625.27
Sep 29 23:00:00 - 23:59:59	39481	5.0%	10.97	5.8 GB	3.4%	1683.50
Sep 30 00:00:00 - 00:59:59	81193	10.3%	22.55	17.2 GB	10.2%	5020.48
Sep 30 01:00:00 - 01:59:59	83515	10.6%	23.20	22.5 GB	13.3%	6568.14
Sep 30 02:00:00 - 02:59:59	75935	9.7%	21.09	21.0 GB	12.4%	6129.69
Sep 30 03:00:00 - 03:59:59	76537	9.8%	21.26	21.0 GB	12.4%	6106.26
Sep 30 04:00:00 - 04:15:02	20818	2.7%	23.08	5.5 GB	3.2%	6336.13
TOTAL: 24:00:01	784910	100.0%	9.08	169.3 GB	100.0%	2054.16

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	15533	192	1818	1	13522
2	news.nask.pl	921	60	848	3	10
3	news.icm.edu.pl	9	0	3	0	6
TOTAL: 3		16463	252	2669	4	13538

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	52
alt.sex.telephones	46
comp.mobile.android	26
it.tlc.cellulari.android	24
it.comp.os.win.windows8	23
it.comp.os.win.windows7	16
comp.sys.raspberry-pi	14
de.rec.sf.startrek	12
hr.alt.cellular.gsm.android	12
comp.mobile.ipad	11
hr.rec.glazba.hifi	4
de.comp.office-pakete.ms-office.word	2
de.comp.lang.vbclassic	2
de.comm.provider.telefonie	2
hr.alt.cellular.gsm.iphone	2
rec.arts.tv.x-factor	1
it.politica.m5s	1
it.discussioni.energia	1
hr.ponuda.hardver.komponente	1
TOTAL: 19	252

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

Groups	Count
fido7.ru.guitar.soft	2
bit.listserv.catholic	1
pl.sci.matematyka	1
TOTAL: 3	4

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	13361
EMP (md5)	11
HTML post	11
Scoring filter (8)	2
Scoring filter (12)	1
TOTAL: 5	13386

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	38221	1020	36248	200	0	2%	23:51:40
2	nask	26976	563	16146	371	0	2%	24:00:12
3	icm	37902	439	29167	596	7	1%	23:59:15
4	poznan	3616	30	2615	3	0	0%	24:00:13
5	okapi	0	0	0	0	2764	0%	24:00:00
TOTAL: 5		106715	2052	84176	1170	2771	1%	119:51:20

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nask	59.9 MB	136.8 MB	196.8 MB	2.3 KB/s	215.7 KB	24:00:12
2	icm	33.1 MB	71.1 MB	104.3 MB	1.2 KB/s	103.2 KB	23:59:15
3	panorama	4.1 MB	910.4 KB	5.0 MB	0.1 KB/s	4.2 KB	23:51:40
4	poznan	147.5 KB	12.9 KB	160.4 KB	0.0 KB/s	4.9 KB	24:00:13
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		97.4 MB	208.9 MB	306.2 MB	0.7 KB/s	97.3 KB	119:51:20

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	287	299	457.2 KB	287	0	00:00:08
2	web.man.lodz.pl	288	192	175.4 KB	76	0	00:00:26
3	lze200.lze.lodz.pl	4	77	143.5 KB	5	0	00:27:59
4	212.51.203.199	2	2	4.9 KB	1	0	00:01:43
5	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 5		582	570	781.1 KB	369	1	23:26:29

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	287	299	457.2 KB	287	0	00:00:08
2	*.man.lodz.pl	673	192	175.4 KB	76	1	00:00:32
3	*.lze.lodz.pl	4	77	143.5 KB	5	0	00:27:59
4	unresolved	3	2	4.9 KB	1	0	00:02:48
5	*.105.135.22.tvsat364.lodz.pl	1	0	0.0 KB	0	0	00:06:25
6	*.toya.net.pl	86	0	0.0 KB	0	0	00:00:35
TOTAL: 6		1054	570	781.1 KB	369	1	23:26:29

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
207.206.15.62.static.jazztel.es	38.910	45.910	22:47:59
lze200.lze.lodz.pl	0.037	0.074	00:27:59
ip-176.105.135.22.tvsat364.lodz.pl	0.006	0.010	00:06:25
212.51.203.199	0.010	0.038	00:01:43
194.33.77.50	0.003	0.014	00:01:04
staticline-31-183-89-184.toya.net.pl	0.060	0.035	00:00:30
web.man.lodz.pl	1.164	3.712	00:00:26
pc-skrzep2.cm.p.lodz.pl	1.058	3.519	00:00:08
staticline41435.toya.net.pl	0.350	1.025	00:00:05
mon.man.lodz.pl	1.077	3.525	00:00:04
david.man.lodz.pl	0.310	1.194	00:00:01
isvcs01.man.lodz.pl	0.013	0.009	00:00:00
TOTAL: 12	42.998	59.065	23:26:29

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	84
staticline-31-183-89-184.toya.net.pl	2
ip-176.105.135.22.tvsat364.lodz.pl	1
194.33.77.50	1
TOTAL: 6	472

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	299	52.5%
2	pl	271	47.5%
TOTAL: 2		570	100.0%

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

Newsgroup		Count
1	lodman.info	299
2	pl.comp.os.ms-windows.winnt	130
3	pl.comp.pecet	92
4	pl.misc.telefonia.gsm	38
5	pl.rec.dom	7
6	pl.rec.kuchnia	2
7	pl.rec.radio.amatorskie	2
TOTAL: 7		570

Daily Usenet report

Sep 29 04:15:01 -- Sep 30 04:15:02