Daily Usenet report: Jun 18 04:15:03

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Jun 18 10:46:44 newsfeed innfeed[2247]: task:0 connect: Network is unreachable
Jun 18 10:46:45 newsfeed innfeed[2247]: nask:0 connect: Network is unreachable
Jun 18 10:46:45 newsfeed innfeed[2247]: icm:0 connect: Network is unreachable
Jun 18 13:19:56 newsfeed nnrpd[7909]: SERVER perl filter not defined
Jun 18 13:20:38 newsfeed nnrpd[7953]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2522890	98.2%	284.0 MB	97.8%
innd	27948	1.1%	4.2 MB	1.5%
nnrpd	10874	0.4%	1.1 MB	0.4%
innfeed	7368	0.3%	1.1 MB	0.4%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	2569081	100.0%	290.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2513759	93.0%
Negative hits	103372	3.8%
Positive hits	83605	3.1%
Cache misses	3058	0.1%
TOTAL: 4	2703794	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:15:19.243	1.1%	41447	0.000	22.179	602.904
article cleanup	00:00:27.388	0.0%	2479687	0.002	0.011	0.281
article logging	00:01:10.086	0.1%	2479871	0.007	0.028	0.756
article parse	00:54:32.337	3.8%	117980437	0.011	0.028	0.156
article write	00:27:05.354	1.9%	2462318	0.249	0.660	96.329
artlog/artcncl	00:00:01.333	0.0%	41297	0.000	0.032	7.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:02:49.100	0.2%	132361311	0.001	0.001	0.062
hisgrep/artcncl	00:00:12.398	0.0%	668	0.000	18.560	230.000
hishave/artcncl	00:06:35.444	0.5%	41447	0.000	9.541	569.846
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	04:22:41.605	18.3%	2663509	0.001	5.918	97.429
history sync	00:00:00.007	0.0%	290	0.000	0.024	2.000
history write	05:52:52.141	24.5%	2473790	0.536	8.559	94.143
hiswrite/artcncl	00:07:56.286	0.6%	40779	0.000	11.680	85.000
idle	06:27:54.188	27.0%	76004482	0.114	0.306	31.656
nntp read	00:35:20.252	2.5%	116021982	0.011	0.018	0.409
overview write	00:00:12.607	0.0%	2462318	0.000	0.005	0.184
perl filter	04:33:08.556	19.0%	2473787	4.340	6.625	85.206
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:06:19.867	0.4%	4985825	0.014	0.076	1.003
TOTAL: 23:58:11.220	23:54:38.192	99.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.186	0.0%	63495	0.000	0.003	0.083
article prepare	00:00:00.017	0.0%	115398	0.000	0.000	0.028
article read	00:00:45.007	0.1%	27789	0.000	1.620	109.000
backlog stats	00:00:00.342	0.0%	451316	0.000	0.001	0.134
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:04.020	0.0%	259665	0.000	0.015	3.109
data write	00:00:13.736	0.0%	234067	0.000	0.059	23.000
idle	23:56:35.266	99.9%	451316	0.000	190.987	12933.000
status file	00:00:09.658	0.0%	351	0.000	27.516	381.000
TOTAL: 23:58:02.980	23:57:48.232	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:04.726	0.0%	501	9.433	9.433	9.433
idle	55:09:11.113	99.9%	152942	0.000	1298.212	600055.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:24.352	0.0%	308464	0.000	0.079	5.375
readart	00:00:05.590	0.0%	554	0.000	10.090	272.000
TOTAL: 55:11:30.484	55:09:45.781	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	590	2467685	2448038	4666	14981	99%	466:07:22
2	news.nask.pl	3	20130	7365	11782	983	36%	23:47:02
3	news.task.gda.pl	14	70112	6134	62610	1368	8%	39:58:11
4	news.icm.edu.pl	35	389	17	352	20	4%	20:32:51
5	localhost	3	2	2	0	0	100%	00:00:01
TOTAL: 5		645	2558318	2461556	79410	17352	96%	550:25:27

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	791.8 GB	285.8 MB	1.9 GB	793.9 GB	99%	338.0 KB
2	news.nask.pl	150.4 MB	22.6 MB	22.7 MB	195.7 MB	76%	24.0 KB
3	news.task.gda.pl	13.2 MB	110.5 KB	4.2 MB	17.5 MB	75%	2.4 KB
4	news.icm.edu.pl	407.1 KB	68.2 KB	446.2 KB	921.5 KB	44%	24.9 KB
5	localhost	3.1 KB	0.0 KB	0.0 KB	3.1 KB	100%	1.6 KB
TOTAL: 5		791.9 GB	308.6 MB	1.9 GB	794.2 GB	99%	335.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 18 04:15:03 - 04:59:59	43804	1.8%	16.24	14.7 GB	1.9%	5722.57
Jun 18 05:00:00 - 05:59:59	85389	3.5%	23.72	28.5 GB	3.6%	8287.11
Jun 18 06:00:00 - 06:59:59	99974	4.1%	27.77	31.8 GB	4.0%	9267.74
Jun 18 07:00:00 - 07:59:59	93851	3.8%	26.07	28.4 GB	3.6%	8283.26
Jun 18 08:00:00 - 08:59:59	110239	4.5%	30.62	30.0 GB	3.8%	8726.15
Jun 18 09:00:00 - 09:59:59	104487	4.2%	29.02	31.5 GB	4.0%	9174.66
Jun 18 10:00:00 - 10:59:59	91645	3.7%	25.46	27.7 GB	3.5%	8065.37
Jun 18 11:00:00 - 11:59:59	102628	4.2%	28.51	34.6 GB	4.4%	10063.57
Jun 18 12:00:00 - 12:59:59	114840	4.7%	31.90	37.5 GB	4.7%	10927.38
Jun 18 13:00:00 - 13:59:59	131378	5.3%	36.49	36.9 GB	4.7%	10742.59
Jun 18 14:00:00 - 14:59:59	130131	5.3%	36.15	36.7 GB	4.6%	10682.11
Jun 18 15:00:00 - 15:59:59	128880	5.2%	35.80	37.0 GB	4.7%	10782.97
Jun 18 16:00:00 - 16:59:59	123323	5.0%	34.26	37.8 GB	4.8%	11010.92
Jun 18 17:00:00 - 17:59:59	123838	5.0%	34.40	37.3 GB	4.7%	10873.62
Jun 18 18:00:00 - 18:59:59	108236	4.4%	30.07	33.6 GB	4.2%	9780.51
Jun 18 19:00:00 - 19:59:59	113022	4.6%	31.39	36.7 GB	4.6%	10682.85
Jun 18 20:00:00 - 20:59:59	103640	4.2%	28.79	36.7 GB	4.6%	10681.28
Jun 18 21:00:00 - 21:59:59	83286	3.4%	23.14	30.3 GB	3.8%	8830.88
Jun 18 22:00:00 - 22:59:59	86126	3.5%	23.92	31.5 GB	4.0%	9172.70
Jun 18 23:00:00 - 23:59:59	89995	3.7%	25.00	32.8 GB	4.1%	9560.47
Jun 19 00:00:00 - 00:59:59	85155	3.5%	23.65	31.7 GB	4.0%	9231.95
Jun 19 01:00:00 - 01:59:59	93363	3.8%	25.93	33.2 GB	4.2%	9667.01
Jun 19 02:00:00 - 02:59:59	105924	4.3%	29.42	36.6 GB	4.6%	10646.16
Jun 19 03:00:00 - 03:59:59	84867	3.4%	23.57	30.7 GB	3.9%	8943.10
Jun 19 04:00:00 - 04:15:05	26023	1.1%	28.75	8.3 GB	1.0%	9621.87
TOTAL: 24:00:02	2464044	100.0%	28.52	792.4 GB	100.0%	9616.04

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	15129	290	4886	11	9942
2	news.task.gda.pl	1411	1188	71	3	149
3	news.nask.pl	998	20	935	2	41
4	news.icm.edu.pl	20	0	5	0	15
TOTAL: 4		17558	1498	5897	16	10147

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-src-all	114
fa.freebsd.cvs-all	114
mailing.freebsd.ports-bugs	86
uk.railway	71
mailing.freebsd.svn-src-head	64
mailing.freebsd.svn-ports-all	63
mailing.freebsd.svn-ports-head	62
uk.rec.cycling.moderated	46
mailing.openbsd.ports-changes	41
alt.windows7.general	35
24hoursupport.helpdesk	32
mailing.freebsd.current	31
mailing.database.pgsql-general	31
mailing.unix.spamassassin-dev	30
mailing.gcc.gcc-cvs	27
mailing.freebsd.ports	27
comp.sys.raspberry-pi	27
mozilla.dev.gaia	26
it.tlc.cellulari.android	26
mailing.unix.spamassassin-talk	23
TOTAL: 87	1498

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

Groups	Count
pl.sci.historia	12
fr.comp.securite	3
bit.listserv.catholic	1
TOTAL: 3	16

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	9715
EMP (fsl)	123
HTML post	92
EMP (md5)	18
Cancel in forbidden group	8
Scoring filter (8)	3
Scoring filter (13)	1
TOTAL: 7	9960

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	76570	7124	34236	16016	4	2302	9%	23:59:14
2	panorama	64574	3678	54498	1480	1	0	5%	23:40:05
3	task	2164	232	994	32	0	0	10%	21:26:59
4	nask	21953	97	15677	1	0	8	0%	23:50:47
5	poznan	15304	93	12460	67	0	0	0%	23:50:01
6	okapi	0	0	0	0	0	3135	0%	23:50:00
TOTAL: 6		180565	11224	117865	17596	5	5445	6%	140:37:06

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	351.7 MB	3.5 GB	3.9 GB	47.1 KB/s	175.8 KB	23:59:14
2	panorama	16.0 MB	91.7 MB	107.7 MB	1.3 KB/s	21.4 KB	23:40:05
3	nask	661.6 KB	1.2 KB	662.8 KB	0.0 KB/s	6.8 KB	23:50:47
4	task	539.1 KB	61.6 KB	600.7 KB	0.0 KB/s	2.3 KB	21:26:59
5	poznan	381.4 KB	211.4 KB	592.8 KB	0.0 KB/s	3.7 KB	23:50:01
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:00
TOTAL: 6		369.2 MB	3.6 GB	4.0 GB	8.3 KB/s	145.1 KB	140:37:06

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	vegas.cm.p.lodz.pl	288	302	457.2 KB	288	0	00:00:12
2	web.man.lodz.pl	289	118	158.1 KB	51	0	00:00:30
3	212.191.78.190	298	111	212.1 KB	35	0	45:19:50
4	router2.cbmm.lodz.pl	8	15	65.0 KB	4	0	00:40:53
5	212.51.203.199	2	6	11.3 KB	1	0	00:24:00
6	ech221.neoplus.adsl.tpnet.pl	3	2	3.1 KB	2	0	00:03:07
7	kujawiak.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 7		890	554	906.8 KB	381	2	55:11:26

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	302	457.2 KB	288	0	00:00:12
2	*.man.lodz.pl	677	118	158.1 KB	51	2	00:30:39
3	unresolved	405	117	223.4 KB	36	0	45:47:48
4	*.cbmm.lodz.pl	8	15	65.0 KB	4	0	00:40:53
5	*.neoplus.adsl.tpnet.pl	3	2	3.1 KB	2	0	00:03:07
6	*.181.14.62.static.jazztel.es	23	0	0.0 KB	0	0	07:37:46
7	*.105.135.22.tvsat364.lodz.pl	1	0	0.0 KB	0	0	00:30:05
8	*.toya.net.pl	73	0	0.0 KB	0	0	00:00:53
TOTAL: 8		1478	554	906.8 KB	381	2	55:11:26

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.78.190	1.316	10.988	45:19:50
249.181.14.62.static.jazztel.es	27.414	45.218	07:37:46
router2.cbmm.lodz.pl	0.100	0.800	00:40:53
ip-176.105.135.22.tvsat364.lodz.pl	0.000	0.032	00:30:05
pc-vicki.man.lodz.pl	0.004	0.012	00:30:00
212.51.203.199	0.016	0.212	00:24:00
122.150.17.59	0.268	2.200	00:03:57
ech221.neoplus.adsl.tpnet.pl	0.000	0.024	00:03:07
staticline41435.toya.net.pl	0.300	3.200	00:00:53
web.man.lodz.pl	1.064	14.512	00:00:30
vegas.cm.p.lodz.pl	1.484	17.512	00:00:12
f-oper-v100.man.lodz.pl	0.996	36.418	00:00:06
david.man.lodz.pl	0.640	5.988	00:00:01
kujawiak.man.lodz.pl	0.008	0.132	00:00:00
TOTAL: 14	33.610	137.248	55:11:26

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	289
122.150.17.59	105
david.man.lodz.pl	96
staticline41435.toya.net.pl	73
249.181.14.62.static.jazztel.es	23
pc-vicki.man.lodz.pl	1
ip-176.105.135.22.tvsat364.lodz.pl	1
TOTAL: 7	588

NNRP client timeouts [Top 20]:

System	Conn	Peer
249.181.14.62.static.jazztel.es	4	1
122.150.17.59	1	1
pc-vicki.man.lodz.pl	1	0
ip-176.105.135.22.tvsat364.lodz.pl	1	0
TOTAL: 4	7	2

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	304	54.9%
2	pl	250	45.1%
TOTAL: 2		554	100.0%

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

Newsgroup		Count
1	lodman.info	304
2	pl.comp.pecet	112
3	pl.misc.kolej	44
4	pl.rec.rowery	35
5	pl.regionalne.lodz	23
6	pl.soc.prawo	11
7	pl.regionalne.warszawa	11
8	pl.rec.radio.amatorskie	6
9	pl.internet.polip	4
10	pl.rec.gory	2
11	pl.comp.os.ms-windows.winnt	2
TOTAL: 11		554

Daily Usenet report

Jun 18 04:15:03 -- Jun 19 04:15:05