Daily Usenet report: Nov 23 04:15:01

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Nov 23 04:15:01 newsfeed nnrpd[20888]: web.man.lodz.pl rejected Flushing log and syslog files
Nov 23 04:15:02 newsfeed nnrpd[20891]: web.man.lodz.pl rejected Flushing log and syslog files
Nov 23 04:15:02 newsfeed nnrpd[20892]: web.man.lodz.pl rejected Flushing log and syslog files
Nov 23 04:15:02 newsfeed nnrpd[20897]: web.man.lodz.pl rejected Flushing log and syslog files
Nov 23 15:22:56 newsfeed nnrpd[11415]: SERVER perl filter not defined
Nov 24 00:07:54 newsfeed nnrpd[28704]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1461268	97.5%	168.9 MB	97.1%
innd	23319	1.6%	3.4 MB	2.0%
nnrpd	7129	0.5%	744.3 KB	0.4%
innfeed	6672	0.4%	975.7 KB	0.5%
TOTAL: 4	1498388	100.0%	174.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1456708	94.5%
Negative hits	68046	4.4%
Positive hits	15960	1.0%
Cache misses	238	0.0%
TOTAL: 4	1540952	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:09.878	0.0%	356	0.000	27.747	609.000
article cleanup	00:00:24.744	0.0%	1461072	0.004	0.017	0.036
article logging	00:00:38.883	0.0%	1461169	0.010	0.027	0.155
article parse	00:51:57.663	3.6%	136995329	0.011	0.023	0.040
article write	00:13:17.115	0.9%	1447207	0.243	0.551	2.301
artlog/artcncl	00:00:00.006	0.0%	299	0.000	0.020	1.000
artlog/artparse	00:00:00.000	0.0%	4	0.000	0.000	0.000
data move	00:02:06.723	0.1%	146121428	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.938	0.0%	317	0.000	2.959	29.000
hishave/artcncl	00:00:00.473	0.0%	356	0.000	1.329	85.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:38:58.444	2.7%	1542349	0.009	1.516	7.822
history sync	00:00:00.013	0.0%	291	0.000	0.045	1.000
history write	02:34:11.479	10.7%	1458186	0.494	6.345	21.819
hiswrite/artcncl	00:00:00.207	0.0%	39	0.000	5.308	18.000
idle	14:54:56.011	62.1%	98967737	0.347	0.543	1.697
nntp read	00:52:44.036	3.7%	135787875	0.014	0.023	0.036
overview write	00:00:09.015	0.0%	1447207	0.000	0.006	0.019
perl filter	03:07:50.735	13.0%	1458182	5.121	7.729	10.450
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:43.560	0.2%	2927744	0.017	0.056	0.092
TOTAL: 24:00:18.555	23:20:09.923	97.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.101	0.0%	33348	0.000	0.003	0.143
article prepare	00:00:00.006	0.0%	32900	0.000	0.000	0.250
article read	00:00:01.407	0.0%	8178	0.000	0.172	90.200
backlog stats	00:00:00.133	0.0%	227362	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.395	0.0%	141032	0.000	0.010	1.000
data write	00:00:07.205	0.0%	114240	0.000	0.063	10.000
idle	24:00:02.005	100.0%	227362	0.000	380.020	21399.000
status file	00:00:00.485	0.0%	197	0.000	2.462	151.500
TOTAL: 24:00:17.895	24:00:12.737	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.109	0.0%	692	0.117	0.158	28.000
idle	04:14:21.955	99.8%	29660	0.000	514.564	504961.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:07.494	0.0%	181989	0.000	0.041	0.500
readart	00:00:00.947	0.0%	996	0.000	0.951	284.000
TOTAL: 04:14:52.976	04:14:30.505	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	488	1457888	1443919	584	13385	99%	250:47:03
2	news.nask.pl	3	15769	3357	12016	396	21%	23:32:22
3	news.icm.edu.pl	41	363	78	194	91	21%	16:10:33
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		536	1474023	1447357	12794	13872	98%	290:29:58

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	423.6 GB	30.3 MB	1.6 GB	425.2 GB	99%	306.0 KB
2	news.nask.pl	14.9 MB	1.0 MB	1.2 MB	17.1 MB	87%	4.7 KB
3	news.icm.edu.pl	6.4 MB	106.4 KB	4.4 MB	10.8 MB	58%	65.7 KB
4	localhost	2.4 KB	0.0 KB	0.0 KB	2.4 KB	100%	0.8 KB
TOTAL: 4		423.6 GB	31.4 MB	1.6 GB	425.3 GB	99%	305.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 23 04:15:01 - 04:59:59	42573	2.9%	15.77	12.8 GB	3.0%	4983.04
Nov 23 05:00:00 - 05:59:59	66927	4.6%	18.59	21.3 GB	5.0%	6211.35
Nov 23 06:00:00 - 06:59:59	62574	4.3%	17.38	20.9 GB	4.9%	6081.64
Nov 23 07:00:00 - 07:59:59	60148	4.2%	16.71	20.1 GB	4.7%	5849.10
Nov 23 08:00:00 - 08:59:59	46273	3.2%	12.85	15.9 GB	3.8%	4629.02
Nov 23 09:00:00 - 09:59:59	55180	3.8%	15.33	16.6 GB	3.9%	4844.64
Nov 23 10:00:00 - 10:59:59	44979	3.1%	12.49	13.5 GB	3.2%	3946.62
Nov 23 11:00:00 - 11:59:59	46785	3.2%	13.00	14.2 GB	3.4%	4139.61
Nov 23 12:00:00 - 12:59:59	54344	3.8%	15.10	16.9 GB	4.0%	4918.54
Nov 23 13:00:00 - 13:59:59	57677	4.0%	16.02	16.4 GB	3.9%	4777.03
Nov 23 14:00:00 - 14:59:59	43552	3.0%	12.10	12.7 GB	3.0%	3695.97
Nov 23 15:00:00 - 15:59:59	63316	4.4%	17.59	19.3 GB	4.6%	5621.68
Nov 23 16:00:00 - 16:59:59	68229	4.7%	18.95	19.7 GB	4.7%	5733.77
Nov 23 17:00:00 - 17:59:59	62982	4.4%	17.50	19.4 GB	4.6%	5663.57
Nov 23 18:00:00 - 18:59:59	74455	5.1%	20.68	21.5 GB	5.1%	6253.73
Nov 23 19:00:00 - 19:59:59	70069	4.8%	19.46	19.6 GB	4.6%	5720.30
Nov 23 20:00:00 - 20:59:59	58314	4.0%	16.20	13.9 GB	3.3%	4046.38
Nov 23 21:00:00 - 21:59:59	43152	3.0%	11.99	10.3 GB	2.4%	2996.87
Nov 23 22:00:00 - 22:59:59	56845	3.9%	15.79	14.7 GB	3.5%	4280.97
Nov 23 23:00:00 - 23:59:59	79718	5.5%	22.14	20.7 GB	4.9%	6027.57
Nov 24 00:00:00 - 00:59:59	58733	4.1%	16.31	14.3 GB	3.4%	4155.12
Nov 24 01:00:00 - 01:59:59	72336	5.0%	20.09	20.8 GB	4.9%	6064.54
Nov 24 02:00:00 - 02:59:59	72193	5.0%	20.05	20.4 GB	4.8%	5952.46
Nov 24 03:00:00 - 03:59:59	68845	4.8%	19.12	21.7 GB	5.1%	6324.09
Nov 24 04:00:00 - 04:15:03	16805	1.2%	18.61	5.6 GB	1.3%	6495.02
TOTAL: 24:00:02	1447004	100.0%	16.75	423.3 GB	100.0%	5137.37

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	13465	187	2538	0	10740
2	news.nask.pl	409	52	347	1	9
3	news.icm.edu.pl	91	0	4	0	87
TOTAL: 3		13965	239	2889	1	10836

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	75
comp.mobile.android	48
alt.sex.telephones	40
it.tlc.cellulari.android	19
it.comp.os.win.windows8	15
uk.rec.cycling.moderated	8
de.rec.sf.startrek	5
uk.net.providers.gradwell	5
comp.mobile.ipad	4
hr.alt.cellular.gsm.iphone	4
rec.arts.tv.x-factor	3
de.comm.provider.telefonie	3
it.comp.os.win.windows7	3
hr.ponuda.hardver.komponente	3
nl.comp.os.linux.techniek	2
comp.sys.raspberry-pi	1
it.discussioni.energia	1
TOTAL: 17	239

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

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

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	10648
EMP (md5)	83
EMP (fsl)	4
TOTAL: 3	10735

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	38227	5063	25718	396	19	13%	24:03:27
2	panorama	34075	1756	31415	222	0	5%	24:03:33
3	nask	24187	286	14332	538	0	1%	23:59:44
4	poznan	4637	15	3322	7	0	0%	24:00:34
5	okapi	0	0	0	0	2206	0%	24:00:01
TOTAL: 5		101126	7120	74787	1163	2225	7%	120:07:19

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	904.6 MB	115.5 MB	1020.1 MB	12.1 KB/s	191.4 KB	24:03:27
2	nask	35.6 MB	128.2 MB	163.8 MB	1.9 KB/s	203.5 KB	23:59:44
3	panorama	7.3 MB	913.7 KB	8.2 MB	0.1 KB/s	4.2 KB	24:03:33
4	poznan	162.8 KB	10.4 KB	173.3 KB	0.0 KB/s	7.9 KB	24:00:34
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		947.6 MB	244.6 MB	1.2 GB	2.8 KB/s	147.4 KB	120:07:19

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	288	364.5 KB	288	0	0	00:00:06
2	web.man.lodz.pl	293	72	166.5 KB	29	0	0	00:00:23
3	staticline-31-182-69-227.toya.net.pl	7	25	20.0 KB	3	0	1	00:20:50
4	pc24.zsk.p.lodz.pl	3	5	4.5 KB	2	2	0	00:39:25
5	84-10-122-104.static.chello.pl	10	4	3.4 KB	1	0	5	01:07:18
6	host-89-230-0-228.ozorkow.mm.pl	8	2	1.6 KB	2	0	3	00:09:04
7	dynamic-78-8-166-182.ssp.dialog.net.pl	1	1	1.3 KB	1	0	0	00:04:39
8	212.191.87.58	1	1	1.0 KB	1	1	0	00:05:47
TOTAL: 8		611	398	562.9 KB	327	3	9	04:14:52

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.cm.p.lodz.pl	288	288	364.5 KB	288	0	0	00:00:06
2	*.man.lodz.pl	677	72	166.5 KB	29	0	0	00:00:29
3	*.toya.net.pl	16	25	20.0 KB	3	0	1	00:21:05
4	*.zsk.p.lodz.pl	3	5	4.5 KB	2	2	0	00:39:25
5	*.static.chello.pl	10	4	3.4 KB	1	0	5	01:07:18
6	*.ozorkow.mm.pl	8	2	1.6 KB	2	0	3	00:09:04
7	unresolved	1	1	1.0 KB	1	1	0	00:05:47
8	*.ssp.dialog.net.pl	1	1	1.3 KB	1	0	0	00:04:39
9	*.elsnet.pl	12	0	0.0 KB	0	0	0	00:01:08
10	*.206.15.62.static.jazztel.es	8	0	0.0 KB	0	0	0	01:45:47
TOTAL: 10		1024	398	562.9 KB	327	3	9	04:14:52

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
252.206.15.62.static.jazztel.es	1.202	1.871	01:45:47
84-10-122-104.static.chello.pl	0.100	0.121	01:07:18
pc24.zsk.p.lodz.pl	0.247	0.129	00:39:25
staticline-31-182-69-227.toya.net.pl	0.055	0.097	00:20:50
host-89-230-0-228.ozorkow.mm.pl	0.030	0.104	00:09:04
212.191.87.58	0.454	0.201	00:05:47
dynamic-78-8-166-182.ssp.dialog.net.pl	0.000	0.019	00:04:39
host227.elsnet.pl	0.040	0.119	00:01:08
web.man.lodz.pl	1.018	3.928	00:00:23
staticline-31-182-69-124.toya.net.pl	0.000	0.015	00:00:13
pc-skrzep2.cm.p.lodz.pl	0.926	3.765	00:00:06
mon.man.lodz.pl	0.932	3.651	00:00:04
david.man.lodz.pl	0.301	1.198	00:00:01
staticline41435.toya.net.pl	0.018	0.111	00:00:00
TOTAL: 14	5.323	15.329	04:14:52

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
host227.elsnet.pl	12
252.206.15.62.static.jazztel.es	8
staticline41435.toya.net.pl	8
staticline-31-182-69-124.toya.net.pl	1
TOTAL: 6	413

NNRP client timeouts [Top 20]:

System	Conn	Peer
84-10-122-104.static.chello.pl	2	0
TOTAL: 1	2	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	289	72.8%
2	pl	78	19.6%
3	lodz	30	7.6%
TOTAL: 3		397	100.0%

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

Newsgroup		Count
1	lodman.info	289
2	pl.comp.pecet	66
3	lodz.test	30
4	pl.test	6
5	pl.comp.os.ms-windows.winnt	4
6	pl.internet.polip	2
TOTAL: 6		397

Daily Usenet report

Nov 23 04:15:01 -- Nov 24 04:15:03